builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0353 starttime: 1464027099.58 results: success (0) buildid: 20160522193137 builduid: c858fb39af334cefa248ec2a3b22030a revision: 2e8129bd6590404ff56ea35ac30d719cf7f566ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:39.578360) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:39.578714) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:39.578983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:39.669962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:39.670214) ========= 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.dEEFdSOKmv/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.1anX425t7e/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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-05-23 11:11:39-- 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% 19.8M=0.001s 2016-05-23 11:11:40 (19.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.463660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:40.155044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:40.155344) ========= 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.dEEFdSOKmv/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.1anX425t7e/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.025630 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:40.204061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:11:40.204389) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2e8129bd6590404ff56ea35ac30d719cf7f566ae --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 2e8129bd6590404ff56ea35ac30d719cf7f566ae --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dEEFdSOKmv/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.1anX425t7e/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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-05-23 11:11:40,264 truncating revision to first 12 chars 2016-05-23 11:11:40,264 Setting DEBUG logging. 2016-05-23 11:11:40,264 attempt 1/10 2016-05-23 11:11:40,264 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2e8129bd6590?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 11:11:41,092 unpacking tar archive at: mozilla-beta-2e8129bd6590/testing/mozharness/ program finished with exit code 0 elapsedTime=1.079362 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:11:41.300429) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:41.300756) ========= script_repo_revision: 2e8129bd6590404ff56ea35ac30d719cf7f566ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:41.301198) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:41.301481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:41.315026) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-23 11:11:41.315325) ========= /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.dEEFdSOKmv/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.1anX425t7e/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 11:11:41 INFO - MultiFileLogger online at 20160523 11:11:41 in /builds/slave/test 11:11:41 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 11:11:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:41 INFO - {'append_to_log': False, 11:11:41 INFO - 'base_work_dir': '/builds/slave/test', 11:11:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:11:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:41 INFO - 'branch': 'Mozilla-Beta', 11:11:41 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:41 INFO - 'config_files': ('talos/mac_config.py',), 11:11:41 INFO - 'default_actions': ('clobber', 11:11:41 INFO - 'read-buildbot-config', 11:11:41 INFO - 'download-and-extract', 11:11:41 INFO - 'populate-webroot', 11:11:41 INFO - 'create-virtualenv', 11:11:41 INFO - 'install', 11:11:41 INFO - 'run-tests'), 11:11:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:41 INFO - 'download_minidump_stackwalk': True, 11:11:41 INFO - 'download_symbols': 'ondemand', 11:11:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:41 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:41 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:41 INFO - 'installer_path': 'installer.exe', 11:11:41 INFO - 'log_level': 'info', 11:11:41 INFO - 'log_name': 'talos', 11:11:41 INFO - 'log_to_console': True, 11:11:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:11:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:11:41 INFO - 'opt_config_files': (), 11:11:41 INFO - 'pip_index': False, 11:11:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:41 INFO - 'cmd': ('bash', 11:11:41 INFO - '-c', 11:11:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:41 INFO - 'enabled': True, 11:11:41 INFO - 'halt_on_failure': False, 11:11:41 INFO - 'name': 'check_screen_resolution'},), 11:11:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:41 INFO - 'cmd': ('bash', 11:11:41 INFO - '-c', 11:11:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:41 INFO - 'enabled': True, 11:11:41 INFO - 'halt_on_failure': False, 11:11:41 INFO - 'name': 'check_screen_resolution'},), 11:11:41 INFO - 'run_cmd_checks_enabled': True, 11:11:41 INFO - 'sps_profile': False, 11:11:41 INFO - 'sps_profile_interval': 0, 11:11:41 INFO - 'suite': 'dromaeojs-e10s', 11:11:41 INFO - 'system_bits': '32', 11:11:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:41 INFO - 'title': 't-yosemite-r7-0353', 11:11:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:41 INFO - 'use_talos_json': True, 11:11:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:41 INFO - 'work_dir': 'build'} 11:11:41 INFO - ##### 11:11:41 INFO - ##### Running clobber step. 11:11:41 INFO - ##### 11:11:41 INFO - Running pre-action listener: _resource_record_pre_action 11:11:41 INFO - Running main action method: clobber 11:11:41 INFO - rmtree: /builds/slave/test/build 11:11:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:43 INFO - Running post-action listener: _resource_record_post_action 11:11:43 INFO - ##### 11:11:43 INFO - ##### Running read-buildbot-config step. 11:11:43 INFO - ##### 11:11:43 INFO - Running pre-action listener: _resource_record_pre_action 11:11:43 INFO - Running main action method: read_buildbot_config 11:11:43 INFO - Using buildbot properties: 11:11:43 INFO - { 11:11:43 INFO - "project": "", 11:11:43 INFO - "product": "firefox", 11:11:43 INFO - "script_repo_revision": "production", 11:11:43 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:11:43 INFO - "repository": "", 11:11:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:11:43 INFO - "buildid": "20160522193137", 11:11:43 INFO - "pgo_build": "False", 11:11:43 INFO - "basedir": "/builds/slave/test", 11:11:43 INFO - "buildnumber": 88, 11:11:43 INFO - "slavename": "t-yosemite-r7-0353", 11:11:43 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:11:43 INFO - "platform": "yosemite_r7", 11:11:43 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:11:43 INFO - "branch": "mozilla-beta", 11:11:43 INFO - "repo_path": "releases/mozilla-beta", 11:11:43 INFO - "revision": "2e8129bd6590404ff56ea35ac30d719cf7f566ae", 11:11:43 INFO - "stage_platform": "macosx64", 11:11:43 INFO - "builduid": "c858fb39af334cefa248ec2a3b22030a", 11:11:43 INFO - "slavebuilddir": "test" 11:11:43 INFO - } 11:11:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 11:11:43 INFO - Running post-action listener: _resource_record_post_action 11:11:43 INFO - ##### 11:11:43 INFO - ##### Running download-and-extract step. 11:11:43 INFO - ##### 11:11:43 INFO - Running pre-action listener: _resource_record_pre_action 11:11:43 INFO - Running main action method: download_and_extract 11:11:43 INFO - mkdir: /builds/slave/test/build/tests 11:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:43 INFO - https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 11:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 11:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 11:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 11:11:48 INFO - Downloaded 1241 bytes. 11:11:48 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 11:11:48 INFO - Using the following test package requirements: 11:11:48 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 11:11:48 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:11:48 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 11:11:48 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:11:48 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 11:11:48 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:11:48 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:11:48 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 11:11:48 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 11:11:48 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:11:48 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 11:11:48 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:11:48 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 11:11:48 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:11:48 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 11:11:48 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 11:11:48 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:11:48 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 11:11:48 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 11:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:48 INFO - https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:11:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 11:11:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 11:11:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 11:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 11:11:49 INFO - Downloaded 17747767 bytes. 11:11:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:11:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:11:52 INFO - Return code: 0 11:11:52 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:52 INFO - https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:11:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 11:11:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 11:11:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 11:11:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 11:11:56 INFO - Downloaded 17747767 bytes. 11:11:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:11:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:12:00 INFO - Return code: 0 11:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:00 INFO - https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:12:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 11:12:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 11:12:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 11:12:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 11:12:01 INFO - Downloaded 10845194 bytes. 11:12:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:12:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:12:01 INFO - Return code: 0 11:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:01 INFO - https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 11:12:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg 11:12:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg 11:12:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 11:12:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 11:12:04 INFO - Downloaded 88423479 bytes. 11:12:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg 11:12:04 INFO - mkdir: /builds/slave/test/properties 11:12:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:04 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:04 INFO - Contents: 11:12:04 INFO - build_url:https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg 11:12:05 INFO - Running post-action listener: _resource_record_post_action 11:12:05 INFO - Running post-action listener: set_extra_try_arguments 11:12:05 INFO - ##### 11:12:05 INFO - ##### Running populate-webroot step. 11:12:05 INFO - ##### 11:12:05 INFO - Running pre-action listener: _resource_record_pre_action 11:12:05 INFO - Running main action method: populate_webroot 11:12:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:05 INFO - '--tppagecycles', 11:12:05 INFO - '7'], 11:12:05 INFO - 'tests': ['tsvgm']}}, 11:12:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:12:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:12:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:12:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:12:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:05 INFO - 'talos_options': ['--e10s'], 11:12:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:05 INFO - 'tests': ['damp', 'tps']}, 11:12:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:05 INFO - 'talos_options': ['--e10s'], 11:12:05 INFO - 'tests': ['damp', 'tps']}, 11:12:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:12:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:05 INFO - 'other': {'tests': ['a11yr', 11:12:05 INFO - 'ts_paint', 11:12:05 INFO - 'tpaint', 11:12:05 INFO - 'sessionrestore', 11:12:05 INFO - 'sessionrestore_no_auto_restore', 11:12:05 INFO - 'tabpaint']}, 11:12:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:12:05 INFO - 'tests': ['a11yr', 11:12:05 INFO - 'ts_paint', 11:12:05 INFO - 'tpaint', 11:12:05 INFO - 'sessionrestore', 11:12:05 INFO - 'sessionrestore_no_auto_restore', 11:12:05 INFO - 'tabpaint']}, 11:12:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:12:05 INFO - 'tests': ['a11yr', 11:12:05 INFO - 'ts_paint', 11:12:05 INFO - 'tpaint', 11:12:05 INFO - 'sessionrestore', 11:12:05 INFO - 'sessionrestore_no_auto_restore', 11:12:05 INFO - 'tabpaint']}, 11:12:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:12:05 INFO - 'tests': ['a11yr', 11:12:05 INFO - 'ts_paint', 11:12:05 INFO - 'tpaint', 11:12:05 INFO - 'sessionrestore', 11:12:05 INFO - 'sessionrestore_no_auto_restore', 11:12:05 INFO - 'tabpaint']}, 11:12:05 INFO - 'other_l64': {'tests': ['a11yr', 11:12:05 INFO - 'ts_paint', 11:12:05 INFO - 'tpaint', 11:12:05 INFO - 'sessionrestore', 11:12:05 INFO - 'sessionrestore_no_auto_restore', 11:12:05 INFO - 'tabpaint']}, 11:12:05 INFO - 'other_nol64': {'tests': ['a11yr', 11:12:05 INFO - 'ts_paint', 11:12:05 INFO - 'tpaint', 11:12:05 INFO - 'sessionrestore', 11:12:05 INFO - 'sessionrestore_no_auto_restore', 11:12:05 INFO - 'tabpaint']}, 11:12:05 INFO - 'svgr': {'tests': ['tsvgx', 11:12:05 INFO - 'tsvgr_opacity', 11:12:05 INFO - 'tart', 11:12:05 INFO - 'tscrollx', 11:12:05 INFO - 'cart']}, 11:12:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:12:05 INFO - 'tests': ['tsvgx', 11:12:05 INFO - 'tsvgr_opacity', 11:12:05 INFO - 'tart', 11:12:05 INFO - 'tscrollx', 11:12:05 INFO - 'cart']}, 11:12:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:05 INFO - 'tests': ['tp5o']}, 11:12:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:05 INFO - 'talos_options': ['--e10s'], 11:12:05 INFO - 'tests': ['tp5o']}, 11:12:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:05 INFO - 'talos_options': ['--xperf_path', 11:12:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:05 INFO - 'tests': ['tp5n']}, 11:12:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:05 INFO - 'talos_options': ['--e10s', 11:12:05 INFO - '--xperf_path', 11:12:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:05 INFO - 'tests': ['tp5n']}}, 11:12:05 INFO - 'talos.zip': {'path': '', 11:12:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:05 INFO - Running post-action listener: _resource_record_post_action 11:12:05 INFO - ##### 11:12:05 INFO - ##### Running create-virtualenv step. 11:12:05 INFO - ##### 11:12:05 INFO - Running pre-action listener: _resource_record_pre_action 11:12:05 INFO - Running main action method: create_virtualenv 11:12:05 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:05 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 11:12:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:12:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:05 INFO - Using real prefix '/tools/python27' 11:12:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:06 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:08 INFO - Installing pip.................done. 11:12:08 INFO - Return code: 0 11:12:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109960a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab0bd81240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109804d30>, '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 0x109668db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097fbb20>, '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.dEEFdSOKmv/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.1anX425t7e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 11:12: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', 'pip>=1.5'] in /builds/slave/test/build 11:12: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 pip>=1.5 11:12:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dEEFdSOKmv/Render', 11:12:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:08 INFO - 'HOME': '/Users/cltbld', 11:12:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:08 INFO - 'LOGNAME': 'cltbld', 11:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:08 INFO - 'MOZ_NO_REMOTE': '1', 11:12:08 INFO - 'NO_EM_RESTART': '1', 11:12:08 INFO - 'PAGER': '/bin/cat', 11:12:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:08 INFO - 'PWD': '/builds/slave/test', 11:12:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:08 INFO - 'SHELL': '/bin/bash', 11:12:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1anX425t7e/Listeners', 11:12:08 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 11:12:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:08 INFO - 'USER': 'cltbld', 11:12:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:08 INFO - 'XPC_FLAGS': '0x0', 11:12:08 INFO - 'XPC_SERVICE_NAME': '0', 11:12:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:09 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 11:12:09 INFO - Cleaning up... 11:12:09 INFO - Return code: 0 11:12:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:12:09 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')]} 11:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:09 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')]} 11:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:09 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 0x109960a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab0bd81240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109804d30>, '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 0x109668db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097fbb20>, '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.dEEFdSOKmv/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.1anX425t7e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 11:12:09 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 11:12:09 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 11:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dEEFdSOKmv/Render', 11:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:09 INFO - 'HOME': '/Users/cltbld', 11:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:09 INFO - 'LOGNAME': 'cltbld', 11:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:09 INFO - 'MOZ_NO_REMOTE': '1', 11:12:09 INFO - 'NO_EM_RESTART': '1', 11:12:09 INFO - 'PAGER': '/bin/cat', 11:12:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:09 INFO - 'PWD': '/builds/slave/test', 11:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:09 INFO - 'SHELL': '/bin/bash', 11:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1anX425t7e/Listeners', 11:12:09 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 11:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:09 INFO - 'USER': 'cltbld', 11:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:09 INFO - 'XPC_FLAGS': '0x0', 11:12:09 INFO - 'XPC_SERVICE_NAME': '0', 11:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:09 INFO - Downloading/unpacking psutil>=0.7.1 11:12:09 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 11:12:09 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 11:12:09 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 11:12:09 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 11:12:09 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 11:12:09 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 11:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:12 INFO - Installing collected packages: psutil 11:12:12 INFO - Running setup.py install for psutil 11:12:13 INFO - building 'psutil._psutil_osx' extension 11:12:13 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 11:12:13 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 11:12:13 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 11:12:13 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 11:12:13 INFO - building 'psutil._psutil_posix' extension 11:12:13 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 11:12:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:12:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:12:13 INFO - ^ 11:12:13 INFO - 1 warning generated. 11:12:13 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 11:12:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:14 INFO - Successfully installed psutil 11:12:14 INFO - Cleaning up... 11:12:14 INFO - Return code: 0 11:12:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:12:14 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')]} 11:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:14 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')]} 11:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:14 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 0x109960a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab0bd81240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109804d30>, '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 0x109668db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097fbb20>, '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.dEEFdSOKmv/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.1anX425t7e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 11:12:14 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 11:12:14 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 11:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dEEFdSOKmv/Render', 11:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:14 INFO - 'HOME': '/Users/cltbld', 11:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:14 INFO - 'LOGNAME': 'cltbld', 11:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:14 INFO - 'MOZ_NO_REMOTE': '1', 11:12:14 INFO - 'NO_EM_RESTART': '1', 11:12:14 INFO - 'PAGER': '/bin/cat', 11:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:14 INFO - 'PWD': '/builds/slave/test', 11:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:14 INFO - 'SHELL': '/bin/bash', 11:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1anX425t7e/Listeners', 11:12:14 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 11:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:14 INFO - 'USER': 'cltbld', 11:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:14 INFO - 'XPC_FLAGS': '0x0', 11:12:14 INFO - 'XPC_SERVICE_NAME': '0', 11:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:12:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:12:16 INFO - Installing collected packages: mozsystemmonitor 11:12:16 INFO - Running setup.py install for mozsystemmonitor 11:12:17 INFO - Successfully installed mozsystemmonitor 11:12:17 INFO - Cleaning up... 11:12:17 INFO - Return code: 0 11:12:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:17 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 0x109960a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab0bd81240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109804d30>, '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 0x109668db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097fbb20>, '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.dEEFdSOKmv/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.1anX425t7e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 11:12:17 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 11:12:17 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 11:12:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dEEFdSOKmv/Render', 11:12:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:17 INFO - 'HOME': '/Users/cltbld', 11:12:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:17 INFO - 'LOGNAME': 'cltbld', 11:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:17 INFO - 'MOZ_NO_REMOTE': '1', 11:12:17 INFO - 'NO_EM_RESTART': '1', 11:12:17 INFO - 'PAGER': '/bin/cat', 11:12:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:17 INFO - 'PWD': '/builds/slave/test', 11:12:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:17 INFO - 'SHELL': '/bin/bash', 11:12:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1anX425t7e/Listeners', 11:12:17 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 11:12:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:17 INFO - 'USER': 'cltbld', 11:12:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:17 INFO - 'XPC_FLAGS': '0x0', 11:12:17 INFO - 'XPC_SERVICE_NAME': '0', 11:12:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:17 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:17 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 11:12:17 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 11:12:17 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 11:12:17 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 11:12:17 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 11:12:17 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 11:12:19 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:20 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 11:12:20 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 11:12:20 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 11:12:20 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 11:12:20 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 11:12:20 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 11:12:20 INFO - Downloading docopt-0.6.1.tar.gz 11:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:21 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:21 INFO - Running setup.py install for blobuploader 11:12:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:21 INFO - Running setup.py install for requests 11:12:21 INFO - Running setup.py install for docopt 11:12:21 INFO - Successfully installed blobuploader requests docopt 11:12:21 INFO - Cleaning up... 11:12:21 INFO - Return code: 0 11:12:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:21 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 0x109960a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab0bd81240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109804d30>, '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 0x109668db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097fbb20>, '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.dEEFdSOKmv/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.1anX425t7e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 11:12:21 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 11:12:21 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 11:12:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dEEFdSOKmv/Render', 11:12:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:21 INFO - 'HOME': '/Users/cltbld', 11:12:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:21 INFO - 'LOGNAME': 'cltbld', 11:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:21 INFO - 'MOZ_NO_REMOTE': '1', 11:12:21 INFO - 'NO_EM_RESTART': '1', 11:12:21 INFO - 'PAGER': '/bin/cat', 11:12:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:21 INFO - 'PWD': '/builds/slave/test', 11:12:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:21 INFO - 'SHELL': '/bin/bash', 11:12:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1anX425t7e/Listeners', 11:12:21 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 11:12:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:21 INFO - 'USER': 'cltbld', 11:12:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:21 INFO - 'XPC_FLAGS': '0x0', 11:12:21 INFO - 'XPC_SERVICE_NAME': '0', 11:12:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-MuBDAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-HBR5Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-bHPAkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-H57ds9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-bvRT2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-KeO20g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-H2QTFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:22 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-spnMPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:23 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-pN1GSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:23 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-lax38t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:23 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-dp28fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:23 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-QzUXUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:23 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-GvZlZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:23 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-FJnZIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:23 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-_hVlTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:23 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-mhR8PS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:23 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-U9mRdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:24 INFO - Running setup.py install for manifestparser 11:12:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Running setup.py install for mozcrash 11:12:24 INFO - Running setup.py install for mozdebug 11:12:24 INFO - Running setup.py install for mozdevice 11:12:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Running setup.py install for mozfile 11:12:24 INFO - Running setup.py install for mozhttpd 11:12:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:24 INFO - Running setup.py install for mozinfo 11:12:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:25 INFO - Running setup.py install for mozInstall 11:12:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:25 INFO - Running setup.py install for mozleak 11:12:25 INFO - Running setup.py install for mozlog 11:12:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:25 INFO - Running setup.py install for moznetwork 11:12:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:25 INFO - Running setup.py install for mozprocess 11:12:25 INFO - Running setup.py install for mozprofile 11:12:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:25 INFO - Running setup.py install for mozrunner 11:12:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:12:26 INFO - Running setup.py install for mozscreenshot 11:12:26 INFO - Running setup.py install for moztest 11:12:26 INFO - Running setup.py install for mozversion 11:12:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:12:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:26 INFO - Cleaning up... 11:12:26 INFO - Return code: 0 11:12:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:26 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 0x109960a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab0bd81240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109804d30>, '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 0x109668db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097fbb20>, '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.dEEFdSOKmv/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.1anX425t7e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 11:12:26 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 11:12:26 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 11:12:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dEEFdSOKmv/Render', 11:12:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:26 INFO - 'HOME': '/Users/cltbld', 11:12:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:26 INFO - 'LOGNAME': 'cltbld', 11:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:26 INFO - 'MOZ_NO_REMOTE': '1', 11:12:26 INFO - 'NO_EM_RESTART': '1', 11:12:26 INFO - 'PAGER': '/bin/cat', 11:12:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:26 INFO - 'PWD': '/builds/slave/test', 11:12:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:26 INFO - 'SHELL': '/bin/bash', 11:12:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1anX425t7e/Listeners', 11:12:26 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 11:12:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:26 INFO - 'USER': 'cltbld', 11:12:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:26 INFO - 'XPC_FLAGS': '0x0', 11:12:26 INFO - 'XPC_SERVICE_NAME': '0', 11:12:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:26 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-mHrlYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:26 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)) 11:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:26 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-exKc_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:27 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)) 11:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-nA3y6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:27 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)) 11:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-qIiLf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:27 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)) 11:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-eWqNQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:27 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)) 11:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-wFS1Yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:27 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)) 11:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-dRt2gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:27 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)) 11:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-MuxonC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:27 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)) 11:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Ka6X6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:27 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)) 11:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-AV4B10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:27 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)) 11:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-U2Lxgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:28 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)) 11:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:28 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-1uYDo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:28 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)) 11:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:28 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-3uyYCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:28 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)) 11:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:28 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-C9leNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:28 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)) 11:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:28 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-oeVsrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:28 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)) 11:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:28 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-vgT1AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:28 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)) 11:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:28 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-JTbtsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:28 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)) 11:12:28 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)) 11:12:28 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)) 11:12:28 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)) 11:12:28 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)) 11:12:28 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)) 11:12:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:28 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 11:12:28 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 11:12:28 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 11:12:28 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 11:12:28 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 11:12:28 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 11:12:31 INFO - Downloading blessings-1.6.tar.gz 11:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:31 INFO - Installing collected packages: blessings 11:12:31 INFO - Running setup.py install for blessings 11:12:31 INFO - Successfully installed blessings 11:12:31 INFO - Cleaning up... 11:12:31 INFO - Return code: 0 11:12:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:31 INFO - Reading from file tmpfile_stdout 11:12:31 INFO - Current package versions: 11:12:31 INFO - blessings == 1.6 11:12:31 INFO - blobuploader == 1.2.4 11:12:31 INFO - docopt == 0.6.1 11:12:31 INFO - manifestparser == 1.1 11:12:31 INFO - mozInstall == 1.12 11:12:31 INFO - mozcrash == 0.17 11:12:31 INFO - mozdebug == 0.1 11:12:31 INFO - mozdevice == 0.48 11:12:31 INFO - mozfile == 1.2 11:12:31 INFO - mozhttpd == 0.7 11:12:31 INFO - mozinfo == 0.9 11:12:31 INFO - mozleak == 0.1 11:12:31 INFO - mozlog == 3.1 11:12:31 INFO - moznetwork == 0.27 11:12:31 INFO - mozprocess == 0.22 11:12:31 INFO - mozprofile == 0.28 11:12:31 INFO - mozrunner == 6.11 11:12:31 INFO - mozscreenshot == 0.1 11:12:31 INFO - mozsystemmonitor == 0.0 11:12:31 INFO - moztest == 0.7 11:12:31 INFO - mozversion == 1.4 11:12:31 INFO - psutil == 3.1.1 11:12:31 INFO - requests == 1.2.3 11:12:31 INFO - wsgiref == 0.1.2 11:12:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:31 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 0x109960a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab0bd81240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109804d30>, '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 0x109668db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097fbb20>, '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.dEEFdSOKmv/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.1anX425t7e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 11:12:31 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 11:12:31 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 11:12:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dEEFdSOKmv/Render', 11:12:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:31 INFO - 'HOME': '/Users/cltbld', 11:12:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:31 INFO - 'LOGNAME': 'cltbld', 11:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:31 INFO - 'MOZ_NO_REMOTE': '1', 11:12:31 INFO - 'NO_EM_RESTART': '1', 11:12:31 INFO - 'PAGER': '/bin/cat', 11:12:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:31 INFO - 'PWD': '/builds/slave/test', 11:12:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:31 INFO - 'SHELL': '/bin/bash', 11:12:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1anX425t7e/Listeners', 11:12:31 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 11:12:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:31 INFO - 'USER': 'cltbld', 11:12:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:31 INFO - 'XPC_FLAGS': '0x0', 11:12:31 INFO - 'XPC_SERVICE_NAME': '0', 11:12:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:32 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)) 11:12:32 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)) 11:12:32 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)) 11:12:32 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)) 11:12:32 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)) 11:12:32 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)) 11:12:32 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)) 11:12:32 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)) 11:12:32 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)) 11:12:32 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)) 11:12:32 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)) 11:12:32 INFO - Cleaning up... 11:12:32 INFO - Return code: 0 11:12:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109960a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab0bd81240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109804d30>, '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 0x109668db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097fbb20>, '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.dEEFdSOKmv/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.1anX425t7e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 11:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:12:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dEEFdSOKmv/Render', 11:12:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:32 INFO - 'HOME': '/Users/cltbld', 11:12:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:32 INFO - 'LOGNAME': 'cltbld', 11:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:32 INFO - 'MOZ_NO_REMOTE': '1', 11:12:32 INFO - 'NO_EM_RESTART': '1', 11:12:32 INFO - 'PAGER': '/bin/cat', 11:12:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:32 INFO - 'PWD': '/builds/slave/test', 11:12:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:32 INFO - 'SHELL': '/bin/bash', 11:12:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1anX425t7e/Listeners', 11:12:32 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 11:12:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:32 INFO - 'USER': 'cltbld', 11:12:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:32 INFO - 'XPC_FLAGS': '0x0', 11:12:32 INFO - 'XPC_SERVICE_NAME': '0', 11:12:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:32 INFO - Downloading/unpacking jsonschema 11:12:32 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 11:12:32 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 11:12:32 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 11:12:32 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 11:12:32 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 11:12:32 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 11:12:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:34 INFO - Downloading/unpacking functools32 (from jsonschema) 11:12:34 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 11:12:34 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 11:12:34 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 11:12:34 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 11:12:34 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 11:12:34 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 11:12:35 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:35 INFO - warning: no files found matching '*.txt' 11:12:35 INFO - no previously-included directories found matching 'build' 11:12:35 INFO - no previously-included directories found matching 'dist' 11:12:35 INFO - no previously-included directories found matching '.git*' 11:12:35 INFO - Installing collected packages: jsonschema, functools32 11:12:35 INFO - Running setup.py install for functools32 11:12:35 INFO - warning: no files found matching '*.txt' 11:12:35 INFO - no previously-included directories found matching 'build' 11:12:35 INFO - no previously-included directories found matching 'dist' 11:12:35 INFO - no previously-included directories found matching '.git*' 11:12:35 INFO - Successfully installed jsonschema functools32 11:12:35 INFO - Cleaning up... 11:12:35 INFO - Return code: 0 11:12:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109960a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab0bd81240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109804d30>, '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 0x109668db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097fbb20>, '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.dEEFdSOKmv/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.1anX425t7e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 11:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:12:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dEEFdSOKmv/Render', 11:12:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:35 INFO - 'HOME': '/Users/cltbld', 11:12:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:35 INFO - 'LOGNAME': 'cltbld', 11:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:35 INFO - 'MOZ_NO_REMOTE': '1', 11:12:35 INFO - 'NO_EM_RESTART': '1', 11:12:35 INFO - 'PAGER': '/bin/cat', 11:12:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:35 INFO - 'PWD': '/builds/slave/test', 11:12:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:35 INFO - 'SHELL': '/bin/bash', 11:12:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1anX425t7e/Listeners', 11:12:35 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 11:12:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:35 INFO - 'USER': 'cltbld', 11:12:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:35 INFO - 'XPC_FLAGS': '0x0', 11:12:35 INFO - 'XPC_SERVICE_NAME': '0', 11:12:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:35 INFO - Downloading/unpacking flake8 11:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:12:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:12:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:12:39 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 11:12:39 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 11:12:39 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 11:12:39 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 11:12:39 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 11:12:39 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 11:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:12:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:39 INFO - no previously-included directories found matching 'docs/_build' 11:12:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:12:39 INFO - Running setup.py install for pep8 11:12:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:39 INFO - no previously-included directories found matching 'docs/_build' 11:12:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:12:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:12:39 INFO - Cleaning up... 11:12:40 INFO - Return code: 0 11:12:40 INFO - Running post-action listener: _resource_record_post_action 11:12:40 INFO - Running post-action listener: _start_resource_monitoring 11:12:40 INFO - Starting resource monitoring. 11:12:40 INFO - ##### 11:12:40 INFO - ##### Running install step. 11:12:40 INFO - ##### 11:12:40 INFO - Running pre-action listener: _resource_record_pre_action 11:12:40 INFO - Running main action method: install 11:12:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:40 INFO - Reading from file tmpfile_stdout 11:12:40 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:12:40 INFO - Reading from file tmpfile_stdout 11:12:40 INFO - Output received: 11:12:40 INFO - Usage: mozinstall [options] installer 11:12:40 INFO - Options: 11:12:40 INFO - -h, --help show this help message and exit 11:12:40 INFO - -d DEST, --destination=DEST 11:12:40 INFO - Directory to install application into. [default: 11:12:40 INFO - "/builds/slave/test"] 11:12:40 INFO - --app=APP Application being installed. [default: firefox] 11:12:40 INFO - mkdir: /builds/slave/test/build/application 11:12:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:13:02 INFO - Reading from file tmpfile_stdout 11:13:02 INFO - Output received: 11:13:02 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:13:02 INFO - Running post-action listener: _resource_record_post_action 11:13:02 INFO - ##### 11:13:02 INFO - ##### Running run-tests step. 11:13:02 INFO - ##### 11:13:02 INFO - Running pre-action listener: _resource_record_pre_action 11:13:02 INFO - Running main action method: run_tests 11:13:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:13:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:13:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:13:02 INFO - 2016-05-23 11:13:02.920 screenresolution[1652:9247] starting screenresolution argv=screenresolution get 11:13:02 INFO - 2016-05-23 11:13:02.923 screenresolution[1652:9247] Display 0: 1600x1200x32@60 11:13:02 INFO - 2016-05-23 11:13:02.929 screenresolution[1653:9249] starting screenresolution argv=screenresolution list 11:13:02 INFO - Available Modes on Display 0 11:13:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:13:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:13:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:13:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:13:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:13:03 INFO - Intel Iris: 11:13:03 INFO - Chipset Model: Intel Iris 11:13:03 INFO - Type: GPU 11:13:03 INFO - Bus: Built-In 11:13:03 INFO - VRAM (Dynamic, Max): 1536 MB 11:13:03 INFO - Vendor: Intel (0x8086) 11:13:03 INFO - Device ID: 0x0a2e 11:13:03 INFO - Revision ID: 0x0009 11:13:03 INFO - Displays: 11:13:03 INFO - Display: 11:13:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:13:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:13:03 INFO - Display Serial Number: 1600x1200 60 11:13:03 INFO - Main Display: Yes 11:13:03 INFO - Mirror: Off 11:13:03 INFO - Online: Yes 11:13:03 INFO - Rotation: Supported 11:13:03 INFO - Return code: 0 11:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:03 INFO - Python 2.7.3 11:13:03 INFO - Return code: 0 11:13:03 INFO - grabbing minidump binary from tooltool 11:13:03 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')]} 11:13:03 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 0x109804d30>, '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 0x109668db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097fbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:03 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 11:13:03 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 11:13:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:03 INFO - Return code: 0 11:13:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:13:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:13:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:13:04 INFO - Return code: 0 11:13:04 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/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 11:13:04 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/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0353 --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 11:13:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dEEFdSOKmv/Render', 11:13:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:04 INFO - 'HOME': '/Users/cltbld', 11:13:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:04 INFO - 'LOGNAME': 'cltbld', 11:13:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:04 INFO - 'MOZ_NO_REMOTE': '1', 11:13:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:04 INFO - 'NO_EM_RESTART': '1', 11:13:04 INFO - 'PAGER': '/bin/cat', 11:13:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:04 INFO - 'PWD': '/builds/slave/test', 11:13:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:04 INFO - 'SHELL': '/bin/bash', 11:13:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1anX425t7e/Listeners', 11:13:04 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 11:13:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:04 INFO - 'USER': 'cltbld', 11:13:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:04 INFO - 'XPC_FLAGS': '0x0', 11:13:04 INFO - 'XPC_SERVICE_NAME': '0', 11:13:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:04 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/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 11:13:04 INFO - mozversion application_buildid: 20160522193137 11:13:04 INFO - mozversion application_changeset: 2e8129bd6590404ff56ea35ac30d719cf7f566ae 11:13:04 INFO - mozversion application_display_name: Firefox 11:13:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:04 INFO - mozversion application_name: Firefox 11:13:04 INFO - mozversion application_remotingname: firefox 11:13:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:13:04 INFO - mozversion application_vendor: Mozilla 11:13:04 INFO - mozversion application_version: 47.0 11:13:04 INFO - mozversion platform_buildid: 20160522193137 11:13:04 INFO - mozversion platform_changeset: 2e8129bd6590404ff56ea35ac30d719cf7f566ae 11:13:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:13:04 INFO - mozversion platform_version: 47.0 11:13:04 INFO - using testdate: 1464027184 11:13:04 INFO - actual date: 1464027184 11:13:04 INFO - starting webserver on 'localhost:49278' 11:13:04 INFO - SUITE-START | Running 2 tests 11:13:04 INFO - TEST-START | dromaeo_css 11:13:04 INFO - operating with platform_type : mac_ 11:13:04 INFO - Initialising browser for dromaeo_css test... 11:13:04 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpnzaLCk/profile http://localhost:49278/getInfo.html) 11:13:07 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 11:13:07 INFO - PROCESS | 1671 | colorDepth:24 11:13:07 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 11:13:07 INFO - PROCESS | 1671 | __metrics 11:13:07 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:13:08 INFO - TEST-INFO | 1671: exit 0 11:13:08 INFO - Browser initialized. 11:13:08 INFO - Running cycle 1/1 for dromaeo_css test... 11:13:08 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpnzaLCk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:20 INFO - PROCESS | 1676 | RSS: Main: 167964672 11:13:20 INFO - PROCESS | 1676 | 11:14:09 INFO - PROCESS | 1676 | 1464027249761 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] 11:16:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 11:16:20 INFO - PROCESS | 1676 | RSS: Main: 178331648 11:16:20 INFO - PROCESS | 1676 | 11:19:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 11:19:23 INFO - PROCESS | 1676 | RSS: Main: 189677568 11:19:23 INFO - PROCESS | 1676 | 11:22:24 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 11:22:25 INFO - PROCESS | 1676 | RSS: Main: 191770624 11:22:25 INFO - PROCESS | 1676 | 11:25:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 11:25:27 INFO - PROCESS | 1676 | RSS: Main: 195239936 11:25:27 INFO - PROCESS | 1676 | 11:28:30 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 11:28:30 INFO - PROCESS | 1676 | RSS: Main: 194486272 11:28:30 INFO - PROCESS | 1676 | 11:31:33 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 11:31:33 INFO - PROCESS | 1676 | RSS: Main: 200073216 11:31:33 INFO - PROCESS | 1676 | 11:31:33 INFO - PROCESS | 1676 | __start_tp_report 11:31:33 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 11:31:33 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 11:31:33 INFO - PROCESS | 1676 | |i|pagename|runs| 11:31:33 INFO - PROCESS | 1676 | |0;dojo.html;3138.1840721412427;3675.375186218341;3677.9080522986937;3717.702583793296;3723.7207209459298;4988.72787439203;5423.457654234579;5884.205632239647;5891.587588868781;5893.145493903381;5837.387074357184;5877.706114694259;5881.206037184978;5886.735096920638;5888.5877988540815;5284.0752868248;5344.198370244475;5385.165299378603;5393.6763794172275;5421.430749771276;5270.104082305998;5379.139337705968;5390.946090539103;5397.3523177218785;5401.162819762943;5313.628046036779;5332.933413317332;5364.7317634118335;5368.355797304329;5466.262054622634;5337.813176538822;5353.304070470853;5353.464653534655;5362.168863826113;5396.730163491829;4348.7390756554705;4439.889002774924;5220.295260139908;5314.9468505314835;5410.891782164374;5061.392632884041;5505.972470137664;5722.427757224286;5785;5794.5074668653215;6259.194063938295;6288.025356069817;6308.684565771693;6313.40022697843;6316.96841515794;6245.281792593864;6265.320080475676;6307.211598550181;6317.210348706411;6331.461825744817;5952.672603006833;6021.638701677914;6040.486558642477;6045.45590896817;6073.574849760518;6353.269374021954;6360.777372792023;6362.745490180341;6363.395477429637;6375.553711240262;6145.446909778141;6231.532635052389;6264.968675156595;6272.341404152589;6275.3724627537795;6262.1546091278005;6308.243010838729;6312.305646378894;6323;6324.9051264231075;6256.374362563707;6300.527460440485;6325.462335701517;6330.05049242608;6335.968320158369;5792.913106303409;6231.3145553989025;6234.251889773256;6265.122882796412;6327.715252813635;4344.54382289855;4511.368408422823;5005.849824505271;5010.674306170087;5040.621953353513;4495.4605447345875;4499.820007199741;4534.77326133692;4551.613112885376;4571.885702857388;5913.70431478433;5980.671063091485;6049.243844519435;6080.391960803972;6109.633421994695;6180;6283.560150789493;6316.842078948063;6343.55595108338;6353.96823015882;6022.5784195105925;6055.333913269536;6058.363871793398;6086.969565152234;6088.969555152196;5397.109476936262;5470.890582188334;5524.751386187631;5548.91676624851;5561.443855614487;6512.479001679854;6537.378948999933;6542.967285163734;6550.0829883816305;6559;6281.96859015702;6292.779752708633;6303;6324.936750632619;6332.145160403471;5758.222639943554;6296.401841825203;6466.353364663496;6550.344965503412;6592.76925307612;6257.468115210076;6319.431251187415;6328.6202827830475;6335.588186767845;6355.5551111421755;6152.107944348134;6314.778982735582;6319.747210111544;6326.778562750282;6336.493080553452;5985.162077309094;6220.502359811114;6251.624902505864;6285.654289014148;6286.088517165077;6236.095766113797;6263.592866463848;6270.216222972129;6272.40412160844;6286.748530058747;5921.082232254007;6013.579049466495;6069.544784141119;6075.574709770273;6153.169322141633;6180.66006369636;6193.473554747717;6255.624662520081;6257.812265632038;6267.435930766253;6107.969460152671;6126.295476020315;6130.754769809158;6145.907811382922;6160.199174107337 11:31:33 INFO - PROCESS | 1676 | |1;ext.html;460.0591789789879;551.9237486900545;576.6943519934437;689.7378995981526;691.8754624167649;39836.40245396318;40214.19571608566;40305.79847100768;40411.78764637062;40504;43582.564174358246;44021;44230;44257;44418;9712.902870971271;9923.206143508502;9923.603055877757;9943.204543636492;9953.950230248838;9771.853422198672;9851.507424628775;9855.507224638775;9888.159506441925;9911.950440247789;9852.064053914866;9876.802463950753;9905.752356191117;9950.567054366269;9999.900001000005;9840.261980351466;9921.553530091163;9934.403935763878;9941.75145621358;9942.955989621094;9703.272254580934;9764.072413120743;9782.804343913152;9820.263480239011;9873.259505537113;34831.65168348309;40978.59021409778;41172.79413602943;41290;41390.37914431286;3295.9340813183603;3430.468277417004;3493.441049432104;3498.702610278129;3607.350676878161;27226.45547089067;27733.861330693217;28681.426371472662;28888.855555722297;29529.557056644167;2803.2571368587137;2818.6899441061673;2829.6745874224316;2890.7398334149816;2908.447394994965;463158;464955;467391;468121;469431;48388.758056209495;48975.75512122488;49148.262776058385;66757.66621166863;68178;46869.29696054562;47618.285725714144;47646.047079058226;47970.5202947973;47980;16723.331066757193;17293.827061729473;17485.82514174842;17490.47528574145;17556.561085972953;10932.125429965583;13281.207037050068;13935.86064139366;13975;14083.718325633636;11770.882291176978;12529.498820047278;12848.715128487263;15404.537863864101;15469.381224750883;6155.415235552616;6596.439302659328;6671.833204169935;6718.49611279156;6724.08363616367;971.3928794503436;998.3061772068343;1051.894810518942;1060.7454210989306;1138.0724709361843;28705.56941645877;29920.952766653063;30965.845170774002;31014.68985310118;31423.05730828079;1060.4220699718671;1171.976560468786;1186.6440067979572;1269.6635391621228;1316.1905428161613;15749.68500629981;15777.921110394604;15783.368665253261;15818.892677512695;16103;490830;491001;491523;493852;494229;62118;62566.74866502736;62761.74476510536;62790.74418511604;62862.057069144;1538.2385719069132;1554.8134223893205;1573.1662219023935;1575.7478803391402;1689.4678176374402;30287.394252115275;30652.386952261277;30795;30999.380012400077;31327.530087048257;48625.513744862095;48889.022219554696;49131.50868491412;49138.01723965429;49237;422646;429916;430308;432434;432735;34884.82557587196;35205.295894081464;35448.46827297541;35712.750053747994;35817.283654326246;47331;47601.285980709625;48534.75732621314;48917.7770555739;49256;32857;39015.02462438462;39697.603023969394;39816;40034.798956031365;31186.688133119285;31717.73129074811;37662.62337376591;38724.80637596794;38846.6115338843;33506.329873401904;38435.42346864855;38575.61424385833;39263.803680981415;39849.60150398575;26210.344741381617;30945.381092378477;32004.35991280208;32311;32478.83760581182;24807.875960620804;25785;25858.83635236381;25916;25927.611085834105 11:31:33 INFO - PROCESS | 1676 | |2;jquery.html;369.58790948092883;381.6927373464361;381.7060863135388;388.92610404023236;390.57232330598004;16091;20580.691289630668;20893.268735594258;21470.677939830915;21817.99999999998;16442.75335869963;21028.474288142766;21219.469513262175;21533.815640139826;21559.784402156012;5882.411758824126;6141.846453838667;6157.568970172089;6158.507319414459;6163.198784158064;5778.913316300238;5974.581779275452;6022.457978781908;6030.306514750794;6055.364186760393;5941.405859414046;5975.611585246967;5976.2230909981645;5978.103284507315;5981.102834574827;5779.739911703983;5825.88348233033;5898.469137777578;5984.640921544721;5988.101784732282;5134.17853143499;5173.767180476888;5191.0656081905245;5200.479952004807;5219.217117432378;10321.690349289533;13763.449462021506;26146.73853261462;26890;26963.595546066827;2140.4327853118934;2152.214441728773;2512.371907023244;2562.1801023672433;2573.974260257411;10324.535395907202;10379.740506487398;10418;10446.164306855433;10640.57437702491;1793.4709260768104;1867.131783720563;1874;1888.1314595286049;1895;93379.53310233406;108113;108414.91585084127;108894.91105088926;111929.44035279853;10912.017918387224;11476.876777796135;11490.712732181762;11503.712407189887;11521.423928803526;11333.603323883624;13869.959753018564;13889.374978126009;14078.71842563143;14171.078879872775;8118.918810811816;8334.291585215204;9063.643452702214;9149.817003660022;9200.95399522998;7426.443016773764;9175.036621154815;9359.29805264608;9374.468893398744;9418.19945304643;4516.538486524852;4552.658550608718;4628.4445866496235;4651.767411629473;4659.138059459011;1683.301429906575;1960.3824795189469;1970.6945423459388;1978.0801927103967;2020.5655784006215;902.4224496322358;951.2627713522076;996.7906739584769;1051.4059556350637;1096.4079397125622;20334.593308133753;20916.89541552313;21101.894490527757;21155.365339039854;21180.15279388807;991.2813210422386;1001.3140998416109;1018.5263852308713;1024.8565200871883;1050.6480329089688;11260.662180134608;11274.943625281821;11278.774424511465;11318.094552435785;11417.828732569018;674789;677030;678753;684999;689416;122598;126006;128625.3320905373;131218;132949;1039.9948000259951;1041.1098510773331;1041.5937784263992;1049.165913099073;1051.847482115089;14441;18198.909005454887;18292.908535457238;18407.447776566725;18737;50695;55173.89652206853;55613;55915.44084559102;55948.72025640008;80144.59927700557;80612;81391.59304203678;81820.77268841091;82865;8286.792830179294;8377;8379.748607541784;8415.747527574182;8458;9512.38169518979;12752.553660622205;13122.278274694983;13518.797218041935;13674.453021879013;11380.260283081574;11383.772324553629;11778.646640600795;11883.762324753283;12175.939120304341;11565.421728913689;11887.643370698894;12118;12153.635390938285;12216.938915305367;11881.762364752829;12227.633171004883;12309.199902006341;12494.206877993098;12507.74984500323;8388.748337549883;8437.451565648213;8496.277816385676;8607.741767746978;8627.266682331821;8582.184692454206;10862.511186996446;11882.346470944181;11898.881011189776;12106.878931210575 11:31:33 INFO - PROCESS | 1676 | |3;mootools.html;1576.1488796050135;1702.3190723710513;2031.3398145602682;2105.6946742722316;2128.0636519931218;8393.916060839405;9051;9155.90844091559;9338.953305233481;9342.906570934289;9104.27165826734;9127.726168214947;9156.175944165025;9197.816043679122;9209.95395023024;2536.1377131775193;2557.7442255774367;2559.5520783862844;2574.3306740247576;2580.6645136132274;2511.309389917778;2553.2340297910646;2572.742725727431;2574.1505303249883;2584.7673709366154;2531.253280282312;2571.4471388651436;2575.6780402449695;2576.987115064422;2580.948381032378;2241.823042902473;2472.1223965492263;2539.9746002539923;2540.466502034575;2551.872406379683;2093.769685334612;2522.583773677341;2568.2552059902605;2586.237060067285;2586.2629150691964;7424.331810137113;7790.7924271737975;9356.766080847965;9357.953210233973;9392.67125650599;5155.226715992593;5666.093425051972;5795.159701843209;5825.592208545403;5831.008728516163;3152.801935264608;3676.522052133232;3750.6811920986747;3788.4696142540065;3817.6373244541724;1088.5264909764198;1102.72431892027;1104.4808939798281;1108.9556417743281;1114.3369695031442;12402.25586464815;12409.255444673348;12680.302583357912;12690.42893069814;12746.936265318707;4060.878173654795;4980.402351717817;5117;5126.15418455958;5134.204198349262;10490.790184196274;10543.209259305582;10601.310914790514;10709.946450267698;10759.139268858473;5614.859628509238;5681;5742.483176514133;5758.539316854725;5774.711264436845;4734;5119.923201151985;5148.227765835155;5148.665336753099;5214.1657334827005;4055.4496345726347;4128.669706423479;4160.875173744793;4184.476940382452;4184.937225941613;1152.3949926288765;1340.9329533523285;1348.9123206991515;1360.9387577559035;1364.3723887012086;1413.5547302599648;1416.709574537238;1418.3050305350305;1422.4452463539228;1467.149053548939;8500.10748871372;8612.78468038304;8687.782805429788;8703.825923481494;8714.564271786385;537.1164434505295;545.0298468725674;546.3061911372614;551.737924485866;552.7595495959271;6434.292227854932;6438.291787903327;6467.450266727381;6509.316521765241;6519.608823470512;11165.609203677832;11404.201705880509;11437.885621143681;11470.369129697947;11500.194986351042;10527.368357898398;10895.400752958505;11146.275492092987;11181.161412894066;11341.149413793999;8644.092370301154;8784.077671844492;8791;8803.559822008874;8934.195922366887;7276.927230727837;8285.378596605158;8369.665213391396;8370.623321950405;8527.74416767498;9202.493862837608;9880.011998800062;9880.752981175528;9983.60065597368;10023.949880250551;8719.910011248594;9978.700638980843;10131.240156988108;10148.949255253676;10342.896571034193;7753.806154846174;7819.765407037798;7872.921270787448;7891.171427000082;7951.165127661512;7135.8572828544175;8478.788030299293;8562.315014798925;8606.870896936425;8636.740897773077;7687.231276872268;7826.804329891571;7858.646360913887;7886.44794864354;7927.920720792718;7541.660625271767;7702.998610180641;7775.961120194363;7837.255460731221;7908.52548847071;8042.718504852302;8047;8053.31546818527;8160.26557609818;8248.505089694638;7268.018817459575;7318.524295920748;7393.334599885821;7405.703771849066;7431.777046688608;7297.270272972661;7362.6318684066655;7399.889001664872;7428.517146385468;7446.962765186139 11:31:33 INFO - PROCESS | 1676 | |4;prototype.html;343.178088478095;345.8167171399159;346.15192777694654;353.764746443615;354.07762777963404;6849.589024658518;6907.378335949764;6920.550164239334;6966.442684585234;6966.756163534277;6865.553739006974;6868.8666370049;6873.2095808981985;6880.2775708550635;6883.655817209132;3947.624975627311;4368.672349573779;4701.435827700664;4916.803327866881;5055.696658200502;4989;5029.748512574357;5040.84877453677;5045.974770126144;5073.39119305682;4981.651284410093;5008.373953255843;5155.19568151146;5156.252343410203;5167.974160129194;5047.31861198739;5060.342155519796;5065.265536497224;5071.137906555876;5090.236464530313;4363.996280855421;4371.388005679208;4382.233109205877;4382.342648602703;4394.296912494017;6304.148939893147;6537.477001839841;6565.67171641416;6615.305392933769;6615.569987950767;4663.997240593255;5899.941000589982;5951.6726580038085;5964.970175149097;5968.31364393096;7344.632768361561;7362.5950572718475;7367.226441223702;7376.557406555624;7379.1183248271345;4744.07490539345;4759.61923046159;4759.881002974953;4766.094442056033;4782.617390608743;6008.068749343815;7119.1457025157315;7707.460477766558;7759.495632783851;7782.883256751154;4715.292706094114;4784.593309568656;4791.233402655558;4793.976030119827;4806.399200099988;4860.9513904861205;4862.659613827069;4865.148598995162;4867.756612169448;4898.118338698997;5852.385499522574;5937.020391635332;5951.672658003851;5953.76184952597;5983.04271316596;6608.933910660928;6817.659117044227;7418.258174182539;7421.8144546386775;7426.9257307427315;1634.6567220883749;1678.4545022867374;1693.1111166637613;1703.6337187504746;1707.0952395230547;1067.4822710985165;1068.9786204275872;1088.6353071720903;1091.6070214722693;1093.830456279278;7027.7188912442925;7029.929700702927;7038.788836334918;7046.894296585555;7062.364387205176;5337.119375303031;5356.116240820299;6216.937830621636;7496.475246732785;7608.353289970304;6028.367021462771;6706.731730730814;6933.618650974245;7022.964885175541;7042.542234754725;3206.679332066821;3999.8800035998966;4026.416169655384;4033.6369726724733;4040.8989775255855;6329.208848893888;7695.611783156386;7999.560024198725;8027.317677997436;8043;6567.244766851778;7843.882341764878;7880.2513761192595;7895.131535531087;7909.327707144842;7950.403719721044;7960.601969901481;7968.083670377865;7992.440529162903;7998.0402351717;6038.5169186465855;6822.522423430312;7389.556626602421;7564.773056808304;7581;7520.962395187989;7568.053993250844;7596.316331529968;7599.126100498514;7634.427417943565;6492.285848556749;8116;8117.310028647631;8130.674773009014;8168.224018718212;4627.565454709051;4828.227483602606;4870.342503761947;4870.95129048705;4872.269159626085;6048.879022419439;7490.887636685563;7595.278448547379;7609.162992070757;7622.466427350032;7304.5252058616015;7406;7417.332440080419;7441.1070671519765;7445.516041457288;7421.517601355895;7439.851202976019;7444.255574442513;7450.590217538087;7456.254374562501;7027.718891244497;7235.3488186063505;7238.167610724834;7285.307895749896;7287.41700663935;7376.520526165782;7423.851522969619;7434.888476672746;7436.516626419266;7457;5929.466348028698;7280.235575264521;7285.453590980592;7294.2341054190665;7297.927020729937 11:31:33 INFO - PROCESS | 1676 | |5;yui.html;715.7065603102728;774.1136398823351;776.1811289090011;787.1459466478872;794.0868001797932;15467;15763.684726305468;15784;15801.446949356774;15830.525084247462;14634.48779292725;14672.19302938338;14678;14713.632159195999;14748.631284217872;800.2957397490201;973.255459573427;980.9852852207205;1007.6674697349857;1009.6314845081566;997.4713401897006;1008.5007921079076;1012.1497941728946;1013.8783345998454;1018;1015.4161357219591;1037.9532921018572;1064.9829412910651;1068.4657671164418;1069.7218723132003;886.5389997201484;1046.979060418795;1056.2870062707718;1057.8677665291839;1057.9576816927313;749.2881762325812;761.2996043639864;771.2904128202067;781.3397678961269;801.3028665061375;15679;15816;15835.20823958809;15878.9206053969;15901.840981590152;13415.664608384868;13434.93282533581;13445.19328840263;13487.325633718276;13567.389467473988;10282.280240383176;10419.635312764018;10429.217808664305;10455.215858810543;10669.946650266776;3660.249648821985;3670.082479380155;3698.9630103698887;3778.6032466590887;3934.9016274593077;85427.57286213529;85751;86229.70655440174;86805;88018;9556.283278754121;9560.617575297048;9738.951305243429;9739.318247722591;9888.307818452784;22119.225827095976;22127;22177.11291548352;22301;22633;7698.807529811799;7868.606569671493;8025.558594277254;8128.83742325162;8198.467099638505;4258.914821703549;4282.400463935051;4294.656427485794;4318.460192475941;4509.0080182359825;3610.151614370621;3700.5929347771726;3711.3690672585726;3735.3463143950244;3765.5293088363956;634.8444631065419;657.0636842499515;660.5739298152664;661.2891142022345;666.3403230801472;499.8025779816952;521.637461963939;555.5805366948009;586.9706514674249;597.1878245585999;8100.513969161869;8260.669573217125;8319.542425166554;8508.361872859436;8591.44155629882;542.6499907559602;597.3399393670019;604.8669292755586;608.2761513798565;608.6317777744489;3881.0879443330796;3882.514685664292;3908.6482216600643;3918.49059622253;4058.6753059755147;97810;99818;99924;102912.48543757234;103915;75521.73434796964;75768;75854.62072689712;76299.61850190714;77243;68884.27789305207;69679.65160174268;70003.64998174977;70106;70633.64683176551;8831.735047948572;8872.29021678277;8893.911060889308;8904.283432120536;9059.63761449561;50917.74541127271;51319.48680513147;51758.74120629373;51846.74076629593;52519;65971.67014164898;66323.00515492368;67024.99462508164;69537.30462695309;71968;11174.776504470028;11375.31748095117;11412.201145919706;11414.086873050303;11534.884651153718;11977.101717371057;12149;12157.574484892986;12398.62804115878;12711.74576508446;11776.104197047565;11832.940835295769;11964.222325548812;11986.041116710468;11995.460204290654;10968.396738179477;11563.132765042823;11735.647930562096;11841.955290374503;12305.93847030759;9632.22942164611;10867.836982445111;11549.076073914235;11607;11755.529778808752;7947.364210863233;10003.399796012263;10063.446510441703;10144.695659130239;10342.172626189737;9558.904410955802;9631;9646.951765241129;9939.850902236327;10009.799804004026 11:31:33 INFO - PROCESS | 1676 | __end_tp_report 11:31:33 INFO - PROCESS | 1676 | __start_cc_report 11:31:33 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,351 11:31:33 INFO - PROCESS | 1676 | __end_cc_report 11:31:33 INFO - PROCESS | 1676 | __startTimestamp1464028293359__endTimestamp 11:31:33 INFO - PROCESS | 1676 | 11:31:33 INFO - PROCESS | 1676 | ------- Summary: start ------- 11:31:33 INFO - PROCESS | 1676 | Number of tests: 6 11:31:33 INFO - PROCESS | 1676 | 11:31:33 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5846.59 Median:6109.63 stddev:659.90 (10.8%) stddev-sans-first:626.79 11:31:33 INFO - PROCESS | 1676 | Values: 3138.2 3675.4 3677.9 3717.7 3723.7 4988.7 5423.5 5884.2 5891.6 5893.1 5837.4 5877.7 5881.2 5886.7 5888.6 5284.1 5344.2 5385.2 5393.7 5421.4 5270.1 5379.1 5390.9 5397.4 5401.2 5313.6 5332.9 5364.7 5368.4 5466.3 5337.8 5353.3 5353.5 5362.2 5396.7 4348.7 4439.9 5220.3 5314.9 5410.9 5061.4 5506.0 5722.4 5785.0 5794.5 6259.2 6288.0 6308.7 6313.4 6317.0 6245.3 6265.3 6307.2 6317.2 6331.5 5952.7 6021.6 6040.5 6045.5 6073.6 6353.3 6360.8 6362.7 6363.4 6375.6 6145.4 6231.5 6265.0 6272.3 6275.4 6262.2 6308.2 6312.3 6323.0 6324.9 6256.4 6300.5 6325.5 6330.1 6336.0 5792.9 6231.3 6234.3 6265.1 6327.7 4344.5 4511.4 5005.8 5010.7 5040.6 4495.5 4499.8 4534.8 4551.6 4571.9 5913.7 5980.7 6049.2 6080.4 6109.6 6180.0 6283.6 6316.8 6343.6 6354.0 6022.6 6055.3 6058.4 6087.0 6089.0 5397.1 5470.9 5524.8 5548.9 5561.4 6512.5 6537.4 6543.0 6550.1 6559.0 6282.0 6292.8 6303.0 6324.9 6332.1 5758.2 6296.4 6466.4 6550.3 6592.8 6257.5 6319.4 6328.6 6335.6 6355.6 6152.1 6314.8 6319.7 6326.8 6336.5 5985.2 6220.5 6251.6 6285.7 6286.1 6236.1 6263.6 6270.2 6272.4 6286.7 5921.1 6013.6 6069.5 6075.6 6153.2 6180.7 6193.5 6255.6 6257.8 6267.4 6108.0 6126.3 6130.8 6145.9 6160.2 11:31:33 INFO - PROCESS | 1676 | 11:31:33 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:61018.63 Median:40260.00 stddev:122950.45 (305.4%) stddev-sans-first:123211.28 11:31:33 INFO - PROCESS | 1676 | Values: 460.1 551.9 576.7 689.7 691.9 39836.4 40214.2 40305.8 40411.8 40504.0 43582.6 44021.0 44230.0 44257.0 44418.0 9712.9 9923.2 9923.6 9943.2 9954.0 9771.9 9851.5 9855.5 9888.2 9912.0 9852.1 9876.8 9905.8 9950.6 9999.9 9840.3 9921.6 9934.4 9941.8 9943.0 9703.3 9764.1 9782.8 9820.3 9873.3 34831.7 40978.6 41172.8 41290.0 41390.4 3295.9 3430.5 3493.4 3498.7 3607.4 27226.5 27733.9 28681.4 28888.9 29529.6 2803.3 2818.7 2829.7 2890.7 2908.4 463158.0 464955.0 467391.0 468121.0 469431.0 48388.8 48975.8 49148.3 66757.7 68178.0 46869.3 47618.3 47646.0 47970.5 47980.0 16723.3 17293.8 17485.8 17490.5 17556.6 10932.1 13281.2 13935.9 13975.0 14083.7 11770.9 12529.5 12848.7 15404.5 15469.4 6155.4 6596.4 6671.8 6718.5 6724.1 971.4 998.3 1051.9 1060.7 1138.1 28705.6 29921.0 30965.8 31014.7 31423.1 1060.4 1172.0 1186.6 1269.7 1316.2 15749.7 15777.9 15783.4 15818.9 16103.0 490830.0 491001.0 491523.0 493852.0 494229.0 62118.0 62566.7 62761.7 62790.7 62862.1 1538.2 1554.8 1573.2 1575.7 1689.5 30287.4 30652.4 30795.0 30999.4 31327.5 48625.5 48889.0 49131.5 49138.0 49237.0 422646.0 429916.0 430308.0 432434.0 432735.0 34884.8 35205.3 35448.5 35712.8 35817.3 47331.0 47601.3 48534.8 48917.8 49256.0 32857.0 39015.0 39697.6 39816.0 40034.8 31186.7 31717.7 37662.6 38724.8 38846.6 33506.3 38435.4 38575.6 39263.8 39849.6 26210.3 30945.4 32004.4 32311.0 32478.8 24807.9 25785.0 25858.8 25916.0 25927.6 11:31:33 INFO - PROCESS | 1676 | 11:31:33 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:37097.11 Median:11679.95 stddev:112795.38 (965.7%) stddev-sans-first:113078.09 11:31:33 INFO - PROCESS | 1676 | Values: 369.6 381.7 381.7 388.9 390.6 16091.0 20580.7 20893.3 21470.7 21818.0 16442.8 21028.5 21219.5 21533.8 21559.8 5882.4 6141.8 6157.6 6158.5 6163.2 5778.9 5974.6 6022.5 6030.3 6055.4 5941.4 5975.6 5976.2 5978.1 5981.1 5779.7 5825.9 5898.5 5984.6 5988.1 5134.2 5173.8 5191.1 5200.5 5219.2 10321.7 13763.4 26146.7 26890.0 26963.6 2140.4 2152.2 2512.4 2562.2 2574.0 10324.5 10379.7 10418.0 10446.2 10640.6 1793.5 1867.1 1874.0 1888.1 1895.0 93379.5 108113.0 108414.9 108894.9 111929.4 10912.0 11476.9 11490.7 11503.7 11521.4 11333.6 13870.0 13889.4 14078.7 14171.1 8118.9 8334.3 9063.6 9149.8 9201.0 7426.4 9175.0 9359.3 9374.5 9418.2 4516.5 4552.7 4628.4 4651.8 4659.1 1683.3 1960.4 1970.7 1978.1 2020.6 902.4 951.3 996.8 1051.4 1096.4 20334.6 20916.9 21101.9 21155.4 21180.2 991.3 1001.3 1018.5 1024.9 1050.6 11260.7 11274.9 11278.8 11318.1 11417.8 674789.0 677030.0 678753.0 684999.0 689416.0 122598.0 126006.0 128625.3 131218.0 132949.0 1040.0 1041.1 1041.6 1049.2 1051.8 14441.0 18198.9 18292.9 18407.4 18737.0 50695.0 55173.9 55613.0 55915.4 55948.7 80144.6 80612.0 81391.6 81820.8 82865.0 8286.8 8377.0 8379.7 8415.7 8458.0 9512.4 12752.6 13122.3 13518.8 13674.5 11380.3 11383.8 11778.6 11883.8 12175.9 11565.4 11887.6 12118.0 12153.6 12216.9 11881.8 12227.6 12309.2 12494.2 12507.7 8388.7 8437.5 8496.3 8607.7 8627.3 8582.2 10862.5 11882.3 11898.9 12106.9 11:31:33 INFO - PROCESS | 1676 | 11:31:33 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:6301.74 Median:541.07 stddev:3351.17 (619.4%) stddev-sans-first:3341.75 11:31:33 INFO - PROCESS | 1676 | Values: 1576.1 1702.3 2031.3 2105.7 2128.1 8393.9 9051.0 9155.9 9339.0 9342.9 9104.3 9127.7 9156.2 9197.8 9210.0 2536.1 2557.7 2559.6 2574.3 2580.7 2511.3 2553.2 2572.7 2574.2 2584.8 2531.3 2571.4 2575.7 2577.0 2580.9 2241.8 2472.1 2540.0 2540.5 2551.9 2093.8 2522.6 2568.3 2586.2 2586.3 7424.3 7790.8 9356.8 9358.0 9392.7 5155.2 5666.1 5795.2 5825.6 5831.0 3152.8 3676.5 3750.7 3788.5 3817.6 1088.5 1102.7 1104.5 1109.0 1114.3 12402.3 12409.3 12680.3 12690.4 12746.9 4060.9 4980.4 5117.0 5126.2 5134.2 10490.8 10543.2 10601.3 10709.9 10759.1 5614.9 5681.0 5742.5 5758.5 5774.7 4734.0 5119.9 5148.2 5148.7 5214.2 4055.4 4128.7 4160.9 4184.5 4184.9 1152.4 1340.9 1348.9 1360.9 1364.4 1413.6 1416.7 1418.3 1422.4 1467.1 8500.1 8612.8 8687.8 8703.8 8714.6 537.1 545.0 546.3 551.7 552.8 6434.3 6438.3 6467.5 6509.3 6519.6 11165.6 11404.2 11437.9 11470.4 11500.2 10527.4 10895.4 11146.3 11181.2 11341.1 8644.1 8784.1 8791.0 8803.6 8934.2 7276.9 8285.4 8369.7 8370.6 8527.7 9202.5 9880.0 9880.8 9983.6 10023.9 8719.9 9978.7 10131.2 10148.9 10342.9 7753.8 7819.8 7872.9 7891.2 7951.2 7135.9 8478.8 8562.3 8606.9 8636.7 7687.2 7826.8 7858.6 7886.4 7927.9 7541.7 7703.0 7776.0 7837.3 7908.5 8042.7 8047.0 8053.3 8160.3 8248.5 7268.0 7318.5 7393.3 7405.7 7431.8 7297.3 7362.6 7399.9 7428.5 7447.0 11:31:33 INFO - PROCESS | 1676 | 11:31:33 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:5937.55 Median:6615.44 stddev:1916.09 (29.0%) stddev-sans-first:1874.89 11:31:33 INFO - PROCESS | 1676 | Values: 343.2 345.8 346.2 353.8 354.1 6849.6 6907.4 6920.6 6966.4 6966.8 6865.6 6868.9 6873.2 6880.3 6883.7 3947.6 4368.7 4701.4 4916.8 5055.7 4989.0 5029.7 5040.8 5046.0 5073.4 4981.7 5008.4 5155.2 5156.3 5168.0 5047.3 5060.3 5065.3 5071.1 5090.2 4364.0 4371.4 4382.2 4382.3 4394.3 6304.1 6537.5 6565.7 6615.3 6615.6 4664.0 5899.9 5951.7 5965.0 5968.3 7344.6 7362.6 7367.2 7376.6 7379.1 4744.1 4759.6 4759.9 4766.1 4782.6 6008.1 7119.1 7707.5 7759.5 7782.9 4715.3 4784.6 4791.2 4794.0 4806.4 4861.0 4862.7 4865.1 4867.8 4898.1 5852.4 5937.0 5951.7 5953.8 5983.0 6608.9 6817.7 7418.3 7421.8 7426.9 1634.7 1678.5 1693.1 1703.6 1707.1 1067.5 1069.0 1088.6 1091.6 1093.8 7027.7 7029.9 7038.8 7046.9 7062.4 5337.1 5356.1 6216.9 7496.5 7608.4 6028.4 6706.7 6933.6 7023.0 7042.5 3206.7 3999.9 4026.4 4033.6 4040.9 6329.2 7695.6 7999.6 8027.3 8043.0 6567.2 7843.9 7880.3 7895.1 7909.3 7950.4 7960.6 7968.1 7992.4 7998.0 6038.5 6822.5 7389.6 7564.8 7581.0 7521.0 7568.1 7596.3 7599.1 7634.4 6492.3 8116.0 8117.3 8130.7 8168.2 4627.6 4828.2 4870.3 4871.0 4872.3 6048.9 7490.9 7595.3 7609.2 7622.5 7304.5 7406.0 7417.3 7441.1 7445.5 7421.5 7439.9 7444.3 7450.6 7456.3 7027.7 7235.3 7238.2 7285.3 7287.4 7376.5 7423.9 7434.9 7436.5 7457.0 5929.5 7280.2 7285.5 7294.2 7297.9 11:31:33 INFO - PROCESS | 1676 | 11:31:33 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:18928.66 Median:4158.80 stddev:26691.18 (641.8%) stddev-sans-first:26731.02 11:31:33 INFO - PROCESS | 1676 | Values: 715.7 774.1 776.2 787.1 794.1 15467.0 15763.7 15784.0 15801.4 15830.5 14634.5 14672.2 14678.0 14713.6 14748.6 800.3 973.3 981.0 1007.7 1009.6 997.5 1008.5 1012.1 1013.9 1018.0 1015.4 1038.0 1065.0 1068.5 1069.7 886.5 1047.0 1056.3 1057.9 1058.0 749.3 761.3 771.3 781.3 801.3 15679.0 15816.0 15835.2 15878.9 15901.8 13415.7 13434.9 13445.2 13487.3 13567.4 10282.3 10419.6 10429.2 10455.2 10669.9 3660.2 3670.1 3699.0 3778.6 3934.9 85427.6 85751.0 86229.7 86805.0 88018.0 9556.3 9560.6 9739.0 9739.3 9888.3 22119.2 22127.0 22177.1 22301.0 22633.0 7698.8 7868.6 8025.6 8128.8 8198.5 4258.9 4282.4 4294.7 4318.5 4509.0 3610.2 3700.6 3711.4 3735.3 3765.5 634.8 657.1 660.6 661.3 666.3 499.8 521.6 555.6 587.0 597.2 8100.5 8260.7 8319.5 8508.4 8591.4 542.6 597.3 604.9 608.3 608.6 3881.1 3882.5 3908.6 3918.5 4058.7 97810.0 99818.0 99924.0 102912.5 103915.0 75521.7 75768.0 75854.6 76299.6 77243.0 68884.3 69679.7 70003.6 70106.0 70633.6 8831.7 8872.3 8893.9 8904.3 9059.6 50917.7 51319.5 51758.7 51846.7 52519.0 65971.7 66323.0 67025.0 69537.3 71968.0 11174.8 11375.3 11412.2 11414.1 11534.9 11977.1 12149.0 12157.6 12398.6 12711.7 11776.1 11832.9 11964.2 11986.0 11995.5 10968.4 11563.1 11735.6 11842.0 12305.9 9632.2 10867.8 11549.1 11607.0 11755.5 7947.4 10003.4 10063.4 10144.7 10342.2 9558.9 9631.0 9647.0 9939.9 10009.8 11:31:33 INFO - PROCESS | 1676 | -------- Summary: end -------- 11:31:33 INFO - PROCESS | 1676 | 11:31:33 INFO - TEST-INFO | 1676: exit 0 11:31:33 INFO - TEST-OK | dromaeo_css | took 1109199ms 11:31:33 INFO - TEST-START | kraken 11:31:33 INFO - operating with platform_type : mac_ 11:31:33 INFO - Initialising browser for kraken test... 11:31:33 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmp8q41jM/profile http://localhost:49278/getInfo.html) 11:31:36 INFO - PROCESS | 1686 | __metrics Screen width/height:1600/1200 11:31:36 INFO - PROCESS | 1686 | colorDepth:24 11:31:36 INFO - PROCESS | 1686 | Browser inner width/height: 1024/689 11:31:36 INFO - PROCESS | 1686 | __metrics 11:31:36 ERROR - PROCESS | 1686 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:31:37 INFO - TEST-INFO | 1686: exit 0 11:31:37 INFO - Browser initialized. 11:31:37 INFO - Running cycle 1/1 for kraken test... 11:31:37 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmp8q41jM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:49 INFO - PROCESS | 1690 | RSS: Main: 168370176 11:31:49 INFO - PROCESS | 1690 | 11:31:51 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:52 INFO - PROCESS | 1690 | RSS: Main: 179802112 11:31:52 INFO - PROCESS | 1690 | 11:31:55 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 11:31:55 INFO - PROCESS | 1690 | RSS: Main: 189272064 11:31:55 INFO - PROCESS | 1690 | 11:31:59 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 11:31:59 INFO - PROCESS | 1690 | RSS: Main: 192274432 11:31:59 INFO - PROCESS | 1690 | 11:32:01 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 11:32:02 INFO - PROCESS | 1690 | RSS: Main: 192802816 11:32:02 INFO - PROCESS | 1690 | 11:32:04 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:04 INFO - PROCESS | 1690 | RSS: Main: 194363392 11:32:04 INFO - PROCESS | 1690 | 11:32:07 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:08 INFO - PROCESS | 1690 | RSS: Main: 195088384 11:32:08 INFO - PROCESS | 1690 | 11:32:11 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:11 INFO - PROCESS | 1690 | RSS: Main: 194793472 11:32:11 INFO - PROCESS | 1690 | 11:32:14 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 11:32:15 INFO - PROCESS | 1690 | RSS: Main: 194953216 11:32:15 INFO - PROCESS | 1690 | 11:32:16 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:17 INFO - PROCESS | 1690 | RSS: Main: 194297856 11:32:17 INFO - PROCESS | 1690 | 11:32:19 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:19 INFO - PROCESS | 1690 | RSS: Main: 194310144 11:32:19 INFO - PROCESS | 1690 | 11:32:22 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:22 INFO - PROCESS | 1690 | RSS: Main: 194637824 11:32:22 INFO - PROCESS | 1690 | 11:32:25 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:25 INFO - PROCESS | 1690 | RSS: Main: 194666496 11:32:25 INFO - PROCESS | 1690 | 11:32:28 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:28 INFO - PROCESS | 1690 | RSS: Main: 194854912 11:32:28 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 11:32:30 INFO - PROCESS | 1690 | RSS: Main: 196587520 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | __start_tp_report 11:32:30 INFO - PROCESS | 1690 | _x_x_mozilla_page_load 11:32:30 INFO - PROCESS | 1690 | _x_x_mozilla_page_load_details 11:32:30 INFO - PROCESS | 1690 | |i|pagename|runs| 11:32:30 INFO - PROCESS | 1690 | |0;ai-astar;114;109;116;115;114;129;115;115;117;114 11:32:30 INFO - PROCESS | 1690 | |1;audio-beat-detection;146;125;138;147;142;170;175;121;148;118 11:32:30 INFO - PROCESS | 1690 | |2;audio-dft;193;196;193;193;193;220;277;214;198;196 11:32:30 INFO - PROCESS | 1690 | |3;audio-fft;73;70;71;111;60;75;91;85;159;57 11:32:30 INFO - PROCESS | 1690 | |4;audio-oscillator;85;86;98;70;89;94;128;63;71;161 11:32:30 INFO - PROCESS | 1690 | |5;imaging-gaussian-blur;104;116;88;98;126;84;91;86;78;132 11:32:30 INFO - PROCESS | 1690 | |6;imaging-darkroom;93;94;118;153;94;107;124;94;125;93 11:32:30 INFO - PROCESS | 1690 | |7;imaging-desaturate;90;91;91;90;94;90;97;92;90;90 11:32:30 INFO - PROCESS | 1690 | |8;json-parse-financial;57;61;57;67;89;91;58;60;55;58 11:32:30 INFO - PROCESS | 1690 | |9;json-stringify-tinderbox;62;64;70;68;74;72;67;64;64;66 11:32:30 INFO - PROCESS | 1690 | |10;stanford-crypto-aes;82;84;82;83;82;82;90;109;108;84 11:32:30 INFO - PROCESS | 1690 | |11;stanford-crypto-ccm;133;123;123;119;122;122;130;129;134;126 11:32:30 INFO - PROCESS | 1690 | |12;stanford-crypto-pbkdf2;138;138;137;180;157;132;136;134;137;124 11:32:30 INFO - PROCESS | 1690 | |13;stanford-crypto-sha256-iterative;67;66;67;67;68;65;66;67;68;67 11:32:30 INFO - PROCESS | 1690 | __end_tp_report 11:32:30 INFO - PROCESS | 1690 | __start_cc_report 11:32:30 INFO - PROCESS | 1690 | _x_x_mozilla_cycle_collect,913 11:32:30 INFO - PROCESS | 1690 | __end_cc_report 11:32:30 INFO - PROCESS | 1690 | __startTimestamp1464028350748__endTimestamp 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | ------- Summary: start ------- 11:32:30 INFO - PROCESS | 1690 | Number of tests: 14 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#0] ai-astar Cycles:10 Average:115.80 Median:115.00 stddev:5.09 (4.4%) stddev-sans-first:5.36 11:32:30 INFO - PROCESS | 1690 | Values: 114.0 109.0 116.0 115.0 114.0 129.0 115.0 115.0 117.0 114.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:146.50 stddev:19.04 (13.0%) stddev-sans-first:20.16 11:32:30 INFO - PROCESS | 1690 | Values: 146.0 125.0 138.0 147.0 142.0 170.0 175.0 121.0 148.0 118.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#2] audio-dft Cycles:10 Average:207.30 Median:197.00 stddev:26.30 (13.3%) stddev-sans-first:27.38 11:32:30 INFO - PROCESS | 1690 | Values: 193.0 196.0 193.0 193.0 193.0 220.0 277.0 214.0 198.0 196.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#3] audio-fft Cycles:10 Average:85.20 Median:72.00 stddev:30.30 (42.1%) stddev-sans-first:31.81 11:32:30 INFO - PROCESS | 1690 | Values: 73.0 70.0 71.0 111.0 60.0 75.0 91.0 85.0 159.0 57.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:85.50 stddev:29.62 (34.6%) stddev-sans-first:31.21 11:32:30 INFO - PROCESS | 1690 | Values: 85.0 86.0 98.0 70.0 89.0 94.0 128.0 63.0 71.0 161.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#5] imaging-gaussian-blur Cycles:10 Average:100.30 Median:85.00 stddev:18.67 (22.0%) stddev-sans-first:19.75 11:32:30 INFO - PROCESS | 1690 | Values: 104.0 116.0 88.0 98.0 126.0 84.0 91.0 86.0 78.0 132.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#6] imaging-darkroom Cycles:10 Average:109.50 Median:93.00 stddev:20.24 (21.8%) stddev-sans-first:20.57 11:32:30 INFO - PROCESS | 1690 | Values: 93.0 94.0 118.0 153.0 94.0 107.0 124.0 94.0 125.0 93.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#7] imaging-desaturate Cycles:10 Average:91.50 Median:91.00 stddev:2.32 (2.6%) stddev-sans-first:2.40 11:32:30 INFO - PROCESS | 1690 | Values: 90.0 91.0 91.0 90.0 94.0 90.0 97.0 92.0 90.0 90.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:60.50 stddev:13.43 (22.2%) stddev-sans-first:13.90 11:32:30 INFO - PROCESS | 1690 | Values: 57.0 61.0 57.0 67.0 89.0 91.0 58.0 60.0 55.0 58.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.50 stddev:3.90 (5.8%) stddev-sans-first:3.67 11:32:30 INFO - PROCESS | 1690 | Values: 62.0 64.0 70.0 68.0 74.0 72.0 67.0 64.0 64.0 66.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:82.50 stddev:10.76 (13.0%) stddev-sans-first:11.15 11:32:30 INFO - PROCESS | 1690 | Values: 82.0 84.0 82.0 83.0 82.0 82.0 90.0 109.0 108.0 84.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:127.50 stddev:5.13 (4.0%) stddev-sans-first:4.80 11:32:30 INFO - PROCESS | 1690 | Values: 133.0 123.0 123.0 119.0 122.0 122.0 130.0 129.0 134.0 126.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.30 Median:137.50 stddev:15.88 (11.6%) stddev-sans-first:16.80 11:32:30 INFO - PROCESS | 1690 | Values: 138.0 138.0 137.0 180.0 157.0 132.0 136.0 134.0 137.0 124.0 11:32:30 INFO - PROCESS | 1690 | 11:32:30 INFO - PROCESS | 1690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 11:32:30 INFO - PROCESS | 1690 | Values: 67.0 66.0 67.0 67.0 68.0 65.0 66.0 67.0 68.0 67.0 11:32:30 INFO - PROCESS | 1690 | -------- Summary: end -------- 11:32:30 INFO - PROCESS | 1690 | 11:32:31 INFO - TEST-INFO | 1690: exit 0 11:32:31 INFO - TEST-OK | kraken | took 57626ms 11:32:31 INFO - SUITE-END | took 1166s 11:32:31 INFO - Completed test suite (00:19:27) 11:32:31 INFO - javascript benchmark 11:32:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3138.1840721412427, 3675.375186218341, 3677.9080522986937, 3717.702583793296, 3723.7207209459298, 4988.72787439203, 5423.457654234579, 5884.205632239647, 5891.587588868781, 5893.145493903381, 5837.387074357184, 5877.706114694259, 5881.206037184978, 5886.735096920638, 5888.5877988540815, 5284.0752868248, 5344.198370244475, 5385.165299378603, 5393.6763794172275, 5421.430749771276, 5270.104082305998, 5379.139337705968, 5390.946090539103, 5397.3523177218785, 5401.162819762943, 5313.628046036779, 5332.933413317332, 5364.7317634118335, 5368.355797304329, 5466.262054622634, 5337.813176538822, 5353.304070470853, 5353.464653534655, 5362.168863826113, 5396.730163491829, 4348.7390756554705, 4439.889002774924, 5220.295260139908, 5314.9468505314835, 5410.891782164374, 5061.392632884041, 5505.972470137664, 5722.427757224286, 5785.0, 5794.5074668653215, 6259.194063938295, 6288.025356069817, 6308.684565771693, 6313.40022697843, 6316.96841515794, 6245.281792593864, 6265.320080475676, 6307.211598550181, 6317.210348706411, 6331.461825744817, 5952.672603006833, 6021.638701677914, 6040.486558642477, 6045.45590896817, 6073.574849760518, 6353.269374021954, 6360.777372792023, 6362.745490180341, 6363.395477429637, 6375.553711240262, 6145.446909778141, 6231.532635052389, 6264.968675156595, 6272.341404152589, 6275.3724627537795, 6262.1546091278005, 6308.243010838729, 6312.305646378894, 6323.0, 6324.9051264231075, 6256.374362563707, 6300.527460440485, 6325.462335701517, 6330.05049242608, 6335.968320158369, 5792.913106303409, 6231.3145553989025, 6234.251889773256, 6265.122882796412, 6327.715252813635, 4344.54382289855, 4511.368408422823, 5005.849824505271, 5010.674306170087, 5040.621953353513, 4495.4605447345875, 4499.820007199741, 4534.77326133692, 4551.613112885376, 4571.885702857388, 5913.70431478433, 5980.671063091485, 6049.243844519435, 6080.391960803972, 6109.633421994695, 6180.0, 6283.560150789493, 6316.842078948063, 6343.55595108338, 6353.96823015882, 6022.5784195105925, 6055.333913269536, 6058.363871793398, 6086.969565152234, 6088.969555152196, 5397.109476936262, 5470.890582188334, 5524.751386187631, 5548.91676624851, 5561.443855614487, 6512.479001679854, 6537.378948999933, 6542.967285163734, 6550.0829883816305, 6559.0, 6281.96859015702, 6292.779752708633, 6303.0, 6324.936750632619, 6332.145160403471, 5758.222639943554, 6296.401841825203, 6466.353364663496, 6550.344965503412, 6592.76925307612, 6257.468115210076, 6319.431251187415, 6328.6202827830475, 6335.588186767845, 6355.5551111421755, 6152.107944348134, 6314.778982735582, 6319.747210111544, 6326.778562750282, 6336.493080553452, 5985.162077309094, 6220.502359811114, 6251.624902505864, 6285.654289014148, 6286.088517165077, 6236.095766113797, 6263.592866463848, 6270.216222972129, 6272.40412160844, 6286.748530058747, 5921.082232254007, 6013.579049466495, 6069.544784141119, 6075.574709770273, 6153.169322141633, 6180.66006369636, 6193.473554747717, 6255.624662520081, 6257.812265632038, 6267.435930766253, 6107.969460152671, 6126.295476020315, 6130.754769809158, 6145.907811382922, 6160.199174107337], "unit": "score", "name": "dojo.html", "value": 5805.617740812416}, {"lowerIsBetter": false, "replicates": [460.0591789789879, 551.9237486900545, 576.6943519934437, 689.7378995981526, 691.8754624167649, 39836.40245396318, 40214.19571608566, 40305.79847100768, 40411.78764637062, 40504.0, 43582.564174358246, 44021.0, 44230.0, 44257.0, 44418.0, 9712.902870971271, 9923.206143508502, 9923.603055877757, 9943.204543636492, 9953.950230248838, 9771.853422198672, 9851.507424628775, 9855.507224638775, 9888.159506441925, 9911.950440247789, 9852.064053914866, 9876.802463950753, 9905.752356191117, 9950.567054366269, 9999.900001000005, 9840.261980351466, 9921.553530091163, 9934.403935763878, 9941.75145621358, 9942.955989621094, 9703.272254580934, 9764.072413120743, 9782.804343913152, 9820.263480239011, 9873.259505537113, 34831.65168348309, 40978.59021409778, 41172.79413602943, 41290.0, 41390.37914431286, 3295.9340813183603, 3430.468277417004, 3493.441049432104, 3498.702610278129, 3607.350676878161, 27226.45547089067, 27733.861330693217, 28681.426371472662, 28888.855555722297, 29529.557056644167, 2803.2571368587137, 2818.6899441061673, 2829.6745874224316, 2890.7398334149816, 2908.447394994965, 463158.0, 464955.0, 467391.0, 468121.0, 469431.0, 48388.758056209495, 48975.75512122488, 49148.262776058385, 66757.66621166863, 68178.0, 46869.29696054562, 47618.285725714144, 47646.047079058226, 47970.5202947973, 47980.0, 16723.331066757193, 17293.827061729473, 17485.82514174842, 17490.47528574145, 17556.561085972953, 10932.125429965583, 13281.207037050068, 13935.86064139366, 13975.0, 14083.718325633636, 11770.882291176978, 12529.498820047278, 12848.715128487263, 15404.537863864101, 15469.381224750883, 6155.415235552616, 6596.439302659328, 6671.833204169935, 6718.49611279156, 6724.08363616367, 971.3928794503436, 998.3061772068343, 1051.894810518942, 1060.7454210989306, 1138.0724709361843, 28705.56941645877, 29920.952766653063, 30965.845170774002, 31014.68985310118, 31423.05730828079, 1060.4220699718671, 1171.976560468786, 1186.6440067979572, 1269.6635391621228, 1316.1905428161613, 15749.68500629981, 15777.921110394604, 15783.368665253261, 15818.892677512695, 16103.0, 490830.0, 491001.0, 491523.0, 493852.0, 494229.0, 62118.0, 62566.74866502736, 62761.74476510536, 62790.74418511604, 62862.057069144, 1538.2385719069132, 1554.8134223893205, 1573.1662219023935, 1575.7478803391402, 1689.4678176374402, 30287.394252115275, 30652.386952261277, 30795.0, 30999.380012400077, 31327.530087048257, 48625.513744862095, 48889.022219554696, 49131.50868491412, 49138.01723965429, 49237.0, 422646.0, 429916.0, 430308.0, 432434.0, 432735.0, 34884.82557587196, 35205.295894081464, 35448.46827297541, 35712.750053747994, 35817.283654326246, 47331.0, 47601.285980709625, 48534.75732621314, 48917.7770555739, 49256.0, 32857.0, 39015.02462438462, 39697.603023969394, 39816.0, 40034.798956031365, 31186.688133119285, 31717.73129074811, 37662.62337376591, 38724.80637596794, 38846.6115338843, 33506.329873401904, 38435.42346864855, 38575.61424385833, 39263.803680981415, 39849.60150398575, 26210.344741381617, 30945.381092378477, 32004.35991280208, 32311.0, 32478.83760581182, 24807.875960620804, 25785.0, 25858.83635236381, 25916.0, 25927.611085834105], "unit": "score", "name": "ext.html", "value": 19677.49440939238}, {"lowerIsBetter": false, "replicates": [369.58790948092883, 381.6927373464361, 381.7060863135388, 388.92610404023236, 390.57232330598004, 16091.0, 20580.691289630668, 20893.268735594258, 21470.677939830915, 21817.99999999998, 16442.75335869963, 21028.474288142766, 21219.469513262175, 21533.815640139826, 21559.784402156012, 5882.411758824126, 6141.846453838667, 6157.568970172089, 6158.507319414459, 6163.198784158064, 5778.913316300238, 5974.581779275452, 6022.457978781908, 6030.306514750794, 6055.364186760393, 5941.405859414046, 5975.611585246967, 5976.2230909981645, 5978.103284507315, 5981.102834574827, 5779.739911703983, 5825.88348233033, 5898.469137777578, 5984.640921544721, 5988.101784732282, 5134.17853143499, 5173.767180476888, 5191.0656081905245, 5200.479952004807, 5219.217117432378, 10321.690349289533, 13763.449462021506, 26146.73853261462, 26890.0, 26963.595546066827, 2140.4327853118934, 2152.214441728773, 2512.371907023244, 2562.1801023672433, 2573.974260257411, 10324.535395907202, 10379.740506487398, 10418.0, 10446.164306855433, 10640.57437702491, 1793.4709260768104, 1867.131783720563, 1874.0, 1888.1314595286049, 1895.0, 93379.53310233406, 108113.0, 108414.91585084127, 108894.91105088926, 111929.44035279853, 10912.017918387224, 11476.876777796135, 11490.712732181762, 11503.712407189887, 11521.423928803526, 11333.603323883624, 13869.959753018564, 13889.374978126009, 14078.71842563143, 14171.078879872775, 8118.918810811816, 8334.291585215204, 9063.643452702214, 9149.817003660022, 9200.95399522998, 7426.443016773764, 9175.036621154815, 9359.29805264608, 9374.468893398744, 9418.19945304643, 4516.538486524852, 4552.658550608718, 4628.4445866496235, 4651.767411629473, 4659.138059459011, 1683.301429906575, 1960.3824795189469, 1970.6945423459388, 1978.0801927103967, 2020.5655784006215, 902.4224496322358, 951.2627713522076, 996.7906739584769, 1051.4059556350637, 1096.4079397125622, 20334.593308133753, 20916.89541552313, 21101.894490527757, 21155.365339039854, 21180.15279388807, 991.2813210422386, 1001.3140998416109, 1018.5263852308713, 1024.8565200871883, 1050.6480329089688, 11260.662180134608, 11274.943625281821, 11278.774424511465, 11318.094552435785, 11417.828732569018, 674789.0, 677030.0, 678753.0, 684999.0, 689416.0, 122598.0, 126006.0, 128625.3320905373, 131218.0, 132949.0, 1039.9948000259951, 1041.1098510773331, 1041.5937784263992, 1049.165913099073, 1051.847482115089, 14441.0, 18198.909005454887, 18292.908535457238, 18407.447776566725, 18737.0, 50695.0, 55173.89652206853, 55613.0, 55915.44084559102, 55948.72025640008, 80144.59927700557, 80612.0, 81391.59304203678, 81820.77268841091, 82865.0, 8286.792830179294, 8377.0, 8379.748607541784, 8415.747527574182, 8458.0, 9512.38169518979, 12752.553660622205, 13122.278274694983, 13518.797218041935, 13674.453021879013, 11380.260283081574, 11383.772324553629, 11778.646640600795, 11883.762324753283, 12175.939120304341, 11565.421728913689, 11887.643370698894, 12118.0, 12153.635390938285, 12216.938915305367, 11881.762364752829, 12227.633171004883, 12309.199902006341, 12494.206877993098, 12507.74984500323, 8388.748337549883, 8437.451565648213, 8496.277816385676, 8607.741767746978, 8627.266682331821, 8582.184692454206, 10862.511186996446, 11882.346470944181, 11898.881011189776, 12106.878931210575], "unit": "score", "name": "jquery.html", "value": 9702.76443373389}, {"lowerIsBetter": false, "replicates": [1576.1488796050135, 1702.3190723710513, 2031.3398145602682, 2105.6946742722316, 2128.0636519931218, 8393.916060839405, 9051.0, 9155.90844091559, 9338.953305233481, 9342.906570934289, 9104.27165826734, 9127.726168214947, 9156.175944165025, 9197.816043679122, 9209.95395023024, 2536.1377131775193, 2557.7442255774367, 2559.5520783862844, 2574.3306740247576, 2580.6645136132274, 2511.309389917778, 2553.2340297910646, 2572.742725727431, 2574.1505303249883, 2584.7673709366154, 2531.253280282312, 2571.4471388651436, 2575.6780402449695, 2576.987115064422, 2580.948381032378, 2241.823042902473, 2472.1223965492263, 2539.9746002539923, 2540.466502034575, 2551.872406379683, 2093.769685334612, 2522.583773677341, 2568.2552059902605, 2586.237060067285, 2586.2629150691964, 7424.331810137113, 7790.7924271737975, 9356.766080847965, 9357.953210233973, 9392.67125650599, 5155.226715992593, 5666.093425051972, 5795.159701843209, 5825.592208545403, 5831.008728516163, 3152.801935264608, 3676.522052133232, 3750.6811920986747, 3788.4696142540065, 3817.6373244541724, 1088.5264909764198, 1102.72431892027, 1104.4808939798281, 1108.9556417743281, 1114.3369695031442, 12402.25586464815, 12409.255444673348, 12680.302583357912, 12690.42893069814, 12746.936265318707, 4060.878173654795, 4980.402351717817, 5117.0, 5126.15418455958, 5134.204198349262, 10490.790184196274, 10543.209259305582, 10601.310914790514, 10709.946450267698, 10759.139268858473, 5614.859628509238, 5681.0, 5742.483176514133, 5758.539316854725, 5774.711264436845, 4734.0, 5119.923201151985, 5148.227765835155, 5148.665336753099, 5214.1657334827005, 4055.4496345726347, 4128.669706423479, 4160.875173744793, 4184.476940382452, 4184.937225941613, 1152.3949926288765, 1340.9329533523285, 1348.9123206991515, 1360.9387577559035, 1364.3723887012086, 1413.5547302599648, 1416.709574537238, 1418.3050305350305, 1422.4452463539228, 1467.149053548939, 8500.10748871372, 8612.78468038304, 8687.782805429788, 8703.825923481494, 8714.564271786385, 537.1164434505295, 545.0298468725674, 546.3061911372614, 551.737924485866, 552.7595495959271, 6434.292227854932, 6438.291787903327, 6467.450266727381, 6509.316521765241, 6519.608823470512, 11165.609203677832, 11404.201705880509, 11437.885621143681, 11470.369129697947, 11500.194986351042, 10527.368357898398, 10895.400752958505, 11146.275492092987, 11181.161412894066, 11341.149413793999, 8644.092370301154, 8784.077671844492, 8791.0, 8803.559822008874, 8934.195922366887, 7276.927230727837, 8285.378596605158, 8369.665213391396, 8370.623321950405, 8527.74416767498, 9202.493862837608, 9880.011998800062, 9880.752981175528, 9983.60065597368, 10023.949880250551, 8719.910011248594, 9978.700638980843, 10131.240156988108, 10148.949255253676, 10342.896571034193, 7753.806154846174, 7819.765407037798, 7872.921270787448, 7891.171427000082, 7951.165127661512, 7135.8572828544175, 8478.788030299293, 8562.315014798925, 8606.870896936425, 8636.740897773077, 7687.231276872268, 7826.804329891571, 7858.646360913887, 7886.44794864354, 7927.920720792718, 7541.660625271767, 7702.998610180641, 7775.961120194363, 7837.255460731221, 7908.52548847071, 8042.718504852302, 8047.0, 8053.31546818527, 8160.26557609818, 8248.505089694638, 7268.018817459575, 7318.524295920748, 7393.334599885821, 7405.703771849066, 7431.777046688608, 7297.270272972661, 7362.6318684066655, 7399.889001664872, 7428.517146385468, 7446.962765186139], "unit": "score", "name": "mootools.html", "value": 5057.279875426698}, {"lowerIsBetter": false, "replicates": [343.178088478095, 345.8167171399159, 346.15192777694654, 353.764746443615, 354.07762777963404, 6849.589024658518, 6907.378335949764, 6920.550164239334, 6966.442684585234, 6966.756163534277, 6865.553739006974, 6868.8666370049, 6873.2095808981985, 6880.2775708550635, 6883.655817209132, 3947.624975627311, 4368.672349573779, 4701.435827700664, 4916.803327866881, 5055.696658200502, 4989.0, 5029.748512574357, 5040.84877453677, 5045.974770126144, 5073.39119305682, 4981.651284410093, 5008.373953255843, 5155.19568151146, 5156.252343410203, 5167.974160129194, 5047.31861198739, 5060.342155519796, 5065.265536497224, 5071.137906555876, 5090.236464530313, 4363.996280855421, 4371.388005679208, 4382.233109205877, 4382.342648602703, 4394.296912494017, 6304.148939893147, 6537.477001839841, 6565.67171641416, 6615.305392933769, 6615.569987950767, 4663.997240593255, 5899.941000589982, 5951.6726580038085, 5964.970175149097, 5968.31364393096, 7344.632768361561, 7362.5950572718475, 7367.226441223702, 7376.557406555624, 7379.1183248271345, 4744.07490539345, 4759.61923046159, 4759.881002974953, 4766.094442056033, 4782.617390608743, 6008.068749343815, 7119.1457025157315, 7707.460477766558, 7759.495632783851, 7782.883256751154, 4715.292706094114, 4784.593309568656, 4791.233402655558, 4793.976030119827, 4806.399200099988, 4860.9513904861205, 4862.659613827069, 4865.148598995162, 4867.756612169448, 4898.118338698997, 5852.385499522574, 5937.020391635332, 5951.672658003851, 5953.76184952597, 5983.04271316596, 6608.933910660928, 6817.659117044227, 7418.258174182539, 7421.8144546386775, 7426.9257307427315, 1634.6567220883749, 1678.4545022867374, 1693.1111166637613, 1703.6337187504746, 1707.0952395230547, 1067.4822710985165, 1068.9786204275872, 1088.6353071720903, 1091.6070214722693, 1093.830456279278, 7027.7188912442925, 7029.929700702927, 7038.788836334918, 7046.894296585555, 7062.364387205176, 5337.119375303031, 5356.116240820299, 6216.937830621636, 7496.475246732785, 7608.353289970304, 6028.367021462771, 6706.731730730814, 6933.618650974245, 7022.964885175541, 7042.542234754725, 3206.679332066821, 3999.8800035998966, 4026.416169655384, 4033.6369726724733, 4040.8989775255855, 6329.208848893888, 7695.611783156386, 7999.560024198725, 8027.317677997436, 8043.0, 6567.244766851778, 7843.882341764878, 7880.2513761192595, 7895.131535531087, 7909.327707144842, 7950.403719721044, 7960.601969901481, 7968.083670377865, 7992.440529162903, 7998.0402351717, 6038.5169186465855, 6822.522423430312, 7389.556626602421, 7564.773056808304, 7581.0, 7520.962395187989, 7568.053993250844, 7596.316331529968, 7599.126100498514, 7634.427417943565, 6492.285848556749, 8116.0, 8117.310028647631, 8130.674773009014, 8168.224018718212, 4627.565454709051, 4828.227483602606, 4870.342503761947, 4870.95129048705, 4872.269159626085, 6048.879022419439, 7490.887636685563, 7595.278448547379, 7609.162992070757, 7622.466427350032, 7304.5252058616015, 7406.0, 7417.332440080419, 7441.1070671519765, 7445.516041457288, 7421.517601355895, 7439.851202976019, 7444.255574442513, 7450.590217538087, 7456.254374562501, 7027.718891244497, 7235.3488186063505, 7238.167610724834, 7285.307895749896, 7287.41700663935, 7376.520526165782, 7423.851522969619, 7434.888476672746, 7436.516626419266, 7457.0, 5929.466348028698, 7280.235575264521, 7285.453590980592, 7294.2341054190665, 7297.927020729937], "unit": "score", "name": "prototype.html", "value": 5304.828315880164}, {"lowerIsBetter": false, "replicates": [715.7065603102728, 774.1136398823351, 776.1811289090011, 787.1459466478872, 794.0868001797932, 15467.0, 15763.684726305468, 15784.0, 15801.446949356774, 15830.525084247462, 14634.48779292725, 14672.19302938338, 14678.0, 14713.632159195999, 14748.631284217872, 800.2957397490201, 973.255459573427, 980.9852852207205, 1007.6674697349857, 1009.6314845081566, 997.4713401897006, 1008.5007921079076, 1012.1497941728946, 1013.8783345998454, 1018.0, 1015.4161357219591, 1037.9532921018572, 1064.9829412910651, 1068.4657671164418, 1069.7218723132003, 886.5389997201484, 1046.979060418795, 1056.2870062707718, 1057.8677665291839, 1057.9576816927313, 749.2881762325812, 761.2996043639864, 771.2904128202067, 781.3397678961269, 801.3028665061375, 15679.0, 15816.0, 15835.20823958809, 15878.9206053969, 15901.840981590152, 13415.664608384868, 13434.93282533581, 13445.19328840263, 13487.325633718276, 13567.389467473988, 10282.280240383176, 10419.635312764018, 10429.217808664305, 10455.215858810543, 10669.946650266776, 3660.249648821985, 3670.082479380155, 3698.9630103698887, 3778.6032466590887, 3934.9016274593077, 85427.57286213529, 85751.0, 86229.70655440174, 86805.0, 88018.0, 9556.283278754121, 9560.617575297048, 9738.951305243429, 9739.318247722591, 9888.307818452784, 22119.225827095976, 22127.0, 22177.11291548352, 22301.0, 22633.0, 7698.807529811799, 7868.606569671493, 8025.558594277254, 8128.83742325162, 8198.467099638505, 4258.914821703549, 4282.400463935051, 4294.656427485794, 4318.460192475941, 4509.0080182359825, 3610.151614370621, 3700.5929347771726, 3711.3690672585726, 3735.3463143950244, 3765.5293088363956, 634.8444631065419, 657.0636842499515, 660.5739298152664, 661.2891142022345, 666.3403230801472, 499.8025779816952, 521.637461963939, 555.5805366948009, 586.9706514674249, 597.1878245585999, 8100.513969161869, 8260.669573217125, 8319.542425166554, 8508.361872859436, 8591.44155629882, 542.6499907559602, 597.3399393670019, 604.8669292755586, 608.2761513798565, 608.6317777744489, 3881.0879443330796, 3882.514685664292, 3908.6482216600643, 3918.49059622253, 4058.6753059755147, 97810.0, 99818.0, 99924.0, 102912.48543757234, 103915.0, 75521.73434796964, 75768.0, 75854.62072689712, 76299.61850190714, 77243.0, 68884.27789305207, 69679.65160174268, 70003.64998174977, 70106.0, 70633.64683176551, 8831.735047948572, 8872.29021678277, 8893.911060889308, 8904.283432120536, 9059.63761449561, 50917.74541127271, 51319.48680513147, 51758.74120629373, 51846.74076629593, 52519.0, 65971.67014164898, 66323.00515492368, 67024.99462508164, 69537.30462695309, 71968.0, 11174.776504470028, 11375.31748095117, 11412.201145919706, 11414.086873050303, 11534.884651153718, 11977.101717371057, 12149.0, 12157.574484892986, 12398.62804115878, 12711.74576508446, 11776.104197047565, 11832.940835295769, 11964.222325548812, 11986.041116710468, 11995.460204290654, 10968.396738179477, 11563.132765042823, 11735.647930562096, 11841.955290374503, 12305.93847030759, 9632.22942164611, 10867.836982445111, 11549.076073914235, 11607.0, 11755.529778808752, 7947.364210863233, 10003.399796012263, 10063.446510441703, 10144.695659130239, 10342.172626189737, 9558.904410955802, 9631.0, 9646.951765241129, 9939.850902236327, 10009.799804004026], "unit": "score", "name": "yui.html", "value": 7189.629383351878}], "name": "dromaeo_css", "value": 7732.861384052544}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 116.0, 115.0, 114.0, 129.0, 115.0, 115.0, 117.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.8}, {"lowerIsBetter": true, "replicates": [146.0, 125.0, 138.0, 147.0, 142.0, 170.0, 175.0, 121.0, 148.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [193.0, 196.0, 193.0, 193.0, 193.0, 220.0, 277.0, 214.0, 198.0, 196.0], "unit": "score", "name": "audio-dft", "value": 207.3}, {"lowerIsBetter": true, "replicates": [73.0, 70.0, 71.0, 111.0, 60.0, 75.0, 91.0, 85.0, 159.0, 57.0], "unit": "score", "name": "audio-fft", "value": 85.2}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 98.0, 70.0, 89.0, 94.0, 128.0, 63.0, 71.0, 161.0], "unit": "score", "name": "audio-oscillator", "value": 94.5}, {"lowerIsBetter": true, "replicates": [104.0, 116.0, 88.0, 98.0, 126.0, 84.0, 91.0, 86.0, 78.0, 132.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.3}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 118.0, 153.0, 94.0, 107.0, 124.0, 94.0, 125.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 109.5}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 91.0, 90.0, 94.0, 90.0, 97.0, 92.0, 90.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 91.5}, {"lowerIsBetter": true, "replicates": [57.0, 61.0, 57.0, 67.0, 89.0, 91.0, 58.0, 60.0, 55.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 65.3}, {"lowerIsBetter": true, "replicates": [62.0, 64.0, 70.0, 68.0, 74.0, 72.0, 67.0, 64.0, 64.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 82.0, 83.0, 82.0, 82.0, 90.0, 109.0, 108.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.6}, {"lowerIsBetter": true, "replicates": [133.0, 123.0, 123.0, 119.0, 122.0, 122.0, 130.0, 129.0, 134.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [138.0, 138.0, 137.0, 180.0, 157.0, 132.0, 136.0, 134.0, 137.0, 124.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 67.0, 68.0, 65.0, 66.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1502.2999999999997}]} 11:32:32 INFO - Return code: 0 11:32:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:32:32 ERROR - # TBPL SUCCESS # 11:32:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:32:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:32:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:32:32 INFO - 2016-05-23 11:32:32.092 screenresolution[1695:12193] starting screenresolution argv=screenresolution get 11:32:32 INFO - 2016-05-23 11:32:32.095 screenresolution[1695:12193] Display 0: 1600x1200x32@60 11:32:32 INFO - 2016-05-23 11:32:32.100 screenresolution[1696:12196] starting screenresolution argv=screenresolution list 11:32:32 INFO - Available Modes on Display 0 11:32:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:32:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:32:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:32:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:32:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:32:32 INFO - Intel Iris: 11:32:32 INFO - Chipset Model: Intel Iris 11:32:32 INFO - Type: GPU 11:32:32 INFO - Bus: Built-In 11:32:32 INFO - VRAM (Dynamic, Max): 1536 MB 11:32:32 INFO - Vendor: Intel (0x8086) 11:32:32 INFO - Device ID: 0x0a2e 11:32:32 INFO - Revision ID: 0x0009 11:32:32 INFO - Displays: 11:32:32 INFO - Display: 11:32:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:32:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:32:32 INFO - Display Serial Number: 1600x1200 60 11:32:32 INFO - Main Display: Yes 11:32:32 INFO - Mirror: Off 11:32:32 INFO - Online: Yes 11:32:32 INFO - Rotation: Supported 11:32:32 INFO - Return code: 0 11:32:32 INFO - Running post-action listener: _resource_record_post_action 11:32:32 INFO - Running post-run listener: _resource_record_post_run 11:32:33 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 31284736; Write bytes: 511702528; Read time: 213; Write time: 1613 11:32:33 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 196442624; Write bytes: 197142528; Read time: 17777; Write time: 429 11:32:33 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 30363136; Write bytes: 304451072; Read time: 202; Write time: 1151 11:32:33 INFO - Running post-run listener: _upload_blobber_files 11:32:33 INFO - Blob upload gear active. 11:32:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:32:33 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 11:32:33 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'] 11:32:33 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 11:32:33 INFO - (blobuploader) - INFO - Open directory for files ... 11:32:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:32:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:32:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:35 INFO - (blobuploader) - INFO - Done attempting. 11:32:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:32:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:32:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:36 INFO - (blobuploader) - INFO - Done attempting. 11:32:36 INFO - (blobuploader) - INFO - Iteration through files over. 11:32:36 INFO - Return code: 0 11:32:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:32:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:32:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e4abe284b82185bbf4b8045826b5fe6097979d21786d9dc3281bfcfccf756139ac2b3944886440c4ed487836c9b3f887d81bd1bca56f4e1ca64785a75bdbd42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51b7fc926f7db30f41a2f19d92741bde1f4fd2b09ae7c08657c4aa13a19aad079fdaf02e5a869e56aa2909c3fc1ed94f7ef9404159885ef565d597e43e7278c0"} 11:32:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:32:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:32:36 INFO - Contents: 11:32:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e4abe284b82185bbf4b8045826b5fe6097979d21786d9dc3281bfcfccf756139ac2b3944886440c4ed487836c9b3f887d81bd1bca56f4e1ca64785a75bdbd42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51b7fc926f7db30f41a2f19d92741bde1f4fd2b09ae7c08657c4aa13a19aad079fdaf02e5a869e56aa2909c3fc1ed94f7ef9404159885ef565d597e43e7278c0"} 11:32:36 INFO - Running post-run listener: copy_logs_to_upload_dir 11:32:36 INFO - Copying logs to upload dir... 11:32:36 INFO - mkdir: /builds/slave/test/build/upload/logs 11:32:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.205280 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-23 11:32:36.566207) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:32:36.569848) ========= 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.dEEFdSOKmv/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.1anX425t7e/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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/7e4abe284b82185bbf4b8045826b5fe6097979d21786d9dc3281bfcfccf756139ac2b3944886440c4ed487836c9b3f887d81bd1bca56f4e1ca64785a75bdbd42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51b7fc926f7db30f41a2f19d92741bde1f4fd2b09ae7c08657c4aa13a19aad079fdaf02e5a869e56aa2909c3fc1ed94f7ef9404159885ef565d597e43e7278c0"} build_url:https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e4abe284b82185bbf4b8045826b5fe6097979d21786d9dc3281bfcfccf756139ac2b3944886440c4ed487836c9b3f887d81bd1bca56f4e1ca64785a75bdbd42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51b7fc926f7db30f41a2f19d92741bde1f4fd2b09ae7c08657c4aa13a19aad079fdaf02e5a869e56aa2909c3fc1ed94f7ef9404159885ef565d597e43e7278c0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:32:36.599227) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:32:36.599566) ========= 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.dEEFdSOKmv/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.1anX425t7e/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.005231 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:32:36.648356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:32:36.648683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:32:36.649320) ========= ========= Total master_lag: 0.17 =========