builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0304 starttime: 1466810462.31 results: success (0) buildid: 20160624143557 builduid: 67b95f07284347e7aea2678b4c3b20e6 revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 16:21:02.313699) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 16:21:02.314106) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 16:21:02.314382) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 16:21:02.340165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 16:21:02.340554) ========= 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.qgY93HxGKG/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.xdyG3KCz9J/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-24 16:21:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-06-24 16:21:02 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.369904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 16:21:02.735441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 16:21:02.735764) ========= 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.qgY93HxGKG/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.xdyG3KCz9J/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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.026632 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 16:21:02.784972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 16:21:02.788485) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 229741b7de0485ca56b91e0e657fe5d37dbbc98f --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 229741b7de0485ca56b91e0e657fe5d37dbbc98f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qgY93HxGKG/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.xdyG3KCz9J/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-24 16:21:02,870 truncating revision to first 12 chars 2016-06-24 16:21:02,870 Setting DEBUG logging. 2016-06-24 16:21:02,870 attempt 1/10 2016-06-24 16:21:02,871 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/229741b7de04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 16:21:04,305 unpacking tar archive at: mozilla-beta-229741b7de04/testing/mozharness/ program finished with exit code 0 elapsedTime=1.701634 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 16:21:04.515532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 16:21:04.515886) ========= script_repo_revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 16:21:04.516313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 16:21:04.516583) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 16:21:04.534472) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 30 mins, 37 secs) (at 2016-06-24 16:21:04.534866) ========= /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.qgY93HxGKG/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.xdyG3KCz9J/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 16:21:04 INFO - MultiFileLogger online at 20160624 16:21:04 in /builds/slave/test 16:21:04 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 16:21:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:21:04 INFO - {'append_to_log': False, 16:21:04 INFO - 'base_work_dir': '/builds/slave/test', 16:21:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:21:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:21:04 INFO - 'branch': 'Mozilla-Beta', 16:21:04 INFO - 'buildbot_json_path': 'buildprops.json', 16:21:04 INFO - 'config_files': ('talos/mac_config.py',), 16:21:04 INFO - 'default_actions': ('clobber', 16:21:04 INFO - 'read-buildbot-config', 16:21:04 INFO - 'download-and-extract', 16:21:04 INFO - 'populate-webroot', 16:21:04 INFO - 'create-virtualenv', 16:21:04 INFO - 'install', 16:21:04 INFO - 'run-tests'), 16:21:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:21:04 INFO - 'download_minidump_stackwalk': True, 16:21:04 INFO - 'download_symbols': 'ondemand', 16:21:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:21:04 INFO - 'tooltool.py': '/tools/tooltool.py', 16:21:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:21:04 INFO - '/tools/misc-python/virtualenv.py')}, 16:21:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:21:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:21:04 INFO - 'installer_path': 'installer.exe', 16:21:04 INFO - 'log_level': 'info', 16:21:04 INFO - 'log_name': 'talos', 16:21:04 INFO - 'log_to_console': True, 16:21:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:21:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:21:04 INFO - 'opt_config_files': (), 16:21:04 INFO - 'pip_index': False, 16:21:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:21:04 INFO - 'cmd': ('bash', 16:21:04 INFO - '-c', 16:21:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:21:04 INFO - 'enabled': True, 16:21:04 INFO - 'halt_on_failure': False, 16:21:04 INFO - 'name': 'check_screen_resolution'},), 16:21:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:21:04 INFO - 'cmd': ('bash', 16:21:04 INFO - '-c', 16:21:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:21:04 INFO - 'enabled': True, 16:21:04 INFO - 'halt_on_failure': False, 16:21:04 INFO - 'name': 'check_screen_resolution'},), 16:21:04 INFO - 'run_cmd_checks_enabled': True, 16:21:04 INFO - 'sps_profile': False, 16:21:04 INFO - 'sps_profile_interval': 0, 16:21:04 INFO - 'suite': 'dromaeojs-e10s', 16:21:04 INFO - 'system_bits': '32', 16:21:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:21:04 INFO - 'title': 't-yosemite-r7-0304', 16:21:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:21:04 INFO - 'use_talos_json': True, 16:21:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:21:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:21:04 INFO - 'work_dir': 'build'} 16:21:04 INFO - ##### 16:21:04 INFO - ##### Running clobber step. 16:21:04 INFO - ##### 16:21:04 INFO - Running pre-action listener: _resource_record_pre_action 16:21:04 INFO - Running main action method: clobber 16:21:04 INFO - rmtree: /builds/slave/test/build 16:21:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:21:06 INFO - Running post-action listener: _resource_record_post_action 16:21:06 INFO - ##### 16:21:06 INFO - ##### Running read-buildbot-config step. 16:21:06 INFO - ##### 16:21:06 INFO - Running pre-action listener: _resource_record_pre_action 16:21:06 INFO - Running main action method: read_buildbot_config 16:21:06 INFO - Using buildbot properties: 16:21:06 INFO - { 16:21:06 INFO - "project": "", 16:21:06 INFO - "product": "firefox", 16:21:06 INFO - "script_repo_revision": "production", 16:21:06 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 16:21:06 INFO - "repository": "", 16:21:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 16:21:06 INFO - "buildid": "20160624143557", 16:21:06 INFO - "pgo_build": "False", 16:21:06 INFO - "basedir": "/builds/slave/test", 16:21:06 INFO - "buildnumber": 6, 16:21:06 INFO - "slavename": "t-yosemite-r7-0304", 16:21:06 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:21:06 INFO - "platform": "yosemite_r7", 16:21:06 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:21:06 INFO - "branch": "mozilla-beta", 16:21:06 INFO - "repo_path": "releases/mozilla-beta", 16:21:06 INFO - "revision": "229741b7de0485ca56b91e0e657fe5d37dbbc98f", 16:21:06 INFO - "stage_platform": "macosx64", 16:21:06 INFO - "builduid": "67b95f07284347e7aea2678b4c3b20e6", 16:21:06 INFO - "slavebuilddir": "test" 16:21:06 INFO - } 16:21:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 16:21:06 INFO - Running post-action listener: _resource_record_post_action 16:21:06 INFO - ##### 16:21:06 INFO - ##### Running download-and-extract step. 16:21:06 INFO - ##### 16:21:06 INFO - Running pre-action listener: _resource_record_pre_action 16:21:06 INFO - Running main action method: download_and_extract 16:21:06 INFO - mkdir: /builds/slave/test/build/tests 16:21:06 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')]} 16:21:06 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:21:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 16:21:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 16:21:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 16:21:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 16:21:08 INFO - Downloaded 1165 bytes. 16:21:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 16:21:08 INFO - Using the following test package requirements: 16:21:08 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 16:21:08 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:21:08 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 16:21:08 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:21:08 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 16:21:08 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:21:08 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:21:08 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 16:21:08 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 16:21:08 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:21:08 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 16:21:08 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:21:08 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 16:21:08 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:21:08 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 16:21:08 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:21:08 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 16:21:08 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 16:21: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')]} 16:21:08 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:21:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 16:21:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 16:21:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 16:21:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 16:21:14 INFO - Downloaded 18344069 bytes. 16:21:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:21:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:21:17 INFO - Return code: 0 16:21:17 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:21: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')]} 16:21:17 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 16:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 16:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 16:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 16:21:18 INFO - Downloaded 18344069 bytes. 16:21:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:21:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:21:22 INFO - Return code: 0 16:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:22 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 16:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 16:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 16:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 16:21:23 INFO - Downloaded 10840145 bytes. 16:21:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:21:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:21:23 INFO - Return code: 0 16:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:23 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 16:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 16:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 16:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 16:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 16:31:09 INFO - Downloaded 86227039 bytes. 16:31:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 16:31:09 INFO - mkdir: /builds/slave/test/properties 16:31:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:09 INFO - Contents: 16:31:09 INFO - build_url:https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 16:31:10 INFO - Running post-action listener: _resource_record_post_action 16:31:10 INFO - Running post-action listener: set_extra_try_arguments 16:31:10 INFO - ##### 16:31:10 INFO - ##### Running populate-webroot step. 16:31:10 INFO - ##### 16:31:10 INFO - Running pre-action listener: _resource_record_pre_action 16:31:10 INFO - Running main action method: populate_webroot 16:31:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:10 INFO - '--tppagecycles', 16:31:10 INFO - '7'], 16:31:10 INFO - 'tests': ['tsvgm']}}, 16:31:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:31:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:31:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:31:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:31:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:31:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:10 INFO - 'talos_options': ['--disable-e10s'], 16:31:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:10 INFO - 'talos_options': ['--disable-e10s'], 16:31:10 INFO - 'tests': ['damp', 'tps']}, 16:31:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:10 INFO - 'tests': ['damp', 'tps']}, 16:31:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:31:10 INFO - 'tests': ['dromaeo_dom']}, 16:31:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:31:10 INFO - 'tests': ['a11yr', 16:31:10 INFO - 'ts_paint', 16:31:10 INFO - 'tpaint', 16:31:10 INFO - 'sessionrestore', 16:31:10 INFO - 'sessionrestore_no_auto_restore', 16:31:10 INFO - 'tabpaint']}, 16:31:10 INFO - 'other-e10s': {'tests': ['a11yr', 16:31:10 INFO - 'ts_paint', 16:31:10 INFO - 'tpaint', 16:31:10 INFO - 'sessionrestore', 16:31:10 INFO - 'sessionrestore_no_auto_restore', 16:31:10 INFO - 'tabpaint']}, 16:31:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:31:10 INFO - 'ts_paint', 16:31:10 INFO - 'tpaint', 16:31:10 INFO - 'sessionrestore', 16:31:10 INFO - 'sessionrestore_no_auto_restore', 16:31:10 INFO - 'tabpaint']}, 16:31:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:31:10 INFO - 'ts_paint', 16:31:10 INFO - 'tpaint', 16:31:10 INFO - 'sessionrestore', 16:31:10 INFO - 'sessionrestore_no_auto_restore', 16:31:10 INFO - 'tabpaint']}, 16:31:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:31:10 INFO - 'tests': ['a11yr', 16:31:10 INFO - 'ts_paint', 16:31:10 INFO - 'tpaint', 16:31:10 INFO - 'sessionrestore', 16:31:10 INFO - 'sessionrestore_no_auto_restore', 16:31:10 INFO - 'tabpaint']}, 16:31:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:31:10 INFO - 'tests': ['a11yr', 16:31:10 INFO - 'ts_paint', 16:31:10 INFO - 'tpaint', 16:31:10 INFO - 'sessionrestore', 16:31:10 INFO - 'sessionrestore_no_auto_restore', 16:31:10 INFO - 'tabpaint']}, 16:31:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:31:10 INFO - 'tests': ['tsvgx', 16:31:10 INFO - 'tsvgr_opacity', 16:31:10 INFO - 'tart', 16:31:10 INFO - 'tscrollx', 16:31:10 INFO - 'cart']}, 16:31:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:31:10 INFO - 'tsvgr_opacity', 16:31:10 INFO - 'tart', 16:31:10 INFO - 'tscrollx', 16:31:10 INFO - 'cart']}, 16:31:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:10 INFO - 'talos_options': ['--disable-e10s'], 16:31:10 INFO - 'tests': ['tp5o']}, 16:31:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:10 INFO - 'tests': ['tp5o']}, 16:31:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:10 INFO - 'talos_options': ['--disable-e10s', 16:31:10 INFO - '--xperf_path', 16:31:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:10 INFO - 'tests': ['tp5n']}, 16:31:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:10 INFO - 'talos_options': ['--xperf_path', 16:31:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:10 INFO - 'tests': ['tp5n']}}, 16:31:10 INFO - 'talos.zip': {'path': '', 16:31:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:10 INFO - Running post-action listener: _resource_record_post_action 16:31:10 INFO - ##### 16:31:10 INFO - ##### Running create-virtualenv step. 16:31:10 INFO - ##### 16:31:10 INFO - Running pre-action listener: _resource_record_pre_action 16:31:10 INFO - Running main action method: create_virtualenv 16:31:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:10 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 16:31:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:10 INFO - Using real prefix '/tools/python27' 16:31:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:13 INFO - Installing pip.................done. 16:31:13 INFO - Return code: 0 16:31:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:13 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 0x107175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107185420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f848b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107014e00>, '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 0x106e7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10700fb20>, '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.qgY93HxGKG/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.xdyG3KCz9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 16:31:13 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 16:31:13 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 16:31:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgY93HxGKG/Render', 16:31:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:13 INFO - 'HOME': '/Users/cltbld', 16:31:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:13 INFO - 'LOGNAME': 'cltbld', 16:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:13 INFO - 'MOZ_NO_REMOTE': '1', 16:31:13 INFO - 'NO_EM_RESTART': '1', 16:31:13 INFO - 'PAGER': '/bin/cat', 16:31:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:13 INFO - 'PWD': '/builds/slave/test', 16:31:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:13 INFO - 'SHELL': '/bin/bash', 16:31:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xdyG3KCz9J/Listeners', 16:31:13 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 16:31:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:13 INFO - 'USER': 'cltbld', 16:31:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:13 INFO - 'XPC_FLAGS': '0x0', 16:31:13 INFO - 'XPC_SERVICE_NAME': '0', 16:31:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:14 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 16:31:14 INFO - Cleaning up... 16:31:14 INFO - Return code: 0 16:31:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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', '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 0x107175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107185420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f848b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107014e00>, '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 0x106e7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10700fb20>, '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.qgY93HxGKG/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.xdyG3KCz9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 16:31: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', 'psutil>=0.7.1'] in /builds/slave/test/build 16:31: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 psutil>=0.7.1 16:31:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgY93HxGKG/Render', 16:31:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:14 INFO - 'HOME': '/Users/cltbld', 16:31:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:14 INFO - 'LOGNAME': 'cltbld', 16:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:14 INFO - 'MOZ_NO_REMOTE': '1', 16:31:14 INFO - 'NO_EM_RESTART': '1', 16:31:14 INFO - 'PAGER': '/bin/cat', 16:31:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:14 INFO - 'PWD': '/builds/slave/test', 16:31:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:14 INFO - 'SHELL': '/bin/bash', 16:31:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xdyG3KCz9J/Listeners', 16:31:14 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 16:31:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:14 INFO - 'USER': 'cltbld', 16:31:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:14 INFO - 'XPC_FLAGS': '0x0', 16:31:14 INFO - 'XPC_SERVICE_NAME': '0', 16:31:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:14 INFO - Downloading/unpacking psutil>=0.7.1 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:17 INFO - Installing collected packages: psutil 16:31:17 INFO - Running setup.py install for psutil 16:31:17 INFO - building 'psutil._psutil_osx' extension 16:31:17 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 16:31:18 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 16:31:18 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 16:31:18 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 16:31:18 INFO - building 'psutil._psutil_posix' extension 16:31:18 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 16:31:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:31:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:31:18 INFO - ^ 16:31:18 INFO - 1 warning generated. 16:31:18 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 16:31:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:18 INFO - Successfully installed psutil 16:31:18 INFO - Cleaning up... 16:31:18 INFO - Return code: 0 16:31:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:31:18 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')]} 16:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:18 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')]} 16:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:18 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 0x107175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107185420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f848b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107014e00>, '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 0x106e7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10700fb20>, '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.qgY93HxGKG/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.xdyG3KCz9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 16:31:18 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 16:31:18 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 16:31:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgY93HxGKG/Render', 16:31:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:18 INFO - 'HOME': '/Users/cltbld', 16:31:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:18 INFO - 'LOGNAME': 'cltbld', 16:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:18 INFO - 'MOZ_NO_REMOTE': '1', 16:31:18 INFO - 'NO_EM_RESTART': '1', 16:31:18 INFO - 'PAGER': '/bin/cat', 16:31:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:18 INFO - 'PWD': '/builds/slave/test', 16:31:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:18 INFO - 'SHELL': '/bin/bash', 16:31:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xdyG3KCz9J/Listeners', 16:31:18 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 16:31:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:18 INFO - 'USER': 'cltbld', 16:31:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:18 INFO - 'XPC_FLAGS': '0x0', 16:31:18 INFO - 'XPC_SERVICE_NAME': '0', 16:31:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:31:18 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 16:31:18 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 16:31:18 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 16:31:18 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 16:31:18 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 16:31:18 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 16:31:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:31:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:31:21 INFO - Installing collected packages: mozsystemmonitor 16:31:21 INFO - Running setup.py install for mozsystemmonitor 16:31:21 INFO - Successfully installed mozsystemmonitor 16:31:21 INFO - Cleaning up... 16:31:21 INFO - Return code: 0 16:31:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:21 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 0x107175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107185420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f848b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107014e00>, '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 0x106e7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10700fb20>, '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.qgY93HxGKG/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.xdyG3KCz9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 16:31:21 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 16:31:21 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 16:31:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgY93HxGKG/Render', 16:31:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:21 INFO - 'HOME': '/Users/cltbld', 16:31:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:21 INFO - 'LOGNAME': 'cltbld', 16:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:21 INFO - 'MOZ_NO_REMOTE': '1', 16:31:21 INFO - 'NO_EM_RESTART': '1', 16:31:21 INFO - 'PAGER': '/bin/cat', 16:31:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:21 INFO - 'PWD': '/builds/slave/test', 16:31:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:21 INFO - 'SHELL': '/bin/bash', 16:31:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xdyG3KCz9J/Listeners', 16:31:21 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 16:31:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:21 INFO - 'USER': 'cltbld', 16:31:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:21 INFO - 'XPC_FLAGS': '0x0', 16:31:21 INFO - 'XPC_SERVICE_NAME': '0', 16:31:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:21 INFO - Downloading/unpacking blobuploader==1.2.4 16:31:21 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 16:31:21 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 16:31:21 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 16:31:21 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 16:31:21 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 16:31:21 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 16:31:24 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31:24 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 16:31:24 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 16:31:24 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 16:31:24 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 16:31:24 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 16:31:24 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 16:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31:24 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 16:31:24 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 16:31:24 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 16:31:24 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 16:31:24 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 16:31:24 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 16:31:25 INFO - Downloading docopt-0.6.1.tar.gz 16:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:25 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:25 INFO - Running setup.py install for blobuploader 16:31:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:25 INFO - Running setup.py install for requests 16:31:26 INFO - Running setup.py install for docopt 16:31:26 INFO - Successfully installed blobuploader requests docopt 16:31:26 INFO - Cleaning up... 16:31:26 INFO - Return code: 0 16:31:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:26 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 0x107175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107185420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f848b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107014e00>, '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 0x106e7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10700fb20>, '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.qgY93HxGKG/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.xdyG3KCz9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 16:31:26 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 16:31:26 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 16:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgY93HxGKG/Render', 16:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:26 INFO - 'HOME': '/Users/cltbld', 16:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:26 INFO - 'LOGNAME': 'cltbld', 16:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:26 INFO - 'MOZ_NO_REMOTE': '1', 16:31:26 INFO - 'NO_EM_RESTART': '1', 16:31:26 INFO - 'PAGER': '/bin/cat', 16:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:26 INFO - 'PWD': '/builds/slave/test', 16:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:26 INFO - 'SHELL': '/bin/bash', 16:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xdyG3KCz9J/Listeners', 16:31:26 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 16:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:26 INFO - 'USER': 'cltbld', 16:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:26 INFO - 'XPC_FLAGS': '0x0', 16:31:26 INFO - 'XPC_SERVICE_NAME': '0', 16:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:26 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-1jIEJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:26 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-twe6ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:26 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-xyaqeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:27 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-o3zByk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:27 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-0L8BJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:27 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-BQb1cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:27 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-71J18K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:27 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-lt7V6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:27 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-1x1sFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:27 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-9wVpar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:27 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-OJNDbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:27 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-Xn1FrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:27 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-nqUWgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:28 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-YAWl7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:28 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-yhBbPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:28 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-27PeFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:28 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-AgUoXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:28 INFO - Running setup.py install for manifestparser 16:31:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:28 INFO - Running setup.py install for mozcrash 16:31:28 INFO - Running setup.py install for mozdebug 16:31:28 INFO - Running setup.py install for mozdevice 16:31:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:31:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:29 INFO - Running setup.py install for mozfile 16:31:29 INFO - Running setup.py install for mozhttpd 16:31:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:29 INFO - Running setup.py install for mozinfo 16:31:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:29 INFO - Running setup.py install for mozInstall 16:31:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:29 INFO - Running setup.py install for mozleak 16:31:29 INFO - Running setup.py install for mozlog 16:31:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:29 INFO - Running setup.py install for moznetwork 16:31:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:30 INFO - Running setup.py install for mozprocess 16:31:30 INFO - Running setup.py install for mozprofile 16:31:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:30 INFO - Running setup.py install for mozrunner 16:31:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:30 INFO - Running setup.py install for mozscreenshot 16:31:30 INFO - Running setup.py install for moztest 16:31:30 INFO - Running setup.py install for mozversion 16:31:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:31 INFO - Cleaning up... 16:31:31 INFO - Return code: 0 16:31:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:31 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 0x107175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107185420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f848b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107014e00>, '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 0x106e7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10700fb20>, '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.qgY93HxGKG/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.xdyG3KCz9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 16:31:31 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 16:31:31 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 16:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgY93HxGKG/Render', 16:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:31 INFO - 'HOME': '/Users/cltbld', 16:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:31 INFO - 'LOGNAME': 'cltbld', 16:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:31 INFO - 'MOZ_NO_REMOTE': '1', 16:31:31 INFO - 'NO_EM_RESTART': '1', 16:31:31 INFO - 'PAGER': '/bin/cat', 16:31:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:31 INFO - 'PWD': '/builds/slave/test', 16:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:31 INFO - 'SHELL': '/bin/bash', 16:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xdyG3KCz9J/Listeners', 16:31:31 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 16:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:31 INFO - 'USER': 'cltbld', 16:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:31 INFO - 'XPC_FLAGS': '0x0', 16:31:31 INFO - 'XPC_SERVICE_NAME': '0', 16:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-cXxqsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:31 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)) 16:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-I0VOJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:31 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)) 16:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-wdKxsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:31 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)) 16:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-PeuHnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:31 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)) 16:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-SDh2tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:31 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)) 16:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-6ej0T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:31 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)) 16:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-FkXyvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:32 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)) 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-CPADxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:32 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)) 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-YePor8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:32 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)) 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-uOaJD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:32 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)) 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-q5AIn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:32 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)) 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-ODsKor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:32 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)) 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-dYpnKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:32 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)) 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-Bx2PcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:32 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)) 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-kfIS5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:32 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)) 16:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-fdtQK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:33 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)) 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:33 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-7OpCEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:33 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)) 16:31:33 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)) 16:31:33 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)) 16:31:33 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)) 16:31:33 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)) 16:31:33 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)) 16:31:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:35 INFO - Downloading blessings-1.6.tar.gz 16:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:31:35 INFO - Installing collected packages: blessings 16:31:35 INFO - Running setup.py install for blessings 16:31:35 INFO - Successfully installed blessings 16:31:35 INFO - Cleaning up... 16:31:36 INFO - Return code: 0 16:31:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:31:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:36 INFO - Reading from file tmpfile_stdout 16:31:36 INFO - Current package versions: 16:31:36 INFO - blessings == 1.6 16:31:36 INFO - blobuploader == 1.2.4 16:31:36 INFO - docopt == 0.6.1 16:31:36 INFO - manifestparser == 1.1 16:31:36 INFO - mozInstall == 1.12 16:31:36 INFO - mozcrash == 0.17 16:31:36 INFO - mozdebug == 0.1 16:31:36 INFO - mozdevice == 0.48 16:31:36 INFO - mozfile == 1.2 16:31:36 INFO - mozhttpd == 0.7 16:31:36 INFO - mozinfo == 0.9 16:31:36 INFO - mozleak == 0.1 16:31:36 INFO - mozlog == 3.1 16:31:36 INFO - moznetwork == 0.27 16:31:36 INFO - mozprocess == 0.22 16:31:36 INFO - mozprofile == 0.28 16:31:36 INFO - mozrunner == 6.11 16:31:36 INFO - mozscreenshot == 0.1 16:31:36 INFO - mozsystemmonitor == 0.0 16:31:36 INFO - moztest == 0.7 16:31:36 INFO - mozversion == 1.4 16:31:36 INFO - psutil == 3.1.1 16:31:36 INFO - requests == 1.2.3 16:31:36 INFO - wsgiref == 0.1.2 16:31:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:36 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 0x107175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107185420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f848b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107014e00>, '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 0x106e7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10700fb20>, '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.qgY93HxGKG/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.xdyG3KCz9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 16:31:36 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 16:31:36 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 16:31:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgY93HxGKG/Render', 16:31:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:36 INFO - 'HOME': '/Users/cltbld', 16:31:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:36 INFO - 'LOGNAME': 'cltbld', 16:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:36 INFO - 'MOZ_NO_REMOTE': '1', 16:31:36 INFO - 'NO_EM_RESTART': '1', 16:31:36 INFO - 'PAGER': '/bin/cat', 16:31:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:36 INFO - 'PWD': '/builds/slave/test', 16:31:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:36 INFO - 'SHELL': '/bin/bash', 16:31:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xdyG3KCz9J/Listeners', 16:31:36 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 16:31:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:36 INFO - 'USER': 'cltbld', 16:31:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:36 INFO - 'XPC_FLAGS': '0x0', 16:31:36 INFO - 'XPC_SERVICE_NAME': '0', 16:31:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:36 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)) 16:31:36 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)) 16:31:36 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)) 16:31:36 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)) 16:31:36 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)) 16:31:36 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)) 16:31:36 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)) 16:31:36 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)) 16:31:36 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)) 16:31:36 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)) 16:31:36 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)) 16:31:36 INFO - Cleaning up... 16:31:36 INFO - Return code: 0 16:31:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:36 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 0x107175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107185420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f848b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107014e00>, '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 0x106e7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10700fb20>, '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.qgY93HxGKG/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.xdyG3KCz9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 16:31:36 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 16:31:36 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 16:31:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgY93HxGKG/Render', 16:31:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:36 INFO - 'HOME': '/Users/cltbld', 16:31:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:36 INFO - 'LOGNAME': 'cltbld', 16:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:36 INFO - 'MOZ_NO_REMOTE': '1', 16:31:36 INFO - 'NO_EM_RESTART': '1', 16:31:36 INFO - 'PAGER': '/bin/cat', 16:31:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:36 INFO - 'PWD': '/builds/slave/test', 16:31:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:36 INFO - 'SHELL': '/bin/bash', 16:31:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xdyG3KCz9J/Listeners', 16:31:36 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 16:31:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:36 INFO - 'USER': 'cltbld', 16:31:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:36 INFO - 'XPC_FLAGS': '0x0', 16:31:36 INFO - 'XPC_SERVICE_NAME': '0', 16:31:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:36 INFO - Downloading/unpacking jsonschema 16:31:36 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 16:31:36 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 16:31:36 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 16:31:36 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 16:31:36 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 16:31:36 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 16:31:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:31:39 INFO - Downloading/unpacking functools32 (from jsonschema) 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31:39 INFO - Downloading functools32-3.2.3-2.tar.gz 16:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:31:39 INFO - warning: no files found matching '*.txt' 16:31:39 INFO - no previously-included directories found matching 'build' 16:31:39 INFO - no previously-included directories found matching 'dist' 16:31:39 INFO - no previously-included directories found matching '.git*' 16:31:39 INFO - Installing collected packages: jsonschema, functools32 16:31:39 INFO - Running setup.py install for functools32 16:31:39 INFO - warning: no files found matching '*.txt' 16:31:39 INFO - no previously-included directories found matching 'build' 16:31:39 INFO - no previously-included directories found matching 'dist' 16:31:39 INFO - no previously-included directories found matching '.git*' 16:31:39 INFO - Successfully installed jsonschema functools32 16:31:39 INFO - Cleaning up... 16:31:40 INFO - Return code: 0 16:31:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107175a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107185420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5f848b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107014e00>, '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 0x106e7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10700fb20>, '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.qgY93HxGKG/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.xdyG3KCz9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 16:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:31:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgY93HxGKG/Render', 16:31:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:40 INFO - 'HOME': '/Users/cltbld', 16:31:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:40 INFO - 'LOGNAME': 'cltbld', 16:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:40 INFO - 'MOZ_NO_REMOTE': '1', 16:31:40 INFO - 'NO_EM_RESTART': '1', 16:31:40 INFO - 'PAGER': '/bin/cat', 16:31:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:40 INFO - 'PWD': '/builds/slave/test', 16:31:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:40 INFO - 'SHELL': '/bin/bash', 16:31:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xdyG3KCz9J/Listeners', 16:31:40 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 16:31:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:40 INFO - 'USER': 'cltbld', 16:31:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:40 INFO - 'XPC_FLAGS': '0x0', 16:31:40 INFO - 'XPC_SERVICE_NAME': '0', 16:31:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:40 INFO - Downloading/unpacking flake8 16:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:31:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:31:42 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 16:31:42 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 16:31:42 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 16:31:42 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 16:31:42 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 16:31:42 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 16:31:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:31:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:31:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:31:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:31:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:31:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:31:44 INFO - no previously-included directories found matching 'docs/_build' 16:31:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:31:44 INFO - Running setup.py install for pep8 16:31:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:31:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:31:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:31:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:31:44 INFO - no previously-included directories found matching 'docs/_build' 16:31:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:31:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:31:44 INFO - Cleaning up... 16:31:44 INFO - Return code: 0 16:31:44 INFO - Running post-action listener: _resource_record_post_action 16:31:44 INFO - Running post-action listener: _start_resource_monitoring 16:31:44 INFO - Starting resource monitoring. 16:31:44 INFO - ##### 16:31:44 INFO - ##### Running install step. 16:31:44 INFO - ##### 16:31:44 INFO - Running pre-action listener: _resource_record_pre_action 16:31:44 INFO - Running main action method: install 16:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:44 INFO - Reading from file tmpfile_stdout 16:31:44 INFO - Detecting whether we're running mozinstall >=1.0... 16:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:31:44 INFO - Reading from file tmpfile_stdout 16:31:44 INFO - Output received: 16:31:44 INFO - Usage: mozinstall [options] installer 16:31:44 INFO - Options: 16:31:44 INFO - -h, --help show this help message and exit 16:31:44 INFO - -d DEST, --destination=DEST 16:31:44 INFO - Directory to install application into. [default: 16:31:44 INFO - "/builds/slave/test"] 16:31:44 INFO - --app=APP Application being installed. [default: firefox] 16:31:44 INFO - mkdir: /builds/slave/test/build/application 16:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 16:32:06 INFO - Reading from file tmpfile_stdout 16:32:06 INFO - Output received: 16:32:06 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:32:06 INFO - Running post-action listener: _resource_record_post_action 16:32:06 INFO - ##### 16:32:06 INFO - ##### Running run-tests step. 16:32:06 INFO - ##### 16:32:06 INFO - Running pre-action listener: _resource_record_pre_action 16:32:06 INFO - Running main action method: run_tests 16:32:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:32:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:32:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:32:06 INFO - 2016-06-24 16:32:06.440 screenresolution[1644:8191] starting screenresolution argv=screenresolution get 16:32:06 INFO - 2016-06-24 16:32:06.443 screenresolution[1644:8191] Display 0: 1600x1200x32@60 16:32:06 INFO - 2016-06-24 16:32:06.449 screenresolution[1645:8194] starting screenresolution argv=screenresolution list 16:32:06 INFO - Available Modes on Display 0 16:32:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:32:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:32:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:32:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:32:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:32:06 INFO - Intel Iris: 16:32:06 INFO - Chipset Model: Intel Iris 16:32:06 INFO - Type: GPU 16:32:06 INFO - Bus: Built-In 16:32:06 INFO - VRAM (Dynamic, Max): 1536 MB 16:32:06 INFO - Vendor: Intel (0x8086) 16:32:06 INFO - Device ID: 0x0a2e 16:32:06 INFO - Revision ID: 0x0009 16:32:06 INFO - Displays: 16:32:06 INFO - Display: 16:32:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:32:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:32:06 INFO - Display Serial Number: 1600x1200 60 16:32:06 INFO - Main Display: Yes 16:32:06 INFO - Mirror: Off 16:32:06 INFO - Online: Yes 16:32:06 INFO - Rotation: Supported 16:32:06 INFO - Return code: 0 16:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:06 INFO - Python 2.7.3 16:32:06 INFO - Return code: 0 16:32:06 INFO - grabbing minidump binary from tooltool 16:32:06 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')]} 16:32:06 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 0x107014e00>, '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 0x106e7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10700fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:06 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 16:32:06 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 16:32:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:06 INFO - Return code: 0 16:32:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:32:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:32:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:32:07 INFO - Return code: 0 16:32:07 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/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0304', '--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 16:32:07 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/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0304 --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 16:32:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgY93HxGKG/Render', 16:32:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:07 INFO - 'HOME': '/Users/cltbld', 16:32:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:07 INFO - 'LOGNAME': 'cltbld', 16:32:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:07 INFO - 'MOZ_NO_REMOTE': '1', 16:32:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:07 INFO - 'NO_EM_RESTART': '1', 16:32:07 INFO - 'PAGER': '/bin/cat', 16:32:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:07 INFO - 'PWD': '/builds/slave/test', 16:32:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:07 INFO - 'SHELL': '/bin/bash', 16:32:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xdyG3KCz9J/Listeners', 16:32:07 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 16:32:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:07 INFO - 'USER': 'cltbld', 16:32:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:07 INFO - 'XPC_FLAGS': '0x0', 16:32:07 INFO - 'XPC_SERVICE_NAME': '0', 16:32:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:07 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/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0304', '--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 16:32:08 INFO - mozversion application_buildid: 20160624143557 16:32:08 INFO - mozversion application_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 16:32:08 INFO - mozversion application_display_name: Firefox 16:32:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:08 INFO - mozversion application_name: Firefox 16:32:08 INFO - mozversion application_remotingname: firefox 16:32:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:32:08 INFO - mozversion application_vendor: Mozilla 16:32:08 INFO - mozversion application_version: 48.0 16:32:08 INFO - mozversion platform_buildid: 20160624143557 16:32:08 INFO - mozversion platform_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 16:32:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:32:08 INFO - mozversion platform_version: 48.0 16:32:08 INFO - using testdate: 1466811128 16:32:08 INFO - actual date: 1466811128 16:32:08 INFO - starting webserver on 'localhost:49271' 16:32:08 INFO - SUITE-START | Running 2 tests 16:32:08 INFO - TEST-START | dromaeo_css 16:32:08 INFO - operating with platform_type : mac_ 16:32:08 INFO - Initialising browser for dromaeo_css test... 16:32:08 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpCFLTxA/profile http://localhost:49271/getInfo.html) 16:32:11 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 16:32:11 INFO - PROCESS | 1663 | colorDepth:24 16:32:11 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 16:32:11 INFO - PROCESS | 1663 | __metrics 16:32:11 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:32:11 INFO - TEST-INFO | 1663: exit 0 16:32:11 INFO - Browser initialized. 16:32:11 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:11 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpCFLTxA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:23 INFO - PROCESS | 1668 | RSS: Main: 170647552 16:32:23 INFO - PROCESS | 1668 | 16:33:13 INFO - PROCESS | 1668 | 1466811193257 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] 16:35:23 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 16:35:24 INFO - PROCESS | 1668 | RSS: Main: 182775808 16:35:24 INFO - PROCESS | 1668 | 16:38:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 16:38:27 INFO - PROCESS | 1668 | RSS: Main: 192159744 16:38:27 INFO - PROCESS | 1668 | 16:41:29 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 16:41:30 INFO - PROCESS | 1668 | RSS: Main: 194334720 16:41:30 INFO - PROCESS | 1668 | 16:44:31 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 16:44:32 INFO - PROCESS | 1668 | RSS: Main: 197910528 16:44:32 INFO - PROCESS | 1668 | 16:47:34 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 16:47:35 INFO - PROCESS | 1668 | RSS: Main: 197357568 16:47:35 INFO - PROCESS | 1668 | 16:50:37 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 16:50:37 INFO - PROCESS | 1668 | RSS: Main: 202571776 16:50:37 INFO - PROCESS | 1668 | 16:50:37 INFO - PROCESS | 1668 | __start_tp_report 16:50:37 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 16:50:37 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 16:50:37 INFO - PROCESS | 1668 | |i|pagename|runs| 16:50:37 INFO - PROCESS | 1668 | |0;dojo.html;3695.076230942264;3702.1670124222046;3716.4982727331803;3738.383166777482;3774.9618854814908;6069.848253793646;6083.634981901078;6086.543509236808;6094.481969032632;6096.390360963901;5973.940260597393;6105.236845394325;6112;6122.173506576611;6136.785212517563;5433.4566543345745;5461.399246082928;5534.723263836792;5559.305086864142;5597.552195824344;5437.619366644337;5475.06923822951;5480.314960629921;5536.861578460531;5635.520980716644;5568.749406276707;5572.58205634577;5580.190872323511;5585;5587.497125258726;5499.670019798825;5553.916691249635;5561.249231353776;5562.443755624446;5583.720813959306;4487.775611219426;5382.9730851345885;5386.569074474072;5459.5359394451125;5485.6982865942355;5878.882422351529;5958.791442299499;5965.642061476326;5995.700214989277;6048.334683184846;6203.751849926042;6292.937070629327;6300.621962682254;6349.777757778455;6401.967990160019;6409.4551963083195;6472.158619379497;6483.513736469784;6515.446187074104;6528.93471065288;6159.23009623797;6172.567920245585;6190.566660333779;6211.2857021442205;6223.253209614875;5318.9202161967605;6465.191851018622;6599.53803233769;6649.634270115093;6690.364415380531;5605.850800585951;6080.969595151996;6225.937740622627;6314.179156709598;6319.115323854664;6395.072714456471;6408.679566021773;6470.676466176767;6473.126127972758;6473.352664733489;6245.750169993149;6255.96872015637;6300.401461861115;6335.524835637346;6356.4279214870885;6340.144080549159;6362.236531616143;6389;6400.871982560323;6409.903851442232;5057.140286151363;5136.30659860914;5137.871553211125;5138.87152821175;5160.200168973815;4635.976820115945;4674.275487299474;4688.906221875543;4690.671652984258;4705.411823522059;6042.305134909454;6084.300305464928;6129.969350153221;6166.660833654102;6172.567920245539;6447.387498187664;6481.578697384655;6481.773137940149;6482.222133344029;6482.319356467598;6025.8192254232445;6128.295246046761;6160.568760186744;6177.96911015442;6183.134361189437;5632.60571759981;5638.097904335286;5643.689597072118;5654;5667.659940403589;6684.097646817618;6703.631300278532;6724.462043036546;6741.3932746052105;6743.865122697617;6316.368363163647;6347.39699728525;6465.2564955030775;6482.222133344029;6507.9912613544975;6679.732810687518;6693.1298931138645;6695.464362851058;6710.798676039727;6721.294264102199;6380.712867921047;6390.297067322498;6391.648459334595;6392.3927226913365;6404.071409645669;6262.812115636538;6380.425761681286;6431.421172094534;6467.159269294962;6485.44873685742;6124.785632502841;6246.718897649525;6273.153124328157;6278.529110316653;6278.874422511615;6172.4136207060255;6267.561270711007;6270.216222972129;6272.5922815016875;6278.905816412849;5115.769790359517;6182.505399568114;6203.286622038343;6263.68681565929;6282.465990390868;6290.968545157428;6319.115323854572;6320.683965801783;6339.746410143727;6343.175387199634;6126.479249263863;6158.291796443466;6183.072539119168;6219.782307619212;6269 16:50:37 INFO - PROCESS | 1668 | |1;ext.html;552.0918089742374;555.5500044963583;577.7342422485658;580.38627622499;605.1316361021936;40758.79620601897;41220.93895305234;42096.57903420965;42100;42179.57820421795;43275.350869736976;43612.345814812805;43916.341254881205;43927.341089883674;43981.680549583565;9795.608175672964;9921.801563968753;9936.850947235796;9982.650607228748;10134.493275336205;9792.853107203398;9985.700428987106;9989.600415983352;10004.59981600735;10029.24780641451;10010.04904534068;10033.498325083752;10059.69820905374;10062.899371006306;10086.747831304203;8661.65353385867;8903.73288801337;9674.935757066716;9769.413835169913;10013.098821106136;9926.553305101288;10049.296549241555;10061.647842325558;10074.294799364048;10077.344972576759;30509.542356864666;34289.828550857084;41652.37521437181;42000.789996049825;42087;3100.937981240385;3266.8856590019473;3308.2225676965895;3355.614104377979;3383.204946837491;27284.727152728417;27654;28199.718002819915;28531;28697.139085827457;2701.6893057298466;2719.170652950849;2739.1371717908796;2747.011076012634;2777.9722202777916;333066;334519.32740336144;336397;336467;337041;30260.394792104034;38642.0339491515;39202.80398597989;39333.606663932995;39366.80316598398;37647;37695.246095078495;38197.61802381941;38421;38436;16434.178291085398;16549.420770272984;17014.48956531306;17163.656726865393;17187.226574804165;14340.56978290653;14607.269636518131;14633.341499632543;14697.26513674312;14722.484713034992;8568.443051201652;8686.52224127679;8731.51976641278;8793.736187914374;8881.555922203865;3525.665061819123;3545.4327307630656;3567.1438854674693;3570.071781336819;3579.982100089535;1039.2517387481003;1056.7569459024314;1078.1428764132534;1111.7053980695123;1195.2768575011992;32098.67901320957;32191.51712724311;32413.912957123874;32773.85291514786;32979.01062968067;1072.9195310351754;1114.6154576671036;1142.4744617476053;1149.4195431307137;1159.113278342069;15151.242437878062;15313.004654697408;15565.688686226213;15638.843611563967;15899.205039747967;625943;736920;742471;750267;760932;63564.36435635677;63575;64478;64544.677276613314;64554.70890582256;1537.6924615076805;1541.429671021729;1551.387202055182;1569.5212960047068;1570.136424966264;30472.542911856784;31607.683923160475;31789.68210317867;32327.676723233406;32434;62834;63780;64357.67821160864;65981.34018659752;66058.66970665116;501836;507947;508963;510694;515095;42409.36385954152;43156.56843431525;44342;44902.3264651037;44982.55017449915;38511.22977540377;38545.421818672185;47314.52685473101;48032.03935921192;50686;40378.79810600928;40563.797181013906;40882.591174089066;41540.58459415367;42308.57691423046;33776.83111584427;37737.037611050444;38119.23761524699;38288.617113828506;39222.215555688155;40647.39028914628;41451.37822932598;41802.79098604488;42384;42550.57449425466;32558;33752.83123584367;34023.498642784536;34034.65965340315;36779.44830827486;22530.324090277318;26184.08355707541;26420.471590567697;26470.470590587694;26481.07316243922 16:50:37 INFO - PROCESS | 1668 | |2;jquery.html;390.62695126154523;401.45201799543634;415.1593024126145;418.90784027513973;421.7322000529664;16004.839951600481;17446;17696.557586060357;21005;21754.12983480661;20276.493087672814;20665.793342066576;20894.01506856846;20917;20978.685319720218;5819.447152520504;5880.029795083806;6062.514998800086;6069.423404776561;6196.597221180609;5967.791127310545;5976;6077.544184186204;6102.328743838174;6145.938540614604;5879.617824841372;6134.6012509186985;6158.815235542941;6201.81394558164;6227.1282020517165;6078.787242446515;6086.939130608682;6104.87059893921;6117.0518569622;6126.724297406628;5826.883462330772;5862.97068514659;5891.617044892111;5902.380250073767;5904.114382842608;13842.792358114637;14162;14195.78706319406;14225.288735563181;24001.27996160118;2330.0563271874917;2366.9053237870467;2828.1656911211035;2836.858157092137;2852.0017993702245;10240.231982601335;10830.837537436944;11832.940835295854;12156.57451989185;13162.736745265136;1646.2509558151012;1649.6370798424448;1681.9495415137565;1684.5030715938706;1809.5747499337645;108571;111219.44390277997;111918;113692;120030;11662.300261984139;11926.46330915111;11934.880651193376;11995.220310679779;12008.279503229835;12636.368181590884;15196.164210968504;15265.313060912285;15411.306491207923;15483.380664773507;9108.544572771334;9292.256619470427;9307.860382094274;9330;9357.052528453516;7916.366690664733;9174.403663761834;9451.574679139456;9471.810563788686;9540.856887146698;4756.1438940990265;4835.927461088087;4841.9031619367415;4847.95152048482;4902.2156454967035;1812.9274829006956;2030.8984550772402;2082.88565617394;2091.3830420025824;2094.7695753467106;944.254039308952;974.28390133252;1012.2610494339026;1071.185898716965;1097.7091070866227;20760.896195519228;20964.16143354249;21323.893380533307;21542.246021389175;21603.67594486084;996.4170959988343;1007.8359494783537;1026.6560702164709;1042.3999161287388;1068.4657671164418;10371.118454931264;11420.543178272943;11429.371384573928;11432.94283528577;11454.484548195185;642529;649712.3829842339;655314;658705;666198;134095.98856017168;137323.31338343245;139978;142899;146315;1022.9590816367411;1043.0768769638923;1051.8842927278147;1053.0364716284514;1054.3199636234585;17036.574085647957;18322.233031505326;18629.254829806658;19094.809051909302;19224.615507689487;55629;56896;57542.42457575371;58021.419785801605;58429.123563147434;67451.98822017772;81214.18785812067;82091.17908820836;83771.5811420939;85699.57150214458;7016.543924644881;7106.182788979127;8507.532085735096;8630.093840146694;8649.221570058473;9618.903810961801;10416.479176041319;12661.303628300531;12853.93573032129;13075.476980920657;11016.614418495314;11161.944190278997;11198.38408887519;11420.543178273108;11541.82687259675;5246.976839516257;9459.38513996588;9800.65697700577;10803.675889723321;11091.168162387692;11485.885141148481;11583.826242606536;11686.714461409409;11770.411479426166;11882.584109556125;8489.787755306166;8546.273566746897;8567.014793298602;8583.699570515002;8691.608877600649;11457.19799614019;11462.770744585228;11469.254498457574;11536.711582210512;11674 16:50:37 INFO - PROCESS | 1668 | |3;mootools.html;1513.8788896888248;1622.3753854765919;1839.659662962352;1956.2175129948018;2006.9498262543425;8294.958525207365;8937.955310223457;9116.270698344133;9341.719748407542;9375.531223438826;8906.376553641232;8930.86603700945;8995.370324077317;9025.097490250988;9049.185573298402;2526.1916186820226;2542.529632018083;2546.80300258878;2552.923412297634;2553.4637726077453;2499.350168956066;2517.1944977607172;2550.1839411388364;2560.6287088372173;2563.3976015636313;2543.9618405723927;2555.1057130004538;2559.5008973250224;2573.240893936293;2574.742525747429;2298.8965496552696;2346.636271377939;2524.6465494830645;2564.974350256492;2568.4092658688605;2333.2533589251448;2522.331582130737;2541.644169816227;2548.554003049459;2554.7700706936466;9198.402103863295;9200.493972831491;9215.58529866151;9245.260379169651;9249.16757491829;5611.719414029282;5668.489835914746;5727.713614319267;5780;5792.4497172768515;3686.705063594906;3727.273181729564;3783.0731470789833;3795.905102372435;3797.4493698413853;1050.4642632257603;1065.057424179599;1069.2301542889186;1079.2175672637354;1079.7624522605015;12173.695657608541;12177.452014659362;12206.450709717996;12210.389480525939;12568.245905245623;4969.801207951641;5027.547520723079;5058.848234552969;5097.566706829887;5198.298229739013;10456.68629941103;10594.470276486145;10624.415657138932;10664.253502254767;10775.191860610486;5670.5463562914865;5682.062459694104;5807.361190269067;5842.824715258464;5905.379935106752;4629.65277604181;4690.202665546865;4753.619710423158;5215.869603259873;5326.828097818474;4152.875413737533;4175.144095460423;4192.182524407772;4229.577042295746;4258.5954334338185;1384.9307534623229;1414.4483651375972;1414.844367119616;1424.1099312929418;1424.5583869000643;911.4166933162782;920.4569304110607;954.1460392948272;954.9379290346105;975.4050029482011;5926.762929482772;6030.547708921848;6056.606320589148;6129.417705317987;6218.614160100066;411.83320755094235;475.49834924155346;480.3563225278144;489.6890474548687;492.9433115191799;3167.2873603439502;3915.7454765440157;3982.6017398260524;4002.959230600065;4050.0482386639114;9748.61005559784;11262.662120136409;11483.942580287212;11575.421228938689;11663.416829158508;11147.275427097375;11264.324140551593;11312.71718207035;11391.430428478543;11430.028447582048;8508.489490630582;8708.91291087081;8826.955865220632;8907.643694252158;8925.776855578533;5771.039836810705;5771.59598828078;5822.679752613647;5872.236609240771;5922.111683247547;9616.423014619146;9626.95186524063;9929.65246216379;9938.403695778277;9943.602255909682;9738.269629777653;10044.497775111362;10203.0817226447;10219.437930913871;10235.641752538626;6841.452683785185;7680.116786569616;8455.365847561334;8560.101189375026;8695.391322607356;8538.01812791537;8552.871706924525;8556.871646925176;8579.485230886166;8612.526311052701;7497.325240728361;7521.285477879593;7702.653380597774;7811.140774514685;7817.140114587277;7167.1757747859665;7478.70085196586;7604.201558836243;7687.807804804925;7703;7221.53060051095;7230.530015549183;7261.854762904818;7271.200167981624;7286;4872.074305881871;4910.950890491049;4989.97705470385;5076.238564215398;5086.0845047891735;4995.200767877122;5010.8246211383885;5040.8991820162655;5067;5221.608379371486 16:50:37 INFO - PROCESS | 1668 | |4;prototype.html;295.46963201054103;342.92627085176684;344.2323618331122;349.93176330615535;355.34793653645556;6831.521793474452;6889.517733758639;6898.65506724663;6922.619255940921;6929.168499780028;6836.82907927302;6899.37905588497;6944.02783610295;6952.582845029289;6957.5129740918155;4841.588464980481;4932.235503496964;5070.949290507103;5082.64421490494;5112.718800465973;4594.621613515948;4654.627629789626;4994.650374473788;5075.543201111899;5083.983203359325;5002.349694539705;5006.324146240266;5018.473060328668;5020.0963826511215;5042.268871013719;5011.32347133136;5023.598112151019;5044.016416798726;5052.898942021176;5110.488951104897;4379.978100109511;4382.2331092059085;4383.561643835591;4391.956080439187;4392.626626736731;6374.840628984266;6604.801855944329;6634.038064480672;6657.367550082734;6670;4856.247281671346;5884.941150588482;5920.585559010871;5937.554683398763;5938.138969849348;5643.8589035274035;6339.95390760524;7398.112226532797;7436;7443.069616297963;3880.767153970771;4741.739204343759;4749.287606858964;4751.596114330286;4770.117528257283;7608.35328997036;7759.8448031039625;7838.372930165573;7866.331361834194;7889.132195458495;4807.351007613997;4821.831235906727;4822.252550854553;4824.300476430898;4833.516648335139;3975.980120099381;4862.319275301461;4920.926186107211;4937.333839726579;4940.086084074458;4620.445546534437;4911.582515486152;5806.896689628957;5914.610066634337;5931.436513531207;6185.567010309235;6197.907031394533;7194.230221364707;7439.479236453396;7453.515521491194;1673.790776152981;1700.6598680263996;1701.8553422959187;1709.5811526176167;1710.4612047205092;909.3361845852564;1055.1875056206832;1069.8716154061563;1080.56777289085;1084.3819023156725;5728.77084916607;6974.79075627732;7023.33278338557;7024.964875175694;7080.787576372614;7391.741289054858;7549.603323385191;7738.574378409242;7763.4953728007495;7824.37405007598;6954.269801670752;6989.1962424321855;6989.720411183597;6990.531988282518;6992.965035174791;4091.9386209206887;4128.525219599785;4131.256373852675;4136.007358234062;4136.524299705572;6526.673666316665;8122.796930076795;8144.877826832602;8209.09699933007;8214;7346.77959661211;7638.388928885676;7972.720954766555;8050.5169689818795;8084.434089613788;8094.392920530866;8155;8155.347572194329;8163.97950256218;8164.387670924823;7778.766637000673;7805.29752322271;7805.531668099932;7808.882866757117;7809.375249979875;7640.235976402315;7650.846983060419;7659.463837531319;7662.463627546018;7674.117476490275;7332.706691732485;7352.816179595553;7788.376929845485;8042;8056.274935255855;4756.500567440507;4861.1006963711825;4864.075825593126;4889.877753056202;4893.877653058702;7780;7831;7835.255650713173;7845.372370210255;7870.173631768582;7148.785536433916;7495.7001719930595;7521.849563008818;7522.435817313833;7531.284527969834;6024.759009639565;7424.554526728413;7503.662335195038;7528.058992625922;7537.434692398202;7297.63511824396;7309.195988441374;7312.305330993547;7326.450516211199;7328.523645962995;7417.443691723034;7440.107187137578;7462;7463.962680186782;7485.214052524407;7068.434525237866;7268.491205615767;7295;7399.704011839682;7411.370033547209 16:50:37 INFO - PROCESS | 1668 | |5;yui.html;720.3804727933976;738.9482736208464;746.2835677749362;767.9040119985002;780.2080887898784;15563.688726225482;15766.76349854753;15767.526974190763;15805.920970395133;15872.761908571367;11302.321860688364;14766.704665906702;14779.778303325458;14790.630234244123;14814.851851481482;770.5915864591748;818.8567000774856;917.7567944494714;928.4846909964966;952.4666186935303;920.4523308631387;921.2537844346101;941.4962994797785;948.8671585977934;953.1564565359672;837.9790505237357;902.1339514066505;932.1051790281338;975.2539307429822;1007.0584003956325;972.1153750087457;976.497103991445;1001.3541265883464;1006.124671535765;1014.3102690170717;724.4240828541269;728.5483000539647;743.0563184755384;756.2399788212866;758.7268583310004;13347.466101355934;14596.927015364961;15010.549683509404;15043.398264069534;15206.391744330214;13285.667858303523;13323.26722030288;13380.264085475295;13426.798598021038;13539.984501162353;9305.720828375159;9577.51548509982;10391.272610917238;10525.894741052569;10537.157027437786;3608.9819550902075;3635.054885729703;3751.9062023449633;3789.3936970084656;3900.7074469414906;75012.62493687551;76389.61805190994;77122.07194820062;79401;80427.59786201031;9676.70969870905;9692.466914319639;9844.458554779556;9847.55685994132;10128.59485620567;21632.24287149942;21731.456713582287;21792.019359128877;21856.12575496994;21864.672029919562;7795.181505941908;7878.1334053254095;7889.447738658354;7963.124056353797;8021.478603890729;4008.158286759755;4038.899027524277;4048.149888523384;4053.61490658387;4115.506139263308;3121.453745594512;3731.7014638828828;3792.563855156637;3793.8292776824555;3803.1062700265416;680.3400701319712;682.2904179653204;692.5982929900646;692.8337199072187;706.9787906362817;579.4495229531962;581.3575998521658;599.9190109335271;602.2080963533027;613.622622087422;7112.715491380287;8303.584820758937;8312.709055183039;8323.209295116954;8657.826843463095;607.5504126946028;609.8374590435365;615.0988801405962;619.8140557832633;623.7536173211647;3895.7857317847793;3929.7445666031617;3953.4267531207815;4014.598540145962;4070.715049946475;94145.5292723532;94824.52587737155;95315;96074.51962740142;96255;79987;80675.59662201769;80909;81444.3711125786;81923.59038204771;57301;70430.94353584701;72878.63560682163;76241.61879190679;78296.6085169582;6851.828704282433;8886.511241881759;8896.154865287788;8908.331875109263;8946.821063578822;50332.74833625955;50706.74646626743;50725.74637126791;51485.7425712869;53166;69925.65037174782;72130.27869721236;72518.27481725326;73122.63438682772;73184.26815731988;11000.284981476498;11064.778704426028;11079.390633515233;11161.995420412202;11535.365554894226;12081.818772718241;12289.56986505468;12334.629961101182;12627;12683.556075537681;11678.70803229926;11740.823887641864;11925.373134328358;11926.761464770829;12040.879591204326;11096.389698566656;11559.479823408135;11686;11720.886515780987;11927.701807454883;10984.395858227554;11361;11493.023093037185;11783.76432471363;12065.577704780291;9478.857817132886;9591.407242693629;9610.74305465879;9664.9033509664;9732.172765315028;9107.59015844302;9513.619455221991;9691.370060946016;10022.548985295532;10044.447555384524 16:50:37 INFO - PROCESS | 1668 | __end_tp_report 16:50:37 INFO - PROCESS | 1668 | __start_cc_report 16:50:37 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,395 16:50:37 INFO - PROCESS | 1668 | __end_cc_report 16:50:37 INFO - PROCESS | 1668 | __startTimestamp1466812237860__endTimestamp 16:50:37 INFO - PROCESS | 1668 | 16:50:37 INFO - PROCESS | 1668 | ------- Summary: start ------- 16:50:37 INFO - PROCESS | 1668 | Number of tests: 6 16:50:37 INFO - PROCESS | 1668 | 16:50:37 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5990.07 Median:6190.57 stddev:628.05 (10.1%) stddev-sans-first:603.62 16:50:37 INFO - PROCESS | 1668 | Values: 3695.1 3702.2 3716.5 3738.4 3775.0 6069.8 6083.6 6086.5 6094.5 6096.4 5973.9 6105.2 6112.0 6122.2 6136.8 5433.5 5461.4 5534.7 5559.3 5597.6 5437.6 5475.1 5480.3 5536.9 5635.5 5568.7 5572.6 5580.2 5585.0 5587.5 5499.7 5553.9 5561.2 5562.4 5583.7 4487.8 5383.0 5386.6 5459.5 5485.7 5878.9 5958.8 5965.6 5995.7 6048.3 6203.8 6292.9 6300.6 6349.8 6402.0 6409.5 6472.2 6483.5 6515.4 6528.9 6159.2 6172.6 6190.6 6211.3 6223.3 5318.9 6465.2 6599.5 6649.6 6690.4 5605.9 6081.0 6225.9 6314.2 6319.1 6395.1 6408.7 6470.7 6473.1 6473.4 6245.8 6256.0 6300.4 6335.5 6356.4 6340.1 6362.2 6389.0 6400.9 6409.9 5057.1 5136.3 5137.9 5138.9 5160.2 4636.0 4674.3 4688.9 4690.7 4705.4 6042.3 6084.3 6130.0 6166.7 6172.6 6447.4 6481.6 6481.8 6482.2 6482.3 6025.8 6128.3 6160.6 6178.0 6183.1 5632.6 5638.1 5643.7 5654.0 5667.7 6684.1 6703.6 6724.5 6741.4 6743.9 6316.4 6347.4 6465.3 6482.2 6508.0 6679.7 6693.1 6695.5 6710.8 6721.3 6380.7 6390.3 6391.6 6392.4 6404.1 6262.8 6380.4 6431.4 6467.2 6485.4 6124.8 6246.7 6273.2 6278.5 6278.9 6172.4 6267.6 6270.2 6272.6 6278.9 5115.8 6182.5 6203.3 6263.7 6282.5 6291.0 6319.1 6320.7 6339.7 6343.2 6126.5 6158.3 6183.1 6219.8 6269.0 16:50:37 INFO - PROCESS | 1668 | 16:50:37 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:65986.62 Median:20179.72 stddev:146801.13 (727.5%) stddev-sans-first:147130.73 16:50:37 INFO - PROCESS | 1668 | Values: 552.1 555.6 577.7 580.4 605.1 40758.8 41220.9 42096.6 42100.0 42179.6 43275.4 43612.3 43916.3 43927.3 43981.7 9795.6 9921.8 9936.9 9982.7 10134.5 9792.9 9985.7 9989.6 10004.6 10029.2 10010.0 10033.5 10059.7 10062.9 10086.7 8661.7 8903.7 9674.9 9769.4 10013.1 9926.6 10049.3 10061.6 10074.3 10077.3 30509.5 34289.8 41652.4 42000.8 42087.0 3100.9 3266.9 3308.2 3355.6 3383.2 27284.7 27654.0 28199.7 28531.0 28697.1 2701.7 2719.2 2739.1 2747.0 2778.0 333066.0 334519.3 336397.0 336467.0 337041.0 30260.4 38642.0 39202.8 39333.6 39366.8 37647.0 37695.2 38197.6 38421.0 38436.0 16434.2 16549.4 17014.5 17163.7 17187.2 14340.6 14607.3 14633.3 14697.3 14722.5 8568.4 8686.5 8731.5 8793.7 8881.6 3525.7 3545.4 3567.1 3570.1 3580.0 1039.3 1056.8 1078.1 1111.7 1195.3 32098.7 32191.5 32413.9 32773.9 32979.0 1072.9 1114.6 1142.5 1149.4 1159.1 15151.2 15313.0 15565.7 15638.8 15899.2 625943.0 736920.0 742471.0 750267.0 760932.0 63564.4 63575.0 64478.0 64544.7 64554.7 1537.7 1541.4 1551.4 1569.5 1570.1 30472.5 31607.7 31789.7 32327.7 32434.0 62834.0 63780.0 64357.7 65981.3 66058.7 501836.0 507947.0 508963.0 510694.0 515095.0 42409.4 43156.6 44342.0 44902.3 44982.6 38511.2 38545.4 47314.5 48032.0 50686.0 40378.8 40563.8 40882.6 41540.6 42308.6 33776.8 37737.0 38119.2 38288.6 39222.2 40647.4 41451.4 41802.8 42384.0 42550.6 32558.0 33752.8 34023.5 34034.7 36779.4 22530.3 26184.1 26420.5 26470.5 26481.1 16:50:37 INFO - PROCESS | 1668 | 16:50:37 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:36811.56 Median:20971.42 stddev:109016.18 (519.8%) stddev-sans-first:109287.70 16:50:37 INFO - PROCESS | 1668 | Values: 390.6 401.5 415.2 418.9 421.7 16004.8 17446.0 17696.6 21005.0 21754.1 20276.5 20665.8 20894.0 20917.0 20978.7 5819.4 5880.0 6062.5 6069.4 6196.6 5967.8 5976.0 6077.5 6102.3 6145.9 5879.6 6134.6 6158.8 6201.8 6227.1 6078.8 6086.9 6104.9 6117.1 6126.7 5826.9 5863.0 5891.6 5902.4 5904.1 13842.8 14162.0 14195.8 14225.3 24001.3 2330.1 2366.9 2828.2 2836.9 2852.0 10240.2 10830.8 11832.9 12156.6 13162.7 1646.3 1649.6 1681.9 1684.5 1809.6 108571.0 111219.4 111918.0 113692.0 120030.0 11662.3 11926.5 11934.9 11995.2 12008.3 12636.4 15196.2 15265.3 15411.3 15483.4 9108.5 9292.3 9307.9 9330.0 9357.1 7916.4 9174.4 9451.6 9471.8 9540.9 4756.1 4835.9 4841.9 4848.0 4902.2 1812.9 2030.9 2082.9 2091.4 2094.8 944.3 974.3 1012.3 1071.2 1097.7 20760.9 20964.2 21323.9 21542.2 21603.7 996.4 1007.8 1026.7 1042.4 1068.5 10371.1 11420.5 11429.4 11432.9 11454.5 642529.0 649712.4 655314.0 658705.0 666198.0 134096.0 137323.3 139978.0 142899.0 146315.0 1023.0 1043.1 1051.9 1053.0 1054.3 17036.6 18322.2 18629.3 19094.8 19224.6 55629.0 56896.0 57542.4 58021.4 58429.1 67452.0 81214.2 82091.2 83771.6 85699.6 7016.5 7106.2 8507.5 8630.1 8649.2 9618.9 10416.5 12661.3 12853.9 13075.5 11016.6 11161.9 11198.4 11420.5 11541.8 5247.0 9459.4 9800.7 10803.7 11091.2 11485.9 11583.8 11686.7 11770.4 11882.6 8489.8 8546.3 8567.0 8583.7 8691.6 11457.2 11462.8 11469.3 11536.7 11674.0 16:50:37 INFO - PROCESS | 1668 | 16:50:37 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5939.57 Median:5003.01 stddev:3336.20 (66.7%) stddev-sans-first:3328.98 16:50:37 INFO - PROCESS | 1668 | Values: 1513.9 1622.4 1839.7 1956.2 2006.9 8295.0 8938.0 9116.3 9341.7 9375.5 8906.4 8930.9 8995.4 9025.1 9049.2 2526.2 2542.5 2546.8 2552.9 2553.5 2499.4 2517.2 2550.2 2560.6 2563.4 2544.0 2555.1 2559.5 2573.2 2574.7 2298.9 2346.6 2524.6 2565.0 2568.4 2333.3 2522.3 2541.6 2548.6 2554.8 9198.4 9200.5 9215.6 9245.3 9249.2 5611.7 5668.5 5727.7 5780.0 5792.4 3686.7 3727.3 3783.1 3795.9 3797.4 1050.5 1065.1 1069.2 1079.2 1079.8 12173.7 12177.5 12206.5 12210.4 12568.2 4969.8 5027.5 5058.8 5097.6 5198.3 10456.7 10594.5 10624.4 10664.3 10775.2 5670.5 5682.1 5807.4 5842.8 5905.4 4629.7 4690.2 4753.6 5215.9 5326.8 4152.9 4175.1 4192.2 4229.6 4258.6 1384.9 1414.4 1414.8 1424.1 1424.6 911.4 920.5 954.1 954.9 975.4 5926.8 6030.5 6056.6 6129.4 6218.6 411.8 475.5 480.4 489.7 492.9 3167.3 3915.7 3982.6 4003.0 4050.0 9748.6 11262.7 11483.9 11575.4 11663.4 11147.3 11264.3 11312.7 11391.4 11430.0 8508.5 8708.9 8827.0 8907.6 8925.8 5771.0 5771.6 5822.7 5872.2 5922.1 9616.4 9627.0 9929.7 9938.4 9943.6 9738.3 10044.5 10203.1 10219.4 10235.6 6841.5 7680.1 8455.4 8560.1 8695.4 8538.0 8552.9 8556.9 8579.5 8612.5 7497.3 7521.3 7702.7 7811.1 7817.1 7167.2 7478.7 7604.2 7687.8 7703.0 7221.5 7230.5 7261.9 7271.2 7286.0 4872.1 4911.0 4990.0 5076.2 5086.1 4995.2 5010.8 5040.9 5067.0 5221.6 16:50:37 INFO - PROCESS | 1668 | 16:50:37 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:6014.73 Median:6911.00 stddev:1969.11 (28.5%) stddev-sans-first:1927.28 16:50:37 INFO - PROCESS | 1668 | Values: 295.5 342.9 344.2 349.9 355.3 6831.5 6889.5 6898.7 6922.6 6929.2 6836.8 6899.4 6944.0 6952.6 6957.5 4841.6 4932.2 5070.9 5082.6 5112.7 4594.6 4654.6 4994.7 5075.5 5084.0 5002.3 5006.3 5018.5 5020.1 5042.3 5011.3 5023.6 5044.0 5052.9 5110.5 4380.0 4382.2 4383.6 4392.0 4392.6 6374.8 6604.8 6634.0 6657.4 6670.0 4856.2 5884.9 5920.6 5937.6 5938.1 5643.9 6340.0 7398.1 7436.0 7443.1 3880.8 4741.7 4749.3 4751.6 4770.1 7608.4 7759.8 7838.4 7866.3 7889.1 4807.4 4821.8 4822.3 4824.3 4833.5 3976.0 4862.3 4920.9 4937.3 4940.1 4620.4 4911.6 5806.9 5914.6 5931.4 6185.6 6197.9 7194.2 7439.5 7453.5 1673.8 1700.7 1701.9 1709.6 1710.5 909.3 1055.2 1069.9 1080.6 1084.4 5728.8 6974.8 7023.3 7025.0 7080.8 7391.7 7549.6 7738.6 7763.5 7824.4 6954.3 6989.2 6989.7 6990.5 6993.0 4091.9 4128.5 4131.3 4136.0 4136.5 6526.7 8122.8 8144.9 8209.1 8214.0 7346.8 7638.4 7972.7 8050.5 8084.4 8094.4 8155.0 8155.3 8164.0 8164.4 7778.8 7805.3 7805.5 7808.9 7809.4 7640.2 7650.8 7659.5 7662.5 7674.1 7332.7 7352.8 7788.4 8042.0 8056.3 4756.5 4861.1 4864.1 4889.9 4893.9 7780.0 7831.0 7835.3 7845.4 7870.2 7148.8 7495.7 7521.8 7522.4 7531.3 6024.8 7424.6 7503.7 7528.1 7537.4 7297.6 7309.2 7312.3 7326.5 7328.5 7417.4 7440.1 7462.0 7464.0 7485.2 7068.4 7268.5 7295.0 7399.7 7411.4 16:50:37 INFO - PROCESS | 1668 | 16:50:37 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18694.06 Median:608.69 stddev:26266.92 (4315.3%) stddev-sans-first:26305.93 16:50:37 INFO - PROCESS | 1668 | Values: 720.4 738.9 746.3 767.9 780.2 15563.7 15766.8 15767.5 15805.9 15872.8 11302.3 14766.7 14779.8 14790.6 14814.9 770.6 818.9 917.8 928.5 952.5 920.5 921.3 941.5 948.9 953.2 838.0 902.1 932.1 975.3 1007.1 972.1 976.5 1001.4 1006.1 1014.3 724.4 728.5 743.1 756.2 758.7 13347.5 14596.9 15010.5 15043.4 15206.4 13285.7 13323.3 13380.3 13426.8 13540.0 9305.7 9577.5 10391.3 10525.9 10537.2 3609.0 3635.1 3751.9 3789.4 3900.7 75012.6 76389.6 77122.1 79401.0 80427.6 9676.7 9692.5 9844.5 9847.6 10128.6 21632.2 21731.5 21792.0 21856.1 21864.7 7795.2 7878.1 7889.4 7963.1 8021.5 4008.2 4038.9 4048.1 4053.6 4115.5 3121.5 3731.7 3792.6 3793.8 3803.1 680.3 682.3 692.6 692.8 707.0 579.4 581.4 599.9 602.2 613.6 7112.7 8303.6 8312.7 8323.2 8657.8 607.6 609.8 615.1 619.8 623.8 3895.8 3929.7 3953.4 4014.6 4070.7 94145.5 94824.5 95315.0 96074.5 96255.0 79987.0 80675.6 80909.0 81444.4 81923.6 57301.0 70430.9 72878.6 76241.6 78296.6 6851.8 8886.5 8896.2 8908.3 8946.8 50332.7 50706.7 50725.7 51485.7 53166.0 69925.7 72130.3 72518.3 73122.6 73184.3 11000.3 11064.8 11079.4 11162.0 11535.4 12081.8 12289.6 12334.6 12627.0 12683.6 11678.7 11740.8 11925.4 11926.8 12040.9 11096.4 11559.5 11686.0 11720.9 11927.7 10984.4 11361.0 11493.0 11783.8 12065.6 9478.9 9591.4 9610.7 9664.9 9732.2 9107.6 9513.6 9691.4 10022.5 10044.4 16:50:37 INFO - PROCESS | 1668 | -------- Summary: end -------- 16:50:37 INFO - PROCESS | 1668 | 16:50:38 INFO - TEST-INFO | 1668: exit 0 16:50:38 INFO - TEST-OK | dromaeo_css | took 1110369ms 16:50:38 INFO - TEST-START | kraken 16:50:38 INFO - operating with platform_type : mac_ 16:50:38 INFO - Initialising browser for kraken test... 16:50:38 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpLDyMC1/profile http://localhost:49271/getInfo.html) 16:50:41 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 16:50:41 INFO - PROCESS | 1676 | colorDepth:24 16:50:41 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 16:50:41 INFO - PROCESS | 1676 | __metrics 16:50:41 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:50:41 INFO - TEST-INFO | 1676: exit 0 16:50:41 INFO - Browser initialized. 16:50:41 INFO - Running cycle 1/1 for kraken test... 16:50:41 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpLDyMC1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:53 INFO - PROCESS | 1680 | RSS: Main: 170729472 16:50:53 INFO - PROCESS | 1680 | 16:50:56 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 16:50:57 INFO - PROCESS | 1680 | RSS: Main: 183697408 16:50:57 INFO - PROCESS | 1680 | 16:50:59 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 16:51:00 INFO - PROCESS | 1680 | RSS: Main: 192315392 16:51:00 INFO - PROCESS | 1680 | 16:51:03 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 16:51:04 INFO - PROCESS | 1680 | RSS: Main: 195899392 16:51:04 INFO - PROCESS | 1680 | 16:51:06 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 16:51:06 INFO - PROCESS | 1680 | RSS: Main: 197689344 16:51:06 INFO - PROCESS | 1680 | 16:51:08 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:09 INFO - PROCESS | 1680 | RSS: Main: 198213632 16:51:09 INFO - PROCESS | 1680 | 16:51:12 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 16:51:13 INFO - PROCESS | 1680 | RSS: Main: 198688768 16:51:13 INFO - PROCESS | 1680 | 16:51:15 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:16 INFO - PROCESS | 1680 | RSS: Main: 198504448 16:51:16 INFO - PROCESS | 1680 | 16:51:19 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 16:51:20 INFO - PROCESS | 1680 | RSS: Main: 198799360 16:51:20 INFO - PROCESS | 1680 | 16:51:21 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:51:22 INFO - PROCESS | 1680 | RSS: Main: 197775360 16:51:22 INFO - PROCESS | 1680 | 16:51:24 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:51:24 INFO - PROCESS | 1680 | RSS: Main: 197894144 16:51:24 INFO - PROCESS | 1680 | 16:51:26 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:51:27 INFO - PROCESS | 1680 | RSS: Main: 198062080 16:51:27 INFO - PROCESS | 1680 | 16:51:30 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:51:31 INFO - PROCESS | 1680 | RSS: Main: 198168576 16:51:31 INFO - PROCESS | 1680 | 16:51:33 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:51:34 INFO - PROCESS | 1680 | RSS: Main: 198582272 16:51:34 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 16:51:36 INFO - PROCESS | 1680 | RSS: Main: 199618560 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | __start_tp_report 16:51:36 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 16:51:36 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 16:51:36 INFO - PROCESS | 1680 | |i|pagename|runs| 16:51:36 INFO - PROCESS | 1680 | |0;ai-astar;117;110;115;116;118;132;115;116;116;116 16:51:36 INFO - PROCESS | 1680 | |1;audio-beat-detection;178;154;138;156;121;140;141;122;207;127 16:51:36 INFO - PROCESS | 1680 | |2;audio-dft;200;202;193;195;196;195;193;197;194;193 16:51:36 INFO - PROCESS | 1680 | |3;audio-fft;64;80;73;142;54;57;60;65;121;57 16:51:36 INFO - PROCESS | 1680 | |4;audio-oscillator;76;83;128;78;78;93;159;87;80;124 16:51:36 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;89;85;88;97;120;85;91;128;89;86 16:51:36 INFO - PROCESS | 1680 | |6;imaging-darkroom;101;95;94;96;94;111;154;128;94;95 16:51:36 INFO - PROCESS | 1680 | |7;imaging-desaturate;139;141;91;106;134;89;97;89;91;91 16:51:36 INFO - PROCESS | 1680 | |8;json-parse-financial;58;64;63;63;65;64;62;79;63;59 16:51:36 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;62;66;64;73;64;95;105;94;62;64 16:51:36 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;81;77;82;81;82;82;79;81;86;83 16:51:36 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;131;146;140;127;132;153;141;119;197;167 16:51:36 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;164;164;164;174;166;163;163;168;160;164 16:51:36 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;69;67;72;66;69;66;65;70;68;69 16:51:36 INFO - PROCESS | 1680 | __end_tp_report 16:51:36 INFO - PROCESS | 1680 | __start_cc_report 16:51:36 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1038 16:51:36 INFO - PROCESS | 1680 | __end_cc_report 16:51:36 INFO - PROCESS | 1680 | __startTimestamp1466812296331__endTimestamp 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | ------- Summary: start ------- 16:51:36 INFO - PROCESS | 1680 | Number of tests: 14 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:117.10 Median:116.00 stddev:5.65 (4.9%) stddev-sans-first:5.99 16:51:36 INFO - PROCESS | 1680 | Values: 117.0 110.0 115.0 116.0 118.0 132.0 115.0 116.0 116.0 116.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:147.50 stddev:26.95 (18.3%) stddev-sans-first:26.37 16:51:36 INFO - PROCESS | 1680 | Values: 178.0 154.0 138.0 156.0 121.0 140.0 141.0 122.0 207.0 127.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:195.80 Median:195.50 stddev:3.08 (1.6%) stddev-sans-first:2.87 16:51:36 INFO - PROCESS | 1680 | Values: 200.0 202.0 193.0 195.0 196.0 195.0 193.0 197.0 194.0 193.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:77.30 Median:62.00 stddev:30.03 (48.4%) stddev-sans-first:31.46 16:51:36 INFO - PROCESS | 1680 | Values: 64.0 80.0 73.0 142.0 54.0 57.0 60.0 65.0 121.0 57.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:79.00 stddev:28.43 (36.0%) stddev-sans-first:28.95 16:51:36 INFO - PROCESS | 1680 | Values: 76.0 83.0 128.0 78.0 78.0 93.0 159.0 87.0 80.0 124.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:95.80 Median:88.50 stddev:15.38 (17.4%) stddev-sans-first:16.12 16:51:36 INFO - PROCESS | 1680 | Values: 89.0 85.0 88.0 97.0 120.0 85.0 91.0 128.0 89.0 86.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:106.20 Median:94.00 stddev:20.03 (21.3%) stddev-sans-first:21.16 16:51:36 INFO - PROCESS | 1680 | Values: 101.0 95.0 94.0 96.0 94.0 111.0 154.0 128.0 94.0 95.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:106.80 Median:90.00 stddev:22.18 (24.6%) stddev-sans-first:20.23 16:51:36 INFO - PROCESS | 1680 | Values: 139.0 141.0 91.0 106.0 134.0 89.0 97.0 89.0 91.0 91.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:63.50 stddev:5.72 (9.0%) stddev-sans-first:5.63 16:51:36 INFO - PROCESS | 1680 | Values: 58.0 64.0 63.0 63.0 65.0 64.0 62.0 79.0 63.0 59.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:74.90 Median:65.00 stddev:16.49 (25.4%) stddev-sans-first:16.82 16:51:36 INFO - PROCESS | 1680 | Values: 62.0 66.0 64.0 73.0 64.0 95.0 105.0 94.0 62.0 64.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.00 stddev:2.37 (2.9%) stddev-sans-first:2.51 16:51:36 INFO - PROCESS | 1680 | Values: 81.0 77.0 82.0 81.0 82.0 82.0 79.0 81.0 86.0 83.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:143.50 stddev:22.75 (15.9%) stddev-sans-first:23.53 16:51:36 INFO - PROCESS | 1680 | Values: 131.0 146.0 140.0 127.0 132.0 153.0 141.0 119.0 197.0 167.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:164.00 stddev:3.77 (2.3%) stddev-sans-first:3.98 16:51:36 INFO - PROCESS | 1680 | Values: 164.0 164.0 164.0 174.0 166.0 163.0 163.0 168.0 160.0 164.0 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:2.13 (3.1%) stddev-sans-first:2.24 16:51:36 INFO - PROCESS | 1680 | Values: 69.0 67.0 72.0 66.0 69.0 66.0 65.0 70.0 68.0 69.0 16:51:36 INFO - PROCESS | 1680 | -------- Summary: end -------- 16:51:36 INFO - PROCESS | 1680 | 16:51:36 INFO - TEST-INFO | 1680: exit 0 16:51:37 INFO - TEST-OK | kraken | took 58573ms 16:51:37 INFO - SUITE-END | took 1168s 16:51:37 INFO - Completed test suite (00:19:29) 16:51:37 INFO - javascript benchmark 16:51:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3695.076230942264, 3702.1670124222046, 3716.4982727331803, 3738.383166777482, 3774.9618854814908, 6069.848253793646, 6083.634981901078, 6086.543509236808, 6094.481969032632, 6096.390360963901, 5973.940260597393, 6105.236845394325, 6112.0, 6122.173506576611, 6136.785212517563, 5433.4566543345745, 5461.399246082928, 5534.723263836792, 5559.305086864142, 5597.552195824344, 5437.619366644337, 5475.06923822951, 5480.314960629921, 5536.861578460531, 5635.520980716644, 5568.749406276707, 5572.58205634577, 5580.190872323511, 5585.0, 5587.497125258726, 5499.670019798825, 5553.916691249635, 5561.249231353776, 5562.443755624446, 5583.720813959306, 4487.775611219426, 5382.9730851345885, 5386.569074474072, 5459.5359394451125, 5485.6982865942355, 5878.882422351529, 5958.791442299499, 5965.642061476326, 5995.700214989277, 6048.334683184846, 6203.751849926042, 6292.937070629327, 6300.621962682254, 6349.777757778455, 6401.967990160019, 6409.4551963083195, 6472.158619379497, 6483.513736469784, 6515.446187074104, 6528.93471065288, 6159.23009623797, 6172.567920245585, 6190.566660333779, 6211.2857021442205, 6223.253209614875, 5318.9202161967605, 6465.191851018622, 6599.53803233769, 6649.634270115093, 6690.364415380531, 5605.850800585951, 6080.969595151996, 6225.937740622627, 6314.179156709598, 6319.115323854664, 6395.072714456471, 6408.679566021773, 6470.676466176767, 6473.126127972758, 6473.352664733489, 6245.750169993149, 6255.96872015637, 6300.401461861115, 6335.524835637346, 6356.4279214870885, 6340.144080549159, 6362.236531616143, 6389.0, 6400.871982560323, 6409.903851442232, 5057.140286151363, 5136.30659860914, 5137.871553211125, 5138.87152821175, 5160.200168973815, 4635.976820115945, 4674.275487299474, 4688.906221875543, 4690.671652984258, 4705.411823522059, 6042.305134909454, 6084.300305464928, 6129.969350153221, 6166.660833654102, 6172.567920245539, 6447.387498187664, 6481.578697384655, 6481.773137940149, 6482.222133344029, 6482.319356467598, 6025.8192254232445, 6128.295246046761, 6160.568760186744, 6177.96911015442, 6183.134361189437, 5632.60571759981, 5638.097904335286, 5643.689597072118, 5654.0, 5667.659940403589, 6684.097646817618, 6703.631300278532, 6724.462043036546, 6741.3932746052105, 6743.865122697617, 6316.368363163647, 6347.39699728525, 6465.2564955030775, 6482.222133344029, 6507.9912613544975, 6679.732810687518, 6693.1298931138645, 6695.464362851058, 6710.798676039727, 6721.294264102199, 6380.712867921047, 6390.297067322498, 6391.648459334595, 6392.3927226913365, 6404.071409645669, 6262.812115636538, 6380.425761681286, 6431.421172094534, 6467.159269294962, 6485.44873685742, 6124.785632502841, 6246.718897649525, 6273.153124328157, 6278.529110316653, 6278.874422511615, 6172.4136207060255, 6267.561270711007, 6270.216222972129, 6272.5922815016875, 6278.905816412849, 5115.769790359517, 6182.505399568114, 6203.286622038343, 6263.68681565929, 6282.465990390868, 6290.968545157428, 6319.115323854572, 6320.683965801783, 6339.746410143727, 6343.175387199634, 6126.479249263863, 6158.291796443466, 6183.072539119168, 6219.782307619212, 6269.0], "value": 5953.91345964859, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.0918089742374, 555.5500044963583, 577.7342422485658, 580.38627622499, 605.1316361021936, 40758.79620601897, 41220.93895305234, 42096.57903420965, 42100.0, 42179.57820421795, 43275.350869736976, 43612.345814812805, 43916.341254881205, 43927.341089883674, 43981.680549583565, 9795.608175672964, 9921.801563968753, 9936.850947235796, 9982.650607228748, 10134.493275336205, 9792.853107203398, 9985.700428987106, 9989.600415983352, 10004.59981600735, 10029.24780641451, 10010.04904534068, 10033.498325083752, 10059.69820905374, 10062.899371006306, 10086.747831304203, 8661.65353385867, 8903.73288801337, 9674.935757066716, 9769.413835169913, 10013.098821106136, 9926.553305101288, 10049.296549241555, 10061.647842325558, 10074.294799364048, 10077.344972576759, 30509.542356864666, 34289.828550857084, 41652.37521437181, 42000.789996049825, 42087.0, 3100.937981240385, 3266.8856590019473, 3308.2225676965895, 3355.614104377979, 3383.204946837491, 27284.727152728417, 27654.0, 28199.718002819915, 28531.0, 28697.139085827457, 2701.6893057298466, 2719.170652950849, 2739.1371717908796, 2747.011076012634, 2777.9722202777916, 333066.0, 334519.32740336144, 336397.0, 336467.0, 337041.0, 30260.394792104034, 38642.0339491515, 39202.80398597989, 39333.606663932995, 39366.80316598398, 37647.0, 37695.246095078495, 38197.61802381941, 38421.0, 38436.0, 16434.178291085398, 16549.420770272984, 17014.48956531306, 17163.656726865393, 17187.226574804165, 14340.56978290653, 14607.269636518131, 14633.341499632543, 14697.26513674312, 14722.484713034992, 8568.443051201652, 8686.52224127679, 8731.51976641278, 8793.736187914374, 8881.555922203865, 3525.665061819123, 3545.4327307630656, 3567.1438854674693, 3570.071781336819, 3579.982100089535, 1039.2517387481003, 1056.7569459024314, 1078.1428764132534, 1111.7053980695123, 1195.2768575011992, 32098.67901320957, 32191.51712724311, 32413.912957123874, 32773.85291514786, 32979.01062968067, 1072.9195310351754, 1114.6154576671036, 1142.4744617476053, 1149.4195431307137, 1159.113278342069, 15151.242437878062, 15313.004654697408, 15565.688686226213, 15638.843611563967, 15899.205039747967, 625943.0, 736920.0, 742471.0, 750267.0, 760932.0, 63564.36435635677, 63575.0, 64478.0, 64544.677276613314, 64554.70890582256, 1537.6924615076805, 1541.429671021729, 1551.387202055182, 1569.5212960047068, 1570.136424966264, 30472.542911856784, 31607.683923160475, 31789.68210317867, 32327.676723233406, 32434.0, 62834.0, 63780.0, 64357.67821160864, 65981.34018659752, 66058.66970665116, 501836.0, 507947.0, 508963.0, 510694.0, 515095.0, 42409.36385954152, 43156.56843431525, 44342.0, 44902.3264651037, 44982.55017449915, 38511.22977540377, 38545.421818672185, 47314.52685473101, 48032.03935921192, 50686.0, 40378.79810600928, 40563.797181013906, 40882.591174089066, 41540.58459415367, 42308.57691423046, 33776.83111584427, 37737.037611050444, 38119.23761524699, 38288.617113828506, 39222.215555688155, 40647.39028914628, 41451.37822932598, 41802.79098604488, 42384.0, 42550.57449425466, 32558.0, 33752.83123584367, 34023.498642784536, 34034.65965340315, 36779.44830827486, 22530.324090277318, 26184.08355707541, 26420.471590567697, 26470.470590587694, 26481.07316243922], "value": 19269.310717837714, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.62695126154523, 401.45201799543634, 415.1593024126145, 418.90784027513973, 421.7322000529664, 16004.839951600481, 17446.0, 17696.557586060357, 21005.0, 21754.12983480661, 20276.493087672814, 20665.793342066576, 20894.01506856846, 20917.0, 20978.685319720218, 5819.447152520504, 5880.029795083806, 6062.514998800086, 6069.423404776561, 6196.597221180609, 5967.791127310545, 5976.0, 6077.544184186204, 6102.328743838174, 6145.938540614604, 5879.617824841372, 6134.6012509186985, 6158.815235542941, 6201.81394558164, 6227.1282020517165, 6078.787242446515, 6086.939130608682, 6104.87059893921, 6117.0518569622, 6126.724297406628, 5826.883462330772, 5862.97068514659, 5891.617044892111, 5902.380250073767, 5904.114382842608, 13842.792358114637, 14162.0, 14195.78706319406, 14225.288735563181, 24001.27996160118, 2330.0563271874917, 2366.9053237870467, 2828.1656911211035, 2836.858157092137, 2852.0017993702245, 10240.231982601335, 10830.837537436944, 11832.940835295854, 12156.57451989185, 13162.736745265136, 1646.2509558151012, 1649.6370798424448, 1681.9495415137565, 1684.5030715938706, 1809.5747499337645, 108571.0, 111219.44390277997, 111918.0, 113692.0, 120030.0, 11662.300261984139, 11926.46330915111, 11934.880651193376, 11995.220310679779, 12008.279503229835, 12636.368181590884, 15196.164210968504, 15265.313060912285, 15411.306491207923, 15483.380664773507, 9108.544572771334, 9292.256619470427, 9307.860382094274, 9330.0, 9357.052528453516, 7916.366690664733, 9174.403663761834, 9451.574679139456, 9471.810563788686, 9540.856887146698, 4756.1438940990265, 4835.927461088087, 4841.9031619367415, 4847.95152048482, 4902.2156454967035, 1812.9274829006956, 2030.8984550772402, 2082.88565617394, 2091.3830420025824, 2094.7695753467106, 944.254039308952, 974.28390133252, 1012.2610494339026, 1071.185898716965, 1097.7091070866227, 20760.896195519228, 20964.16143354249, 21323.893380533307, 21542.246021389175, 21603.67594486084, 996.4170959988343, 1007.8359494783537, 1026.6560702164709, 1042.3999161287388, 1068.4657671164418, 10371.118454931264, 11420.543178272943, 11429.371384573928, 11432.94283528577, 11454.484548195185, 642529.0, 649712.3829842339, 655314.0, 658705.0, 666198.0, 134095.98856017168, 137323.31338343245, 139978.0, 142899.0, 146315.0, 1022.9590816367411, 1043.0768769638923, 1051.8842927278147, 1053.0364716284514, 1054.3199636234585, 17036.574085647957, 18322.233031505326, 18629.254829806658, 19094.809051909302, 19224.615507689487, 55629.0, 56896.0, 57542.42457575371, 58021.419785801605, 58429.123563147434, 67451.98822017772, 81214.18785812067, 82091.17908820836, 83771.5811420939, 85699.57150214458, 7016.543924644881, 7106.182788979127, 8507.532085735096, 8630.093840146694, 8649.221570058473, 9618.903810961801, 10416.479176041319, 12661.303628300531, 12853.93573032129, 13075.476980920657, 11016.614418495314, 11161.944190278997, 11198.38408887519, 11420.543178273108, 11541.82687259675, 5246.976839516257, 9459.38513996588, 9800.65697700577, 10803.675889723321, 11091.168162387692, 11485.885141148481, 11583.826242606536, 11686.714461409409, 11770.411479426166, 11882.584109556125, 8489.787755306166, 8546.273566746897, 8567.014793298602, 8583.699570515002, 8691.608877600649, 11457.19799614019, 11462.770744585228, 11469.254498457574, 11536.711582210512, 11674.0], "value": 9752.546159056295, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.8788896888248, 1622.3753854765919, 1839.659662962352, 1956.2175129948018, 2006.9498262543425, 8294.958525207365, 8937.955310223457, 9116.270698344133, 9341.719748407542, 9375.531223438826, 8906.376553641232, 8930.86603700945, 8995.370324077317, 9025.097490250988, 9049.185573298402, 2526.1916186820226, 2542.529632018083, 2546.80300258878, 2552.923412297634, 2553.4637726077453, 2499.350168956066, 2517.1944977607172, 2550.1839411388364, 2560.6287088372173, 2563.3976015636313, 2543.9618405723927, 2555.1057130004538, 2559.5008973250224, 2573.240893936293, 2574.742525747429, 2298.8965496552696, 2346.636271377939, 2524.6465494830645, 2564.974350256492, 2568.4092658688605, 2333.2533589251448, 2522.331582130737, 2541.644169816227, 2548.554003049459, 2554.7700706936466, 9198.402103863295, 9200.493972831491, 9215.58529866151, 9245.260379169651, 9249.16757491829, 5611.719414029282, 5668.489835914746, 5727.713614319267, 5780.0, 5792.4497172768515, 3686.705063594906, 3727.273181729564, 3783.0731470789833, 3795.905102372435, 3797.4493698413853, 1050.4642632257603, 1065.057424179599, 1069.2301542889186, 1079.2175672637354, 1079.7624522605015, 12173.695657608541, 12177.452014659362, 12206.450709717996, 12210.389480525939, 12568.245905245623, 4969.801207951641, 5027.547520723079, 5058.848234552969, 5097.566706829887, 5198.298229739013, 10456.68629941103, 10594.470276486145, 10624.415657138932, 10664.253502254767, 10775.191860610486, 5670.5463562914865, 5682.062459694104, 5807.361190269067, 5842.824715258464, 5905.379935106752, 4629.65277604181, 4690.202665546865, 4753.619710423158, 5215.869603259873, 5326.828097818474, 4152.875413737533, 4175.144095460423, 4192.182524407772, 4229.577042295746, 4258.5954334338185, 1384.9307534623229, 1414.4483651375972, 1414.844367119616, 1424.1099312929418, 1424.5583869000643, 911.4166933162782, 920.4569304110607, 954.1460392948272, 954.9379290346105, 975.4050029482011, 5926.762929482772, 6030.547708921848, 6056.606320589148, 6129.417705317987, 6218.614160100066, 411.83320755094235, 475.49834924155346, 480.3563225278144, 489.6890474548687, 492.9433115191799, 3167.2873603439502, 3915.7454765440157, 3982.6017398260524, 4002.959230600065, 4050.0482386639114, 9748.61005559784, 11262.662120136409, 11483.942580287212, 11575.421228938689, 11663.416829158508, 11147.275427097375, 11264.324140551593, 11312.71718207035, 11391.430428478543, 11430.028447582048, 8508.489490630582, 8708.91291087081, 8826.955865220632, 8907.643694252158, 8925.776855578533, 5771.039836810705, 5771.59598828078, 5822.679752613647, 5872.236609240771, 5922.111683247547, 9616.423014619146, 9626.95186524063, 9929.65246216379, 9938.403695778277, 9943.602255909682, 9738.269629777653, 10044.497775111362, 10203.0817226447, 10219.437930913871, 10235.641752538626, 6841.452683785185, 7680.116786569616, 8455.365847561334, 8560.101189375026, 8695.391322607356, 8538.01812791537, 8552.871706924525, 8556.871646925176, 8579.485230886166, 8612.526311052701, 7497.325240728361, 7521.285477879593, 7702.653380597774, 7811.140774514685, 7817.140114587277, 7167.1757747859665, 7478.70085196586, 7604.201558836243, 7687.807804804925, 7703.0, 7221.53060051095, 7230.530015549183, 7261.854762904818, 7271.200167981624, 7286.0, 4872.074305881871, 4910.950890491049, 4989.97705470385, 5076.238564215398, 5086.0845047891735, 4995.200767877122, 5010.8246211383885, 5040.8991820162655, 5067.0, 5221.608379371486], "value": 4708.635732829095, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.46963201054103, 342.92627085176684, 344.2323618331122, 349.93176330615535, 355.34793653645556, 6831.521793474452, 6889.517733758639, 6898.65506724663, 6922.619255940921, 6929.168499780028, 6836.82907927302, 6899.37905588497, 6944.02783610295, 6952.582845029289, 6957.5129740918155, 4841.588464980481, 4932.235503496964, 5070.949290507103, 5082.64421490494, 5112.718800465973, 4594.621613515948, 4654.627629789626, 4994.650374473788, 5075.543201111899, 5083.983203359325, 5002.349694539705, 5006.324146240266, 5018.473060328668, 5020.0963826511215, 5042.268871013719, 5011.32347133136, 5023.598112151019, 5044.016416798726, 5052.898942021176, 5110.488951104897, 4379.978100109511, 4382.2331092059085, 4383.561643835591, 4391.956080439187, 4392.626626736731, 6374.840628984266, 6604.801855944329, 6634.038064480672, 6657.367550082734, 6670.0, 4856.247281671346, 5884.941150588482, 5920.585559010871, 5937.554683398763, 5938.138969849348, 5643.8589035274035, 6339.95390760524, 7398.112226532797, 7436.0, 7443.069616297963, 3880.767153970771, 4741.739204343759, 4749.287606858964, 4751.596114330286, 4770.117528257283, 7608.35328997036, 7759.8448031039625, 7838.372930165573, 7866.331361834194, 7889.132195458495, 4807.351007613997, 4821.831235906727, 4822.252550854553, 4824.300476430898, 4833.516648335139, 3975.980120099381, 4862.319275301461, 4920.926186107211, 4937.333839726579, 4940.086084074458, 4620.445546534437, 4911.582515486152, 5806.896689628957, 5914.610066634337, 5931.436513531207, 6185.567010309235, 6197.907031394533, 7194.230221364707, 7439.479236453396, 7453.515521491194, 1673.790776152981, 1700.6598680263996, 1701.8553422959187, 1709.5811526176167, 1710.4612047205092, 909.3361845852564, 1055.1875056206832, 1069.8716154061563, 1080.56777289085, 1084.3819023156725, 5728.77084916607, 6974.79075627732, 7023.33278338557, 7024.964875175694, 7080.787576372614, 7391.741289054858, 7549.603323385191, 7738.574378409242, 7763.4953728007495, 7824.37405007598, 6954.269801670752, 6989.1962424321855, 6989.720411183597, 6990.531988282518, 6992.965035174791, 4091.9386209206887, 4128.525219599785, 4131.256373852675, 4136.007358234062, 4136.524299705572, 6526.673666316665, 8122.796930076795, 8144.877826832602, 8209.09699933007, 8214.0, 7346.77959661211, 7638.388928885676, 7972.720954766555, 8050.5169689818795, 8084.434089613788, 8094.392920530866, 8155.0, 8155.347572194329, 8163.97950256218, 8164.387670924823, 7778.766637000673, 7805.29752322271, 7805.531668099932, 7808.882866757117, 7809.375249979875, 7640.235976402315, 7650.846983060419, 7659.463837531319, 7662.463627546018, 7674.117476490275, 7332.706691732485, 7352.816179595553, 7788.376929845485, 8042.0, 8056.274935255855, 4756.500567440507, 4861.1006963711825, 4864.075825593126, 4889.877753056202, 4893.877653058702, 7780.0, 7831.0, 7835.255650713173, 7845.372370210255, 7870.173631768582, 7148.785536433916, 7495.7001719930595, 7521.849563008818, 7522.435817313833, 7531.284527969834, 6024.759009639565, 7424.554526728413, 7503.662335195038, 7528.058992625922, 7537.434692398202, 7297.63511824396, 7309.195988441374, 7312.305330993547, 7326.450516211199, 7328.523645962995, 7417.443691723034, 7440.107187137578, 7462.0, 7463.962680186782, 7485.214052524407, 7068.434525237866, 7268.491205615767, 7295.0, 7399.704011839682, 7411.370033547209], "value": 5352.7792616263005, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.3804727933976, 738.9482736208464, 746.2835677749362, 767.9040119985002, 780.2080887898784, 15563.688726225482, 15766.76349854753, 15767.526974190763, 15805.920970395133, 15872.761908571367, 11302.321860688364, 14766.704665906702, 14779.778303325458, 14790.630234244123, 14814.851851481482, 770.5915864591748, 818.8567000774856, 917.7567944494714, 928.4846909964966, 952.4666186935303, 920.4523308631387, 921.2537844346101, 941.4962994797785, 948.8671585977934, 953.1564565359672, 837.9790505237357, 902.1339514066505, 932.1051790281338, 975.2539307429822, 1007.0584003956325, 972.1153750087457, 976.497103991445, 1001.3541265883464, 1006.124671535765, 1014.3102690170717, 724.4240828541269, 728.5483000539647, 743.0563184755384, 756.2399788212866, 758.7268583310004, 13347.466101355934, 14596.927015364961, 15010.549683509404, 15043.398264069534, 15206.391744330214, 13285.667858303523, 13323.26722030288, 13380.264085475295, 13426.798598021038, 13539.984501162353, 9305.720828375159, 9577.51548509982, 10391.272610917238, 10525.894741052569, 10537.157027437786, 3608.9819550902075, 3635.054885729703, 3751.9062023449633, 3789.3936970084656, 3900.7074469414906, 75012.62493687551, 76389.61805190994, 77122.07194820062, 79401.0, 80427.59786201031, 9676.70969870905, 9692.466914319639, 9844.458554779556, 9847.55685994132, 10128.59485620567, 21632.24287149942, 21731.456713582287, 21792.019359128877, 21856.12575496994, 21864.672029919562, 7795.181505941908, 7878.1334053254095, 7889.447738658354, 7963.124056353797, 8021.478603890729, 4008.158286759755, 4038.899027524277, 4048.149888523384, 4053.61490658387, 4115.506139263308, 3121.453745594512, 3731.7014638828828, 3792.563855156637, 3793.8292776824555, 3803.1062700265416, 680.3400701319712, 682.2904179653204, 692.5982929900646, 692.8337199072187, 706.9787906362817, 579.4495229531962, 581.3575998521658, 599.9190109335271, 602.2080963533027, 613.622622087422, 7112.715491380287, 8303.584820758937, 8312.709055183039, 8323.209295116954, 8657.826843463095, 607.5504126946028, 609.8374590435365, 615.0988801405962, 619.8140557832633, 623.7536173211647, 3895.7857317847793, 3929.7445666031617, 3953.4267531207815, 4014.598540145962, 4070.715049946475, 94145.5292723532, 94824.52587737155, 95315.0, 96074.51962740142, 96255.0, 79987.0, 80675.59662201769, 80909.0, 81444.3711125786, 81923.59038204771, 57301.0, 70430.94353584701, 72878.63560682163, 76241.61879190679, 78296.6085169582, 6851.828704282433, 8886.511241881759, 8896.154865287788, 8908.331875109263, 8946.821063578822, 50332.74833625955, 50706.74646626743, 50725.74637126791, 51485.7425712869, 53166.0, 69925.65037174782, 72130.27869721236, 72518.27481725326, 73122.63438682772, 73184.26815731988, 11000.284981476498, 11064.778704426028, 11079.390633515233, 11161.995420412202, 11535.365554894226, 12081.818772718241, 12289.56986505468, 12334.629961101182, 12627.0, 12683.556075537681, 11678.70803229926, 11740.823887641864, 11925.373134328358, 11926.761464770829, 12040.879591204326, 11096.389698566656, 11559.479823408135, 11686.0, 11720.886515780987, 11927.701807454883, 10984.395858227554, 11361.0, 11493.023093037185, 11783.76432471363, 12065.577704780291, 9478.857817132886, 9591.407242693629, 9610.74305465879, 9664.9033509664, 9732.172765315028, 9107.59015844302, 9513.619455221991, 9691.370060946016, 10022.548985295532, 10044.447555384524], "value": 7077.428466014076, "unit": "score"}], "name": "dromaeo_css", "value": 7644.7229514400315, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 110.0, 115.0, 116.0, 118.0, 132.0, 115.0, 116.0, 116.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 154.0, 138.0, 156.0, 121.0, 140.0, 141.0, 122.0, 207.0, 127.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 202.0, 193.0, 195.0, 196.0, 195.0, 193.0, 197.0, 194.0, 193.0], "value": 195.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 80.0, 73.0, 142.0, 54.0, 57.0, 60.0, 65.0, 121.0, 57.0], "value": 77.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 128.0, 78.0, 78.0, 93.0, 159.0, 87.0, 80.0, 124.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 88.0, 97.0, 120.0, 85.0, 91.0, 128.0, 89.0, 86.0], "value": 95.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 95.0, 94.0, 96.0, 94.0, 111.0, 154.0, 128.0, 94.0, 95.0], "value": 106.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 91.0, 106.0, 134.0, 89.0, 97.0, 89.0, 91.0, 91.0], "value": 106.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 63.0, 63.0, 65.0, 64.0, 62.0, 79.0, 63.0, 59.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 64.0, 73.0, 64.0, 95.0, 105.0, 94.0, 62.0, 64.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 82.0, 81.0, 82.0, 82.0, 79.0, 81.0, 86.0, 83.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 146.0, 140.0, 127.0, 132.0, 153.0, 141.0, 119.0, 197.0, 167.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 174.0, 166.0, 163.0, 163.0, 168.0, 160.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 72.0, 66.0, 69.0, 66.0, 65.0, 70.0, 68.0, 69.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1544.7, "alertThreshold": 2.0}]} 16:51:37 INFO - Return code: 0 16:51:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:51:37 ERROR - # TBPL SUCCESS # 16:51:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:51:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:51:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:51:37 INFO - 2016-06-24 16:51:37.646 screenresolution[1685:11080] starting screenresolution argv=screenresolution get 16:51:37 INFO - 2016-06-24 16:51:37.648 screenresolution[1685:11080] Display 0: 1600x1200x32@60 16:51:37 INFO - 2016-06-24 16:51:37.654 screenresolution[1686:11083] starting screenresolution argv=screenresolution list 16:51:37 INFO - Available Modes on Display 0 16:51:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:51:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:51:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:51:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:51:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:51:37 INFO - Intel Iris: 16:51:37 INFO - Chipset Model: Intel Iris 16:51:37 INFO - Type: GPU 16:51:37 INFO - Bus: Built-In 16:51:37 INFO - VRAM (Dynamic, Max): 1536 MB 16:51:37 INFO - Vendor: Intel (0x8086) 16:51:37 INFO - Device ID: 0x0a2e 16:51:37 INFO - Revision ID: 0x0009 16:51:37 INFO - Displays: 16:51:37 INFO - Display: 16:51:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:51:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:51:37 INFO - Display Serial Number: 1600x1200 60 16:51:37 INFO - Main Display: Yes 16:51:37 INFO - Mirror: Off 16:51:37 INFO - Online: Yes 16:51:37 INFO - Rotation: Supported 16:51:37 INFO - Return code: 0 16:51:37 INFO - Running post-action listener: _resource_record_post_action 16:51:37 INFO - Running post-run listener: _resource_record_post_run 16:51:38 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 31710720; Write bytes: 498050048; Read time: 202; Write time: 1555 16:51:38 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 237568; Write bytes: 197548032; Read time: 4; Write time: 429 16:51:38 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 29928960; Write bytes: 299654144; Read time: 186; Write time: 1124 16:51:38 INFO - Running post-run listener: _upload_blobber_files 16:51:38 INFO - Blob upload gear active. 16:51:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:51:38 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 16:51:38 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'] 16:51:38 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 16:51:39 INFO - (blobuploader) - INFO - Open directory for files ... 16:51:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:51:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:40 INFO - (blobuploader) - INFO - Done attempting. 16:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:41 INFO - (blobuploader) - INFO - Done attempting. 16:51:41 INFO - (blobuploader) - INFO - Iteration through files over. 16:51:41 INFO - Return code: 0 16:51:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:51:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:51:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f670b7f9be2bb9e2b5cd29782c60375980e3b8b014b69f572afa1ce7acebb010341fb71c6fbcfb2b12cb7a4bba1c74efe678d39e2dc589f929829becad1c7792", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b6fc4db6ca556b34b79c06b6742d62835eaca6dbce2e865dd99946664fd67ca88462138d6e6c2759828df19d0cf03c02b7c7d517ae91210378a7eaa651627c3"} 16:51:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:51:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:51:41 INFO - Contents: 16:51:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f670b7f9be2bb9e2b5cd29782c60375980e3b8b014b69f572afa1ce7acebb010341fb71c6fbcfb2b12cb7a4bba1c74efe678d39e2dc589f929829becad1c7792", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b6fc4db6ca556b34b79c06b6742d62835eaca6dbce2e865dd99946664fd67ca88462138d6e6c2759828df19d0cf03c02b7c7d517ae91210378a7eaa651627c3"} 16:51:41 INFO - Running post-run listener: copy_logs_to_upload_dir 16:51:41 INFO - Copying logs to upload dir... 16:51:41 INFO - mkdir: /builds/slave/test/build/upload/logs 16:51:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1837.042649 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 30 mins, 37 secs) (at 2016-06-24 16:51:41.628712) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 16:51:41.632530) ========= 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.qgY93HxGKG/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.xdyG3KCz9J/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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/f670b7f9be2bb9e2b5cd29782c60375980e3b8b014b69f572afa1ce7acebb010341fb71c6fbcfb2b12cb7a4bba1c74efe678d39e2dc589f929829becad1c7792", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b6fc4db6ca556b34b79c06b6742d62835eaca6dbce2e865dd99946664fd67ca88462138d6e6c2759828df19d0cf03c02b7c7d517ae91210378a7eaa651627c3"} build_url:https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010996 build_url: 'https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f670b7f9be2bb9e2b5cd29782c60375980e3b8b014b69f572afa1ce7acebb010341fb71c6fbcfb2b12cb7a4bba1c74efe678d39e2dc589f929829becad1c7792", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b6fc4db6ca556b34b79c06b6742d62835eaca6dbce2e865dd99946664fd67ca88462138d6e6c2759828df19d0cf03c02b7c7d517ae91210378a7eaa651627c3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 16:51:41.665232) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 16:51:41.665553) ========= 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.qgY93HxGKG/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.xdyG3KCz9J/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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.005214 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 16:51:41.713866) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 16:51:41.714188) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 16:51:41.714685) ========= ========= Total master_lag: 0.19 =========