builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0038 starttime: 1469119094.1 results: success (0) buildid: 20160721073720 builduid: 66c3ba6aeda144fc8ac69205b6970116 revision: 6688064e8ad629276830b941df87681a21b67cdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:14.102693) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:14.103100) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:14.103372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:14.125564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:14.125826) ========= 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.cVCujKu1lK/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.X3rR32QB89/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-21 09:38:14-- 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% 147M=0s 2016-07-21 09:38:14 (147 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193806 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:14.341248) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:14.341552) ========= 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.cVCujKu1lK/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.X3rR32QB89/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.021097 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:14.393579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:14.393916) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6688064e8ad629276830b941df87681a21b67cdc --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 6688064e8ad629276830b941df87681a21b67cdc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cVCujKu1lK/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.X3rR32QB89/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-21 09:38:14,467 truncating revision to first 12 chars 2016-07-21 09:38:14,467 Setting DEBUG logging. 2016-07-21 09:38:14,467 attempt 1/10 2016-07-21 09:38:14,467 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6688064e8ad6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 09:38:15,100 unpacking tar archive at: mozilla-beta-6688064e8ad6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.888192 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:15.311291) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:15.311655) ========= script_repo_revision: 6688064e8ad629276830b941df87681a21b67cdc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:15.315113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:15.315479) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 09:38:15.335994) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-21 09:38:15.336402) ========= /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.cVCujKu1lK/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.X3rR32QB89/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 09:38:15 INFO - MultiFileLogger online at 20160721 09:38:15 in /builds/slave/test 09:38:15 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 09:38:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:38:15 INFO - {'append_to_log': False, 09:38:15 INFO - 'base_work_dir': '/builds/slave/test', 09:38:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:38:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:38:15 INFO - 'branch': 'Mozilla-Beta', 09:38:15 INFO - 'buildbot_json_path': 'buildprops.json', 09:38:15 INFO - 'config_files': ('talos/mac_config.py',), 09:38:15 INFO - 'default_actions': ('clobber', 09:38:15 INFO - 'read-buildbot-config', 09:38:15 INFO - 'download-and-extract', 09:38:15 INFO - 'populate-webroot', 09:38:15 INFO - 'create-virtualenv', 09:38:15 INFO - 'install', 09:38:15 INFO - 'run-tests'), 09:38:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:38:15 INFO - 'download_minidump_stackwalk': True, 09:38:15 INFO - 'download_symbols': 'ondemand', 09:38:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:38:15 INFO - 'tooltool.py': '/tools/tooltool.py', 09:38:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:38:15 INFO - '/tools/misc-python/virtualenv.py')}, 09:38:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:38:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:38:15 INFO - 'installer_path': 'installer.exe', 09:38:15 INFO - 'log_level': 'info', 09:38:15 INFO - 'log_name': 'talos', 09:38:15 INFO - 'log_to_console': True, 09:38:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:38:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:38:15 INFO - 'opt_config_files': (), 09:38:15 INFO - 'pip_index': False, 09:38:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:38:15 INFO - 'cmd': ('bash', 09:38:15 INFO - '-c', 09:38:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:38:15 INFO - 'enabled': True, 09:38:15 INFO - 'halt_on_failure': False, 09:38:15 INFO - 'name': 'check_screen_resolution'},), 09:38:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:38:15 INFO - 'cmd': ('bash', 09:38:15 INFO - '-c', 09:38:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:38:15 INFO - 'enabled': True, 09:38:15 INFO - 'halt_on_failure': False, 09:38:15 INFO - 'name': 'check_screen_resolution'},), 09:38:15 INFO - 'run_cmd_checks_enabled': True, 09:38:15 INFO - 'sps_profile': False, 09:38:15 INFO - 'sps_profile_interval': 0, 09:38:15 INFO - 'suite': 'dromaeojs-e10s', 09:38:15 INFO - 'system_bits': '32', 09:38:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:38:15 INFO - 'title': 't-yosemite-r7-0038', 09:38:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:38:15 INFO - 'use_talos_json': True, 09:38:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:38:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:38:15 INFO - 'work_dir': 'build'} 09:38:15 INFO - ##### 09:38:15 INFO - ##### Running clobber step. 09:38:15 INFO - ##### 09:38:15 INFO - Running pre-action listener: _resource_record_pre_action 09:38:15 INFO - Running main action method: clobber 09:38:15 INFO - rmtree: /builds/slave/test/build 09:38:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:38:15 INFO - Running post-action listener: _resource_record_post_action 09:38:15 INFO - ##### 09:38:15 INFO - ##### Running read-buildbot-config step. 09:38:15 INFO - ##### 09:38:15 INFO - Running pre-action listener: _resource_record_pre_action 09:38:15 INFO - Running main action method: read_buildbot_config 09:38:15 INFO - Using buildbot properties: 09:38:15 INFO - { 09:38:15 INFO - "project": "", 09:38:15 INFO - "product": "firefox", 09:38:15 INFO - "script_repo_revision": "production", 09:38:15 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 09:38:15 INFO - "repository": "", 09:38:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 09:38:15 INFO - "buildid": "20160721073720", 09:38:15 INFO - "pgo_build": "False", 09:38:15 INFO - "basedir": "/builds/slave/test", 09:38:15 INFO - "buildnumber": 37, 09:38:15 INFO - "slavename": "t-yosemite-r7-0038", 09:38:15 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:38:15 INFO - "platform": "yosemite_r7", 09:38:15 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:38:15 INFO - "branch": "mozilla-beta", 09:38:15 INFO - "repo_path": "releases/mozilla-beta", 09:38:15 INFO - "revision": "6688064e8ad629276830b941df87681a21b67cdc", 09:38:15 INFO - "stage_platform": "macosx64", 09:38:15 INFO - "builduid": "66c3ba6aeda144fc8ac69205b6970116", 09:38:15 INFO - "slavebuilddir": "test" 09:38:15 INFO - } 09:38:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 09:38:15 INFO - Running post-action listener: _resource_record_post_action 09:38:15 INFO - ##### 09:38:15 INFO - ##### Running download-and-extract step. 09:38:15 INFO - ##### 09:38:15 INFO - Running pre-action listener: _resource_record_pre_action 09:38:15 INFO - Running main action method: download_and_extract 09:38:15 INFO - mkdir: /builds/slave/test/build/tests 09:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:15 INFO - https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:38:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 09:38:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 09:38:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/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 09:38:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/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 09:38:19 INFO - Downloaded 1165 bytes. 09:38:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:38:19 INFO - Using the following test package requirements: 09:38:19 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:38:19 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:38:19 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 09:38:19 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:38:19 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 09:38:19 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:38:19 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:38:19 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 09:38:19 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:38:19 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:38:19 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 09:38:19 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:38:19 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 09:38:19 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:38:19 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 09:38:19 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:38:19 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 09:38:19 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 09:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:19 INFO - https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:38:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:38:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:38:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/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 09:38:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/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 09:38:25 INFO - Downloaded 18314928 bytes. 09:38:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:38:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:38:28 INFO - Return code: 0 09:38:28 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:28 INFO - https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:38:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:38:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:38:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/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 09:38:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/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 09:38:31 INFO - Downloaded 18314928 bytes. 09:38:31 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'] 09:38:31 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 09:38:35 INFO - Return code: 0 09:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:35 INFO - https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:38:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 09:38:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 09:38:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/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 09:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/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 09:38:36 INFO - Downloaded 10840145 bytes. 09:38:36 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'] 09:38:36 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 09:38:37 INFO - Return code: 0 09:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:37 INFO - https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 09:38:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:38:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:38:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 09:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0mJpSlqS2-zMNUyZf96eg/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 09:38:40 INFO - Downloaded 86191973 bytes. 09:38:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:38:40 INFO - mkdir: /builds/slave/test/properties 09:38:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:38:40 INFO - Writing to file /builds/slave/test/properties/build_url 09:38:40 INFO - Contents: 09:38:40 INFO - build_url:https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:38:42 INFO - Running post-action listener: _resource_record_post_action 09:38:42 INFO - Running post-action listener: set_extra_try_arguments 09:38:42 INFO - ##### 09:38:42 INFO - ##### Running populate-webroot step. 09:38:42 INFO - ##### 09:38:42 INFO - Running pre-action listener: _resource_record_pre_action 09:38:42 INFO - Running main action method: populate_webroot 09:38:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:38:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:38:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:38:42 INFO - '--tppagecycles', 09:38:42 INFO - '7'], 09:38:42 INFO - 'tests': ['tsvgm']}}, 09:38:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:38:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:38:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:38:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:38:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:38:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:38:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:42 INFO - 'talos_options': ['--disable-e10s'], 09:38:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:42 INFO - 'talos_options': ['--disable-e10s'], 09:38:42 INFO - 'tests': ['damp', 'tps']}, 09:38:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:42 INFO - 'tests': ['damp', 'tps']}, 09:38:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:38:42 INFO - 'tests': ['dromaeo_dom']}, 09:38:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:38:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:38:42 INFO - 'tests': ['a11yr', 09:38:42 INFO - 'ts_paint', 09:38:42 INFO - 'tpaint', 09:38:42 INFO - 'sessionrestore', 09:38:42 INFO - 'sessionrestore_no_auto_restore', 09:38:42 INFO - 'tabpaint']}, 09:38:42 INFO - 'other-e10s': {'tests': ['a11yr', 09:38:42 INFO - 'ts_paint', 09:38:42 INFO - 'tpaint', 09:38:42 INFO - 'sessionrestore', 09:38:42 INFO - 'sessionrestore_no_auto_restore', 09:38:42 INFO - 'tabpaint']}, 09:38:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:38:42 INFO - 'ts_paint', 09:38:42 INFO - 'tpaint', 09:38:42 INFO - 'sessionrestore', 09:38:42 INFO - 'sessionrestore_no_auto_restore', 09:38:42 INFO - 'tabpaint']}, 09:38:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:38:42 INFO - 'ts_paint', 09:38:42 INFO - 'tpaint', 09:38:42 INFO - 'sessionrestore', 09:38:42 INFO - 'sessionrestore_no_auto_restore', 09:38:42 INFO - 'tabpaint']}, 09:38:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:38:42 INFO - 'tests': ['a11yr', 09:38:42 INFO - 'ts_paint', 09:38:42 INFO - 'tpaint', 09:38:42 INFO - 'sessionrestore', 09:38:42 INFO - 'sessionrestore_no_auto_restore', 09:38:42 INFO - 'tabpaint']}, 09:38:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:38:42 INFO - 'tests': ['a11yr', 09:38:42 INFO - 'ts_paint', 09:38:42 INFO - 'tpaint', 09:38:42 INFO - 'sessionrestore', 09:38:42 INFO - 'sessionrestore_no_auto_restore', 09:38:42 INFO - 'tabpaint']}, 09:38:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:38:42 INFO - 'tests': ['tsvgx', 09:38:42 INFO - 'tsvgr_opacity', 09:38:42 INFO - 'tart', 09:38:42 INFO - 'tscrollx', 09:38:42 INFO - 'cart']}, 09:38:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:38:42 INFO - 'tsvgr_opacity', 09:38:42 INFO - 'tart', 09:38:42 INFO - 'tscrollx', 09:38:42 INFO - 'cart']}, 09:38:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:42 INFO - 'talos_options': ['--disable-e10s'], 09:38:42 INFO - 'tests': ['tp5o']}, 09:38:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:42 INFO - 'tests': ['tp5o']}, 09:38:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:42 INFO - 'talos_options': ['--disable-e10s', 09:38:42 INFO - '--xperf_path', 09:38:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:42 INFO - 'tests': ['tp5n']}, 09:38:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:42 INFO - 'talos_options': ['--xperf_path', 09:38:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:42 INFO - 'tests': ['tp5n']}}, 09:38:42 INFO - 'talos.zip': {'path': '', 09:38:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:38:42 INFO - Running post-action listener: _resource_record_post_action 09:38:42 INFO - ##### 09:38:42 INFO - ##### Running create-virtualenv step. 09:38:42 INFO - ##### 09:38:42 INFO - Running pre-action listener: _resource_record_pre_action 09:38:42 INFO - Running main action method: create_virtualenv 09:38:42 INFO - Creating virtualenv /builds/slave/test/build/venv 09:38:42 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 09:38:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:38:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:38:42 INFO - Using real prefix '/tools/python27' 09:38:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:38:43 INFO - Installing distribute.............................................................................................................................................................................................done. 09:38:45 INFO - Installing pip.................done. 09:38:45 INFO - Return code: 0 09:38:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b78420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4605d4540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a07e00>, '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 0x101870db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a02b20>, '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.cVCujKu1lK/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.X3rR32QB89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 09:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:38:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cVCujKu1lK/Render', 09:38:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:45 INFO - 'HOME': '/Users/cltbld', 09:38:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:45 INFO - 'LOGNAME': 'cltbld', 09:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:45 INFO - 'MOZ_NO_REMOTE': '1', 09:38:45 INFO - 'NO_EM_RESTART': '1', 09:38:45 INFO - 'PAGER': '/bin/cat', 09:38:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:45 INFO - 'PWD': '/builds/slave/test', 09:38:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:45 INFO - 'SHELL': '/bin/bash', 09:38:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X3rR32QB89/Listeners', 09:38:45 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 09:38:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:45 INFO - 'USER': 'cltbld', 09:38:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:45 INFO - 'XPC_FLAGS': '0x0', 09:38:45 INFO - 'XPC_SERVICE_NAME': '0', 09:38:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:46 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 09:38:46 INFO - Cleaning up... 09:38:46 INFO - Return code: 0 09:38:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:38:46 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')]} 09:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:46 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')]} 09:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:46 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 0x101b68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b78420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4605d4540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a07e00>, '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 0x101870db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a02b20>, '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.cVCujKu1lK/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.X3rR32QB89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 09:38:46 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 09:38:46 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 09:38:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cVCujKu1lK/Render', 09:38:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:46 INFO - 'HOME': '/Users/cltbld', 09:38:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:46 INFO - 'LOGNAME': 'cltbld', 09:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:46 INFO - 'MOZ_NO_REMOTE': '1', 09:38:46 INFO - 'NO_EM_RESTART': '1', 09:38:46 INFO - 'PAGER': '/bin/cat', 09:38:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:46 INFO - 'PWD': '/builds/slave/test', 09:38:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:46 INFO - 'SHELL': '/bin/bash', 09:38:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X3rR32QB89/Listeners', 09:38:46 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 09:38:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:46 INFO - 'USER': 'cltbld', 09:38:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:46 INFO - 'XPC_FLAGS': '0x0', 09:38:46 INFO - 'XPC_SERVICE_NAME': '0', 09:38:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:46 INFO - Downloading/unpacking psutil>=0.7.1 09:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:38:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:38:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:38:49 INFO - Installing collected packages: psutil 09:38:49 INFO - Running setup.py install for psutil 09:38:49 INFO - building 'psutil._psutil_osx' extension 09:38:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:38:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:38:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:38:49 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:38:49 INFO - building 'psutil._psutil_posix' extension 09:38:49 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 09:38:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:38:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:38:50 INFO - ^ 09:38:50 INFO - 1 warning generated. 09:38:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:38:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:38:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:38:50 INFO - Successfully installed psutil 09:38:50 INFO - Cleaning up... 09:38:50 INFO - Return code: 0 09:38:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b78420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4605d4540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a07e00>, '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 0x101870db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a02b20>, '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.cVCujKu1lK/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.X3rR32QB89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 09:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cVCujKu1lK/Render', 09:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:50 INFO - 'HOME': '/Users/cltbld', 09:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:50 INFO - 'LOGNAME': 'cltbld', 09:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:50 INFO - 'MOZ_NO_REMOTE': '1', 09:38:50 INFO - 'NO_EM_RESTART': '1', 09:38:50 INFO - 'PAGER': '/bin/cat', 09:38:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:50 INFO - 'PWD': '/builds/slave/test', 09:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:50 INFO - 'SHELL': '/bin/bash', 09:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X3rR32QB89/Listeners', 09:38:50 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 09:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:50 INFO - 'USER': 'cltbld', 09:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:50 INFO - 'XPC_FLAGS': '0x0', 09:38:50 INFO - 'XPC_SERVICE_NAME': '0', 09:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:38:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:38:53 INFO - Installing collected packages: mozsystemmonitor 09:38:53 INFO - Running setup.py install for mozsystemmonitor 09:38:53 INFO - Successfully installed mozsystemmonitor 09:38:53 INFO - Cleaning up... 09:38:53 INFO - Return code: 0 09:38:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b78420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4605d4540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a07e00>, '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 0x101870db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a02b20>, '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.cVCujKu1lK/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.X3rR32QB89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 09:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:38:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cVCujKu1lK/Render', 09:38:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:53 INFO - 'HOME': '/Users/cltbld', 09:38:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:53 INFO - 'LOGNAME': 'cltbld', 09:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:53 INFO - 'MOZ_NO_REMOTE': '1', 09:38:53 INFO - 'NO_EM_RESTART': '1', 09:38:53 INFO - 'PAGER': '/bin/cat', 09:38:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:53 INFO - 'PWD': '/builds/slave/test', 09:38:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:53 INFO - 'SHELL': '/bin/bash', 09:38:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X3rR32QB89/Listeners', 09:38:53 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 09:38:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:53 INFO - 'USER': 'cltbld', 09:38:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:53 INFO - 'XPC_FLAGS': '0x0', 09:38:53 INFO - 'XPC_SERVICE_NAME': '0', 09:38:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:53 INFO - Downloading/unpacking blobuploader==1.2.4 09:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:55 INFO - Downloading blobuploader-1.2.4.tar.gz 09:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:38:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:38:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:57 INFO - Downloading docopt-0.6.1.tar.gz 09:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:38:57 INFO - Installing collected packages: blobuploader, requests, docopt 09:38:57 INFO - Running setup.py install for blobuploader 09:38:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:38:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:38:57 INFO - Running setup.py install for requests 09:38:57 INFO - Running setup.py install for docopt 09:38:58 INFO - Successfully installed blobuploader requests docopt 09:38:58 INFO - Cleaning up... 09:38:58 INFO - Return code: 0 09:38:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b78420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4605d4540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a07e00>, '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 0x101870db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a02b20>, '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.cVCujKu1lK/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.X3rR32QB89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 09:38:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:38:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cVCujKu1lK/Render', 09:38:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:58 INFO - 'HOME': '/Users/cltbld', 09:38:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:58 INFO - 'LOGNAME': 'cltbld', 09:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:58 INFO - 'MOZ_NO_REMOTE': '1', 09:38:58 INFO - 'NO_EM_RESTART': '1', 09:38:58 INFO - 'PAGER': '/bin/cat', 09:38:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:58 INFO - 'PWD': '/builds/slave/test', 09:38:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:58 INFO - 'SHELL': '/bin/bash', 09:38:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X3rR32QB89/Listeners', 09:38:58 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 09:38:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:58 INFO - 'USER': 'cltbld', 09:38:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:58 INFO - 'XPC_FLAGS': '0x0', 09:38:58 INFO - 'XPC_SERVICE_NAME': '0', 09:38:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-PwdIrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-S_D5ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-LsMF1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-tZdmAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-m6eWQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-qIA8zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ATKPp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-m3Rb9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-vviDXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-2ThnkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-l_wYe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-sWnE_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-aECOkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-28wj8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-XEMuxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-YJXvNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:00 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-qjW5ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:39:00 INFO - Running setup.py install for manifestparser 09:39:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:39:00 INFO - Running setup.py install for mozcrash 09:39:00 INFO - Running setup.py install for mozdebug 09:39:00 INFO - Running setup.py install for mozdevice 09:39:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:39:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:39:00 INFO - Running setup.py install for mozfile 09:39:00 INFO - Running setup.py install for mozhttpd 09:39:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:39:01 INFO - Running setup.py install for mozinfo 09:39:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:39:01 INFO - Running setup.py install for mozInstall 09:39:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:39:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:39:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:39:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:39:01 INFO - Running setup.py install for mozleak 09:39:01 INFO - Running setup.py install for mozlog 09:39:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:39:01 INFO - Running setup.py install for moznetwork 09:39:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:39:01 INFO - Running setup.py install for mozprocess 09:39:01 INFO - Running setup.py install for mozprofile 09:39:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:39:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:39:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:39:02 INFO - Running setup.py install for mozrunner 09:39:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:39:02 INFO - Running setup.py install for mozscreenshot 09:39:02 INFO - Running setup.py install for moztest 09:39:02 INFO - Running setup.py install for mozversion 09:39:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:39:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:39:02 INFO - Cleaning up... 09:39:02 INFO - Return code: 0 09:39:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b78420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4605d4540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a07e00>, '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 0x101870db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a02b20>, '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.cVCujKu1lK/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.X3rR32QB89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 09:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:39:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cVCujKu1lK/Render', 09:39:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:02 INFO - 'HOME': '/Users/cltbld', 09:39:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:02 INFO - 'LOGNAME': 'cltbld', 09:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:02 INFO - 'MOZ_NO_REMOTE': '1', 09:39:02 INFO - 'NO_EM_RESTART': '1', 09:39:02 INFO - 'PAGER': '/bin/cat', 09:39:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:02 INFO - 'PWD': '/builds/slave/test', 09:39:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:02 INFO - 'SHELL': '/bin/bash', 09:39:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X3rR32QB89/Listeners', 09:39:02 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 09:39:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:02 INFO - 'USER': 'cltbld', 09:39:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:02 INFO - 'XPC_FLAGS': '0x0', 09:39:02 INFO - 'XPC_SERVICE_NAME': '0', 09:39:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-5rfQjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-rs39B7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-xzh13t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-XTleQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-dP97V3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-qE_x2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-droVhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-KLJ6Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-p49T_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-dQ6VVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-hoHTut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-l0SV06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-fv7Uu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-zXAQ_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-45jYp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-xd87jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-lxr56l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:39:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:07 INFO - Downloading blessings-1.6.tar.gz 09:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:39:07 INFO - Installing collected packages: blessings 09:39:07 INFO - Running setup.py install for blessings 09:39:07 INFO - Successfully installed blessings 09:39:07 INFO - Cleaning up... 09:39:07 INFO - Return code: 0 09:39:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:39:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:08 INFO - Reading from file tmpfile_stdout 09:39:08 INFO - Current package versions: 09:39:08 INFO - blessings == 1.6 09:39:08 INFO - blobuploader == 1.2.4 09:39:08 INFO - docopt == 0.6.1 09:39:08 INFO - manifestparser == 1.1 09:39:08 INFO - mozInstall == 1.12 09:39:08 INFO - mozcrash == 0.17 09:39:08 INFO - mozdebug == 0.1 09:39:08 INFO - mozdevice == 0.48 09:39:08 INFO - mozfile == 1.2 09:39:08 INFO - mozhttpd == 0.7 09:39:08 INFO - mozinfo == 0.9 09:39:08 INFO - mozleak == 0.1 09:39:08 INFO - mozlog == 3.1 09:39:08 INFO - moznetwork == 0.27 09:39:08 INFO - mozprocess == 0.22 09:39:08 INFO - mozprofile == 0.28 09:39:08 INFO - mozrunner == 6.11 09:39:08 INFO - mozscreenshot == 0.1 09:39:08 INFO - mozsystemmonitor == 0.0 09:39:08 INFO - moztest == 0.7 09:39:08 INFO - mozversion == 1.4 09:39:08 INFO - psutil == 3.1.1 09:39:08 INFO - requests == 1.2.3 09:39:08 INFO - wsgiref == 0.1.2 09:39:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:08 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 0x101b68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b78420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4605d4540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a07e00>, '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 0x101870db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a02b20>, '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.cVCujKu1lK/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.X3rR32QB89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 09:39:08 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 09:39:08 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 09:39:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cVCujKu1lK/Render', 09:39:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:08 INFO - 'HOME': '/Users/cltbld', 09:39:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:08 INFO - 'LOGNAME': 'cltbld', 09:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:08 INFO - 'MOZ_NO_REMOTE': '1', 09:39:08 INFO - 'NO_EM_RESTART': '1', 09:39:08 INFO - 'PAGER': '/bin/cat', 09:39:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:08 INFO - 'PWD': '/builds/slave/test', 09:39:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:08 INFO - 'SHELL': '/bin/bash', 09:39:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X3rR32QB89/Listeners', 09:39:08 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 09:39:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:08 INFO - 'USER': 'cltbld', 09:39:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:08 INFO - 'XPC_FLAGS': '0x0', 09:39:08 INFO - 'XPC_SERVICE_NAME': '0', 09:39:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:39:08 INFO - Cleaning up... 09:39:08 INFO - Return code: 0 09:39:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b78420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4605d4540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a07e00>, '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 0x101870db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a02b20>, '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.cVCujKu1lK/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.X3rR32QB89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 09:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:39:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cVCujKu1lK/Render', 09:39:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:08 INFO - 'HOME': '/Users/cltbld', 09:39:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:08 INFO - 'LOGNAME': 'cltbld', 09:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:08 INFO - 'MOZ_NO_REMOTE': '1', 09:39:08 INFO - 'NO_EM_RESTART': '1', 09:39:08 INFO - 'PAGER': '/bin/cat', 09:39:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:08 INFO - 'PWD': '/builds/slave/test', 09:39:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:08 INFO - 'SHELL': '/bin/bash', 09:39:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X3rR32QB89/Listeners', 09:39:08 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 09:39:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:08 INFO - 'USER': 'cltbld', 09:39:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:08 INFO - 'XPC_FLAGS': '0x0', 09:39:08 INFO - 'XPC_SERVICE_NAME': '0', 09:39:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:08 INFO - Downloading/unpacking jsonschema 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:11 INFO - Downloading/unpacking functools32 (from jsonschema) 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39:11 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:11 INFO - warning: no files found matching '*.txt' 09:39:11 INFO - no previously-included directories found matching 'build' 09:39:11 INFO - no previously-included directories found matching 'dist' 09:39:11 INFO - no previously-included directories found matching '.git*' 09:39:11 INFO - Installing collected packages: jsonschema, functools32 09:39:11 INFO - Running setup.py install for functools32 09:39:12 INFO - warning: no files found matching '*.txt' 09:39:12 INFO - no previously-included directories found matching 'build' 09:39:12 INFO - no previously-included directories found matching 'dist' 09:39:12 INFO - no previously-included directories found matching '.git*' 09:39:12 INFO - Successfully installed jsonschema functools32 09:39:12 INFO - Cleaning up... 09:39:12 INFO - Return code: 0 09:39:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:39:12 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')]} 09:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:12 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')]} 09:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:12 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 0x101b68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b78420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4605d4540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a07e00>, '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 0x101870db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a02b20>, '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.cVCujKu1lK/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.X3rR32QB89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 09:39:12 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 09:39:12 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 09:39:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cVCujKu1lK/Render', 09:39:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:12 INFO - 'HOME': '/Users/cltbld', 09:39:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:12 INFO - 'LOGNAME': 'cltbld', 09:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:12 INFO - 'MOZ_NO_REMOTE': '1', 09:39:12 INFO - 'NO_EM_RESTART': '1', 09:39:12 INFO - 'PAGER': '/bin/cat', 09:39:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:12 INFO - 'PWD': '/builds/slave/test', 09:39:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:12 INFO - 'SHELL': '/bin/bash', 09:39:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X3rR32QB89/Listeners', 09:39:12 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 09:39:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:12 INFO - 'USER': 'cltbld', 09:39:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:12 INFO - 'XPC_FLAGS': '0x0', 09:39:12 INFO - 'XPC_SERVICE_NAME': '0', 09:39:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:12 INFO - Downloading/unpacking flake8 09:39:12 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 09:39:12 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 09:39:12 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 09:39:12 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 09:39:12 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 09:39:12 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 09:39:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:39:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:39:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:39:16 INFO - no previously-included directories found matching 'docs/_build' 09:39:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:39:16 INFO - Running setup.py install for pep8 09:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:39:16 INFO - no previously-included directories found matching 'docs/_build' 09:39:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:39:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:39:16 INFO - Cleaning up... 09:39:16 INFO - Return code: 0 09:39:16 INFO - Running post-action listener: _resource_record_post_action 09:39:16 INFO - Running post-action listener: _start_resource_monitoring 09:39:16 INFO - Starting resource monitoring. 09:39:16 INFO - ##### 09:39:16 INFO - ##### Running install step. 09:39:16 INFO - ##### 09:39:16 INFO - Running pre-action listener: _resource_record_pre_action 09:39:16 INFO - Running main action method: install 09:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:16 INFO - Reading from file tmpfile_stdout 09:39:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:39:16 INFO - Reading from file tmpfile_stdout 09:39:16 INFO - Output received: 09:39:16 INFO - Usage: mozinstall [options] installer 09:39:16 INFO - Options: 09:39:16 INFO - -h, --help show this help message and exit 09:39:16 INFO - -d DEST, --destination=DEST 09:39:16 INFO - Directory to install application into. [default: 09:39:16 INFO - "/builds/slave/test"] 09:39:16 INFO - --app=APP Application being installed. [default: firefox] 09:39:16 INFO - mkdir: /builds/slave/test/build/application 09:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:39:38 INFO - Reading from file tmpfile_stdout 09:39:38 INFO - Output received: 09:39:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:39:38 INFO - Running post-action listener: _resource_record_post_action 09:39:38 INFO - ##### 09:39:38 INFO - ##### Running run-tests step. 09:39:38 INFO - ##### 09:39:38 INFO - Running pre-action listener: _resource_record_pre_action 09:39:38 INFO - Running main action method: run_tests 09:39:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:39:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:39:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:39:38 INFO - 2016-07-21 09:39:38.575 screenresolution[2320:280463] starting screenresolution argv=screenresolution get 09:39:38 INFO - 2016-07-21 09:39:38.577 screenresolution[2320:280463] Display 0: 1600x1200x32@60 09:39:38 INFO - 2016-07-21 09:39:38.583 screenresolution[2321:280466] starting screenresolution argv=screenresolution list 09:39:38 INFO - Available Modes on Display 0 09:39:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:39:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:39:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:39:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:39:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:39:38 INFO - Intel Iris: 09:39:38 INFO - Chipset Model: Intel Iris 09:39:38 INFO - Type: GPU 09:39:38 INFO - Bus: Built-In 09:39:38 INFO - VRAM (Dynamic, Max): 1536 MB 09:39:38 INFO - Vendor: Intel (0x8086) 09:39:38 INFO - Device ID: 0x0a2e 09:39:38 INFO - Revision ID: 0x0009 09:39:38 INFO - Displays: 09:39:38 INFO - Display: 09:39:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:39:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:39:38 INFO - Display Serial Number: 1600x1200 60 09:39:38 INFO - Main Display: Yes 09:39:38 INFO - Mirror: Off 09:39:38 INFO - Online: Yes 09:39:38 INFO - Rotation: Supported 09:39:38 INFO - Return code: 0 09:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:39:38 INFO - Python 2.7.3 09:39:38 INFO - Return code: 0 09:39:38 INFO - grabbing minidump binary from tooltool 09:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:38 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 0x101a07e00>, '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 0x101870db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a02b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:39:38 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 09:39:38 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 09:39:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:39:38 INFO - Return code: 0 09:39:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:39:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:39:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:39:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:39:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:39:40 INFO - Return code: 0 09:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 09:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --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 09:39:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cVCujKu1lK/Render', 09:39:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:40 INFO - 'HOME': '/Users/cltbld', 09:39:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:40 INFO - 'LOGNAME': 'cltbld', 09:39:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:39:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:40 INFO - 'MOZ_NO_REMOTE': '1', 09:39:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:39:40 INFO - 'NO_EM_RESTART': '1', 09:39:40 INFO - 'PAGER': '/bin/cat', 09:39:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:40 INFO - 'PWD': '/builds/slave/test', 09:39:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:39:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:40 INFO - 'SHELL': '/bin/bash', 09:39:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X3rR32QB89/Listeners', 09:39:40 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 09:39:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:40 INFO - 'USER': 'cltbld', 09:39:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:40 INFO - 'XPC_FLAGS': '0x0', 09:39:40 INFO - 'XPC_SERVICE_NAME': '0', 09:39:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 09:39:40 INFO - mozversion application_buildid: 20160721073720 09:39:40 INFO - mozversion application_changeset: 6688064e8ad629276830b941df87681a21b67cdc 09:39:40 INFO - mozversion application_display_name: Firefox 09:39:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:39:40 INFO - mozversion application_name: Firefox 09:39:40 INFO - mozversion application_remotingname: firefox 09:39:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:39:40 INFO - mozversion application_vendor: Mozilla 09:39:40 INFO - mozversion application_version: 48.0 09:39:40 INFO - mozversion platform_buildid: 20160721073720 09:39:40 INFO - mozversion platform_changeset: 6688064e8ad629276830b941df87681a21b67cdc 09:39:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:39:40 INFO - mozversion platform_version: 48.0 09:39:40 INFO - using testdate: 1469119180 09:39:40 INFO - actual date: 1469119180 09:39:40 INFO - starting webserver on 'localhost:49498' 09:39:40 INFO - SUITE-START | Running 2 tests 09:39:40 INFO - TEST-START | dromaeo_css 09:39:40 INFO - operating with platform_type : mac_ 09:39:40 INFO - Initialising browser for dromaeo_css test... 09:39:40 INFO - TEST-INFO | started process 2339 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpB_PBNr/profile http://localhost:49498/getInfo.html) 09:39:43 INFO - PROCESS | 2339 | __metrics Screen width/height:1600/1200 09:39:43 INFO - PROCESS | 2339 | colorDepth:24 09:39:43 INFO - PROCESS | 2339 | Browser inner width/height: 1024/689 09:39:43 INFO - PROCESS | 2339 | __metrics 09:39:43 ERROR - PROCESS | 2339 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 09:39:43 INFO - TEST-INFO | 2339: exit 0 09:39:43 INFO - Browser initialized. 09:39:43 INFO - Running cycle 1/1 for dromaeo_css test... 09:39:43 INFO - TEST-INFO | started process 2344 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpB_PBNr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:55 INFO - PROCESS | 2344 | RSS: Main: 170778624 09:39:55 INFO - PROCESS | 2344 | 09:40:45 INFO - PROCESS | 2344 | 1469119245431 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] 09:42:55 INFO - PROCESS | 2344 | Cycle 1(1): loaded http://localhost:49498/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49498/tests/dromaeo/cssquery-ext.html) 09:42:56 INFO - PROCESS | 2344 | RSS: Main: 187441152 09:42:56 INFO - PROCESS | 2344 | 09:45:58 INFO - PROCESS | 2344 | Cycle 1(1): loaded http://localhost:49498/tests/dromaeo/cssquery-ext.html (next: http://localhost:49498/tests/dromaeo/cssquery-jquery.html) 09:45:59 INFO - PROCESS | 2344 | RSS: Main: 197009408 09:45:59 INFO - PROCESS | 2344 | 09:49:01 INFO - PROCESS | 2344 | Cycle 1(1): loaded http://localhost:49498/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49498/tests/dromaeo/cssquery-mootools.html) 09:49:01 INFO - PROCESS | 2344 | RSS: Main: 198889472 09:49:01 INFO - PROCESS | 2344 | 09:52:03 INFO - PROCESS | 2344 | Cycle 1(1): loaded http://localhost:49498/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49498/tests/dromaeo/cssquery-prototype.html) 09:52:04 INFO - PROCESS | 2344 | RSS: Main: 203034624 09:52:04 INFO - PROCESS | 2344 | 09:55:06 INFO - PROCESS | 2344 | Cycle 1(1): loaded http://localhost:49498/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49498/tests/dromaeo/cssquery-yui.html) 09:55:07 INFO - PROCESS | 2344 | RSS: Main: 202002432 09:55:07 INFO - PROCESS | 2344 | 09:58:09 INFO - PROCESS | 2344 | Cycle 1(1): loaded http://localhost:49498/tests/dromaeo/cssquery-yui.html (next: http://localhost:49498/tests/dromaeo/cssquery-dojo.html) 09:58:09 INFO - PROCESS | 2344 | RSS: Main: 206774272 09:58:09 INFO - PROCESS | 2344 | 09:58:09 INFO - PROCESS | 2344 | __start_tp_report 09:58:09 INFO - PROCESS | 2344 | _x_x_mozilla_page_load 09:58:09 INFO - PROCESS | 2344 | _x_x_mozilla_page_load_details 09:58:09 INFO - PROCESS | 2344 | |i|pagename|runs| 09:58:09 INFO - PROCESS | 2344 | |0;dojo.html;3590.066582688501;3620.999999999999;3626.818659067046;3655.3968595181796;3682.116292089899;5856.912146317809;5993.670348130857;6018.0972854071915;6033.818985430438;6058.242719660043;5930.110483427488;5988.850278743033;5999.640021598696;6021.488173505258;6047.758089676418;5352.598555108353;5394.7842086316505;5398.595105367093;5404.729763511808;5413.26920865682;5383.542398896079;5441.374241962166;5514.145307477327;5556.749946252428;5570.693611851347;5473.0969390050595;5491.450854914517;5525.364583072937;5527.806526771564;5528.226048353234;4698.73134253753;5380.327459067597;5407.351117865842;5418.91871621926;5464.426235245322;5237;5285.048691235576;5374.48942350476;5391.676499410048;5426.701531415771;5700.429957004308;5783.768649254025;5848.239728835224;5872.530197584183;5895.439933206381;6264.7807326743805;6292.2134733158355;6311.495080393557;6317.589356691847;6344.429001389851;6250.406211409909;6313;6329.145565348665;6390.009548519987;6414.647194404306;6054.334023257438;6079.969600152015;6099.054646529795;6101.206843110367;6106.023036314213;6301.747930082745;6477.805665830033;6478.676066196671;6479.44924681398;6513.348665133449;6179.84550386235;6205.348438413902;6258.499320054385;6265.248170219603;6285.308616052231;6324.71538780756;6343.904841427382;6358.459530939829;6376.202974628171;6396.488280937607;6185.659788711574;6209.844753881099;6279.309275979638;6283.246010478681;6296.65368404733;6211.844703882439;6279.717412716439;6280.246370435577;6295.370462953668;6308.211473565804;5081.364829396325;5092.974535127375;5114;5123.231515272739;5149.073166829931;4449.7775111244955;4537.818487260539;4541.909161816745;4599.103174880866;4643.8374656886845;6043.54673399488;6110.175126357974;6114.449699526975;6144.078388241799;6170.691465426711;6394.136791533177;6421.165248517663;6432.421082102634;6447.1618689571;6461.19235095613;5953.1070339449425;6106.755729770759;6178.073289006685;6191.25704915413;6199.380061993765;5625.887482250332;5636.436356364413;5636.943630563724;5650.3219613646625;5655.236543066633;6600.669966501751;6619.106420633249;6634.734610615521;6638.4357329626555;6645.335466453316;6254.8123556293385;6308.936910630835;6363.5545511813725;6379.457746091634;6389.840253993501;6587.308332625005;6612.90080648781;6621.304763000008;6636.734530618721;6649.102371179829;6308.33762454954;6320.841978950563;6332.651704156316;6333.588316759396;6342.143810585512;6207.6585787782105;6353.142325786144;6360.268569114611;6362.840928976812;6410.455111315404;6244.843878903063;6269.7178626962805;6278.591891527036;6278.686065696788;6292.811215663537;6194.473469754941;6254.530910181846;6267.811965641038;6275;6294.622322660655;5720.913026524947;5893.351731309638;6097.115918191748;6209.223847019122;6242.531810114168;6237.7193026314835;6265.655388953652;6268.780592679234;6279.215098112736;6282.246130464374;6081.756729730761;6201.658908760061;6247.5939063960695;6265.780697675559;6272.40412160844 09:58:09 INFO - PROCESS | 2344 | |1;ext.html;564.4045531963778;568.7412227436516;575.3326141675657;590.2710152961093;591.7366771786554;36110.819445902765;38863.028424289405;39426.620068297576;39471;39514.80242598783;39451.42194312231;39550.81347559578;40070;40572.98567535813;40591.79704101483;8206.630701618427;9603.423794572349;9709.174720148796;9793.412395256271;9803.705888823346;9530.80938381232;9717.659881904136;9773.26700497462;9784.02159784023;9799.804003919917;8289.461185022985;9646.951765241163;9719.416834989888;9788.168005719523;9830.557624906896;9657.420554766737;9767.120959113643;9767.902320976771;9820.459874706889;9823.263255255848;9658.275629327829;9727.756806079833;9760.658376956844;9779.608815647365;9808.117269445784;32968.175795605064;38709.80645096757;38805.22389552221;39057.82826515209;39469.210615787524;3311.2549676322874;3319.96680033199;3329.783564068328;3382.30662714143;3460.2041530447887;26453.3386665333;26725.866370668216;26867.865660671767;26969.46061078787;27237.727622723916;2700.0954680181967;2716.456708658276;2772.7365900239447;2815;2836.9858150709115;326559;328246;330657;331046.344768277;331460;33212;33795;59922;60350;60370.09444858331;31863.52204716931;32507.34985300328;32694.855680051085;32911.34177316488;32944.1763955903;16173.191340432932;16374.099424531527;16580.83419165817;16596.83403165977;16614.75077873833;13640.454381824617;13654.795178072336;14007.929960350337;14087;14178.71642567143;8034.196580341919;8161.469504482189;8298.626561804733;8309.127541608164;8359.038710548242;3525.8060806655367;3547.077759782475;3568.5717713873983;3586.8923932282073;3590.8563657453933;867.9088695686988;915.7893684452613;936.2865955301781;1073.6403304892792;1117.0002847451485;24286.14998475045;30124.397512049636;30326.086956522093;30546;30573.847130764203;1095.3920574081462;1139.794836929344;1149.431031639344;1194.4445832687843;1224.4367590908105;12595.24428534291;15273;15334.309956052004;15340;15410.306536205673;595933;602658;608358;609825;611024;60783.39216607866;61067.69466152641;61372.38627613756;61379;61451;1538.2846976155918;1558.5869744517486;1564.6635973265802;1579.2182869479682;1583.6515966487354;29790.25524361908;29800.254993624465;30034.549481757353;30174.698253017188;30444.391112178077;45179.64461066173;49101.754491227315;50942.74528627333;51265.7436712829;51511.48488515217;447243;533116;533147;536858;537207;22907.427314317276;25691.871540642176;26041.95832166692;27022.594661079707;27447.45105097847;46193.76903115597;46576;47489.7625511884;47718;47749.76125119352;37676.623233767314;38666.226675466896;38867.80566097151;39125.60874391333;39453.40819887647;37917.81041094777;38199.42700859545;38238.42642360422;38670;38978.6102138975;31167.844160779958;36822.44766328454;38071.619283807915;38222.426663599515;38686.41970370503;29846;31708.682913170574;31848.681513184572;31875;32187.195320117185;24480;24495;24605.38486537851;24788.752112478644;24972.87622057048 09:58:09 INFO - PROCESS | 2344 | |2;jquery.html;407.59851546226963;409.1101853468705;410.27995867252974;412.2990915443746;421.7827818673382;13897.79153312701;16263.75604365934;17381.739273910902;19992.400607951346;21229.36311910643;17761.64476710468;17958.5510362241;20532.692009619866;20858.791412085873;21012.579748405024;5801.709914504279;6059.6364218147055;6068.848278793022;6076.908846367308;6084.817455476343;5668.914966275509;5961.910571341434;5996.700164991755;6005.6396616203165;6007.15899774032;5723.170140329649;5964.761409543635;5973.551983601225;6041.124037014631;6042.486388656969;5693.633527953303;5936.910946335808;5996.880062398771;6012.819615411545;6155.292141403706;5961.135635332853;6024.367441418632;6024.789132380346;6028.306744724369;6041.154238406627;10352.844707329396;13608.931955340258;13710.588682339545;13737.175769453765;13803.792943105862;2094.1623350659706;2145.6340452472587;2213.524092320159;2302.7927486526128;2355.9882200588886;9904.752381190456;10412.895871041268;10820.08029317509;11562.248453850472;15192.696146077127;1753.158483927709;1763.938262160818;1770.7697999260142;1820.599468117012;1846.492214640971;107939;108028.37957430567;115063;115247.42376288064;116180;11422.914823091793;11782.646520604396;11925.045996320274;11991.64025079249;12205.511779528897;12812.359382030862;15099.773503397459;15116.244187790566;15128.167950762594;15159.545213643609;7680.961595191989;9097.40866843653;9152.496612686366;9184.311176661777;9236.72289831306;9198.632054717737;9279.582418791035;9310;9315.767105822273;9332.34673572857;3925.6270654287796;4048.959510404858;4496.4154659894;4646.210144275481;4750.643701722384;1924.3553409607657;1940.553672655297;2025.7670367907585;2053.856230063881;2079;907.9228265597366;941.2187884056217;1005.2008653120787;1011.9071402884866;1023.5036007536339;16752.581185470463;18294.08529573516;20313.289034883706;20406.795932040488;20527.38417847437;903.9231665308391;910.0035461170008;965.1892410375178;997.3417544420647;1052.7473406382567;10187.643432479828;10532.473376331152;10655;10683.732906677395;10733.195010374253;592135;599687;603159;606219;642331;82356;104660;119234.4038279803;128366.35816820856;130740.3462982679;992.1120597065586;1004.467632154959;1012.9848052279369;1024.2267088348249;1024.8155332040155;16588.66822663564;17917.462476125736;18250.543736406165;18284.634307314045;18572.44282671522;44026.55973440353;50604.74697626488;53250.2012469821;55050.44949550613;56153.43846561482;70872.64563677149;71522;76715.84926226223;78206.21793781989;80891;8335.624896879533;8384.580770961305;8427.578621069044;8458.154184581492;8635.222829945084;12022.098342624164;12687.984961203267;12875;12931.418086186331;12933.676658083623;10840.186985976241;11067.83398249043;11128.610498632834;11339.546418143513;11434.656960291204;10887.673369798918;11131.165162612675;11216;11348.659540213806;11367.54529818798;5849.181114643869;10301.536430860479;11353.772924541297;11365.715857103638;11381.203315767816;8237.79405514843;8251.133630968661;8406.789830254293;8546.2308392245;8613.923259592551;9708.32170341745;11262.549498020315;11289.322640641587;11428.657140285804;11435.485403156712 09:58:09 INFO - PROCESS | 2344 | |3;mootools.html;1581.6283173454235;1592.2277695317773;1872.1388161445734;1990.8506861985354;2061.5773766377874;8464.95767521163;9158.725238242863;9320.627174913005;9532.809343813129;9537.57080931358;9166.312526560518;9181.944076431213;9296.674616388427;9307.162355388014;9328.906710932888;2533.6199570064455;2540.6570113034736;2570.717221105677;2571.2671888511777;2586.172424824057;2490.6139548369943;2573.691157061146;2579.935501612456;2580.419405633736;2583.599542070982;2554.846709197445;2555.6038813983864;2556.2586849813533;2556.6165075238678;2596.9220923372327;2573.1765834932735;2580.8193426460157;2582.5222333868296;2591.2485379239997;2601.752833480816;2547.7707006369515;2568.345072006645;2581.174024312221;2606.8696565171854;2612.4383257599707;9226.16964473194;9341.346105772598;9476.336656434052;9479;9545.809083818285;5365.087935051011;5647.887042259173;5817.680027598481;5867.530597552186;5978.163057172;3247.65899580543;3672.6510981456718;3791.2607041626893;3814.370628846237;3816.160444702161;1038.5274700011553;1058.6929790360787;1067.9466026698713;1073.8174510333183;1081.4754843900703;10569.41868197249;12664;12775.74448511034;12801.48794048237;12807.359632018455;5057.963117560891;5095.923561146586;5117.130087885069;5226.738663066832;5247.239150323182;10599.311044782064;10798.622048228275;10844.403557804397;10858.837117443245;10883.074938630147;5716.114002329646;5832.066869300977;5850.912236316459;5909.645421274738;5924.348321684612;4703.270992996091;5169.25045868347;5226.92159617606;5239.685618862804;5302.867428314245;4324.789059063467;4332.935005974913;4340.47914250292;4371.30059190528;4446.066326071496;1427.5503216486773;1440.0855456784807;1463.8609332113433;1467.1710483576744;1473.1750219876903;949.2486362660879;974.3423189347304;984.6849008317413;985.2413641496008;1008.4655132779639;5124.69251844883;6197.411245931629;6226.25284965807;6281.968590157111;6310.52671049664;491.12579608296573;493.4769144706622;495.8091134913012;497.5845169283689;504.71231398103464;4119.814608342632;4145.79271036447;4155.854545090907;4207.663386929038;4219.915601688011;11118.388488633203;11266.155038371991;11516.596919107791;11539.884601154048;11584.652460426201;10571.841422378671;11050.613228536962;11339.433028348549;11349.829752553718;11401.144914131473;8611.61247743853;8640.870386944202;8714.956425217833;8767.298616110696;8913.197812196933;6012.488938440281;6040.6677632730625;6141.1402403664415;6172.938270617416;6261.96869015652;10048.497575121068;10052.597896084075;10172.79654406893;10302.124319432933;10323.896761032294;10176.287659863738;10509.632162874263;10714.678559643224;10753.46232688378;10899.346039237671;7217.025701530226;7741.845163096819;7854.921450785419;7900.170482099296;7968.402369822403;8542.316614670935;8688.174623410765;8706.390552661253;8765.824683506422;8787.736367908972;7553.131389890233;7735.729249476241;7764.650590723318;7767.417443691633;7829.099653539688;7530.6611202497115;7550.5469671819865;7558.962205188939;7612.657430415756;7741;7417.8145546361775;7466.626668666437;7475.02824632816;7478.326950574475;7483.663235154322;5043.672161309503;5047.1419858623385;5167.457416971164;5214.608904332114;5255.973720131375;5192.922106168486;5224.921626175535;5322.54758345545;5398.541124004347;5462.317210348707 09:58:09 INFO - PROCESS | 2344 | |4;prototype.html;324.50188959946485;331.2893842707393;344.17226570098916;345.12166536165455;347.9182392137849;5402.864928376787;6657.33426657334;6769.796906092813;6817.488688348375;6824.488163387741;6797.456203503721;6815.693293801778;6834;6835.1797784265955;6889.5521791083665;4015.638592526672;5019.6988180709095;5033.5721463675445;5044.596432285409;5053.69677819332;4196.349565817303;5041.521055499722;5049.419316778581;5057.671251368668;5084.669496482736;4885.902281954359;4996.825111121111;5017.899642007158;5017.974910125463;5018.971110922253;3979.5622481527007;4871.366722326093;4927.359443272388;4989.950100498985;5015.673981191211;3230.8384580771103;4146.714518499275;4287.035417031143;4288.849890253826;4301.763403012833;6538.869222615569;6543.312952140004;6550.475961923034;6552.7378904843745;6558.376954189344;5934.317553481362;5950.940490595125;5957.076653118774;5987.790427335022;6009.2188015557695;7295.4893157479;7312.049433573601;7314.305141011595;7321.633918304116;7383.778486645409;4515.345274935149;4715.08055929094;4729.219678753002;4813.278008298748;4825.445073816486;7674.309312161877;7718.845623087507;7779.922200777976;7785.026871640988;7795.805104872366;4790.760461976887;4794.113089078462;4799.496052914464;4815.085133824562;4817.0365926814775;4886.21820508724;4894.853154405374;4900.730459824673;4901.975490122527;4907.509249075064;5889.998700220887;5892.882142357129;5911.408859114054;5912.940870591325;5919.644821310649;6251.187345645037;7141.464390170758;7341.339279464767;7388.298111679382;7401.222871598405;1673.2972151696317;1675.8491735743842;1690.8079803738335;1695.2710334556014;1698.6008288052299;997.7428440165444;1051.2746205118444;1055.9155267578576;1072.2922870905165;1073.9087177589993;6752.459803215731;6820.795376138723;6828.556143850634;6863.142107236596;6929.653517324114;7567.205443428471;7673.616319184019;7684.423668224906;7697.961510192413;7703.114141873644;5681.289838770153;6178.845528861814;6896.586204827727;6900.171979362408;6926.549774264657;3924.4898163238595;4027.395890616431;4077.8776636700945;4078.6336577246952;4100.487439070116;7409.740659077014;8040.477368970998;8040.8793868092025;8045.919540804634;8057.677692892219;6347.39699728525;6422.550421470452;7905.328047115944;7950.681972721142;7963.641636126388;7075.363217310467;7360.926390736238;8033.277005069572;8046.758597242092;8047.114817370085;6110.541709371726;7383.012190326302;7678.1170165431695;7691.961540192263;7704.30661240491;7503.4372422069655;7526.209747976603;7547.773566793005;7562.886556701544;7569.432292578189;8020.15788342239;8026.919730802617;8030.357571394391;8031.759047228593;8065.709486482135;4972.5276098770555;5037.848864534069;5054.16606259963;5062.746862656779;5068.746562671926;7307.159676637255;7523.930918997319;7587;7605.125410577854;7646.235376462309;5884.852878678067;7266.055412796302;7291.671874765754;7307.525010874276;7320.670569824264;5787.334456537552;7228.9277107230355;7280.417566594766;7286.380657644159;7296.379807716404;7121.893171602534;7124.145102587722;7139.286071392819;7139.82150446243;7145.1068616422945;5854.302252346772;7301.452391070585;7352.558846469229;7404.296591823768;7414.184439711736;6909.550879193038;7054.541454805421;7160.427165826825;7166.677499512431;7182.102237220348 09:58:09 INFO - PROCESS | 2344 | |5;yui.html;644.2301449767524;716.7670507085197;747.3908764357049;750.2759836757527;785.0579304834197;15386.384544618215;15713;15745.448909288178;15747.976381535193;15748.291326890274;14387.784183237234;14441.711165776678;14483.493077742281;14485.565433037;14489.347979340928;754.852803703278;938.5401153434802;972.9951350243274;976.7948730766548;978.2076518020391;968.0222974795472;977.4379731654292;978.4911845840159;984.5569493727816;984.6356847966263;1045.6078970386104;1045.9529321180528;1046.016744260393;1047.4239168457357;1048.0619845238507;1003.4932359158614;1013.0224333518154;1035.063267742694;1035.4822588705647;1036.5646428499972;755.9886601700979;763.9465237433382;770.2797883978442;779.0067663728735;779.9883001754978;15072.924635376863;15082.773758393632;15095.4716584919;15138.167400792952;15514.534563962987;10200.897991020069;13304.600861974157;13367.732645347136;13428.530001449903;13478.663033424145;10141.13800326973;10336.741581460448;10385.2211084169;10589.04698577124;10632.627858024933;3140.654528001918;3550.467429885512;3604.6395360464007;3613.8915832525067;3662.029562166028;80149.59925200394;80270.59864700698;80448.59775701142;80611.5969420155;80824;9329.34694571387;9615.711528654152;9695.563699633392;9724.416535007922;9892.208623310118;22390;22533.88733056324;22675.546489070126;22928.770712292997;23254.418639534146;7519.172890981988;7568.508046976929;7613.314801667876;7645;7697.268759467842;3850.345441274934;4206.41110244566;4211.136716973013;4219.346001369792;4221.345691417835;3821.464994900716;3834.5206849143856;3892.2993861104706;3906.4921560196995;3922.6273504017645;713.4470785141453;739.1721272175091;769.1078349114999;771.5717776634021;776.1927595300824;511.4629638879162;551.8399664097448;599.9209329907079;606.0485038489617;611.5688439650036;8203.548804815673;8462.61918213682;8513.361497887683;8612.65549378018;8748.650053997897;570.3791079987451;622.6015350175891;627.9294695335186;633.7971849008273;634.352959980817;3951.124814434137;3968.0873399118364;4030.858919937788;4039.171969746195;4221.6833737469815;88580.5570972141;90372;91103;97244;97838;72865.6356718213;72911;72957;73004;74843;71330.64334678293;71557.99999999895;72109.55780884458;72508.27491725121;73085.6345718268;8656.91343086561;8670.82658346817;8738.606762695821;8835.558222089;8877.689280875138;48214.27678584754;49087.509124909724;49906.50093499019;50022.49977500179;52453.7377313111;66919.99620005606;71009;71836.64081679558;72579.18552036241;73622;10994.670159895217;11075;11307.773844523228;11348.886511134782;11648.883511165119;10084.949575252076;12109.69725756863;12329.321887296284;12417.62747117588;12683.936580317039;11416.486258118572;11476.263962010218;11538.307701537935;11621.477033533341;11866.525338986345;11548.82676759866;11552.191346605658;11797.823032654345;11853.229540079867;12059.879401205875;10947.726306842393;11064.502097405797;11104.389258590532;11490.08079353633;11611.6516504505;9691.176250018827;9728.416295022322;9800.607975680892;9857.901420985698;9881.258905581966;8332.583370831555;9533.904660953302;9666;9763.56063977137;9891.258155638212 09:58:09 INFO - PROCESS | 2344 | __end_tp_report 09:58:09 INFO - PROCESS | 2344 | __start_cc_report 09:58:09 INFO - PROCESS | 2344 | _x_x_mozilla_cycle_collect,392 09:58:09 INFO - PROCESS | 2344 | __end_cc_report 09:58:09 INFO - PROCESS | 2344 | __startTimestamp1469120289593__endTimestamp 09:58:09 INFO - PROCESS | 2344 | 09:58:09 INFO - PROCESS | 2344 | ------- Summary: start ------- 09:58:09 INFO - PROCESS | 2344 | Number of tests: 6 09:58:09 INFO - PROCESS | 2344 | 09:58:09 INFO - PROCESS | 2344 | [#0] dojo.html Cycles:165 Average:5940.76 Median:6201.66 stddev:626.39 (10.1%) stddev-sans-first:600.55 09:58:09 INFO - PROCESS | 2344 | Values: 3590.1 3621.0 3626.8 3655.4 3682.1 5856.9 5993.7 6018.1 6033.8 6058.2 5930.1 5988.9 5999.6 6021.5 6047.8 5352.6 5394.8 5398.6 5404.7 5413.3 5383.5 5441.4 5514.1 5556.7 5570.7 5473.1 5491.5 5525.4 5527.8 5528.2 4698.7 5380.3 5407.4 5418.9 5464.4 5237.0 5285.0 5374.5 5391.7 5426.7 5700.4 5783.8 5848.2 5872.5 5895.4 6264.8 6292.2 6311.5 6317.6 6344.4 6250.4 6313.0 6329.1 6390.0 6414.6 6054.3 6080.0 6099.1 6101.2 6106.0 6301.7 6477.8 6478.7 6479.4 6513.3 6179.8 6205.3 6258.5 6265.2 6285.3 6324.7 6343.9 6358.5 6376.2 6396.5 6185.7 6209.8 6279.3 6283.2 6296.7 6211.8 6279.7 6280.2 6295.4 6308.2 5081.4 5093.0 5114.0 5123.2 5149.1 4449.8 4537.8 4541.9 4599.1 4643.8 6043.5 6110.2 6114.4 6144.1 6170.7 6394.1 6421.2 6432.4 6447.2 6461.2 5953.1 6106.8 6178.1 6191.3 6199.4 5625.9 5636.4 5636.9 5650.3 5655.2 6600.7 6619.1 6634.7 6638.4 6645.3 6254.8 6308.9 6363.6 6379.5 6389.8 6587.3 6612.9 6621.3 6636.7 6649.1 6308.3 6320.8 6332.7 6333.6 6342.1 6207.7 6353.1 6360.3 6362.8 6410.5 6244.8 6269.7 6278.6 6278.7 6292.8 6194.5 6254.5 6267.8 6275.0 6294.6 5720.9 5893.4 6097.1 6209.2 6242.5 6237.7 6265.7 6268.8 6279.2 6282.2 6081.8 6201.7 6247.6 6265.8 6272.4 09:58:09 INFO - PROCESS | 2344 | 09:58:09 INFO - PROCESS | 2344 | [#1] ext.html Cycles:180 Average:61293.59 Median:38135.52 stddev:133304.24 (349.6%) stddev-sans-first:133600.22 09:58:09 INFO - PROCESS | 2344 | Values: 564.4 568.7 575.3 590.3 591.7 36110.8 38863.0 39426.6 39471.0 39514.8 39451.4 39550.8 40070.0 40573.0 40591.8 8206.6 9603.4 9709.2 9793.4 9803.7 9530.8 9717.7 9773.3 9784.0 9799.8 8289.5 9647.0 9719.4 9788.2 9830.6 9657.4 9767.1 9767.9 9820.5 9823.3 9658.3 9727.8 9760.7 9779.6 9808.1 32968.2 38709.8 38805.2 39057.8 39469.2 3311.3 3320.0 3329.8 3382.3 3460.2 26453.3 26725.9 26867.9 26969.5 27237.7 2700.1 2716.5 2772.7 2815.0 2837.0 326559.0 328246.0 330657.0 331046.3 331460.0 33212.0 33795.0 59922.0 60350.0 60370.1 31863.5 32507.3 32694.9 32911.3 32944.2 16173.2 16374.1 16580.8 16596.8 16614.8 13640.5 13654.8 14007.9 14087.0 14178.7 8034.2 8161.5 8298.6 8309.1 8359.0 3525.8 3547.1 3568.6 3586.9 3590.9 867.9 915.8 936.3 1073.6 1117.0 24286.1 30124.4 30326.1 30546.0 30573.8 1095.4 1139.8 1149.4 1194.4 1224.4 12595.2 15273.0 15334.3 15340.0 15410.3 595933.0 602658.0 608358.0 609825.0 611024.0 60783.4 61067.7 61372.4 61379.0 61451.0 1538.3 1558.6 1564.7 1579.2 1583.7 29790.3 29800.3 30034.5 30174.7 30444.4 45179.6 49101.8 50942.7 51265.7 51511.5 447243.0 533116.0 533147.0 536858.0 537207.0 22907.4 25691.9 26042.0 27022.6 27447.5 46193.8 46576.0 47489.8 47718.0 47749.8 37676.6 38666.2 38867.8 39125.6 39453.4 37917.8 38199.4 38238.4 38670.0 38978.6 31167.8 36822.4 38071.6 38222.4 38686.4 29846.0 31708.7 31848.7 31875.0 32187.2 24480.0 24495.0 24605.4 24788.8 24972.9 09:58:09 INFO - PROCESS | 2344 | 09:58:09 INFO - PROCESS | 2344 | [#2] jquery.html Cycles:180 Average:34243.34 Median:11468.90 stddev:101134.40 (881.8%) stddev-sans-first:101386.19 09:58:09 INFO - PROCESS | 2344 | Values: 407.6 409.1 410.3 412.3 421.8 13897.8 16263.8 17381.7 19992.4 21229.4 17761.6 17958.6 20532.7 20858.8 21012.6 5801.7 6059.6 6068.8 6076.9 6084.8 5668.9 5961.9 5996.7 6005.6 6007.2 5723.2 5964.8 5973.6 6041.1 6042.5 5693.6 5936.9 5996.9 6012.8 6155.3 5961.1 6024.4 6024.8 6028.3 6041.2 10352.8 13608.9 13710.6 13737.2 13803.8 2094.2 2145.6 2213.5 2302.8 2356.0 9904.8 10412.9 10820.1 11562.2 15192.7 1753.2 1763.9 1770.8 1820.6 1846.5 107939.0 108028.4 115063.0 115247.4 116180.0 11422.9 11782.6 11925.0 11991.6 12205.5 12812.4 15099.8 15116.2 15128.2 15159.5 7681.0 9097.4 9152.5 9184.3 9236.7 9198.6 9279.6 9310.0 9315.8 9332.3 3925.6 4049.0 4496.4 4646.2 4750.6 1924.4 1940.6 2025.8 2053.9 2079.0 907.9 941.2 1005.2 1011.9 1023.5 16752.6 18294.1 20313.3 20406.8 20527.4 903.9 910.0 965.2 997.3 1052.7 10187.6 10532.5 10655.0 10683.7 10733.2 592135.0 599687.0 603159.0 606219.0 642331.0 82356.0 104660.0 119234.4 128366.4 130740.3 992.1 1004.5 1013.0 1024.2 1024.8 16588.7 17917.5 18250.5 18284.6 18572.4 44026.6 50604.7 53250.2 55050.4 56153.4 70872.6 71522.0 76715.8 78206.2 80891.0 8335.6 8384.6 8427.6 8458.2 8635.2 12022.1 12688.0 12875.0 12931.4 12933.7 10840.2 11067.8 11128.6 11339.5 11434.7 10887.7 11131.2 11216.0 11348.7 11367.5 5849.2 10301.5 11353.8 11365.7 11381.2 8237.8 8251.1 8406.8 8546.2 8613.9 9708.3 11262.5 11289.3 11428.7 11435.5 09:58:09 INFO - PROCESS | 2344 | 09:58:09 INFO - PROCESS | 2344 | [#3] mootools.html Cycles:180 Average:6045.56 Median:501.15 stddev:3375.86 (673.6%) stddev-sans-first:3368.66 09:58:09 INFO - PROCESS | 2344 | Values: 1581.6 1592.2 1872.1 1990.9 2061.6 8465.0 9158.7 9320.6 9532.8 9537.6 9166.3 9181.9 9296.7 9307.2 9328.9 2533.6 2540.7 2570.7 2571.3 2586.2 2490.6 2573.7 2579.9 2580.4 2583.6 2554.8 2555.6 2556.3 2556.6 2596.9 2573.2 2580.8 2582.5 2591.2 2601.8 2547.8 2568.3 2581.2 2606.9 2612.4 9226.2 9341.3 9476.3 9479.0 9545.8 5365.1 5647.9 5817.7 5867.5 5978.2 3247.7 3672.7 3791.3 3814.4 3816.2 1038.5 1058.7 1067.9 1073.8 1081.5 10569.4 12664.0 12775.7 12801.5 12807.4 5058.0 5095.9 5117.1 5226.7 5247.2 10599.3 10798.6 10844.4 10858.8 10883.1 5716.1 5832.1 5850.9 5909.6 5924.3 4703.3 5169.3 5226.9 5239.7 5302.9 4324.8 4332.9 4340.5 4371.3 4446.1 1427.6 1440.1 1463.9 1467.2 1473.2 949.2 974.3 984.7 985.2 1008.5 5124.7 6197.4 6226.3 6282.0 6310.5 491.1 493.5 495.8 497.6 504.7 4119.8 4145.8 4155.9 4207.7 4219.9 11118.4 11266.2 11516.6 11539.9 11584.7 10571.8 11050.6 11339.4 11349.8 11401.1 8611.6 8640.9 8715.0 8767.3 8913.2 6012.5 6040.7 6141.1 6172.9 6262.0 10048.5 10052.6 10172.8 10302.1 10323.9 10176.3 10509.6 10714.7 10753.5 10899.3 7217.0 7741.8 7854.9 7900.2 7968.4 8542.3 8688.2 8706.4 8765.8 8787.7 7553.1 7735.7 7764.7 7767.4 7829.1 7530.7 7550.5 7559.0 7612.7 7741.0 7417.8 7466.6 7475.0 7478.3 7483.7 5043.7 5047.1 5167.5 5214.6 5256.0 5192.9 5224.9 5322.5 5398.5 5462.3 09:58:09 INFO - PROCESS | 2344 | 09:58:09 INFO - PROCESS | 2344 | [#4] prototype.html Cycles:180 Average:5936.20 Median:6761.13 stddev:1922.10 (28.4%) stddev-sans-first:1880.77 09:58:09 INFO - PROCESS | 2344 | Values: 324.5 331.3 344.2 345.1 347.9 5402.9 6657.3 6769.8 6817.5 6824.5 6797.5 6815.7 6834.0 6835.2 6889.6 4015.6 5019.7 5033.6 5044.6 5053.7 4196.3 5041.5 5049.4 5057.7 5084.7 4885.9 4996.8 5017.9 5018.0 5019.0 3979.6 4871.4 4927.4 4990.0 5015.7 3230.8 4146.7 4287.0 4288.8 4301.8 6538.9 6543.3 6550.5 6552.7 6558.4 5934.3 5950.9 5957.1 5987.8 6009.2 7295.5 7312.0 7314.3 7321.6 7383.8 4515.3 4715.1 4729.2 4813.3 4825.4 7674.3 7718.8 7779.9 7785.0 7795.8 4790.8 4794.1 4799.5 4815.1 4817.0 4886.2 4894.9 4900.7 4902.0 4907.5 5890.0 5892.9 5911.4 5912.9 5919.6 6251.2 7141.5 7341.3 7388.3 7401.2 1673.3 1675.8 1690.8 1695.3 1698.6 997.7 1051.3 1055.9 1072.3 1073.9 6752.5 6820.8 6828.6 6863.1 6929.7 7567.2 7673.6 7684.4 7698.0 7703.1 5681.3 6178.8 6896.6 6900.2 6926.5 3924.5 4027.4 4077.9 4078.6 4100.5 7409.7 8040.5 8040.9 8045.9 8057.7 6347.4 6422.6 7905.3 7950.7 7963.6 7075.4 7360.9 8033.3 8046.8 8047.1 6110.5 7383.0 7678.1 7692.0 7704.3 7503.4 7526.2 7547.8 7562.9 7569.4 8020.2 8026.9 8030.4 8031.8 8065.7 4972.5 5037.8 5054.2 5062.7 5068.7 7307.2 7523.9 7587.0 7605.1 7646.2 5884.9 7266.1 7291.7 7307.5 7320.7 5787.3 7228.9 7280.4 7286.4 7296.4 7121.9 7124.1 7139.3 7139.8 7145.1 5854.3 7301.5 7352.6 7404.3 7414.2 6909.6 7054.5 7160.4 7166.7 7182.1 09:58:09 INFO - PROCESS | 2344 | 09:58:09 INFO - PROCESS | 2344 | [#5] yui.html Cycles:180 Average:18495.20 Median:26502.79 stddev:25714.70 (97.0%) stddev-sans-first:25751.90 09:58:09 INFO - PROCESS | 2344 | Values: 644.2 716.8 747.4 750.3 785.1 15386.4 15713.0 15745.4 15748.0 15748.3 14387.8 14441.7 14483.5 14485.6 14489.3 754.9 938.5 973.0 976.8 978.2 968.0 977.4 978.5 984.6 984.6 1045.6 1046.0 1046.0 1047.4 1048.1 1003.5 1013.0 1035.1 1035.5 1036.6 756.0 763.9 770.3 779.0 780.0 15072.9 15082.8 15095.5 15138.2 15514.5 10200.9 13304.6 13367.7 13428.5 13478.7 10141.1 10336.7 10385.2 10589.0 10632.6 3140.7 3550.5 3604.6 3613.9 3662.0 80149.6 80270.6 80448.6 80611.6 80824.0 9329.3 9615.7 9695.6 9724.4 9892.2 22390.0 22533.9 22675.5 22928.8 23254.4 7519.2 7568.5 7613.3 7645.0 7697.3 3850.3 4206.4 4211.1 4219.3 4221.3 3821.5 3834.5 3892.3 3906.5 3922.6 713.4 739.2 769.1 771.6 776.2 511.5 551.8 599.9 606.0 611.6 8203.5 8462.6 8513.4 8612.7 8748.7 570.4 622.6 627.9 633.8 634.4 3951.1 3968.1 4030.9 4039.2 4221.7 88580.6 90372.0 91103.0 97244.0 97838.0 72865.6 72911.0 72957.0 73004.0 74843.0 71330.6 71558.0 72109.6 72508.3 73085.6 8656.9 8670.8 8738.6 8835.6 8877.7 48214.3 49087.5 49906.5 50022.5 52453.7 66920.0 71009.0 71836.6 72579.2 73622.0 10994.7 11075.0 11307.8 11348.9 11648.9 10084.9 12109.7 12329.3 12417.6 12683.9 11416.5 11476.3 11538.3 11621.5 11866.5 11548.8 11552.2 11797.8 11853.2 12059.9 10947.7 11064.5 11104.4 11490.1 11611.7 9691.2 9728.4 9800.6 9857.9 9881.3 8332.6 9533.9 9666.0 9763.6 9891.3 09:58:09 INFO - PROCESS | 2344 | -------- Summary: end -------- 09:58:09 INFO - PROCESS | 2344 | 09:58:10 INFO - TEST-INFO | 2344: exit 0 09:58:10 INFO - TEST-OK | dromaeo_css | took 1109943ms 09:58:10 INFO - TEST-START | kraken 09:58:10 INFO - operating with platform_type : mac_ 09:58:10 INFO - Initialising browser for kraken test... 09:58:10 INFO - TEST-INFO | started process 2350 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpBDGzQH/profile http://localhost:49498/getInfo.html) 09:58:12 INFO - PROCESS | 2350 | __metrics Screen width/height:1600/1200 09:58:12 INFO - PROCESS | 2350 | colorDepth:24 09:58:12 INFO - PROCESS | 2350 | Browser inner width/height: 1024/689 09:58:12 INFO - PROCESS | 2350 | __metrics 09:58:12 ERROR - PROCESS | 2350 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 09:58:13 INFO - TEST-INFO | 2350: exit 0 09:58:13 INFO - Browser initialized. 09:58:13 INFO - Running cycle 1/1 for kraken test... 09:58:13 INFO - TEST-INFO | started process 2354 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpBDGzQH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:25 INFO - PROCESS | 2354 | RSS: Main: 171294720 09:58:25 INFO - PROCESS | 2354 | 09:58:28 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49498/tests/kraken/driver.html?testName=audio-beat-detection) 09:58:28 INFO - PROCESS | 2354 | RSS: Main: 183873536 09:58:28 INFO - PROCESS | 2354 | 09:58:31 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49498/tests/kraken/driver.html?testName=audio-dft) 09:58:32 INFO - PROCESS | 2354 | RSS: Main: 192520192 09:58:32 INFO - PROCESS | 2354 | 09:58:35 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49498/tests/kraken/driver.html?testName=audio-fft) 09:58:36 INFO - PROCESS | 2354 | RSS: Main: 195936256 09:58:36 INFO - PROCESS | 2354 | 09:58:38 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49498/tests/kraken/driver.html?testName=audio-oscillator) 09:58:38 INFO - PROCESS | 2354 | RSS: Main: 196321280 09:58:38 INFO - PROCESS | 2354 | 09:58:40 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49498/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:58:41 INFO - PROCESS | 2354 | RSS: Main: 196562944 09:58:41 INFO - PROCESS | 2354 | 09:58:44 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49498/tests/kraken/driver.html?testName=imaging-darkroom) 09:58:44 INFO - PROCESS | 2354 | RSS: Main: 198295552 09:58:44 INFO - PROCESS | 2354 | 09:58:47 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49498/tests/kraken/driver.html?testName=imaging-desaturate) 09:58:48 INFO - PROCESS | 2354 | RSS: Main: 197971968 09:58:48 INFO - PROCESS | 2354 | 09:58:51 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49498/tests/kraken/driver.html?testName=json-parse-financial) 09:58:51 INFO - PROCESS | 2354 | RSS: Main: 198033408 09:58:51 INFO - PROCESS | 2354 | 09:58:53 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49498/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:58:54 INFO - PROCESS | 2354 | RSS: Main: 197738496 09:58:54 INFO - PROCESS | 2354 | 09:58:55 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:58:56 INFO - PROCESS | 2354 | RSS: Main: 197820416 09:58:56 INFO - PROCESS | 2354 | 09:58:58 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:58:59 INFO - PROCESS | 2354 | RSS: Main: 197791744 09:58:59 INFO - PROCESS | 2354 | 09:59:02 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:59:02 INFO - PROCESS | 2354 | RSS: Main: 197963776 09:59:02 INFO - PROCESS | 2354 | 09:59:05 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:59:06 INFO - PROCESS | 2354 | RSS: Main: 197869568 09:59:06 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | Cycle 1(1): loaded http://localhost:49498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49498/tests/kraken/driver.html?testName=ai-astar) 09:59:08 INFO - PROCESS | 2354 | RSS: Main: 199561216 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | __start_tp_report 09:59:08 INFO - PROCESS | 2354 | _x_x_mozilla_page_load 09:59:08 INFO - PROCESS | 2354 | _x_x_mozilla_page_load_details 09:59:08 INFO - PROCESS | 2354 | |i|pagename|runs| 09:59:08 INFO - PROCESS | 2354 | |0;ai-astar;112;119;109;116;121;117;107;117;117;115 09:59:08 INFO - PROCESS | 2354 | |1;audio-beat-detection;155;122;144;158;122;139;130;195;194;132 09:59:08 INFO - PROCESS | 2354 | |2;audio-dft;201;199;198;201;219;228;197;201;187;198 09:59:08 INFO - PROCESS | 2354 | |3;audio-fft;64;79;74;145;74;82;60;73;127;56 09:59:08 INFO - PROCESS | 2354 | |4;audio-oscillator;81;113;172;116;84;97;123;80;80;123 09:59:08 INFO - PROCESS | 2354 | |5;imaging-gaussian-blur;91;90;89;86;88;86;89;86;90;85 09:59:08 INFO - PROCESS | 2354 | |6;imaging-darkroom;93;95;94;94;95;94;95;124;128;97 09:59:08 INFO - PROCESS | 2354 | |7;imaging-desaturate;92;91;89;105;97;91;91;127;143;90 09:59:08 INFO - PROCESS | 2354 | |8;json-parse-financial;60;67;64;64;65;68;89;95;51;61 09:59:08 INFO - PROCESS | 2354 | |9;json-stringify-tinderbox;61;65;72;63;74;72;70;67;65;68 09:59:08 INFO - PROCESS | 2354 | |10;stanford-crypto-aes;82;97;79;81;80;79;79;83;92;110 09:59:08 INFO - PROCESS | 2354 | |11;stanford-crypto-ccm;129;123;128;136;140;112;143;114;173;164 09:59:08 INFO - PROCESS | 2354 | |12;stanford-crypto-pbkdf2;203;153;193;176;149;193;219;177;194;212 09:59:08 INFO - PROCESS | 2354 | |13;stanford-crypto-sha256-iterative;69;66;69;69;69;65;70;66;69;65 09:59:08 INFO - PROCESS | 2354 | __end_tp_report 09:59:08 INFO - PROCESS | 2354 | __start_cc_report 09:59:08 INFO - PROCESS | 2354 | _x_x_mozilla_cycle_collect,1058 09:59:08 INFO - PROCESS | 2354 | __end_cc_report 09:59:08 INFO - PROCESS | 2354 | __startTimestamp1469120348337__endTimestamp 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | ------- Summary: start ------- 09:59:08 INFO - PROCESS | 2354 | Number of tests: 14 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#0] ai-astar Cycles:10 Average:115.00 Median:117.00 stddev:4.40 (3.8%) stddev-sans-first:4.53 09:59:08 INFO - PROCESS | 2354 | Values: 112.0 119.0 109.0 116.0 121.0 117.0 107.0 117.0 117.0 115.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:149.50 stddev:26.86 (18.0%) stddev-sans-first:28.40 09:59:08 INFO - PROCESS | 2354 | Values: 155.0 122.0 144.0 158.0 122.0 139.0 130.0 195.0 194.0 132.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#2] audio-dft Cycles:10 Average:202.90 Median:201.00 stddev:11.79 (5.9%) stddev-sans-first:12.48 09:59:08 INFO - PROCESS | 2354 | Values: 201.0 199.0 198.0 201.0 219.0 228.0 197.0 201.0 187.0 198.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#3] audio-fft Cycles:10 Average:83.40 Median:73.50 stddev:29.21 (39.7%) stddev-sans-first:30.12 09:59:08 INFO - PROCESS | 2354 | Values: 64.0 79.0 74.0 145.0 74.0 82.0 60.0 73.0 127.0 56.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#4] audio-oscillator Cycles:10 Average:106.90 Median:80.00 stddev:29.09 (36.4%) stddev-sans-first:29.31 09:59:08 INFO - PROCESS | 2354 | Values: 81.0 113.0 172.0 116.0 84.0 97.0 123.0 80.0 80.0 123.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:89.00 stddev:2.11 (2.4%) stddev-sans-first:1.94 09:59:08 INFO - PROCESS | 2354 | Values: 91.0 90.0 89.0 86.0 88.0 86.0 89.0 86.0 90.0 85.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:94.50 stddev:13.30 (14.1%) stddev-sans-first:13.80 09:59:08 INFO - PROCESS | 2354 | Values: 93.0 95.0 94.0 94.0 95.0 94.0 95.0 124.0 128.0 97.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#7] imaging-desaturate Cycles:10 Average:101.60 Median:91.00 stddev:18.60 (20.4%) stddev-sans-first:19.40 09:59:08 INFO - PROCESS | 2354 | Values: 92.0 91.0 89.0 105.0 97.0 91.0 91.0 127.0 143.0 90.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:66.00 stddev:13.38 (20.3%) stddev-sans-first:13.85 09:59:08 INFO - PROCESS | 2354 | Values: 60.0 67.0 64.0 64.0 65.0 68.0 89.0 95.0 51.0 61.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:69.00 stddev:4.27 (6.2%) stddev-sans-first:3.78 09:59:08 INFO - PROCESS | 2354 | Values: 61.0 65.0 72.0 63.0 74.0 72.0 70.0 67.0 65.0 68.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:81.50 stddev:10.36 (12.7%) stddev-sans-first:10.87 09:59:08 INFO - PROCESS | 2354 | Values: 82.0 97.0 79.0 81.0 80.0 79.0 79.0 83.0 92.0 110.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:138.00 stddev:19.89 (14.4%) stddev-sans-first:20.92 09:59:08 INFO - PROCESS | 2354 | Values: 129.0 123.0 128.0 136.0 140.0 112.0 143.0 114.0 173.0 164.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.90 Median:193.50 stddev:23.21 (12.0%) stddev-sans-first:23.87 09:59:08 INFO - PROCESS | 2354 | Values: 203.0 153.0 193.0 176.0 149.0 193.0 219.0 177.0 194.0 212.0 09:59:08 INFO - PROCESS | 2354 | 09:59:08 INFO - PROCESS | 2354 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:69.00 stddev:1.95 (2.8%) stddev-sans-first:2.01 09:59:08 INFO - PROCESS | 2354 | Values: 69.0 66.0 69.0 69.0 69.0 65.0 70.0 66.0 69.0 65.0 09:59:08 INFO - PROCESS | 2354 | -------- Summary: end -------- 09:59:08 INFO - PROCESS | 2354 | 09:59:09 INFO - TEST-INFO | 2354: exit 0 09:59:09 INFO - TEST-OK | kraken | took 59031ms 09:59:09 INFO - SUITE-END | took 1168s 09:59:09 INFO - Completed test suite (00:19:29) 09:59:09 INFO - javascript benchmark 09:59:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3590.066582688501, 3620.999999999999, 3626.818659067046, 3655.3968595181796, 3682.116292089899, 5856.912146317809, 5993.670348130857, 6018.0972854071915, 6033.818985430438, 6058.242719660043, 5930.110483427488, 5988.850278743033, 5999.640021598696, 6021.488173505258, 6047.758089676418, 5352.598555108353, 5394.7842086316505, 5398.595105367093, 5404.729763511808, 5413.26920865682, 5383.542398896079, 5441.374241962166, 5514.145307477327, 5556.749946252428, 5570.693611851347, 5473.0969390050595, 5491.450854914517, 5525.364583072937, 5527.806526771564, 5528.226048353234, 4698.73134253753, 5380.327459067597, 5407.351117865842, 5418.91871621926, 5464.426235245322, 5237.0, 5285.048691235576, 5374.48942350476, 5391.676499410048, 5426.701531415771, 5700.429957004308, 5783.768649254025, 5848.239728835224, 5872.530197584183, 5895.439933206381, 6264.7807326743805, 6292.2134733158355, 6311.495080393557, 6317.589356691847, 6344.429001389851, 6250.406211409909, 6313.0, 6329.145565348665, 6390.009548519987, 6414.647194404306, 6054.334023257438, 6079.969600152015, 6099.054646529795, 6101.206843110367, 6106.023036314213, 6301.747930082745, 6477.805665830033, 6478.676066196671, 6479.44924681398, 6513.348665133449, 6179.84550386235, 6205.348438413902, 6258.499320054385, 6265.248170219603, 6285.308616052231, 6324.71538780756, 6343.904841427382, 6358.459530939829, 6376.202974628171, 6396.488280937607, 6185.659788711574, 6209.844753881099, 6279.309275979638, 6283.246010478681, 6296.65368404733, 6211.844703882439, 6279.717412716439, 6280.246370435577, 6295.370462953668, 6308.211473565804, 5081.364829396325, 5092.974535127375, 5114.0, 5123.231515272739, 5149.073166829931, 4449.7775111244955, 4537.818487260539, 4541.909161816745, 4599.103174880866, 4643.8374656886845, 6043.54673399488, 6110.175126357974, 6114.449699526975, 6144.078388241799, 6170.691465426711, 6394.136791533177, 6421.165248517663, 6432.421082102634, 6447.1618689571, 6461.19235095613, 5953.1070339449425, 6106.755729770759, 6178.073289006685, 6191.25704915413, 6199.380061993765, 5625.887482250332, 5636.436356364413, 5636.943630563724, 5650.3219613646625, 5655.236543066633, 6600.669966501751, 6619.106420633249, 6634.734610615521, 6638.4357329626555, 6645.335466453316, 6254.8123556293385, 6308.936910630835, 6363.5545511813725, 6379.457746091634, 6389.840253993501, 6587.308332625005, 6612.90080648781, 6621.304763000008, 6636.734530618721, 6649.102371179829, 6308.33762454954, 6320.841978950563, 6332.651704156316, 6333.588316759396, 6342.143810585512, 6207.6585787782105, 6353.142325786144, 6360.268569114611, 6362.840928976812, 6410.455111315404, 6244.843878903063, 6269.7178626962805, 6278.591891527036, 6278.686065696788, 6292.811215663537, 6194.473469754941, 6254.530910181846, 6267.811965641038, 6275.0, 6294.622322660655, 5720.913026524947, 5893.351731309638, 6097.115918191748, 6209.223847019122, 6242.531810114168, 6237.7193026314835, 6265.655388953652, 6268.780592679234, 6279.215098112736, 6282.246130464374, 6081.756729730761, 6201.658908760061, 6247.5939063960695, 6265.780697675559, 6272.40412160844], "value": 5902.581674609215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.4045531963778, 568.7412227436516, 575.3326141675657, 590.2710152961093, 591.7366771786554, 36110.819445902765, 38863.028424289405, 39426.620068297576, 39471.0, 39514.80242598783, 39451.42194312231, 39550.81347559578, 40070.0, 40572.98567535813, 40591.79704101483, 8206.630701618427, 9603.423794572349, 9709.174720148796, 9793.412395256271, 9803.705888823346, 9530.80938381232, 9717.659881904136, 9773.26700497462, 9784.02159784023, 9799.804003919917, 8289.461185022985, 9646.951765241163, 9719.416834989888, 9788.168005719523, 9830.557624906896, 9657.420554766737, 9767.120959113643, 9767.902320976771, 9820.459874706889, 9823.263255255848, 9658.275629327829, 9727.756806079833, 9760.658376956844, 9779.608815647365, 9808.117269445784, 32968.175795605064, 38709.80645096757, 38805.22389552221, 39057.82826515209, 39469.210615787524, 3311.2549676322874, 3319.96680033199, 3329.783564068328, 3382.30662714143, 3460.2041530447887, 26453.3386665333, 26725.866370668216, 26867.865660671767, 26969.46061078787, 27237.727622723916, 2700.0954680181967, 2716.456708658276, 2772.7365900239447, 2815.0, 2836.9858150709115, 326559.0, 328246.0, 330657.0, 331046.344768277, 331460.0, 33212.0, 33795.0, 59922.0, 60350.0, 60370.09444858331, 31863.52204716931, 32507.34985300328, 32694.855680051085, 32911.34177316488, 32944.1763955903, 16173.191340432932, 16374.099424531527, 16580.83419165817, 16596.83403165977, 16614.75077873833, 13640.454381824617, 13654.795178072336, 14007.929960350337, 14087.0, 14178.71642567143, 8034.196580341919, 8161.469504482189, 8298.626561804733, 8309.127541608164, 8359.038710548242, 3525.8060806655367, 3547.077759782475, 3568.5717713873983, 3586.8923932282073, 3590.8563657453933, 867.9088695686988, 915.7893684452613, 936.2865955301781, 1073.6403304892792, 1117.0002847451485, 24286.14998475045, 30124.397512049636, 30326.086956522093, 30546.0, 30573.847130764203, 1095.3920574081462, 1139.794836929344, 1149.431031639344, 1194.4445832687843, 1224.4367590908105, 12595.24428534291, 15273.0, 15334.309956052004, 15340.0, 15410.306536205673, 595933.0, 602658.0, 608358.0, 609825.0, 611024.0, 60783.39216607866, 61067.69466152641, 61372.38627613756, 61379.0, 61451.0, 1538.2846976155918, 1558.5869744517486, 1564.6635973265802, 1579.2182869479682, 1583.6515966487354, 29790.25524361908, 29800.254993624465, 30034.549481757353, 30174.698253017188, 30444.391112178077, 45179.64461066173, 49101.754491227315, 50942.74528627333, 51265.7436712829, 51511.48488515217, 447243.0, 533116.0, 533147.0, 536858.0, 537207.0, 22907.427314317276, 25691.871540642176, 26041.95832166692, 27022.594661079707, 27447.45105097847, 46193.76903115597, 46576.0, 47489.7625511884, 47718.0, 47749.76125119352, 37676.623233767314, 38666.226675466896, 38867.80566097151, 39125.60874391333, 39453.40819887647, 37917.81041094777, 38199.42700859545, 38238.42642360422, 38670.0, 38978.6102138975, 31167.844160779958, 36822.44766328454, 38071.619283807915, 38222.426663599515, 38686.41970370503, 29846.0, 31708.682913170574, 31848.681513184572, 31875.0, 32187.195320117185, 24480.0, 24495.0, 24605.38486537851, 24788.752112478644, 24972.87622057048], "value": 18305.744215017112, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.59851546226963, 409.1101853468705, 410.27995867252974, 412.2990915443746, 421.7827818673382, 13897.79153312701, 16263.75604365934, 17381.739273910902, 19992.400607951346, 21229.36311910643, 17761.64476710468, 17958.5510362241, 20532.692009619866, 20858.791412085873, 21012.579748405024, 5801.709914504279, 6059.6364218147055, 6068.848278793022, 6076.908846367308, 6084.817455476343, 5668.914966275509, 5961.910571341434, 5996.700164991755, 6005.6396616203165, 6007.15899774032, 5723.170140329649, 5964.761409543635, 5973.551983601225, 6041.124037014631, 6042.486388656969, 5693.633527953303, 5936.910946335808, 5996.880062398771, 6012.819615411545, 6155.292141403706, 5961.135635332853, 6024.367441418632, 6024.789132380346, 6028.306744724369, 6041.154238406627, 10352.844707329396, 13608.931955340258, 13710.588682339545, 13737.175769453765, 13803.792943105862, 2094.1623350659706, 2145.6340452472587, 2213.524092320159, 2302.7927486526128, 2355.9882200588886, 9904.752381190456, 10412.895871041268, 10820.08029317509, 11562.248453850472, 15192.696146077127, 1753.158483927709, 1763.938262160818, 1770.7697999260142, 1820.599468117012, 1846.492214640971, 107939.0, 108028.37957430567, 115063.0, 115247.42376288064, 116180.0, 11422.914823091793, 11782.646520604396, 11925.045996320274, 11991.64025079249, 12205.511779528897, 12812.359382030862, 15099.773503397459, 15116.244187790566, 15128.167950762594, 15159.545213643609, 7680.961595191989, 9097.40866843653, 9152.496612686366, 9184.311176661777, 9236.72289831306, 9198.632054717737, 9279.582418791035, 9310.0, 9315.767105822273, 9332.34673572857, 3925.6270654287796, 4048.959510404858, 4496.4154659894, 4646.210144275481, 4750.643701722384, 1924.3553409607657, 1940.553672655297, 2025.7670367907585, 2053.856230063881, 2079.0, 907.9228265597366, 941.2187884056217, 1005.2008653120787, 1011.9071402884866, 1023.5036007536339, 16752.581185470463, 18294.08529573516, 20313.289034883706, 20406.795932040488, 20527.38417847437, 903.9231665308391, 910.0035461170008, 965.1892410375178, 997.3417544420647, 1052.7473406382567, 10187.643432479828, 10532.473376331152, 10655.0, 10683.732906677395, 10733.195010374253, 592135.0, 599687.0, 603159.0, 606219.0, 642331.0, 82356.0, 104660.0, 119234.4038279803, 128366.35816820856, 130740.3462982679, 992.1120597065586, 1004.467632154959, 1012.9848052279369, 1024.2267088348249, 1024.8155332040155, 16588.66822663564, 17917.462476125736, 18250.543736406165, 18284.634307314045, 18572.44282671522, 44026.55973440353, 50604.74697626488, 53250.2012469821, 55050.44949550613, 56153.43846561482, 70872.64563677149, 71522.0, 76715.84926226223, 78206.21793781989, 80891.0, 8335.624896879533, 8384.580770961305, 8427.578621069044, 8458.154184581492, 8635.222829945084, 12022.098342624164, 12687.984961203267, 12875.0, 12931.418086186331, 12933.676658083623, 10840.186985976241, 11067.83398249043, 11128.610498632834, 11339.546418143513, 11434.656960291204, 10887.673369798918, 11131.165162612675, 11216.0, 11348.659540213806, 11367.54529818798, 5849.181114643869, 10301.536430860479, 11353.772924541297, 11365.715857103638, 11381.203315767816, 8237.79405514843, 8251.133630968661, 8406.789830254293, 8546.2308392245, 8613.923259592551, 9708.32170341745, 11262.549498020315, 11289.322640641587, 11428.657140285804, 11435.485403156712], "value": 9404.129454069336, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1581.6283173454235, 1592.2277695317773, 1872.1388161445734, 1990.8506861985354, 2061.5773766377874, 8464.95767521163, 9158.725238242863, 9320.627174913005, 9532.809343813129, 9537.57080931358, 9166.312526560518, 9181.944076431213, 9296.674616388427, 9307.162355388014, 9328.906710932888, 2533.6199570064455, 2540.6570113034736, 2570.717221105677, 2571.2671888511777, 2586.172424824057, 2490.6139548369943, 2573.691157061146, 2579.935501612456, 2580.419405633736, 2583.599542070982, 2554.846709197445, 2555.6038813983864, 2556.2586849813533, 2556.6165075238678, 2596.9220923372327, 2573.1765834932735, 2580.8193426460157, 2582.5222333868296, 2591.2485379239997, 2601.752833480816, 2547.7707006369515, 2568.345072006645, 2581.174024312221, 2606.8696565171854, 2612.4383257599707, 9226.16964473194, 9341.346105772598, 9476.336656434052, 9479.0, 9545.809083818285, 5365.087935051011, 5647.887042259173, 5817.680027598481, 5867.530597552186, 5978.163057172, 3247.65899580543, 3672.6510981456718, 3791.2607041626893, 3814.370628846237, 3816.160444702161, 1038.5274700011553, 1058.6929790360787, 1067.9466026698713, 1073.8174510333183, 1081.4754843900703, 10569.41868197249, 12664.0, 12775.74448511034, 12801.48794048237, 12807.359632018455, 5057.963117560891, 5095.923561146586, 5117.130087885069, 5226.738663066832, 5247.239150323182, 10599.311044782064, 10798.622048228275, 10844.403557804397, 10858.837117443245, 10883.074938630147, 5716.114002329646, 5832.066869300977, 5850.912236316459, 5909.645421274738, 5924.348321684612, 4703.270992996091, 5169.25045868347, 5226.92159617606, 5239.685618862804, 5302.867428314245, 4324.789059063467, 4332.935005974913, 4340.47914250292, 4371.30059190528, 4446.066326071496, 1427.5503216486773, 1440.0855456784807, 1463.8609332113433, 1467.1710483576744, 1473.1750219876903, 949.2486362660879, 974.3423189347304, 984.6849008317413, 985.2413641496008, 1008.4655132779639, 5124.69251844883, 6197.411245931629, 6226.25284965807, 6281.968590157111, 6310.52671049664, 491.12579608296573, 493.4769144706622, 495.8091134913012, 497.5845169283689, 504.71231398103464, 4119.814608342632, 4145.79271036447, 4155.854545090907, 4207.663386929038, 4219.915601688011, 11118.388488633203, 11266.155038371991, 11516.596919107791, 11539.884601154048, 11584.652460426201, 10571.841422378671, 11050.613228536962, 11339.433028348549, 11349.829752553718, 11401.144914131473, 8611.61247743853, 8640.870386944202, 8714.956425217833, 8767.298616110696, 8913.197812196933, 6012.488938440281, 6040.6677632730625, 6141.1402403664415, 6172.938270617416, 6261.96869015652, 10048.497575121068, 10052.597896084075, 10172.79654406893, 10302.124319432933, 10323.896761032294, 10176.287659863738, 10509.632162874263, 10714.678559643224, 10753.46232688378, 10899.346039237671, 7217.025701530226, 7741.845163096819, 7854.921450785419, 7900.170482099296, 7968.402369822403, 8542.316614670935, 8688.174623410765, 8706.390552661253, 8765.824683506422, 8787.736367908972, 7553.131389890233, 7735.729249476241, 7764.650590723318, 7767.417443691633, 7829.099653539688, 7530.6611202497115, 7550.5469671819865, 7558.962205188939, 7612.657430415756, 7741.0, 7417.8145546361775, 7466.626668666437, 7475.02824632816, 7478.326950574475, 7483.663235154322, 5043.672161309503, 5047.1419858623385, 5167.457416971164, 5214.608904332114, 5255.973720131375, 5192.922106168486, 5224.921626175535, 5322.54758345545, 5398.541124004347, 5462.317210348707], "value": 4805.308496035564, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.50188959946485, 331.2893842707393, 344.17226570098916, 345.12166536165455, 347.9182392137849, 5402.864928376787, 6657.33426657334, 6769.796906092813, 6817.488688348375, 6824.488163387741, 6797.456203503721, 6815.693293801778, 6834.0, 6835.1797784265955, 6889.5521791083665, 4015.638592526672, 5019.6988180709095, 5033.5721463675445, 5044.596432285409, 5053.69677819332, 4196.349565817303, 5041.521055499722, 5049.419316778581, 5057.671251368668, 5084.669496482736, 4885.902281954359, 4996.825111121111, 5017.899642007158, 5017.974910125463, 5018.971110922253, 3979.5622481527007, 4871.366722326093, 4927.359443272388, 4989.950100498985, 5015.673981191211, 3230.8384580771103, 4146.714518499275, 4287.035417031143, 4288.849890253826, 4301.763403012833, 6538.869222615569, 6543.312952140004, 6550.475961923034, 6552.7378904843745, 6558.376954189344, 5934.317553481362, 5950.940490595125, 5957.076653118774, 5987.790427335022, 6009.2188015557695, 7295.4893157479, 7312.049433573601, 7314.305141011595, 7321.633918304116, 7383.778486645409, 4515.345274935149, 4715.08055929094, 4729.219678753002, 4813.278008298748, 4825.445073816486, 7674.309312161877, 7718.845623087507, 7779.922200777976, 7785.026871640988, 7795.805104872366, 4790.760461976887, 4794.113089078462, 4799.496052914464, 4815.085133824562, 4817.0365926814775, 4886.21820508724, 4894.853154405374, 4900.730459824673, 4901.975490122527, 4907.509249075064, 5889.998700220887, 5892.882142357129, 5911.408859114054, 5912.940870591325, 5919.644821310649, 6251.187345645037, 7141.464390170758, 7341.339279464767, 7388.298111679382, 7401.222871598405, 1673.2972151696317, 1675.8491735743842, 1690.8079803738335, 1695.2710334556014, 1698.6008288052299, 997.7428440165444, 1051.2746205118444, 1055.9155267578576, 1072.2922870905165, 1073.9087177589993, 6752.459803215731, 6820.795376138723, 6828.556143850634, 6863.142107236596, 6929.653517324114, 7567.205443428471, 7673.616319184019, 7684.423668224906, 7697.961510192413, 7703.114141873644, 5681.289838770153, 6178.845528861814, 6896.586204827727, 6900.171979362408, 6926.549774264657, 3924.4898163238595, 4027.395890616431, 4077.8776636700945, 4078.6336577246952, 4100.487439070116, 7409.740659077014, 8040.477368970998, 8040.8793868092025, 8045.919540804634, 8057.677692892219, 6347.39699728525, 6422.550421470452, 7905.328047115944, 7950.681972721142, 7963.641636126388, 7075.363217310467, 7360.926390736238, 8033.277005069572, 8046.758597242092, 8047.114817370085, 6110.541709371726, 7383.012190326302, 7678.1170165431695, 7691.961540192263, 7704.30661240491, 7503.4372422069655, 7526.209747976603, 7547.773566793005, 7562.886556701544, 7569.432292578189, 8020.15788342239, 8026.919730802617, 8030.357571394391, 8031.759047228593, 8065.709486482135, 4972.5276098770555, 5037.848864534069, 5054.16606259963, 5062.746862656779, 5068.746562671926, 7307.159676637255, 7523.930918997319, 7587.0, 7605.125410577854, 7646.235376462309, 5884.852878678067, 7266.055412796302, 7291.671874765754, 7307.525010874276, 7320.670569824264, 5787.334456537552, 7228.9277107230355, 7280.417566594766, 7286.380657644159, 7296.379807716404, 7121.893171602534, 7124.145102587722, 7139.286071392819, 7139.82150446243, 7145.1068616422945, 5854.302252346772, 7301.452391070585, 7352.558846469229, 7404.296591823768, 7414.184439711736, 6909.550879193038, 7054.541454805421, 7160.427165826825, 7166.677499512431, 7182.102237220348], "value": 5294.042428139333, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.2301449767524, 716.7670507085197, 747.3908764357049, 750.2759836757527, 785.0579304834197, 15386.384544618215, 15713.0, 15745.448909288178, 15747.976381535193, 15748.291326890274, 14387.784183237234, 14441.711165776678, 14483.493077742281, 14485.565433037, 14489.347979340928, 754.852803703278, 938.5401153434802, 972.9951350243274, 976.7948730766548, 978.2076518020391, 968.0222974795472, 977.4379731654292, 978.4911845840159, 984.5569493727816, 984.6356847966263, 1045.6078970386104, 1045.9529321180528, 1046.016744260393, 1047.4239168457357, 1048.0619845238507, 1003.4932359158614, 1013.0224333518154, 1035.063267742694, 1035.4822588705647, 1036.5646428499972, 755.9886601700979, 763.9465237433382, 770.2797883978442, 779.0067663728735, 779.9883001754978, 15072.924635376863, 15082.773758393632, 15095.4716584919, 15138.167400792952, 15514.534563962987, 10200.897991020069, 13304.600861974157, 13367.732645347136, 13428.530001449903, 13478.663033424145, 10141.13800326973, 10336.741581460448, 10385.2211084169, 10589.04698577124, 10632.627858024933, 3140.654528001918, 3550.467429885512, 3604.6395360464007, 3613.8915832525067, 3662.029562166028, 80149.59925200394, 80270.59864700698, 80448.59775701142, 80611.5969420155, 80824.0, 9329.34694571387, 9615.711528654152, 9695.563699633392, 9724.416535007922, 9892.208623310118, 22390.0, 22533.88733056324, 22675.546489070126, 22928.770712292997, 23254.418639534146, 7519.172890981988, 7568.508046976929, 7613.314801667876, 7645.0, 7697.268759467842, 3850.345441274934, 4206.41110244566, 4211.136716973013, 4219.346001369792, 4221.345691417835, 3821.464994900716, 3834.5206849143856, 3892.2993861104706, 3906.4921560196995, 3922.6273504017645, 713.4470785141453, 739.1721272175091, 769.1078349114999, 771.5717776634021, 776.1927595300824, 511.4629638879162, 551.8399664097448, 599.9209329907079, 606.0485038489617, 611.5688439650036, 8203.548804815673, 8462.61918213682, 8513.361497887683, 8612.65549378018, 8748.650053997897, 570.3791079987451, 622.6015350175891, 627.9294695335186, 633.7971849008273, 634.352959980817, 3951.124814434137, 3968.0873399118364, 4030.858919937788, 4039.171969746195, 4221.6833737469815, 88580.5570972141, 90372.0, 91103.0, 97244.0, 97838.0, 72865.6356718213, 72911.0, 72957.0, 73004.0, 74843.0, 71330.64334678293, 71557.99999999895, 72109.55780884458, 72508.27491725121, 73085.6345718268, 8656.91343086561, 8670.82658346817, 8738.606762695821, 8835.558222089, 8877.689280875138, 48214.27678584754, 49087.509124909724, 49906.50093499019, 50022.49977500179, 52453.7377313111, 66919.99620005606, 71009.0, 71836.64081679558, 72579.18552036241, 73622.0, 10994.670159895217, 11075.0, 11307.773844523228, 11348.886511134782, 11648.883511165119, 10084.949575252076, 12109.69725756863, 12329.321887296284, 12417.62747117588, 12683.936580317039, 11416.486258118572, 11476.263962010218, 11538.307701537935, 11621.477033533341, 11866.525338986345, 11548.82676759866, 11552.191346605658, 11797.823032654345, 11853.229540079867, 12059.879401205875, 10947.726306842393, 11064.502097405797, 11104.389258590532, 11490.08079353633, 11611.6516504505, 9691.176250018827, 9728.416295022322, 9800.607975680892, 9857.901420985698, 9881.258905581966, 8332.583370831555, 9533.904660953302, 9666.0, 9763.56063977137, 9891.258155638212], "value": 7129.096595419105, "unit": "score"}], "name": "dromaeo_css", "value": 7543.746657276731, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 119.0, 109.0, 116.0, 121.0, 117.0, 107.0, 117.0, 117.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 144.0, 158.0, 122.0, 139.0, 130.0, 195.0, 194.0, 132.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 199.0, 198.0, 201.0, 219.0, 228.0, 197.0, 201.0, 187.0, 198.0], "value": 202.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 79.0, 74.0, 145.0, 74.0, 82.0, 60.0, 73.0, 127.0, 56.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 113.0, 172.0, 116.0, 84.0, 97.0, 123.0, 80.0, 80.0, 123.0], "value": 106.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 89.0, 86.0, 88.0, 86.0, 89.0, 86.0, 90.0, 85.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 124.0, 128.0, 97.0], "value": 100.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 89.0, 105.0, 97.0, 91.0, 91.0, 127.0, 143.0, 90.0], "value": 101.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 67.0, 64.0, 64.0, 65.0, 68.0, 89.0, 95.0, 51.0, 61.0], "value": 68.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 72.0, 63.0, 74.0, 72.0, 70.0, 67.0, 65.0, 68.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 97.0, 79.0, 81.0, 80.0, 79.0, 79.0, 83.0, 92.0, 110.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 123.0, 128.0, 136.0, 140.0, 112.0, 143.0, 114.0, 173.0, 164.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 153.0, 193.0, 176.0, 149.0, 193.0, 219.0, 177.0, 194.0, 212.0], "value": 186.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 69.0, 69.0, 69.0, 65.0, 70.0, 66.0, 69.0, 65.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1560.9, "alertThreshold": 2.0}]} 09:59:09 INFO - Return code: 0 09:59:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:59:09 ERROR - # TBPL SUCCESS # 09:59:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:59:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:59:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:59:09 INFO - 2016-07-21 09:59:09.667 screenresolution[2359:283129] starting screenresolution argv=screenresolution get 09:59:09 INFO - 2016-07-21 09:59:09.669 screenresolution[2359:283129] Display 0: 1600x1200x32@60 09:59:09 INFO - 2016-07-21 09:59:09.675 screenresolution[2360:283132] starting screenresolution argv=screenresolution list 09:59:09 INFO - Available Modes on Display 0 09:59:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:59:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:59:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:59:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:59:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:59:09 INFO - Intel Iris: 09:59:09 INFO - Chipset Model: Intel Iris 09:59:09 INFO - Type: GPU 09:59:09 INFO - Bus: Built-In 09:59:09 INFO - VRAM (Dynamic, Max): 1536 MB 09:59:09 INFO - Vendor: Intel (0x8086) 09:59:09 INFO - Device ID: 0x0a2e 09:59:09 INFO - Revision ID: 0x0009 09:59:09 INFO - Displays: 09:59:09 INFO - Display: 09:59:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:59:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:59:09 INFO - Display Serial Number: 1600x1200 60 09:59:09 INFO - Main Display: Yes 09:59:09 INFO - Mirror: Off 09:59:09 INFO - Online: Yes 09:59:09 INFO - Rotation: Supported 09:59:09 INFO - Return code: 0 09:59:09 INFO - Running post-action listener: _resource_record_post_action 09:59:09 INFO - Running post-run listener: _resource_record_post_run 09:59:10 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 6726656; Write bytes: 494715904; Read time: 59; Write time: 1872 09:59:10 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194679296; Write bytes: 196642816; Read time: 17625; Write time: 401 09:59:10 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 6702080; Write bytes: 297225216; Read time: 58; Write time: 1469 09:59:10 INFO - Running post-run listener: _upload_blobber_files 09:59:10 INFO - Blob upload gear active. 09:59:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:59:10 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 09:59:10 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'] 09:59:10 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 09:59:11 INFO - (blobuploader) - INFO - Open directory for files ... 09:59:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:59:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:59:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:12 INFO - (blobuploader) - INFO - Done attempting. 09:59:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:59:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:59:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:13 INFO - (blobuploader) - INFO - Done attempting. 09:59:13 INFO - (blobuploader) - INFO - Iteration through files over. 09:59:13 INFO - Return code: 0 09:59:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:59:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:59:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/44105068114b9f6cc0a6b82afaf5969f1f8ea1a99840daeb604f81a5a48e61e881aff55d7d0e6a70b9a6811d8eabbf51916874877239d0e31adaf93aa34a6d62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2dfc50a1b245988e82087dd0b6e435d9f25ec9751fc9bb725fc42b22dbc2752bc711f74c5a1ed961000ccac83c341abfacf3e8b57843168949bf793f86fc6e9"} 09:59:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:59:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:59:13 INFO - Contents: 09:59:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/44105068114b9f6cc0a6b82afaf5969f1f8ea1a99840daeb604f81a5a48e61e881aff55d7d0e6a70b9a6811d8eabbf51916874877239d0e31adaf93aa34a6d62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2dfc50a1b245988e82087dd0b6e435d9f25ec9751fc9bb725fc42b22dbc2752bc711f74c5a1ed961000ccac83c341abfacf3e8b57843168949bf793f86fc6e9"} 09:59:13 INFO - Running post-run listener: copy_logs_to_upload_dir 09:59:13 INFO - Copying logs to upload dir... 09:59:13 INFO - mkdir: /builds/slave/test/build/upload/logs 09:59:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.255354 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-21 09:59:13.740361) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 09:59:13.743477) ========= 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.cVCujKu1lK/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.X3rR32QB89/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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/44105068114b9f6cc0a6b82afaf5969f1f8ea1a99840daeb604f81a5a48e61e881aff55d7d0e6a70b9a6811d8eabbf51916874877239d0e31adaf93aa34a6d62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2dfc50a1b245988e82087dd0b6e435d9f25ec9751fc9bb725fc42b22dbc2752bc711f74c5a1ed961000ccac83c341abfacf3e8b57843168949bf793f86fc6e9"} build_url:https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011452 build_url: 'https://queue.taskcluster.net/v1/task/b0mJpSlqS2-zMNUyZf96eg/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/44105068114b9f6cc0a6b82afaf5969f1f8ea1a99840daeb604f81a5a48e61e881aff55d7d0e6a70b9a6811d8eabbf51916874877239d0e31adaf93aa34a6d62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2dfc50a1b245988e82087dd0b6e435d9f25ec9751fc9bb725fc42b22dbc2752bc711f74c5a1ed961000ccac83c341abfacf3e8b57843168949bf793f86fc6e9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 09:59:13.776238) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:59:13.776556) ========= 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.cVCujKu1lK/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.X3rR32QB89/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.004680 ========= master_lag: 0.31 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 09:59:14.089856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 09:59:14.090178) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 09:59:14.091056) ========= ========= Total master_lag: 0.56 =========