builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0171 starttime: 1467949339.91 results: success (0) buildid: 20160707183926 builduid: 328b1b0c396c47e78703d0d1de60df83 revision: f4e161a1dd38df3f4679d7b647371e2388e7eb72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:19.907652) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:19.908176) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:19.908497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:19.934413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:19.934844) ========= 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.25UdZSOlla/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.U313Q1azTP/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-07 20:42:19-- 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% 71.5M=0s 2016-07-07 20:42:20 (71.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119757 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:20.077954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:20.078321) ========= 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.25UdZSOlla/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.U313Q1azTP/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.026925 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:20.126754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 20:42:20.127162) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f4e161a1dd38df3f4679d7b647371e2388e7eb72 --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 f4e161a1dd38df3f4679d7b647371e2388e7eb72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.25UdZSOlla/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.U313Q1azTP/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-07 20:42:20,203 truncating revision to first 12 chars 2016-07-07 20:42:20,203 Setting DEBUG logging. 2016-07-07 20:42:20,204 attempt 1/10 2016-07-07 20:42:20,204 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f4e161a1dd38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 20:42:21,263 unpacking tar archive at: mozilla-beta-f4e161a1dd38/testing/mozharness/ program finished with exit code 0 elapsedTime=1.330641 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 20:42:21.481158) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:21.481529) ========= script_repo_revision: f4e161a1dd38df3f4679d7b647371e2388e7eb72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:21.482124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:21.482489) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 20:42:21.501834) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-07 20:42:21.502238) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.25UdZSOlla/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.U313Q1azTP/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 20:42:21 INFO - MultiFileLogger online at 20160707 20:42:21 in /builds/slave/test 20:42:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:42:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:42:21 INFO - {'append_to_log': False, 20:42:21 INFO - 'base_work_dir': '/builds/slave/test', 20:42:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:42:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:42:21 INFO - 'branch': 'Mozilla-Beta', 20:42:21 INFO - 'buildbot_json_path': 'buildprops.json', 20:42:21 INFO - 'config_files': ('talos/mac_config.py',), 20:42:21 INFO - 'default_actions': ('clobber', 20:42:21 INFO - 'read-buildbot-config', 20:42:21 INFO - 'download-and-extract', 20:42:21 INFO - 'populate-webroot', 20:42:21 INFO - 'create-virtualenv', 20:42:21 INFO - 'install', 20:42:21 INFO - 'run-tests'), 20:42:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:42:21 INFO - 'download_minidump_stackwalk': True, 20:42:21 INFO - 'download_symbols': 'ondemand', 20:42:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:42:21 INFO - 'tooltool.py': '/tools/tooltool.py', 20:42:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:42:21 INFO - '/tools/misc-python/virtualenv.py')}, 20:42:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:42:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:42:21 INFO - 'installer_path': 'installer.exe', 20:42:21 INFO - 'log_level': 'info', 20:42:21 INFO - 'log_name': 'talos', 20:42:21 INFO - 'log_to_console': True, 20:42:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:42:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:42:21 INFO - 'opt_config_files': (), 20:42:21 INFO - 'pip_index': False, 20:42:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:42:21 INFO - 'cmd': ('bash', 20:42:21 INFO - '-c', 20:42:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:42:21 INFO - 'enabled': True, 20:42:21 INFO - 'halt_on_failure': False, 20:42:21 INFO - 'name': 'check_screen_resolution'},), 20:42:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:42:21 INFO - 'cmd': ('bash', 20:42:21 INFO - '-c', 20:42:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:42:21 INFO - 'enabled': True, 20:42:21 INFO - 'halt_on_failure': False, 20:42:21 INFO - 'name': 'check_screen_resolution'},), 20:42:21 INFO - 'run_cmd_checks_enabled': True, 20:42:21 INFO - 'sps_profile': False, 20:42:21 INFO - 'sps_profile_interval': 0, 20:42:21 INFO - 'suite': 'dromaeojs', 20:42:21 INFO - 'system_bits': '32', 20:42:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:42:21 INFO - 'title': 't-yosemite-r7-0171', 20:42:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:42:21 INFO - 'use_talos_json': True, 20:42:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:42:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:42:21 INFO - 'work_dir': 'build'} 20:42:21 INFO - ##### 20:42:21 INFO - ##### Running clobber step. 20:42:21 INFO - ##### 20:42:21 INFO - Running pre-action listener: _resource_record_pre_action 20:42:21 INFO - Running main action method: clobber 20:42:21 INFO - rmtree: /builds/slave/test/build 20:42:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:42:23 INFO - Running post-action listener: _resource_record_post_action 20:42:23 INFO - ##### 20:42:23 INFO - ##### Running read-buildbot-config step. 20:42:23 INFO - ##### 20:42:23 INFO - Running pre-action listener: _resource_record_pre_action 20:42:23 INFO - Running main action method: read_buildbot_config 20:42:23 INFO - Using buildbot properties: 20:42:23 INFO - { 20:42:23 INFO - "project": "", 20:42:23 INFO - "product": "firefox", 20:42:23 INFO - "script_repo_revision": "production", 20:42:23 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 20:42:23 INFO - "repository": "", 20:42:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 20:42:23 INFO - "buildid": "20160707183926", 20:42:23 INFO - "pgo_build": "False", 20:42:23 INFO - "basedir": "/builds/slave/test", 20:42:23 INFO - "buildnumber": 13, 20:42:23 INFO - "slavename": "t-yosemite-r7-0171", 20:42:23 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 20:42:23 INFO - "platform": "yosemite_r7", 20:42:23 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:42:23 INFO - "branch": "mozilla-beta", 20:42:23 INFO - "repo_path": "releases/mozilla-beta", 20:42:23 INFO - "revision": "f4e161a1dd38df3f4679d7b647371e2388e7eb72", 20:42:23 INFO - "stage_platform": "macosx64", 20:42:23 INFO - "builduid": "328b1b0c396c47e78703d0d1de60df83", 20:42:23 INFO - "slavebuilddir": "test" 20:42:23 INFO - } 20:42:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 20:42:23 INFO - Running post-action listener: _resource_record_post_action 20:42:23 INFO - ##### 20:42:23 INFO - ##### Running download-and-extract step. 20:42:23 INFO - ##### 20:42:23 INFO - Running pre-action listener: _resource_record_pre_action 20:42:23 INFO - Running main action method: download_and_extract 20:42:23 INFO - mkdir: /builds/slave/test/build/tests 20:42: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')]} 20:42:23 INFO - https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 20:42:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 20:42:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 20:42:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:32 INFO - Downloaded 1165 bytes. 20:42:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 20:42:32 INFO - Using the following test package requirements: 20:42:32 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:42:32 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:32 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 20:42:32 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:32 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 20:42:32 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:42:32 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:32 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 20:42:32 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 20:42:32 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:32 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 20:42:32 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:32 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 20:42:32 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:32 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 20:42:32 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 20:42:32 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 20:42:32 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 20:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:32 INFO - https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:42:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 20:42:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 20:42:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:33 INFO - Downloaded 18351528 bytes. 20:42:33 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'] 20:42:33 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 20:42:36 INFO - Return code: 0 20:42:36 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 20:42: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')]} 20:42:36 INFO - https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:42:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 20:42:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 20:42:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:38 INFO - Downloaded 18351528 bytes. 20:42:38 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'] 20:42:38 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 20:42:42 INFO - Return code: 0 20:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:42 INFO - https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:42:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 20:42:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 20:42:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:43 INFO - Downloaded 10840145 bytes. 20:42:43 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'] 20:42:43 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 20:42:43 INFO - Return code: 0 20:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:43 INFO - https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 20:42:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg 20:42:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg 20:42:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 20:42:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/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 20:42:49 INFO - Downloaded 86190245 bytes. 20:42:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg 20:42:49 INFO - mkdir: /builds/slave/test/properties 20:42:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:42:49 INFO - Writing to file /builds/slave/test/properties/build_url 20:42:49 INFO - Contents: 20:42:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg 20:42:50 INFO - Running post-action listener: _resource_record_post_action 20:42:50 INFO - Running post-action listener: set_extra_try_arguments 20:42:50 INFO - ##### 20:42:50 INFO - ##### Running populate-webroot step. 20:42:50 INFO - ##### 20:42:50 INFO - Running pre-action listener: _resource_record_pre_action 20:42:50 INFO - Running main action method: populate_webroot 20:42:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:42:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:42:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:42:50 INFO - '--tppagecycles', 20:42:50 INFO - '7'], 20:42:50 INFO - 'tests': ['tsvgm']}}, 20:42:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:42:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:42:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:42:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:42:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:42:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:42:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:50 INFO - 'talos_options': ['--disable-e10s'], 20:42:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:42:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:42:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:50 INFO - 'talos_options': ['--disable-e10s'], 20:42:50 INFO - 'tests': ['damp', 'tps']}, 20:42:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:50 INFO - 'tests': ['damp', 'tps']}, 20:42:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:42:50 INFO - 'tests': ['dromaeo_dom']}, 20:42:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:42:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:42:50 INFO - 'tests': ['a11yr', 20:42:50 INFO - 'ts_paint', 20:42:50 INFO - 'tpaint', 20:42:50 INFO - 'sessionrestore', 20:42:50 INFO - 'sessionrestore_no_auto_restore', 20:42:50 INFO - 'tabpaint']}, 20:42:50 INFO - 'other-e10s': {'tests': ['a11yr', 20:42:50 INFO - 'ts_paint', 20:42:50 INFO - 'tpaint', 20:42:50 INFO - 'sessionrestore', 20:42:50 INFO - 'sessionrestore_no_auto_restore', 20:42:50 INFO - 'tabpaint']}, 20:42:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:42:50 INFO - 'ts_paint', 20:42:50 INFO - 'tpaint', 20:42:50 INFO - 'sessionrestore', 20:42:50 INFO - 'sessionrestore_no_auto_restore', 20:42:50 INFO - 'tabpaint']}, 20:42:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:42:50 INFO - 'ts_paint', 20:42:50 INFO - 'tpaint', 20:42:50 INFO - 'sessionrestore', 20:42:50 INFO - 'sessionrestore_no_auto_restore', 20:42:50 INFO - 'tabpaint']}, 20:42:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:42:50 INFO - 'tests': ['a11yr', 20:42:50 INFO - 'ts_paint', 20:42:50 INFO - 'tpaint', 20:42:50 INFO - 'sessionrestore', 20:42:50 INFO - 'sessionrestore_no_auto_restore', 20:42:50 INFO - 'tabpaint']}, 20:42:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:42:50 INFO - 'tests': ['a11yr', 20:42:50 INFO - 'ts_paint', 20:42:50 INFO - 'tpaint', 20:42:50 INFO - 'sessionrestore', 20:42:50 INFO - 'sessionrestore_no_auto_restore', 20:42:50 INFO - 'tabpaint']}, 20:42:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:42:50 INFO - 'tests': ['tsvgx', 20:42:50 INFO - 'tsvgr_opacity', 20:42:50 INFO - 'tart', 20:42:50 INFO - 'tscrollx', 20:42:50 INFO - 'cart']}, 20:42:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:42:50 INFO - 'tsvgr_opacity', 20:42:50 INFO - 'tart', 20:42:50 INFO - 'tscrollx', 20:42:50 INFO - 'cart']}, 20:42:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:50 INFO - 'talos_options': ['--disable-e10s'], 20:42:50 INFO - 'tests': ['tp5o']}, 20:42:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:50 INFO - 'tests': ['tp5o']}, 20:42:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:50 INFO - 'talos_options': ['--disable-e10s', 20:42:50 INFO - '--xperf_path', 20:42:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:42:50 INFO - 'tests': ['tp5n']}, 20:42:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:50 INFO - 'talos_options': ['--xperf_path', 20:42:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:42:50 INFO - 'tests': ['tp5n']}}, 20:42:50 INFO - 'talos.zip': {'path': '', 20:42:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:42:50 INFO - Running post-action listener: _resource_record_post_action 20:42:50 INFO - ##### 20:42:50 INFO - ##### Running create-virtualenv step. 20:42:50 INFO - ##### 20:42:50 INFO - Running pre-action listener: _resource_record_pre_action 20:42:50 INFO - Running main action method: create_virtualenv 20:42:50 INFO - Creating virtualenv /builds/slave/test/build/venv 20:42:50 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 20:42:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:42:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:42:50 INFO - Using real prefix '/tools/python27' 20:42:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:42:51 INFO - Installing distribute.............................................................................................................................................................................................done. 20:42:54 INFO - Installing pip.................done. 20:42:54 INFO - Return code: 0 20:42:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:54 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 0x10cacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cade420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff593da0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c96de00>, '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 0x10c7d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c968b20>, '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.25UdZSOlla/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.U313Q1azTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 20:42:54 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 20:42:54 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 20:42:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.25UdZSOlla/Render', 20:42:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:42:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:42:54 INFO - 'HOME': '/Users/cltbld', 20:42:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:42:54 INFO - 'LOGNAME': 'cltbld', 20:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:54 INFO - 'MOZ_NO_REMOTE': '1', 20:42:54 INFO - 'NO_EM_RESTART': '1', 20:42:54 INFO - 'PAGER': '/bin/cat', 20:42:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:54 INFO - 'PWD': '/builds/slave/test', 20:42:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:42:54 INFO - 'SHELL': '/bin/bash', 20:42:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U313Q1azTP/Listeners', 20:42:54 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 20:42:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:42:54 INFO - 'USER': 'cltbld', 20:42:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:42:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:54 INFO - 'XPC_FLAGS': '0x0', 20:42:54 INFO - 'XPC_SERVICE_NAME': '0', 20:42:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:54 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 20:42:54 INFO - Cleaning up... 20:42:54 INFO - Return code: 0 20:42:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:54 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 0x10cacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cade420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff593da0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c96de00>, '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 0x10c7d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c968b20>, '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.25UdZSOlla/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.U313Q1azTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 20:42:54 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 20:42:54 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 20:42:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.25UdZSOlla/Render', 20:42:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:42:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:42:54 INFO - 'HOME': '/Users/cltbld', 20:42:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:42:54 INFO - 'LOGNAME': 'cltbld', 20:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:54 INFO - 'MOZ_NO_REMOTE': '1', 20:42:54 INFO - 'NO_EM_RESTART': '1', 20:42:54 INFO - 'PAGER': '/bin/cat', 20:42:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:54 INFO - 'PWD': '/builds/slave/test', 20:42:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:42:54 INFO - 'SHELL': '/bin/bash', 20:42:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U313Q1azTP/Listeners', 20:42:54 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 20:42:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:42:54 INFO - 'USER': 'cltbld', 20:42:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:42:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:54 INFO - 'XPC_FLAGS': '0x0', 20:42:54 INFO - 'XPC_SERVICE_NAME': '0', 20:42:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:54 INFO - Downloading/unpacking psutil>=0.7.1 20:42:54 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 20:42:54 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 20:42:54 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 20:42:54 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 20:42:54 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 20:42:54 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 20:42:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:42:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:42:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:42:57 INFO - Installing collected packages: psutil 20:42:57 INFO - Running setup.py install for psutil 20:42:57 INFO - building 'psutil._psutil_osx' extension 20:42:57 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 20:42:57 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 20:42:58 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 20:42:58 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 20:42:58 INFO - building 'psutil._psutil_posix' extension 20:42:58 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 20:42:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:42:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:42:58 INFO - ^ 20:42:58 INFO - 1 warning generated. 20:42:58 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 20:42:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:42:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:42:58 INFO - Successfully installed psutil 20:42:58 INFO - Cleaning up... 20:42:58 INFO - Return code: 0 20:42:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cade420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff593da0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c96de00>, '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 0x10c7d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c968b20>, '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.25UdZSOlla/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.U313Q1azTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 20:42:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:42:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.25UdZSOlla/Render', 20:42:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:42:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:42:58 INFO - 'HOME': '/Users/cltbld', 20:42:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:42:58 INFO - 'LOGNAME': 'cltbld', 20:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:58 INFO - 'MOZ_NO_REMOTE': '1', 20:42:58 INFO - 'NO_EM_RESTART': '1', 20:42:58 INFO - 'PAGER': '/bin/cat', 20:42:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:58 INFO - 'PWD': '/builds/slave/test', 20:42:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:42:58 INFO - 'SHELL': '/bin/bash', 20:42:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U313Q1azTP/Listeners', 20:42:58 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 20:42:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:42:58 INFO - 'USER': 'cltbld', 20:42:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:42:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:58 INFO - 'XPC_FLAGS': '0x0', 20:42:58 INFO - 'XPC_SERVICE_NAME': '0', 20:42:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:43:01 INFO - Installing collected packages: mozsystemmonitor 20:43:01 INFO - Running setup.py install for mozsystemmonitor 20:43:01 INFO - Successfully installed mozsystemmonitor 20:43:01 INFO - Cleaning up... 20:43:01 INFO - Return code: 0 20:43:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cade420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff593da0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c96de00>, '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 0x10c7d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c968b20>, '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.25UdZSOlla/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.U313Q1azTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 20:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:43:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.25UdZSOlla/Render', 20:43:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:01 INFO - 'HOME': '/Users/cltbld', 20:43:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:01 INFO - 'LOGNAME': 'cltbld', 20:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:01 INFO - 'MOZ_NO_REMOTE': '1', 20:43:01 INFO - 'NO_EM_RESTART': '1', 20:43:01 INFO - 'PAGER': '/bin/cat', 20:43:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:01 INFO - 'PWD': '/builds/slave/test', 20:43:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:01 INFO - 'SHELL': '/bin/bash', 20:43:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U313Q1azTP/Listeners', 20:43:01 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 20:43:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:01 INFO - 'USER': 'cltbld', 20:43:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:01 INFO - 'XPC_FLAGS': '0x0', 20:43:01 INFO - 'XPC_SERVICE_NAME': '0', 20:43:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:01 INFO - Downloading/unpacking blobuploader==1.2.4 20:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:04 INFO - Downloading blobuploader-1.2.4.tar.gz 20:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:43:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:43:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:05 INFO - Downloading docopt-0.6.1.tar.gz 20:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:43:05 INFO - Installing collected packages: blobuploader, requests, docopt 20:43:05 INFO - Running setup.py install for blobuploader 20:43:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:43:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:43:05 INFO - Running setup.py install for requests 20:43:06 INFO - Running setup.py install for docopt 20:43:06 INFO - Successfully installed blobuploader requests docopt 20:43:06 INFO - Cleaning up... 20:43:06 INFO - Return code: 0 20:43:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:43: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')]} 20:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43: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')]} 20:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:06 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 0x10cacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cade420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff593da0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c96de00>, '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 0x10c7d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c968b20>, '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.25UdZSOlla/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.U313Q1azTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 20:43:06 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 20:43:06 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 20:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.25UdZSOlla/Render', 20:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:06 INFO - 'HOME': '/Users/cltbld', 20:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:06 INFO - 'LOGNAME': 'cltbld', 20:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:06 INFO - 'MOZ_NO_REMOTE': '1', 20:43:06 INFO - 'NO_EM_RESTART': '1', 20:43:06 INFO - 'PAGER': '/bin/cat', 20:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:06 INFO - 'PWD': '/builds/slave/test', 20:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:06 INFO - 'SHELL': '/bin/bash', 20:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U313Q1azTP/Listeners', 20:43:06 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 20:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:06 INFO - 'USER': 'cltbld', 20:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:06 INFO - 'XPC_FLAGS': '0x0', 20:43:06 INFO - 'XPC_SERVICE_NAME': '0', 20:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:43:06 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-afpq7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:43:06 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-vJG1gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:43:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-9r16U0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:43:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-jBj9Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:43:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-TUp2te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:43:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-r6AIAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:43:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-N27KhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:43:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-F1s4MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:43:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-ffVWyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:43:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-2HqtgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:43:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-9dR7DF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:43:08 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-jTZL0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:43:08 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-5j7v4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:43:08 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-JPDzoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:43:08 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-NuZdpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:43:08 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-YYDITi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:43:08 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-2j3tI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:43:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:43:08 INFO - Running setup.py install for manifestparser 20:43:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:43:08 INFO - Running setup.py install for mozcrash 20:43:08 INFO - Running setup.py install for mozdebug 20:43:09 INFO - Running setup.py install for mozdevice 20:43:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:43:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:43:09 INFO - Running setup.py install for mozfile 20:43:09 INFO - Running setup.py install for mozhttpd 20:43:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:43:09 INFO - Running setup.py install for mozinfo 20:43:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:43:09 INFO - Running setup.py install for mozInstall 20:43:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:43:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:43:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:43:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:43:09 INFO - Running setup.py install for mozleak 20:43:09 INFO - Running setup.py install for mozlog 20:43:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:43:10 INFO - Running setup.py install for moznetwork 20:43:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:43:10 INFO - Running setup.py install for mozprocess 20:43:10 INFO - Running setup.py install for mozprofile 20:43:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:43:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:43:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:43:10 INFO - Running setup.py install for mozrunner 20:43:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:43:10 INFO - Running setup.py install for mozscreenshot 20:43:10 INFO - Running setup.py install for moztest 20:43:11 INFO - Running setup.py install for mozversion 20:43:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:43:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:43:11 INFO - Cleaning up... 20:43:11 INFO - Return code: 0 20:43:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:43:11 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')]} 20:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:11 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')]} 20:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:11 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 0x10cacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cade420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff593da0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c96de00>, '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 0x10c7d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c968b20>, '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.25UdZSOlla/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.U313Q1azTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 20:43:11 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 20:43:11 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 20:43:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.25UdZSOlla/Render', 20:43:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:11 INFO - 'HOME': '/Users/cltbld', 20:43:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:11 INFO - 'LOGNAME': 'cltbld', 20:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:11 INFO - 'MOZ_NO_REMOTE': '1', 20:43:11 INFO - 'NO_EM_RESTART': '1', 20:43:11 INFO - 'PAGER': '/bin/cat', 20:43:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:11 INFO - 'PWD': '/builds/slave/test', 20:43:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:11 INFO - 'SHELL': '/bin/bash', 20:43:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U313Q1azTP/Listeners', 20:43:11 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 20:43:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:11 INFO - 'USER': 'cltbld', 20:43:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:11 INFO - 'XPC_FLAGS': '0x0', 20:43:11 INFO - 'XPC_SERVICE_NAME': '0', 20:43:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:43:11 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-u1h2Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:43:11 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)) 20:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:43:11 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-_V0uSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:43:11 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)) 20:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:43:11 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-DYrXk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:43:11 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)) 20:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:43:11 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Z4YEPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:43:11 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)) 20:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:43:11 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-4spZoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:43:11 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)) 20:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:43:11 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-im6tKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:43:12 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)) 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:43:12 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-dfDsJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:43:12 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)) 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:43:12 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-GBTz7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:43:12 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)) 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:43:12 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-z31_dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:43:12 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)) 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:43:12 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-CzXsoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:43:12 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)) 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:43:12 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-3rtuTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:43:12 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)) 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:43:12 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-5OqMQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:43:12 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)) 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:43:12 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-7_9W4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:43:12 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)) 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:43:12 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-WtJHkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:43:12 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)) 20:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:43:12 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-c4X0kI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:43:13 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)) 20:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:43:13 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-1i5_R1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:43:13 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)) 20:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:43:13 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-al7bfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:43:13 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)) 20:43:13 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)) 20:43:13 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)) 20:43:13 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)) 20:43:13 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)) 20:43:13 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)) 20:43:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:43:13 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 20:43:13 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 20:43:13 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 20:43:13 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 20:43:13 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 20:43:13 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 20:43:15 INFO - Downloading blessings-1.6.tar.gz 20:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:43:15 INFO - Installing collected packages: blessings 20:43:15 INFO - Running setup.py install for blessings 20:43:15 INFO - Successfully installed blessings 20:43:15 INFO - Cleaning up... 20:43:16 INFO - Return code: 0 20:43:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:43:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:43:16 INFO - Reading from file tmpfile_stdout 20:43:16 INFO - Current package versions: 20:43:16 INFO - blessings == 1.6 20:43:16 INFO - blobuploader == 1.2.4 20:43:16 INFO - docopt == 0.6.1 20:43:16 INFO - manifestparser == 1.1 20:43:16 INFO - mozInstall == 1.12 20:43:16 INFO - mozcrash == 0.17 20:43:16 INFO - mozdebug == 0.1 20:43:16 INFO - mozdevice == 0.48 20:43:16 INFO - mozfile == 1.2 20:43:16 INFO - mozhttpd == 0.7 20:43:16 INFO - mozinfo == 0.9 20:43:16 INFO - mozleak == 0.1 20:43:16 INFO - mozlog == 3.1 20:43:16 INFO - moznetwork == 0.27 20:43:16 INFO - mozprocess == 0.22 20:43:16 INFO - mozprofile == 0.28 20:43:16 INFO - mozrunner == 6.11 20:43:16 INFO - mozscreenshot == 0.1 20:43:16 INFO - mozsystemmonitor == 0.0 20:43:16 INFO - moztest == 0.7 20:43:16 INFO - mozversion == 1.4 20:43:16 INFO - psutil == 3.1.1 20:43:16 INFO - requests == 1.2.3 20:43:16 INFO - wsgiref == 0.1.2 20:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:43:16 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')]} 20:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43: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')]} 20:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:17 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 0x10cacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cade420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff593da0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c96de00>, '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 0x10c7d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c968b20>, '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.25UdZSOlla/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.U313Q1azTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 20:43:17 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 20:43:17 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 20:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.25UdZSOlla/Render', 20:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:17 INFO - 'HOME': '/Users/cltbld', 20:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:17 INFO - 'LOGNAME': 'cltbld', 20:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:17 INFO - 'MOZ_NO_REMOTE': '1', 20:43:17 INFO - 'NO_EM_RESTART': '1', 20:43:17 INFO - 'PAGER': '/bin/cat', 20:43:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:17 INFO - 'PWD': '/builds/slave/test', 20:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:17 INFO - 'SHELL': '/bin/bash', 20:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U313Q1azTP/Listeners', 20:43:17 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 20:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:17 INFO - 'USER': 'cltbld', 20:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:17 INFO - 'XPC_FLAGS': '0x0', 20:43:17 INFO - 'XPC_SERVICE_NAME': '0', 20:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:17 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)) 20:43:17 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)) 20:43:17 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)) 20:43:17 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)) 20:43:17 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)) 20:43:17 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)) 20:43:17 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)) 20:43:17 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)) 20:43:17 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)) 20:43:17 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)) 20:43:17 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)) 20:43:17 INFO - Cleaning up... 20:43:17 INFO - Return code: 0 20:43:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:43: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')]} 20:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43: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')]} 20:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cade420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff593da0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c96de00>, '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 0x10c7d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c968b20>, '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.25UdZSOlla/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.U313Q1azTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 20:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.25UdZSOlla/Render', 20:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:17 INFO - 'HOME': '/Users/cltbld', 20:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:17 INFO - 'LOGNAME': 'cltbld', 20:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:17 INFO - 'MOZ_NO_REMOTE': '1', 20:43:17 INFO - 'NO_EM_RESTART': '1', 20:43:17 INFO - 'PAGER': '/bin/cat', 20:43:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:17 INFO - 'PWD': '/builds/slave/test', 20:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:17 INFO - 'SHELL': '/bin/bash', 20:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U313Q1azTP/Listeners', 20:43:17 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 20:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:17 INFO - 'USER': 'cltbld', 20:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:17 INFO - 'XPC_FLAGS': '0x0', 20:43:17 INFO - 'XPC_SERVICE_NAME': '0', 20:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:17 INFO - Downloading/unpacking jsonschema 20:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:43:20 INFO - Downloading/unpacking functools32 (from jsonschema) 20:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:20 INFO - Downloading functools32-3.2.3-2.tar.gz 20:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:43:20 INFO - warning: no files found matching '*.txt' 20:43:20 INFO - no previously-included directories found matching 'build' 20:43:20 INFO - no previously-included directories found matching 'dist' 20:43:20 INFO - no previously-included directories found matching '.git*' 20:43:20 INFO - Installing collected packages: jsonschema, functools32 20:43:20 INFO - Running setup.py install for functools32 20:43:21 INFO - warning: no files found matching '*.txt' 20:43:21 INFO - no previously-included directories found matching 'build' 20:43:21 INFO - no previously-included directories found matching 'dist' 20:43:21 INFO - no previously-included directories found matching '.git*' 20:43:21 INFO - Successfully installed jsonschema functools32 20:43:21 INFO - Cleaning up... 20:43:21 INFO - Return code: 0 20:43:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:43: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')]} 20:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43: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')]} 20:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:43: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cacea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cade420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff593da0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c96de00>, '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 0x10c7d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c968b20>, '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.25UdZSOlla/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.U313Q1azTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 20:43: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', 'flake8'] in /builds/slave/test/build 20:43: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 flake8 20:43:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.25UdZSOlla/Render', 20:43:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:21 INFO - 'HOME': '/Users/cltbld', 20:43:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:21 INFO - 'LOGNAME': 'cltbld', 20:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:21 INFO - 'MOZ_NO_REMOTE': '1', 20:43:21 INFO - 'NO_EM_RESTART': '1', 20:43:21 INFO - 'PAGER': '/bin/cat', 20:43:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:21 INFO - 'PWD': '/builds/slave/test', 20:43:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:21 INFO - 'SHELL': '/bin/bash', 20:43:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U313Q1azTP/Listeners', 20:43:21 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 20:43:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:21 INFO - 'USER': 'cltbld', 20:43:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:21 INFO - 'XPC_FLAGS': '0x0', 20:43:21 INFO - 'XPC_SERVICE_NAME': '0', 20:43:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:43:21 INFO - Downloading/unpacking flake8 20:43: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 20:43: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 20:43: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 20:43: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 20:43: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 20:43: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 20:43:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:43:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:43:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:43:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:43: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 20:43: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 20:43: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 20:43: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 20:43: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 20:43: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 20:43:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:43: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 20:43: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 20:43: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 20:43: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 20:43: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 20:43: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 20:43:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:43:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:43:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:43:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:43:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:43:25 INFO - no previously-included directories found matching 'docs/_build' 20:43:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:43:25 INFO - Running setup.py install for pep8 20:43:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:43:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:43:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:43:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:43:25 INFO - no previously-included directories found matching 'docs/_build' 20:43:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:43:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:43:25 INFO - Cleaning up... 20:43:25 INFO - Return code: 0 20:43:25 INFO - Running post-action listener: _resource_record_post_action 20:43:25 INFO - Running post-action listener: _start_resource_monitoring 20:43:25 INFO - Starting resource monitoring. 20:43:25 INFO - ##### 20:43:25 INFO - ##### Running install step. 20:43:25 INFO - ##### 20:43:25 INFO - Running pre-action listener: _resource_record_pre_action 20:43:25 INFO - Running main action method: install 20:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:43:25 INFO - Reading from file tmpfile_stdout 20:43:25 INFO - Detecting whether we're running mozinstall >=1.0... 20:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:43:25 INFO - Reading from file tmpfile_stdout 20:43:25 INFO - Output received: 20:43:25 INFO - Usage: mozinstall [options] installer 20:43:25 INFO - Options: 20:43:25 INFO - -h, --help show this help message and exit 20:43:25 INFO - -d DEST, --destination=DEST 20:43:25 INFO - Directory to install application into. [default: 20:43:25 INFO - "/builds/slave/test"] 20:43:25 INFO - --app=APP Application being installed. [default: firefox] 20:43:25 INFO - mkdir: /builds/slave/test/build/application 20:43:25 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'] 20:43:25 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 20:43:47 INFO - Reading from file tmpfile_stdout 20:43:47 INFO - Output received: 20:43:47 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:43:47 INFO - Running post-action listener: _resource_record_post_action 20:43:47 INFO - ##### 20:43:47 INFO - ##### Running run-tests step. 20:43:47 INFO - ##### 20:43:47 INFO - Running pre-action listener: _resource_record_pre_action 20:43:47 INFO - Running main action method: run_tests 20:43:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:43:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:43:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:43:47 INFO - 2016-07-07 20:43:47.759 screenresolution[1638:7345] starting screenresolution argv=screenresolution get 20:43:47 INFO - 2016-07-07 20:43:47.761 screenresolution[1638:7345] Display 0: 1600x1200x32@60 20:43:47 INFO - 2016-07-07 20:43:47.767 screenresolution[1639:7348] starting screenresolution argv=screenresolution list 20:43:47 INFO - Available Modes on Display 0 20:43:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:43:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:43:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:43:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:43:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:43:47 INFO - Intel Iris: 20:43:47 INFO - Chipset Model: Intel Iris 20:43:47 INFO - Type: GPU 20:43:47 INFO - Bus: Built-In 20:43:47 INFO - VRAM (Dynamic, Max): 1536 MB 20:43:47 INFO - Vendor: Intel (0x8086) 20:43:47 INFO - Device ID: 0x0a2e 20:43:47 INFO - Revision ID: 0x0009 20:43:47 INFO - Displays: 20:43:47 INFO - Display: 20:43:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:43:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:43:47 INFO - Display Serial Number: 1600x1200 60 20:43:48 INFO - Main Display: Yes 20:43:48 INFO - Mirror: Off 20:43:48 INFO - Online: Yes 20:43:48 INFO - Rotation: Supported 20:43:48 INFO - Return code: 0 20:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:43:48 INFO - Python 2.7.3 20:43:48 INFO - Return code: 0 20:43:48 INFO - grabbing minidump binary from tooltool 20:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:43:48 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 0x10c96de00>, '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 0x10c7d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c968b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:43:48 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 20:43:48 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 20:43:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:43:48 INFO - Return code: 0 20:43:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:43:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:43:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:43:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:43:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:43:49 INFO - Return code: 0 20:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0171 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:43:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.25UdZSOlla/Render', 20:43:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:43:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:43:49 INFO - 'HOME': '/Users/cltbld', 20:43:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:43:49 INFO - 'LOGNAME': 'cltbld', 20:43:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:43:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:49 INFO - 'MOZ_NO_REMOTE': '1', 20:43:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:43:49 INFO - 'NO_EM_RESTART': '1', 20:43:49 INFO - 'PAGER': '/bin/cat', 20:43:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:49 INFO - 'PWD': '/builds/slave/test', 20:43:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:43:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:43:49 INFO - 'SHELL': '/bin/bash', 20:43:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U313Q1azTP/Listeners', 20:43:49 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 20:43:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:43:49 INFO - 'USER': 'cltbld', 20:43:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:43:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:49 INFO - 'XPC_FLAGS': '0x0', 20:43:49 INFO - 'XPC_SERVICE_NAME': '0', 20:43:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:43:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:43:49 INFO - mozversion application_buildid: 20160707183926 20:43:49 INFO - mozversion application_changeset: f4e161a1dd38df3f4679d7b647371e2388e7eb72 20:43:49 INFO - mozversion application_display_name: Firefox 20:43:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:43:49 INFO - mozversion application_name: Firefox 20:43:49 INFO - mozversion application_remotingname: firefox 20:43:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:43:49 INFO - mozversion application_vendor: Mozilla 20:43:49 INFO - mozversion application_version: 48.0 20:43:49 INFO - mozversion platform_buildid: 20160707183926 20:43:49 INFO - mozversion platform_changeset: f4e161a1dd38df3f4679d7b647371e2388e7eb72 20:43:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:43:49 INFO - mozversion platform_version: 48.0 20:43:49 INFO - using testdate: 1467949429 20:43:49 INFO - actual date: 1467949429 20:43:49 INFO - starting webserver on 'localhost:49277' 20:43:49 INFO - SUITE-START | Running 2 tests 20:43:49 INFO - TEST-START | dromaeo_css 20:43:49 INFO - operating with platform_type : mac_ 20:43:49 INFO - Initialising browser for dromaeo_css test... 20:43:49 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpi4eLuS/profile http://localhost:49277/getInfo.html) 20:43:51 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 20:43:51 INFO - PROCESS | 1657 | colorDepth:24 20:43:51 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 20:43:51 INFO - PROCESS | 1657 | __metrics 20:43:51 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:43:51 ERROR - PROCESS | 1657 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:43:52 INFO - TEST-INFO | 1657: exit 0 20:43:52 INFO - Browser initialized. 20:43:52 INFO - Running cycle 1/1 for dromaeo_css test... 20:43:52 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpi4eLuS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:44:04 INFO - PROCESS | 1660 | RSS: Main: 161959936 20:44:04 INFO - PROCESS | 1660 | 20:44:55 INFO - PROCESS | 1660 | 1467949495233 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] 20:47:05 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 20:47:06 INFO - PROCESS | 1660 | RSS: Main: 256188416 20:47:06 INFO - PROCESS | 1660 | 20:50:09 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 20:50:09 INFO - PROCESS | 1660 | RSS: Main: 299487232 20:50:09 INFO - PROCESS | 1660 | 20:53:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 20:53:12 INFO - PROCESS | 1660 | RSS: Main: 302424064 20:53:12 INFO - PROCESS | 1660 | 20:56:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 20:56:14 INFO - PROCESS | 1660 | RSS: Main: 304848896 20:56:14 INFO - PROCESS | 1660 | 20:59:17 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 20:59:18 INFO - PROCESS | 1660 | RSS: Main: 269082624 20:59:18 INFO - PROCESS | 1660 | 21:02:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 21:02:21 INFO - PROCESS | 1660 | RSS: Main: 314556416 21:02:21 INFO - PROCESS | 1660 | 21:02:21 INFO - PROCESS | 1660 | __start_tp_report 21:02:21 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 21:02:21 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 21:02:21 INFO - PROCESS | 1660 | |i|pagename|runs| 21:02:21 INFO - PROCESS | 1660 | |0;dojo.html;3072.216584770883;3496.388132076887;3596.1189508570405;3604.441311596702;3625.3836847735884;5837.241158649375;5851.122331650244;5854.268216472941;5882.205902203202;5884.264466941638;5853.151293062503;5901.527877769779;5902.675352855591;5906.084556893688;5916.319623243328;5250.737463126848;5288.15389537674;5305.761240744176;5308.389535203462;5353.759080841352;5349.22436246744;5387.19192121181;5391.892162156754;5393.622446428752;5396.082665946778;5264.842054738345;5315.707636080034;5350.652207606493;5352.652077614943;5376.462353764631;5342.118550439192;5370.194470829368;5383.515483606494;5406.378266499363;5413.188021796723;5149.382074151126;5237.3453318335205;5287.550558202557;5334.306540149794;5337.5996800239745;5718.285214348207;5731.770729170828;5781.53747700183;5801.9129713054335;5803.7968671096305;6239.906401403937;6250.9062364064575;6259.718312675895;6272.090546870678;6276.874462510724;6178.7219575119225;6257.186565746424;6276;6287.2140982377205;6291.213598300213;5953.1070339449;5967.6419414835245;5982.162497250389;5985.820425387245;6010.218671572711;6398.200224971879;6403.167588213502;6406.551541392151;6408;6426.807195784134;6208.565400422018;6251.937480625226;6254.655993920287;6259.561830671901;6280.246370435577;6261.686915654199;6265.686715664289;6266.686665666698;6279.183706118175;6282.308946016026;6191.102290167901;6259.342769009279;6263.060540918807;6265.0602409638;6279.717412716439;6205.193324867739;6251.74993000284;6258.718357673915;6259.593126446766;6273.309935907047;5030.220315851049;5066.695998240118;5082.491750824962;5085.567726743194;5086.364204474441;4532.252178390529;4537.251353526631;4542.954570454253;4571.428571428572;4613.423322084739;6039.033754599243;6106.2061931948565;6136.519078024463;6182.010878259457;6189.81430557084;6236.875262494816;6247.468965137923;6254.6247225166635;6258.874822503524;6276.748930042839;6078.149059131725;6084.756609735649;6104.786332478342;6104.969475152596;6126.23422072241;5382.407935127133;5506.33923929123;5546.168074788814;5588.91616625751;5608.158776183605;6513.2184137902805;6540.574862633914;6543.411093001652;6559.442447392025;6592.439642630334;6250.49996000328;6282.089097080989;6283.5287353449585;6288.591241569284;6305.4009869062365;6433.099366088845;6580.30906754803;6617.636030018395;6631.767888123893;6643.50173736962;6231.22109736283;6236.126942228001;6251.218597675291;6258.687065646791;6279.623222606659;6190.102435146969;6202.968985155046;6221.720022598904;6223.875522489434;6281.497480201664;6213.720382582705;6265.185525881606;6274.247090349188;6283.8114856554375;6299.118123462627;6084.39156084388;6272.874542509216;6297.96851015742;6317.5893566918;6343.777967771106;6095.05526643371;6096.75612975476;6167.84580385494;6175.104609831639;6177.289611694712;6127.111568822585;6140.258857967814;6210.441060304594;6247;6276.874462510816;5841;6157.692115394302;6228.22147231596;6229.626222426669;6245.812625621239 21:02:21 INFO - PROCESS | 1660 | |1;ext.html;535.8178219405402;544.3930018029895;544.760305465595;582.9768755833511;659.1529884098934;31528.527072093908;32092.518612220836;32096.518552221736;32118.67881321186;39757;44283.55716442835;44700;44834.551654483446;44905;44928.77535612325;9727.124558789725;9940;9945;9959.601615935353;9968.551415186297;9187.081291870827;9737.269704772136;11752.529898804038;11968.281903085843;11982.46078926446;11706.590269340575;11767.352795596238;11792.29246245228;11794.882051179507;11800.350980696057;11792.94103529481;11832.585859494962;11885.94057029718;11886.108541859396;11887.40562971848;9872.358296710763;11644.534218631245;11777.470013849312;11793.823092653616;11795.646130616095;40931.59068409308;41349.79325103355;41383.96540086522;41413;41450.1709965799;3458.688718015391;3497.422925217336;3543.8759643412614;3671.522702048743;3865.3042452358563;28469.86120555175;29179.97870074537;29212.269693257625;29457.410851783057;29643.737507501606;2763.309172706823;2764.101666958247;2802.243394283532;2814.8733307001235;2824.7316504932;446351;700244.9999999949;710964;712474.4376278138;713554;37340.87977360629;63150.68424657939;63242.683786580776;63892.68053659795;63903;36236.275274494365;36339.27321453556;36355.818220908724;36369.636303637155;36432.08919777027;16264.18679066042;16468;16471.505854824376;16471.752923706154;16484.505464835835;12874.291913944822;13013.284269365087;14053.156810591398;14131.222782747047;14158.50445234412;8417.831643367099;8485.95757021211;8519.105493923173;8563.058063612998;8576.356773242032;3556.5554305711785;3574.5174401455993;3575.783014531007;3579.8568057277416;3608.729345299113;1053.9894601054045;1060.3584831177027;1092.322759888874;1111.4387234446554;1187.4122309456875;27081.5870354849;28287.43425131486;30074.849625751733;30472.69527304743;31367.68632313693;1121.534563156281;1155.1913660437726;1173.8884805943421;1179.1745777955293;1232.6918270432393;15348.309326080353;15739.134347610763;15832.92083539598;15874;16041.037537747772;616252.9187354035;617801;625192;626047;626478;61417.69291153605;61989;62028.68985655043;62168.689156553926;62257.37742622606;1404.3680343845106;1436.3751767980962;1609.3964763213794;1631.3311542267613;1667.8415550522682;29337.85331073331;29459.55810662799;29801.956931507295;29990;30051.69948300489;45936.770316148206;46188.53811461842;46218.76890615525;46282.537174627825;46306.30540541962;353731;355287;356014;356045;356496;27324;42851.571484286;43000.13999719926;44775.32837007513;44835;43548.56451435445;43646.56353436552;43685;44440;45368.77315613533;35695.82152089223;36393.45409818802;38199.6180038196;38697.6130238694;38779.836604901895;37455.438168426954;37515.06212344713;37935.62064379321;38362.04094897538;38685;37755;37934.051648709006;38071;38478.80760596179;38531.61468385392;31908.36183276368;32685.509717354733;33322.333553329285;33385.998420047436;33450.83274583612;25131.74868251294;25138.497230055662;25505.97976080936;25580.360490987874;25581 21:02:21 INFO - PROCESS | 1660 | |2;jquery.html;411.69328850006747;414.12206123019206;416.6770752666682;419.3081415664154;425.83392476933983;19628.509287267825;20091;20541.486462838435;20765.480862978435;20804.959752012415;20972.8951355243;21245.25641602544;22243;22264.88675566219;22372.440688982744;5609.52319052881;6034.275886893579;6055.2430946131735;6074.757009719606;6098.54260930432;5882.205902203191;5997.130416089664;6017.729202185912;6029.638221706711;6040.516758659297;5693.373728889819;6054.60645058072;6058.878822423571;6070.0591408331775;6072.514198864103;5878.941210587882;5911.763529458816;5995.250593675791;5997.070454079603;6014.037753959389;4552.863414097583;5076.492350764931;5278.076336641111;5285.2600635911;5288.709120998344;26532.60201096985;26727.465450690877;26994.5950810738;27256;27371.45257094867;2251.324602619208;2398.0647547456506;2447.7062752469637;2495.563276426618;2876.5972763813083;14175.362108705132;15063.322150503254;15178.468753593681;15827.129507877062;16133.83866161335;1824.060608786476;1870.494966359089;1874;1878.7651543557056;1929.305450037985;115228;118316;121517.78482215153;122018.16972745417;122542.77457225403;11345.602903898489;11506.712332191762;11676.532938682527;11688.298702077902;11813.822792658117;12950.64018278086;14241;14884.925575372054;14896.180710060835;14918.552443426715;8820.162084601952;9067.863982040275;9231.261499080058;9328.486933218603;9366.531673416439;8938.374313798102;9278.257739380833;9302.95348523253;9405.623775048922;9431.292653051049;4751.667383283206;4802.055167657105;4820.373351464287;4859.805607775649;4889.584385327287;1572.5518227305163;1973.9901300493405;2030.2183659290984;2051.6922461630875;2086.467950672569;918.9172974432333;956.0917128727598;1028.2391030637275;1045.325764881647;1103.172620534599;20834.47913802137;21419;21439.67840482394;21579.352619421443;21728.89135554312;986.5757724178673;987.4174237199943;1009.8081364540714;1020.4795554267378;1025.3284098915221;11086;11517.539298428137;11528.423578821026;11538.250013749079;11600.941995290139;548727.5127248756;563454;607334;629441;648443;113049;132587;132603;134998;139785;946.4368700623119;999.2405771613626;1048.3343077146067;1059.5549869054862;1062.718379629399;18431;18803;18974.241030359182;18990.715139273198;19264.61470770605;40649.39025914555;52632.73683631558;52894.22952064143;53510.66223344448;54425.72787136039;73042.63478682573;75917.86123208267;76412;79269;79826;8235.29999949987;8300.2114799094;8500.404971651926;8795.164459376605;8865.64537418496;12022.879771202526;13011.544595939096;13380;13478.932605336911;13481.460741570227;11240.269382490113;11562.595309164139;11718.414079296172;11883.34641594686;11885.524579016743;11225.60710375133;11433.428328583372;11514.36670983104;11522.193446458667;11717.296962182296;11829.704257393634;11921.284722916653;11939.880601194225;12060.51757929673;12141.817872731739;8094.959525202572;8349.499030057974;8360.372972027;8760.299176065771;9039.3672442931;8356.749297521084;10377.896221037692;11264.155188360743;11555.364454954723;11594.478248479007 21:02:21 INFO - PROCESS | 1660 | |3;mootools.html;1495.573761477979;1611.798525184352;1633.5181121569133;1925.39350104717;2040.6020825938938;7190.748323808668;8930.24092952099;9106.362554621179;9109.407888487243;9109.954450227748;8778.98083440809;8990.91009089909;9005.909940900588;9010.774730631738;9022.368434209608;2522.356799016253;2550.6174073888974;2551.119863647039;2552.7702506774385;2554.246497283297;2470.777630013298;2557.961630575543;2559.1298958354155;2560.2063360358256;2560.795136389094;2504.524140413325;2538;2554.514642217982;2559.5648739714293;2560.2063360358256;2509.4855554611263;2541.6949966004013;2550.3369124027795;2551.7448255174518;2560.1039636127207;2493.164789795421;2539.492101579673;2541.809364297685;2543.249741326313;2547.936301592475;8835.867461988075;9074.591643376063;9101.135392137736;9121.361504694674;9126.908730912739;5520.834374968757;5648.661080335152;5648.915266271009;5695.515881150107;5722.170285308607;2995.715407036328;3709.684676802475;3754.7559408638626;3782.8108594570162;3797.6202379761803;1066.211003857148;1077.1275267033727;1077.3482043363808;1081.7998670245952;1084.2897901874205;12073.91334779874;12190.2076365036;12391.504339826397;12419.75160496785;12451.501939922393;4687.695299805502;4712.293156026623;4832.855014349575;4833.492483289204;4886.584640305614;9666.984966578548;9680.177184939219;9680.661176858775;9686.806263874683;9695.66065187715;5544.390117087117;5568.1091025435735;5569.749361278752;5577.079781836032;5584.162375643605;4600;4611.584957353787;4762.857114286577;4769.904601907942;5209.47905209476;3035.3777475617444;3710.2950439416963;3999.8400063997697;4094.1197642507004;4097.262492751273;1253.6051143889645;1275.0755702116078;1275.3750662175466;1284.9807252891214;1286.5111257722006;944.1078181118777;959.7696552827272;963.7012526116786;973.1047436358567;1002.8946960569035;5304.946950530522;5921.585489015728;5947.9702601486715;5972.850678733066;6129.662868542184;470.76226505614443;478.6051507506321;484.09715879883765;489.26121556450016;491.5379543229353;3936.1340505088833;3969.166475040216;4050.4126901599693;4095.4675892133832;4135.958640413617;10756.408397538211;11162.553497860157;11290.54837806495;11298.548058077586;11301.71745706364;10879.891201088047;10956.178286628534;11019.118470522339;11157.888421115847;11162.776744465065;8538.615762290712;8632.050474447806;8632.223099921037;8635.222829945209;8635.963684357917;5739.684317362585;5892.381299963442;5996.5502587307;6017.518598512196;6083;9604.807903841744;9610.135087842127;9957.551910164206;9958.053984871425;9973.551190196604;9670.226381889292;10025.398476091457;10089.293749437762;10177;10205.132563732166;7055.858882822417;7241.094863142107;7700.19147989453;7832.608369581612;7835.921640783519;8330.250277475056;8535.573221339033;8538.487690738575;8549.14508549165;8566.82866342682;5918.881622367615;6880.827979300358;7118.822029449305;7378.815529611588;7640.350570201373;7466.066741657293;7519.586422746802;7546.886796697944;7611.3530349918665;7612.581308028111;7000.929990700028;7050.612216328152;7080.822979425556;7082.964585177041;7086.681099350645;5008.824691135793;5027.245913113063;5038.697678139323;5138.3833939927445;5151.866589350337;5013.24801279811;5069.9746501267255;5128.333316668809;5229.111051121243;5243.580513558983 21:02:21 INFO - PROCESS | 1660 | |4;prototype.html;327.3485763330972;332.747112194732;341.6617548626859;343.1524135385598;344.1362180925875;6490.448311893483;6645.202575690918;6646.634435106073;6649.069130321759;6743.730250789975;5521.702399936012;6442.935570644304;6692.799216023527;6717.697703603338;6720.831979200522;4909.042736666352;4942.332785074005;4951.306817045616;4954.3063971044085;4959.454460009396;4724.858254252378;4800.42394912611;4949.802007919697;4952.638024543244;4977.7262250576205;4465.754383508905;4903.387076615423;4911.75441227939;4927.384076990376;4942.382202224722;4868.172410690174;4877.414710234759;4899.069176856421;4900.436449808282;4903.828366007173;4185.100203456272;4191.832326706928;4196.685248606367;4197.727147735387;4210.263203939329;6398.104265402801;6399.552031357807;6405.903911441332;6408.58344207625;6419.5506314558;5644.8306550803545;5854.560907931879;5854.648721076749;5874.9118763218585;5891.909996650634;7046.189688185873;7131.857362852766;7144.464165187632;7146.642667866638;7161.534500257519;4760.785764640599;4761.642876784255;4761.6904901181315;4761.857144285642;4778.593819525345;7312.1956584775635;7456.850862982764;7525.247475252431;7529.171791102919;7536.397088232983;4695.530446955346;4708.8351907683755;4734.313524538922;4734.526547345306;4741.004389078264;4631.120087183424;4811.422629284439;4814.494478079821;4817.084753896818;4822.807087716452;4945.184044632667;5694.97152514243;5698.116791897262;5702;5712.514436272963;6718.857794175002;7138;7143.82140446493;7155.642217889189;7172.928270717331;1379.1311473771661;1663.6839000589848;1665.0842036879667;1668.341005302923;1670.073109424257;1028.1980055556678;1040.9403816126594;1060.2260349944584;1061.692109288313;1064.350746044912;5912.881742365129;6892.172939247323;6899.93100069003;6907.378335949688;6912.792616221522;7416.443766717518;7418.777436676908;7426.2945020223;7436.628168591549;7441.962790186123;6866.382025617619;6883.690233939485;6895.827604309932;6896.827579310558;6897;3362.7477939154173;3795.7094587840265;3897.493325867619;3910.569837317893;3945.6251656092627;7822.882656760153;7858.0963189232825;7859.921400786034;7860.6855725771475;7886.408519361071;7571.3942884569105;7627.12288086866;7628.732994345171;7642.5032372895585;7650.73222437212;7840.176781437981;7850.371970242367;7850.568218747795;7884.250996155356;7884.802879927933;7208.819779505554;7378.741744038933;7382.778516644509;7400.259974002772;7506.13679426851;7317.195108538163;7358;7367.963160184165;7378.372838308804;7399.334059934632;7912.762617121495;7921.960390198012;7928.445008849325;7948.125706172201;7949.403794715304;4540.909181816412;4652.55800698933;4661;4695.5304469552775;4762.809487620457;7419.777406677808;7419.961205431136;7430.665620047002;7432.962835185789;7440.218777028334;7182.163045597064;7184.389326907271;7194.604296763729;7200.459965502503;7202.747903823341;7138.107736532934;7141.714331426892;7159.176694680178;7166.104236970379;7167.784966451015;6759.459243260626;6986;6992.2308546058875;7000.47496437759;7017.894731579133;7078.964605176941;7115.1106111736035;7131.144262688511;7148.17795953472;7162.319579639926;6987.196472405535;6999.545029573062;7014.333638304353;7018.719251229893;7029.507934444539 21:02:21 INFO - PROCESS | 1660 | |5;yui.html;690.875642384371;731.5647189921998;731.615901651633;753.1564647594695;803.9638216280267;15779.921100394497;15979.520614381558;16004.75992860108;16018.919905400457;16053.036817790926;14600.707985840303;14653.413863445476;14659.560213193621;14664.853351466481;14669;791.584418180457;819.5779173725537;945.394947233771;975.1175186456232;977.0424983516158;973.7224890906093;983.2625530851861;988.461288597716;989.5003023473135;990.1187942730975;1040.0847254416103;1042.8227201375746;1044.6761503933767;1045.5242864496636;1046.1630695443653;838.174398217755;1023.8924912884152;1055.0873494427303;1056.4506456642503;1057.4924036462542;783.6904422753038;784.0826233307045;784.4038530716697;784.6861255497789;784.7606480023591;15387.230638468032;15445.382184712598;15467;15509.457168999032;15513.534593962198;13112.86887131126;13392.665183370495;13483.393247303895;13563.59309220725;13593.864061359458;10280.537375818107;10401.53193106312;10464.476776161162;10626.574937002511;10961.232713710044;3581.0510214793103;3596.730245231592;3631.2918980798754;3680.411134218539;3858.575556688762;80254.19745802526;81771.5911420445;84321.15678843133;84484.57757711172;84803.5759821197;9854.458004809661;9859.50702464874;9911.207103431709;9911.553980070914;10109;23184.3044708659;23208.651870221624;23210.53578928412;23258.883705581702;23297.88351058234;7512.812179695442;7526.172121066678;7614.466987310946;7621.961890190513;7844.333231675371;4193.32906734927;4244.257254980428;4307.353896915488;4328.220920234388;4518.841840535565;3785.0348161218712;3830.2148059647707;3847.826847791856;3859.324618191861;3859.8456061757215;668.9664468396339;683.4498228925663;689.9926107882548;697.7592730507967;714.4353865035556;505.7167985927892;592.7688201601379;610.4444955090846;613.8588124731248;626.8056902360283;7898.60506974649;7953.32396746283;7997.6800927963395;8150.7147249845975;8424.199701028392;604.9126843248348;608.4736702752087;612.2591664086416;619.9566030377921;626.2578844069701;3686.4654625079215;3869.1294458746556;3921.117748506563;3942.4086387042175;3996.080901392696;87623;88923;89691;90057.09942900487;90123;78148;78654.03364915923;79046.02384940423;79441.60279198567;79461.60269198618;69399.3060069403;69790.90627281088;69900;69934;69971.65014174896;7532.510386824839;7651.846963060819;7746.0317460317465;7917.524948503108;8108.2297181767635;47393.28910066421;47553.52446475491;49017.529474115836;49707.00585988188;49761.75119124381;64621.70756584936;67014;67410.31474213184;67426;68455.31544684489;10388.948055259676;10403.58385664565;10829.67510974672;11279.943600281946;11308.604198853001;11924.582639607572;12066.034717222425;12150.939245304071;12274.877251227374;12694;9640.566174522022;11610.94194529022;11791.29252244868;12031.338276394883;12077.939610302245;11489.827652585385;11588.132287977223;11594.826077609012;11653.30080195191;11987.520499180284;10921.290116142743;10966.177536684621;11474.254173478697;11485.942570287096;12084.818727719266;8117.878231826646;9620.75948101303;9921.255905807238;9966.50167491608;10072.043155900177;9617.278704097082;9635.662751803933;9689.563969621526;9803.509824508888;9818.901810981799 21:02:21 INFO - PROCESS | 1660 | __end_tp_report 21:02:21 INFO - PROCESS | 1660 | __start_cc_report 21:02:21 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1176 21:02:21 INFO - PROCESS | 1660 | __end_cc_report 21:02:21 INFO - PROCESS | 1660 | __startTimestamp1467950541206__endTimestamp 21:02:21 INFO - PROCESS | 1660 | 21:02:21 INFO - PROCESS | 1660 | ------- Summary: start ------- 21:02:21 INFO - PROCESS | 1660 | Number of tests: 6 21:02:21 INFO - PROCESS | 1660 | 21:02:21 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5883.24 Median:6177.29 stddev:634.57 (10.3%) stddev-sans-first:596.97 21:02:21 INFO - PROCESS | 1660 | Values: 3072.2 3496.4 3596.1 3604.4 3625.4 5837.2 5851.1 5854.3 5882.2 5884.3 5853.2 5901.5 5902.7 5906.1 5916.3 5250.7 5288.2 5305.8 5308.4 5353.8 5349.2 5387.2 5391.9 5393.6 5396.1 5264.8 5315.7 5350.7 5352.7 5376.5 5342.1 5370.2 5383.5 5406.4 5413.2 5149.4 5237.3 5287.6 5334.3 5337.6 5718.3 5731.8 5781.5 5801.9 5803.8 6239.9 6250.9 6259.7 6272.1 6276.9 6178.7 6257.2 6276.0 6287.2 6291.2 5953.1 5967.6 5982.2 5985.8 6010.2 6398.2 6403.2 6406.6 6408.0 6426.8 6208.6 6251.9 6254.7 6259.6 6280.2 6261.7 6265.7 6266.7 6279.2 6282.3 6191.1 6259.3 6263.1 6265.1 6279.7 6205.2 6251.7 6258.7 6259.6 6273.3 5030.2 5066.7 5082.5 5085.6 5086.4 4532.3 4537.3 4543.0 4571.4 4613.4 6039.0 6106.2 6136.5 6182.0 6189.8 6236.9 6247.5 6254.6 6258.9 6276.7 6078.1 6084.8 6104.8 6105.0 6126.2 5382.4 5506.3 5546.2 5588.9 5608.2 6513.2 6540.6 6543.4 6559.4 6592.4 6250.5 6282.1 6283.5 6288.6 6305.4 6433.1 6580.3 6617.6 6631.8 6643.5 6231.2 6236.1 6251.2 6258.7 6279.6 6190.1 6203.0 6221.7 6223.9 6281.5 6213.7 6265.2 6274.2 6283.8 6299.1 6084.4 6272.9 6298.0 6317.6 6343.8 6095.1 6096.8 6167.8 6175.1 6177.3 6127.1 6140.3 6210.4 6247.0 6276.9 5841.0 6157.7 6228.2 6229.6 6245.8 21:02:21 INFO - PROCESS | 1660 | 21:02:21 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:67406.55 Median:196095.91 stddev:151519.73 (77.3%) stddev-sans-first:151861.60 21:02:21 INFO - PROCESS | 1660 | Values: 535.8 544.4 544.8 583.0 659.2 31528.5 32092.5 32096.5 32118.7 39757.0 44283.6 44700.0 44834.6 44905.0 44928.8 9727.1 9940.0 9945.0 9959.6 9968.6 9187.1 9737.3 11752.5 11968.3 11982.5 11706.6 11767.4 11792.3 11794.9 11800.4 11792.9 11832.6 11885.9 11886.1 11887.4 9872.4 11644.5 11777.5 11793.8 11795.6 40931.6 41349.8 41384.0 41413.0 41450.2 3458.7 3497.4 3543.9 3671.5 3865.3 28469.9 29180.0 29212.3 29457.4 29643.7 2763.3 2764.1 2802.2 2814.9 2824.7 446351.0 700245.0 710964.0 712474.4 713554.0 37340.9 63150.7 63242.7 63892.7 63903.0 36236.3 36339.3 36355.8 36369.6 36432.1 16264.2 16468.0 16471.5 16471.8 16484.5 12874.3 13013.3 14053.2 14131.2 14158.5 8417.8 8486.0 8519.1 8563.1 8576.4 3556.6 3574.5 3575.8 3579.9 3608.7 1054.0 1060.4 1092.3 1111.4 1187.4 27081.6 28287.4 30074.8 30472.7 31367.7 1121.5 1155.2 1173.9 1179.2 1232.7 15348.3 15739.1 15832.9 15874.0 16041.0 616252.9 617801.0 625192.0 626047.0 626478.0 61417.7 61989.0 62028.7 62168.7 62257.4 1404.4 1436.4 1609.4 1631.3 1667.8 29337.9 29459.6 29802.0 29990.0 30051.7 45936.8 46188.5 46218.8 46282.5 46306.3 353731.0 355287.0 356014.0 356045.0 356496.0 27324.0 42851.6 43000.1 44775.3 44835.0 43548.6 43646.6 43685.0 44440.0 45368.8 35695.8 36393.5 38199.6 38697.6 38779.8 37455.4 37515.1 37935.6 38362.0 38685.0 37755.0 37934.1 38071.0 38478.8 38531.6 31908.4 32685.5 33322.3 33386.0 33450.8 25131.7 25138.5 25506.0 25580.4 25581.0 21:02:21 INFO - PROCESS | 1660 | 21:02:21 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:35495.01 Median:22253.94 stddev:100263.38 (450.5%) stddev-sans-first:100510.04 21:02:21 INFO - PROCESS | 1660 | Values: 411.7 414.1 416.7 419.3 425.8 19628.5 20091.0 20541.5 20765.5 20805.0 20972.9 21245.3 22243.0 22264.9 22372.4 5609.5 6034.3 6055.2 6074.8 6098.5 5882.2 5997.1 6017.7 6029.6 6040.5 5693.4 6054.6 6058.9 6070.1 6072.5 5878.9 5911.8 5995.3 5997.1 6014.0 4552.9 5076.5 5278.1 5285.3 5288.7 26532.6 26727.5 26994.6 27256.0 27371.5 2251.3 2398.1 2447.7 2495.6 2876.6 14175.4 15063.3 15178.5 15827.1 16133.8 1824.1 1870.5 1874.0 1878.8 1929.3 115228.0 118316.0 121517.8 122018.2 122542.8 11345.6 11506.7 11676.5 11688.3 11813.8 12950.6 14241.0 14884.9 14896.2 14918.6 8820.2 9067.9 9231.3 9328.5 9366.5 8938.4 9278.3 9303.0 9405.6 9431.3 4751.7 4802.1 4820.4 4859.8 4889.6 1572.6 1974.0 2030.2 2051.7 2086.5 918.9 956.1 1028.2 1045.3 1103.2 20834.5 21419.0 21439.7 21579.4 21728.9 986.6 987.4 1009.8 1020.5 1025.3 11086.0 11517.5 11528.4 11538.3 11600.9 548727.5 563454.0 607334.0 629441.0 648443.0 113049.0 132587.0 132603.0 134998.0 139785.0 946.4 999.2 1048.3 1059.6 1062.7 18431.0 18803.0 18974.2 18990.7 19264.6 40649.4 52632.7 52894.2 53510.7 54425.7 73042.6 75917.9 76412.0 79269.0 79826.0 8235.3 8300.2 8500.4 8795.2 8865.6 12022.9 13011.5 13380.0 13478.9 13481.5 11240.3 11562.6 11718.4 11883.3 11885.5 11225.6 11433.4 11514.4 11522.2 11717.3 11829.7 11921.3 11939.9 12060.5 12141.8 8095.0 8349.5 8360.4 8760.3 9039.4 8356.7 10377.9 11264.2 11555.4 11594.5 21:02:21 INFO - PROCESS | 1660 | 21:02:21 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5819.08 Median:5020.25 stddev:3264.62 (65.0%) stddev-sans-first:3257.61 21:02:21 INFO - PROCESS | 1660 | Values: 1495.6 1611.8 1633.5 1925.4 2040.6 7190.7 8930.2 9106.4 9109.4 9110.0 8779.0 8990.9 9005.9 9010.8 9022.4 2522.4 2550.6 2551.1 2552.8 2554.2 2470.8 2558.0 2559.1 2560.2 2560.8 2504.5 2538.0 2554.5 2559.6 2560.2 2509.5 2541.7 2550.3 2551.7 2560.1 2493.2 2539.5 2541.8 2543.2 2547.9 8835.9 9074.6 9101.1 9121.4 9126.9 5520.8 5648.7 5648.9 5695.5 5722.2 2995.7 3709.7 3754.8 3782.8 3797.6 1066.2 1077.1 1077.3 1081.8 1084.3 12073.9 12190.2 12391.5 12419.8 12451.5 4687.7 4712.3 4832.9 4833.5 4886.6 9667.0 9680.2 9680.7 9686.8 9695.7 5544.4 5568.1 5569.7 5577.1 5584.2 4600.0 4611.6 4762.9 4769.9 5209.5 3035.4 3710.3 3999.8 4094.1 4097.3 1253.6 1275.1 1275.4 1285.0 1286.5 944.1 959.8 963.7 973.1 1002.9 5304.9 5921.6 5948.0 5972.9 6129.7 470.8 478.6 484.1 489.3 491.5 3936.1 3969.2 4050.4 4095.5 4136.0 10756.4 11162.6 11290.5 11298.5 11301.7 10879.9 10956.2 11019.1 11157.9 11162.8 8538.6 8632.1 8632.2 8635.2 8636.0 5739.7 5892.4 5996.6 6017.5 6083.0 9604.8 9610.1 9957.6 9958.1 9973.6 9670.2 10025.4 10089.3 10177.0 10205.1 7055.9 7241.1 7700.2 7832.6 7835.9 8330.3 8535.6 8538.5 8549.1 8566.8 5918.9 6880.8 7118.8 7378.8 7640.4 7466.1 7519.6 7546.9 7611.4 7612.6 7000.9 7050.6 7080.8 7083.0 7086.7 5008.8 5027.2 5038.7 5138.4 5151.9 5013.2 5070.0 5128.3 5229.1 5243.6 21:02:21 INFO - PROCESS | 1660 | 21:02:21 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:5884.75 Median:6732.28 stddev:1901.83 (28.2%) stddev-sans-first:1860.86 21:02:21 INFO - PROCESS | 1660 | Values: 327.3 332.7 341.7 343.2 344.1 6490.4 6645.2 6646.6 6649.1 6743.7 5521.7 6442.9 6692.8 6717.7 6720.8 4909.0 4942.3 4951.3 4954.3 4959.5 4724.9 4800.4 4949.8 4952.6 4977.7 4465.8 4903.4 4911.8 4927.4 4942.4 4868.2 4877.4 4899.1 4900.4 4903.8 4185.1 4191.8 4196.7 4197.7 4210.3 6398.1 6399.6 6405.9 6408.6 6419.6 5644.8 5854.6 5854.6 5874.9 5891.9 7046.2 7131.9 7144.5 7146.6 7161.5 4760.8 4761.6 4761.7 4761.9 4778.6 7312.2 7456.9 7525.2 7529.2 7536.4 4695.5 4708.8 4734.3 4734.5 4741.0 4631.1 4811.4 4814.5 4817.1 4822.8 4945.2 5695.0 5698.1 5702.0 5712.5 6718.9 7138.0 7143.8 7155.6 7172.9 1379.1 1663.7 1665.1 1668.3 1670.1 1028.2 1040.9 1060.2 1061.7 1064.4 5912.9 6892.2 6899.9 6907.4 6912.8 7416.4 7418.8 7426.3 7436.6 7442.0 6866.4 6883.7 6895.8 6896.8 6897.0 3362.7 3795.7 3897.5 3910.6 3945.6 7822.9 7858.1 7859.9 7860.7 7886.4 7571.4 7627.1 7628.7 7642.5 7650.7 7840.2 7850.4 7850.6 7884.3 7884.8 7208.8 7378.7 7382.8 7400.3 7506.1 7317.2 7358.0 7368.0 7378.4 7399.3 7912.8 7922.0 7928.4 7948.1 7949.4 4540.9 4652.6 4661.0 4695.5 4762.8 7419.8 7420.0 7430.7 7433.0 7440.2 7182.2 7184.4 7194.6 7200.5 7202.7 7138.1 7141.7 7159.2 7166.1 7167.8 6759.5 6986.0 6992.2 7000.5 7017.9 7079.0 7115.1 7131.1 7148.2 7162.3 6987.2 6999.5 7014.3 7018.7 7029.5 21:02:21 INFO - PROCESS | 1660 | 21:02:21 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:18428.15 Median:549.24 stddev:25548.38 (4651.6%) stddev-sans-first:25585.33 21:02:21 INFO - PROCESS | 1660 | Values: 690.9 731.6 731.6 753.2 804.0 15779.9 15979.5 16004.8 16018.9 16053.0 14600.7 14653.4 14659.6 14664.9 14669.0 791.6 819.6 945.4 975.1 977.0 973.7 983.3 988.5 989.5 990.1 1040.1 1042.8 1044.7 1045.5 1046.2 838.2 1023.9 1055.1 1056.5 1057.5 783.7 784.1 784.4 784.7 784.8 15387.2 15445.4 15467.0 15509.5 15513.5 13112.9 13392.7 13483.4 13563.6 13593.9 10280.5 10401.5 10464.5 10626.6 10961.2 3581.1 3596.7 3631.3 3680.4 3858.6 80254.2 81771.6 84321.2 84484.6 84803.6 9854.5 9859.5 9911.2 9911.6 10109.0 23184.3 23208.7 23210.5 23258.9 23297.9 7512.8 7526.2 7614.5 7622.0 7844.3 4193.3 4244.3 4307.4 4328.2 4518.8 3785.0 3830.2 3847.8 3859.3 3859.8 669.0 683.4 690.0 697.8 714.4 505.7 592.8 610.4 613.9 626.8 7898.6 7953.3 7997.7 8150.7 8424.2 604.9 608.5 612.3 620.0 626.3 3686.5 3869.1 3921.1 3942.4 3996.1 87623.0 88923.0 89691.0 90057.1 90123.0 78148.0 78654.0 79046.0 79441.6 79461.6 69399.3 69790.9 69900.0 69934.0 69971.7 7532.5 7651.8 7746.0 7917.5 8108.2 47393.3 47553.5 49017.5 49707.0 49761.8 64621.7 67014.0 67410.3 67426.0 68455.3 10388.9 10403.6 10829.7 11279.9 11308.6 11924.6 12066.0 12150.9 12274.9 12694.0 9640.6 11610.9 11791.3 12031.3 12077.9 11489.8 11588.1 11594.8 11653.3 11987.5 10921.3 10966.2 11474.3 11485.9 12084.8 8117.9 9620.8 9921.3 9966.5 10072.0 9617.3 9635.7 9689.6 9803.5 9818.9 21:02:21 INFO - PROCESS | 1660 | -------- Summary: end -------- 21:02:21 INFO - PROCESS | 1660 | 21:02:21 INFO - TEST-INFO | 1660: exit 0 21:02:21 INFO - TEST-OK | dromaeo_css | took 1112363ms 21:02:21 INFO - TEST-START | kraken 21:02:21 INFO - operating with platform_type : mac_ 21:02:21 INFO - Initialising browser for kraken test... 21:02:21 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpfAAoUu/profile http://localhost:49277/getInfo.html) 21:02:23 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 21:02:23 INFO - PROCESS | 1669 | colorDepth:24 21:02:23 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 21:02:23 INFO - PROCESS | 1669 | __metrics 21:02:24 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:02:24 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:02:24 INFO - TEST-INFO | 1669: exit 0 21:02:24 INFO - Browser initialized. 21:02:24 INFO - Running cycle 1/1 for kraken test... 21:02:24 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpfAAoUu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:02:36 INFO - PROCESS | 1672 | RSS: Main: 162181120 21:02:36 INFO - PROCESS | 1672 | 21:02:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 21:02:40 INFO - PROCESS | 1672 | RSS: Main: 223846400 21:02:40 INFO - PROCESS | 1672 | 21:02:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 21:02:43 INFO - PROCESS | 1672 | RSS: Main: 239804416 21:02:43 INFO - PROCESS | 1672 | 21:02:46 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 21:02:47 INFO - PROCESS | 1672 | RSS: Main: 324534272 21:02:47 INFO - PROCESS | 1672 | 21:02:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 21:02:49 INFO - PROCESS | 1672 | RSS: Main: 230510592 21:02:49 INFO - PROCESS | 1672 | 21:02:51 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:02:52 INFO - PROCESS | 1672 | RSS: Main: 231936000 21:02:52 INFO - PROCESS | 1672 | 21:02:55 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 21:02:55 INFO - PROCESS | 1672 | RSS: Main: 269742080 21:02:55 INFO - PROCESS | 1672 | 21:02:58 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 21:02:59 INFO - PROCESS | 1672 | RSS: Main: 271118336 21:02:59 INFO - PROCESS | 1672 | 21:03:02 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 21:03:02 INFO - PROCESS | 1672 | RSS: Main: 268984320 21:03:02 INFO - PROCESS | 1672 | 21:03:04 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:03:04 INFO - PROCESS | 1672 | RSS: Main: 260706304 21:03:04 INFO - PROCESS | 1672 | 21:03:06 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:03:07 INFO - PROCESS | 1672 | RSS: Main: 267493376 21:03:07 INFO - PROCESS | 1672 | 21:03:09 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:03:10 INFO - PROCESS | 1672 | RSS: Main: 270970880 21:03:10 INFO - PROCESS | 1672 | 21:03:12 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:03:13 INFO - PROCESS | 1672 | RSS: Main: 278216704 21:03:13 INFO - PROCESS | 1672 | 21:03:16 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:03:16 INFO - PROCESS | 1672 | RSS: Main: 275496960 21:03:16 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 21:03:18 INFO - PROCESS | 1672 | RSS: Main: 336007168 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | __start_tp_report 21:03:18 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 21:03:18 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 21:03:18 INFO - PROCESS | 1672 | |i|pagename|runs| 21:03:18 INFO - PROCESS | 1672 | |0;ai-astar;115;113;118;113;111;112;113;113;113;133 21:03:18 INFO - PROCESS | 1672 | |1;audio-beat-detection;155;118;143;166;111;140;117;152;152;117 21:03:18 INFO - PROCESS | 1672 | |2;audio-dft;182;184;184;184;180;185;185;185;184;187 21:03:18 INFO - PROCESS | 1672 | |3;audio-fft;69;80;91;174;73;73;83;91;145;73 21:03:18 INFO - PROCESS | 1672 | |4;audio-oscillator;92;91;139;79;78;80;125;80;77;125 21:03:18 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;88;85;87;85;88;84;88;86;88;84 21:03:18 INFO - PROCESS | 1672 | |6;imaging-darkroom;135;137;94;93;93;100;94;93;94;93 21:03:18 INFO - PROCESS | 1672 | |7;imaging-desaturate;84;86;83;85;85;96;138;87;85;83 21:03:18 INFO - PROCESS | 1672 | |8;json-parse-financial;59;62;63;62;63;63;64;76;60;56 21:03:18 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;61;63;65;78;76;70;70;66;65;67 21:03:18 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;80;80;80;81;80;78;80;79;80;82 21:03:18 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;128;127;125;123;126;126;127;130;136;129 21:03:18 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;163;163;161;161;162;158;161;162;162;163 21:03:18 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;68;65;67;67;69;91;94;95;94;65 21:03:18 INFO - PROCESS | 1672 | __end_tp_report 21:03:18 INFO - PROCESS | 1672 | __start_cc_report 21:03:18 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1926 21:03:18 INFO - PROCESS | 1672 | __end_cc_report 21:03:18 INFO - PROCESS | 1672 | __startTimestamp1467950598857__endTimestamp 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | ------- Summary: start ------- 21:03:18 INFO - PROCESS | 1672 | Number of tests: 14 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:115.40 Median:113.00 stddev:6.47 (5.7%) stddev-sans-first:6.86 21:03:18 INFO - PROCESS | 1672 | Values: 115.0 113.0 118.0 113.0 111.0 112.0 113.0 113.0 113.0 133.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:147.50 stddev:19.71 (13.4%) stddev-sans-first:19.81 21:03:18 INFO - PROCESS | 1672 | Values: 155.0 118.0 143.0 166.0 111.0 140.0 117.0 152.0 152.0 117.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.89 (1.0%) stddev-sans-first:1.86 21:03:18 INFO - PROCESS | 1672 | Values: 182.0 184.0 184.0 184.0 180.0 185.0 185.0 185.0 184.0 187.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.50 stddev:35.39 (46.3%) stddev-sans-first:36.24 21:03:18 INFO - PROCESS | 1672 | Values: 69.0 80.0 91.0 174.0 73.0 73.0 83.0 91.0 145.0 73.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:79.50 stddev:23.70 (29.8%) stddev-sans-first:25.08 21:03:18 INFO - PROCESS | 1672 | Values: 92.0 91.0 139.0 79.0 78.0 80.0 125.0 80.0 77.0 125.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.50 stddev:1.70 (1.9%) stddev-sans-first:1.69 21:03:18 INFO - PROCESS | 1672 | Values: 88.0 85.0 87.0 85.0 88.0 84.0 88.0 86.0 88.0 84.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:93.00 stddev:17.73 (19.1%) stddev-sans-first:14.42 21:03:18 INFO - PROCESS | 1672 | Values: 135.0 137.0 94.0 93.0 93.0 100.0 94.0 93.0 94.0 93.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:91.20 Median:85.00 stddev:16.86 (19.8%) stddev-sans-first:17.68 21:03:18 INFO - PROCESS | 1672 | Values: 84.0 86.0 83.0 85.0 85.0 96.0 138.0 87.0 85.0 83.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:5.22 (8.3%) stddev-sans-first:5.36 21:03:18 INFO - PROCESS | 1672 | Values: 59.0 62.0 63.0 62.0 63.0 63.0 64.0 76.0 60.0 56.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.50 stddev:5.47 (8.0%) stddev-sans-first:5.16 21:03:18 INFO - PROCESS | 1672 | Values: 61.0 63.0 65.0 78.0 76.0 70.0 70.0 66.0 65.0 67.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:1.05 (1.3%) stddev-sans-first:1.12 21:03:18 INFO - PROCESS | 1672 | Values: 80.0 80.0 80.0 81.0 80.0 78.0 80.0 79.0 80.0 82.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.50 stddev:3.53 (2.8%) stddev-sans-first:3.74 21:03:18 INFO - PROCESS | 1672 | Values: 128.0 127.0 125.0 123.0 126.0 126.0 127.0 130.0 136.0 129.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.00 stddev:1.51 (0.9%) stddev-sans-first:1.51 21:03:18 INFO - PROCESS | 1672 | Values: 163.0 163.0 161.0 161.0 162.0 158.0 161.0 162.0 162.0 163.0 21:03:18 INFO - PROCESS | 1672 | 21:03:18 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:80.00 stddev:13.86 (17.3%) stddev-sans-first:14.27 21:03:18 INFO - PROCESS | 1672 | Values: 68.0 65.0 67.0 67.0 69.0 91.0 94.0 95.0 94.0 65.0 21:03:18 INFO - PROCESS | 1672 | -------- Summary: end -------- 21:03:18 INFO - PROCESS | 1672 | 21:03:19 INFO - TEST-INFO | 1672: exit 0 21:03:19 INFO - TEST-OK | kraken | took 57862ms 21:03:19 INFO - SUITE-END | took 1170s 21:03:20 INFO - Completed test suite (00:19:30) 21:03:20 INFO - javascript benchmark 21:03:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.216584770883, 3496.388132076887, 3596.1189508570405, 3604.441311596702, 3625.3836847735884, 5837.241158649375, 5851.122331650244, 5854.268216472941, 5882.205902203202, 5884.264466941638, 5853.151293062503, 5901.527877769779, 5902.675352855591, 5906.084556893688, 5916.319623243328, 5250.737463126848, 5288.15389537674, 5305.761240744176, 5308.389535203462, 5353.759080841352, 5349.22436246744, 5387.19192121181, 5391.892162156754, 5393.622446428752, 5396.082665946778, 5264.842054738345, 5315.707636080034, 5350.652207606493, 5352.652077614943, 5376.462353764631, 5342.118550439192, 5370.194470829368, 5383.515483606494, 5406.378266499363, 5413.188021796723, 5149.382074151126, 5237.3453318335205, 5287.550558202557, 5334.306540149794, 5337.5996800239745, 5718.285214348207, 5731.770729170828, 5781.53747700183, 5801.9129713054335, 5803.7968671096305, 6239.906401403937, 6250.9062364064575, 6259.718312675895, 6272.090546870678, 6276.874462510724, 6178.7219575119225, 6257.186565746424, 6276.0, 6287.2140982377205, 6291.213598300213, 5953.1070339449, 5967.6419414835245, 5982.162497250389, 5985.820425387245, 6010.218671572711, 6398.200224971879, 6403.167588213502, 6406.551541392151, 6408.0, 6426.807195784134, 6208.565400422018, 6251.937480625226, 6254.655993920287, 6259.561830671901, 6280.246370435577, 6261.686915654199, 6265.686715664289, 6266.686665666698, 6279.183706118175, 6282.308946016026, 6191.102290167901, 6259.342769009279, 6263.060540918807, 6265.0602409638, 6279.717412716439, 6205.193324867739, 6251.74993000284, 6258.718357673915, 6259.593126446766, 6273.309935907047, 5030.220315851049, 5066.695998240118, 5082.491750824962, 5085.567726743194, 5086.364204474441, 4532.252178390529, 4537.251353526631, 4542.954570454253, 4571.428571428572, 4613.423322084739, 6039.033754599243, 6106.2061931948565, 6136.519078024463, 6182.010878259457, 6189.81430557084, 6236.875262494816, 6247.468965137923, 6254.6247225166635, 6258.874822503524, 6276.748930042839, 6078.149059131725, 6084.756609735649, 6104.786332478342, 6104.969475152596, 6126.23422072241, 5382.407935127133, 5506.33923929123, 5546.168074788814, 5588.91616625751, 5608.158776183605, 6513.2184137902805, 6540.574862633914, 6543.411093001652, 6559.442447392025, 6592.439642630334, 6250.49996000328, 6282.089097080989, 6283.5287353449585, 6288.591241569284, 6305.4009869062365, 6433.099366088845, 6580.30906754803, 6617.636030018395, 6631.767888123893, 6643.50173736962, 6231.22109736283, 6236.126942228001, 6251.218597675291, 6258.687065646791, 6279.623222606659, 6190.102435146969, 6202.968985155046, 6221.720022598904, 6223.875522489434, 6281.497480201664, 6213.720382582705, 6265.185525881606, 6274.247090349188, 6283.8114856554375, 6299.118123462627, 6084.39156084388, 6272.874542509216, 6297.96851015742, 6317.5893566918, 6343.777967771106, 6095.05526643371, 6096.75612975476, 6167.84580385494, 6175.104609831639, 6177.289611694712, 6127.111568822585, 6140.258857967814, 6210.441060304594, 6247.0, 6276.874462510816, 5841.0, 6157.692115394302, 6228.22147231596, 6229.626222426669, 6245.812625621239], "value": 5842.894259254752, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.8178219405402, 544.3930018029895, 544.760305465595, 582.9768755833511, 659.1529884098934, 31528.527072093908, 32092.518612220836, 32096.518552221736, 32118.67881321186, 39757.0, 44283.55716442835, 44700.0, 44834.551654483446, 44905.0, 44928.77535612325, 9727.124558789725, 9940.0, 9945.0, 9959.601615935353, 9968.551415186297, 9187.081291870827, 9737.269704772136, 11752.529898804038, 11968.281903085843, 11982.46078926446, 11706.590269340575, 11767.352795596238, 11792.29246245228, 11794.882051179507, 11800.350980696057, 11792.94103529481, 11832.585859494962, 11885.94057029718, 11886.108541859396, 11887.40562971848, 9872.358296710763, 11644.534218631245, 11777.470013849312, 11793.823092653616, 11795.646130616095, 40931.59068409308, 41349.79325103355, 41383.96540086522, 41413.0, 41450.1709965799, 3458.688718015391, 3497.422925217336, 3543.8759643412614, 3671.522702048743, 3865.3042452358563, 28469.86120555175, 29179.97870074537, 29212.269693257625, 29457.410851783057, 29643.737507501606, 2763.309172706823, 2764.101666958247, 2802.243394283532, 2814.8733307001235, 2824.7316504932, 446351.0, 700244.9999999949, 710964.0, 712474.4376278138, 713554.0, 37340.87977360629, 63150.68424657939, 63242.683786580776, 63892.68053659795, 63903.0, 36236.275274494365, 36339.27321453556, 36355.818220908724, 36369.636303637155, 36432.08919777027, 16264.18679066042, 16468.0, 16471.505854824376, 16471.752923706154, 16484.505464835835, 12874.291913944822, 13013.284269365087, 14053.156810591398, 14131.222782747047, 14158.50445234412, 8417.831643367099, 8485.95757021211, 8519.105493923173, 8563.058063612998, 8576.356773242032, 3556.5554305711785, 3574.5174401455993, 3575.783014531007, 3579.8568057277416, 3608.729345299113, 1053.9894601054045, 1060.3584831177027, 1092.322759888874, 1111.4387234446554, 1187.4122309456875, 27081.5870354849, 28287.43425131486, 30074.849625751733, 30472.69527304743, 31367.68632313693, 1121.534563156281, 1155.1913660437726, 1173.8884805943421, 1179.1745777955293, 1232.6918270432393, 15348.309326080353, 15739.134347610763, 15832.92083539598, 15874.0, 16041.037537747772, 616252.9187354035, 617801.0, 625192.0, 626047.0, 626478.0, 61417.69291153605, 61989.0, 62028.68985655043, 62168.689156553926, 62257.37742622606, 1404.3680343845106, 1436.3751767980962, 1609.3964763213794, 1631.3311542267613, 1667.8415550522682, 29337.85331073331, 29459.55810662799, 29801.956931507295, 29990.0, 30051.69948300489, 45936.770316148206, 46188.53811461842, 46218.76890615525, 46282.537174627825, 46306.30540541962, 353731.0, 355287.0, 356014.0, 356045.0, 356496.0, 27324.0, 42851.571484286, 43000.13999719926, 44775.32837007513, 44835.0, 43548.56451435445, 43646.56353436552, 43685.0, 44440.0, 45368.77315613533, 35695.82152089223, 36393.45409818802, 38199.6180038196, 38697.6130238694, 38779.836604901895, 37455.438168426954, 37515.06212344713, 37935.62064379321, 38362.04094897538, 38685.0, 37755.0, 37934.051648709006, 38071.0, 38478.80760596179, 38531.61468385392, 31908.36183276368, 32685.509717354733, 33322.333553329285, 33385.998420047436, 33450.83274583612, 25131.74868251294, 25138.497230055662, 25505.97976080936, 25580.360490987874, 25581.0], "value": 19434.335069707115, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.69328850006747, 414.12206123019206, 416.6770752666682, 419.3081415664154, 425.83392476933983, 19628.509287267825, 20091.0, 20541.486462838435, 20765.480862978435, 20804.959752012415, 20972.8951355243, 21245.25641602544, 22243.0, 22264.88675566219, 22372.440688982744, 5609.52319052881, 6034.275886893579, 6055.2430946131735, 6074.757009719606, 6098.54260930432, 5882.205902203191, 5997.130416089664, 6017.729202185912, 6029.638221706711, 6040.516758659297, 5693.373728889819, 6054.60645058072, 6058.878822423571, 6070.0591408331775, 6072.514198864103, 5878.941210587882, 5911.763529458816, 5995.250593675791, 5997.070454079603, 6014.037753959389, 4552.863414097583, 5076.492350764931, 5278.076336641111, 5285.2600635911, 5288.709120998344, 26532.60201096985, 26727.465450690877, 26994.5950810738, 27256.0, 27371.45257094867, 2251.324602619208, 2398.0647547456506, 2447.7062752469637, 2495.563276426618, 2876.5972763813083, 14175.362108705132, 15063.322150503254, 15178.468753593681, 15827.129507877062, 16133.83866161335, 1824.060608786476, 1870.494966359089, 1874.0, 1878.7651543557056, 1929.305450037985, 115228.0, 118316.0, 121517.78482215153, 122018.16972745417, 122542.77457225403, 11345.602903898489, 11506.712332191762, 11676.532938682527, 11688.298702077902, 11813.822792658117, 12950.64018278086, 14241.0, 14884.925575372054, 14896.180710060835, 14918.552443426715, 8820.162084601952, 9067.863982040275, 9231.261499080058, 9328.486933218603, 9366.531673416439, 8938.374313798102, 9278.257739380833, 9302.95348523253, 9405.623775048922, 9431.292653051049, 4751.667383283206, 4802.055167657105, 4820.373351464287, 4859.805607775649, 4889.584385327287, 1572.5518227305163, 1973.9901300493405, 2030.2183659290984, 2051.6922461630875, 2086.467950672569, 918.9172974432333, 956.0917128727598, 1028.2391030637275, 1045.325764881647, 1103.172620534599, 20834.47913802137, 21419.0, 21439.67840482394, 21579.352619421443, 21728.89135554312, 986.5757724178673, 987.4174237199943, 1009.8081364540714, 1020.4795554267378, 1025.3284098915221, 11086.0, 11517.539298428137, 11528.423578821026, 11538.250013749079, 11600.941995290139, 548727.5127248756, 563454.0, 607334.0, 629441.0, 648443.0, 113049.0, 132587.0, 132603.0, 134998.0, 139785.0, 946.4368700623119, 999.2405771613626, 1048.3343077146067, 1059.5549869054862, 1062.718379629399, 18431.0, 18803.0, 18974.241030359182, 18990.715139273198, 19264.61470770605, 40649.39025914555, 52632.73683631558, 52894.22952064143, 53510.66223344448, 54425.72787136039, 73042.63478682573, 75917.86123208267, 76412.0, 79269.0, 79826.0, 8235.29999949987, 8300.2114799094, 8500.404971651926, 8795.164459376605, 8865.64537418496, 12022.879771202526, 13011.544595939096, 13380.0, 13478.932605336911, 13481.460741570227, 11240.269382490113, 11562.595309164139, 11718.414079296172, 11883.34641594686, 11885.524579016743, 11225.60710375133, 11433.428328583372, 11514.36670983104, 11522.193446458667, 11717.296962182296, 11829.704257393634, 11921.284722916653, 11939.880601194225, 12060.51757929673, 12141.817872731739, 8094.959525202572, 8349.499030057974, 8360.372972027, 8760.299176065771, 9039.3672442931, 8356.749297521084, 10377.896221037692, 11264.155188360743, 11555.364454954723, 11594.478248479007], "value": 9968.360276140396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.573761477979, 1611.798525184352, 1633.5181121569133, 1925.39350104717, 2040.6020825938938, 7190.748323808668, 8930.24092952099, 9106.362554621179, 9109.407888487243, 9109.954450227748, 8778.98083440809, 8990.91009089909, 9005.909940900588, 9010.774730631738, 9022.368434209608, 2522.356799016253, 2550.6174073888974, 2551.119863647039, 2552.7702506774385, 2554.246497283297, 2470.777630013298, 2557.961630575543, 2559.1298958354155, 2560.2063360358256, 2560.795136389094, 2504.524140413325, 2538.0, 2554.514642217982, 2559.5648739714293, 2560.2063360358256, 2509.4855554611263, 2541.6949966004013, 2550.3369124027795, 2551.7448255174518, 2560.1039636127207, 2493.164789795421, 2539.492101579673, 2541.809364297685, 2543.249741326313, 2547.936301592475, 8835.867461988075, 9074.591643376063, 9101.135392137736, 9121.361504694674, 9126.908730912739, 5520.834374968757, 5648.661080335152, 5648.915266271009, 5695.515881150107, 5722.170285308607, 2995.715407036328, 3709.684676802475, 3754.7559408638626, 3782.8108594570162, 3797.6202379761803, 1066.211003857148, 1077.1275267033727, 1077.3482043363808, 1081.7998670245952, 1084.2897901874205, 12073.91334779874, 12190.2076365036, 12391.504339826397, 12419.75160496785, 12451.501939922393, 4687.695299805502, 4712.293156026623, 4832.855014349575, 4833.492483289204, 4886.584640305614, 9666.984966578548, 9680.177184939219, 9680.661176858775, 9686.806263874683, 9695.66065187715, 5544.390117087117, 5568.1091025435735, 5569.749361278752, 5577.079781836032, 5584.162375643605, 4600.0, 4611.584957353787, 4762.857114286577, 4769.904601907942, 5209.47905209476, 3035.3777475617444, 3710.2950439416963, 3999.8400063997697, 4094.1197642507004, 4097.262492751273, 1253.6051143889645, 1275.0755702116078, 1275.3750662175466, 1284.9807252891214, 1286.5111257722006, 944.1078181118777, 959.7696552827272, 963.7012526116786, 973.1047436358567, 1002.8946960569035, 5304.946950530522, 5921.585489015728, 5947.9702601486715, 5972.850678733066, 6129.662868542184, 470.76226505614443, 478.6051507506321, 484.09715879883765, 489.26121556450016, 491.5379543229353, 3936.1340505088833, 3969.166475040216, 4050.4126901599693, 4095.4675892133832, 4135.958640413617, 10756.408397538211, 11162.553497860157, 11290.54837806495, 11298.548058077586, 11301.71745706364, 10879.891201088047, 10956.178286628534, 11019.118470522339, 11157.888421115847, 11162.776744465065, 8538.615762290712, 8632.050474447806, 8632.223099921037, 8635.222829945209, 8635.963684357917, 5739.684317362585, 5892.381299963442, 5996.5502587307, 6017.518598512196, 6083.0, 9604.807903841744, 9610.135087842127, 9957.551910164206, 9958.053984871425, 9973.551190196604, 9670.226381889292, 10025.398476091457, 10089.293749437762, 10177.0, 10205.132563732166, 7055.858882822417, 7241.094863142107, 7700.19147989453, 7832.608369581612, 7835.921640783519, 8330.250277475056, 8535.573221339033, 8538.487690738575, 8549.14508549165, 8566.82866342682, 5918.881622367615, 6880.827979300358, 7118.822029449305, 7378.815529611588, 7640.350570201373, 7466.066741657293, 7519.586422746802, 7546.886796697944, 7611.3530349918665, 7612.581308028111, 7000.929990700028, 7050.612216328152, 7080.822979425556, 7082.964585177041, 7086.681099350645, 5008.824691135793, 5027.245913113063, 5038.697678139323, 5138.3833939927445, 5151.866589350337, 5013.24801279811, 5069.9746501267255, 5128.333316668809, 5229.111051121243, 5243.580513558983], "value": 4628.2210756791865, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.3485763330972, 332.747112194732, 341.6617548626859, 343.1524135385598, 344.1362180925875, 6490.448311893483, 6645.202575690918, 6646.634435106073, 6649.069130321759, 6743.730250789975, 5521.702399936012, 6442.935570644304, 6692.799216023527, 6717.697703603338, 6720.831979200522, 4909.042736666352, 4942.332785074005, 4951.306817045616, 4954.3063971044085, 4959.454460009396, 4724.858254252378, 4800.42394912611, 4949.802007919697, 4952.638024543244, 4977.7262250576205, 4465.754383508905, 4903.387076615423, 4911.75441227939, 4927.384076990376, 4942.382202224722, 4868.172410690174, 4877.414710234759, 4899.069176856421, 4900.436449808282, 4903.828366007173, 4185.100203456272, 4191.832326706928, 4196.685248606367, 4197.727147735387, 4210.263203939329, 6398.104265402801, 6399.552031357807, 6405.903911441332, 6408.58344207625, 6419.5506314558, 5644.8306550803545, 5854.560907931879, 5854.648721076749, 5874.9118763218585, 5891.909996650634, 7046.189688185873, 7131.857362852766, 7144.464165187632, 7146.642667866638, 7161.534500257519, 4760.785764640599, 4761.642876784255, 4761.6904901181315, 4761.857144285642, 4778.593819525345, 7312.1956584775635, 7456.850862982764, 7525.247475252431, 7529.171791102919, 7536.397088232983, 4695.530446955346, 4708.8351907683755, 4734.313524538922, 4734.526547345306, 4741.004389078264, 4631.120087183424, 4811.422629284439, 4814.494478079821, 4817.084753896818, 4822.807087716452, 4945.184044632667, 5694.97152514243, 5698.116791897262, 5702.0, 5712.514436272963, 6718.857794175002, 7138.0, 7143.82140446493, 7155.642217889189, 7172.928270717331, 1379.1311473771661, 1663.6839000589848, 1665.0842036879667, 1668.341005302923, 1670.073109424257, 1028.1980055556678, 1040.9403816126594, 1060.2260349944584, 1061.692109288313, 1064.350746044912, 5912.881742365129, 6892.172939247323, 6899.93100069003, 6907.378335949688, 6912.792616221522, 7416.443766717518, 7418.777436676908, 7426.2945020223, 7436.628168591549, 7441.962790186123, 6866.382025617619, 6883.690233939485, 6895.827604309932, 6896.827579310558, 6897.0, 3362.7477939154173, 3795.7094587840265, 3897.493325867619, 3910.569837317893, 3945.6251656092627, 7822.882656760153, 7858.0963189232825, 7859.921400786034, 7860.6855725771475, 7886.408519361071, 7571.3942884569105, 7627.12288086866, 7628.732994345171, 7642.5032372895585, 7650.73222437212, 7840.176781437981, 7850.371970242367, 7850.568218747795, 7884.250996155356, 7884.802879927933, 7208.819779505554, 7378.741744038933, 7382.778516644509, 7400.259974002772, 7506.13679426851, 7317.195108538163, 7358.0, 7367.963160184165, 7378.372838308804, 7399.334059934632, 7912.762617121495, 7921.960390198012, 7928.445008849325, 7948.125706172201, 7949.403794715304, 4540.909181816412, 4652.55800698933, 4661.0, 4695.5304469552775, 4762.809487620457, 7419.777406677808, 7419.961205431136, 7430.665620047002, 7432.962835185789, 7440.218777028334, 7182.163045597064, 7184.389326907271, 7194.604296763729, 7200.459965502503, 7202.747903823341, 7138.107736532934, 7141.714331426892, 7159.176694680178, 7166.104236970379, 7167.784966451015, 6759.459243260626, 6986.0, 6992.2308546058875, 7000.47496437759, 7017.894731579133, 7078.964605176941, 7115.1106111736035, 7131.144262688511, 7148.17795953472, 7162.319579639926, 6987.196472405535, 6999.545029573062, 7014.333638304353, 7018.719251229893, 7029.507934444539], "value": 5241.928007992463, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.875642384371, 731.5647189921998, 731.615901651633, 753.1564647594695, 803.9638216280267, 15779.921100394497, 15979.520614381558, 16004.75992860108, 16018.919905400457, 16053.036817790926, 14600.707985840303, 14653.413863445476, 14659.560213193621, 14664.853351466481, 14669.0, 791.584418180457, 819.5779173725537, 945.394947233771, 975.1175186456232, 977.0424983516158, 973.7224890906093, 983.2625530851861, 988.461288597716, 989.5003023473135, 990.1187942730975, 1040.0847254416103, 1042.8227201375746, 1044.6761503933767, 1045.5242864496636, 1046.1630695443653, 838.174398217755, 1023.8924912884152, 1055.0873494427303, 1056.4506456642503, 1057.4924036462542, 783.6904422753038, 784.0826233307045, 784.4038530716697, 784.6861255497789, 784.7606480023591, 15387.230638468032, 15445.382184712598, 15467.0, 15509.457168999032, 15513.534593962198, 13112.86887131126, 13392.665183370495, 13483.393247303895, 13563.59309220725, 13593.864061359458, 10280.537375818107, 10401.53193106312, 10464.476776161162, 10626.574937002511, 10961.232713710044, 3581.0510214793103, 3596.730245231592, 3631.2918980798754, 3680.411134218539, 3858.575556688762, 80254.19745802526, 81771.5911420445, 84321.15678843133, 84484.57757711172, 84803.5759821197, 9854.458004809661, 9859.50702464874, 9911.207103431709, 9911.553980070914, 10109.0, 23184.3044708659, 23208.651870221624, 23210.53578928412, 23258.883705581702, 23297.88351058234, 7512.812179695442, 7526.172121066678, 7614.466987310946, 7621.961890190513, 7844.333231675371, 4193.32906734927, 4244.257254980428, 4307.353896915488, 4328.220920234388, 4518.841840535565, 3785.0348161218712, 3830.2148059647707, 3847.826847791856, 3859.324618191861, 3859.8456061757215, 668.9664468396339, 683.4498228925663, 689.9926107882548, 697.7592730507967, 714.4353865035556, 505.7167985927892, 592.7688201601379, 610.4444955090846, 613.8588124731248, 626.8056902360283, 7898.60506974649, 7953.32396746283, 7997.6800927963395, 8150.7147249845975, 8424.199701028392, 604.9126843248348, 608.4736702752087, 612.2591664086416, 619.9566030377921, 626.2578844069701, 3686.4654625079215, 3869.1294458746556, 3921.117748506563, 3942.4086387042175, 3996.080901392696, 87623.0, 88923.0, 89691.0, 90057.09942900487, 90123.0, 78148.0, 78654.03364915923, 79046.02384940423, 79441.60279198567, 79461.60269198618, 69399.3060069403, 69790.90627281088, 69900.0, 69934.0, 69971.65014174896, 7532.510386824839, 7651.846963060819, 7746.0317460317465, 7917.524948503108, 8108.2297181767635, 47393.28910066421, 47553.52446475491, 49017.529474115836, 49707.00585988188, 49761.75119124381, 64621.70756584936, 67014.0, 67410.31474213184, 67426.0, 68455.31544684489, 10388.948055259676, 10403.58385664565, 10829.67510974672, 11279.943600281946, 11308.604198853001, 11924.582639607572, 12066.034717222425, 12150.939245304071, 12274.877251227374, 12694.0, 9640.566174522022, 11610.94194529022, 11791.29252244868, 12031.338276394883, 12077.939610302245, 11489.827652585385, 11588.132287977223, 11594.826077609012, 11653.30080195191, 11987.520499180284, 10921.290116142743, 10966.177536684621, 11474.254173478697, 11485.942570287096, 12084.818727719266, 8117.878231826646, 9620.75948101303, 9921.255905807238, 9966.50167491608, 10072.043155900177, 9617.278704097082, 9635.662751803933, 9689.563969621526, 9803.509824508888, 9818.901810981799], "value": 7106.700728415978, "unit": "score"}], "name": "dromaeo_css", "value": 7616.20137239823, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 118.0, 113.0, 111.0, 112.0, 113.0, 113.0, 113.0, 133.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 143.0, 166.0, 111.0, 140.0, 117.0, 152.0, 152.0, 117.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 184.0, 184.0, 180.0, 185.0, 185.0, 185.0, 184.0, 187.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 80.0, 91.0, 174.0, 73.0, 73.0, 83.0, 91.0, 145.0, 73.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 139.0, 79.0, 78.0, 80.0, 125.0, 80.0, 77.0, 125.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 85.0, 88.0, 84.0, 88.0, 86.0, 88.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 94.0, 93.0, 93.0, 100.0, 94.0, 93.0, 94.0, 93.0], "value": 102.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 83.0, 85.0, 85.0, 96.0, 138.0, 87.0, 85.0, 83.0], "value": 91.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 63.0, 62.0, 63.0, 63.0, 64.0, 76.0, 60.0, 56.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 65.0, 78.0, 76.0, 70.0, 70.0, 66.0, 65.0, 67.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 81.0, 80.0, 78.0, 80.0, 79.0, 80.0, 82.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 125.0, 123.0, 126.0, 126.0, 127.0, 130.0, 136.0, 129.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 161.0, 162.0, 158.0, 161.0, 162.0, 162.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 67.0, 67.0, 69.0, 91.0, 94.0, 95.0, 94.0, 65.0], "value": 77.5, "unit": "score"}], "name": "kraken", "value": 1486.1, "alertThreshold": 2.0}]} 21:03:20 INFO - Return code: 0 21:03:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:03:20 ERROR - # TBPL SUCCESS # 21:03:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:03:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:03:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:03:20 INFO - 2016-07-07 21:03:20.167 screenresolution[1676:9597] starting screenresolution argv=screenresolution get 21:03:20 INFO - 2016-07-07 21:03:20.170 screenresolution[1676:9597] Display 0: 1600x1200x32@60 21:03:20 INFO - 2016-07-07 21:03:20.176 screenresolution[1677:9601] starting screenresolution argv=screenresolution list 21:03:20 INFO - Available Modes on Display 0 21:03:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:03:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:03:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:03:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:03:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:03:20 INFO - Intel Iris: 21:03:20 INFO - Chipset Model: Intel Iris 21:03:20 INFO - Type: GPU 21:03:20 INFO - Bus: Built-In 21:03:20 INFO - VRAM (Dynamic, Max): 1536 MB 21:03:20 INFO - Vendor: Intel (0x8086) 21:03:20 INFO - Device ID: 0x0a2e 21:03:20 INFO - Revision ID: 0x0009 21:03:20 INFO - Displays: 21:03:20 INFO - Display: 21:03:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:03:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:03:20 INFO - Display Serial Number: 1600x1200 60 21:03:20 INFO - Main Display: Yes 21:03:20 INFO - Mirror: Off 21:03:20 INFO - Online: Yes 21:03:20 INFO - Rotation: Supported 21:03:20 INFO - Return code: 0 21:03:20 INFO - Running post-action listener: _resource_record_post_action 21:03:20 INFO - Running post-run listener: _resource_record_post_run 21:03:21 INFO - Total resource usage - Wall time: 1194s; CPU: 52.0%; Read bytes: 38012416; Write bytes: 493003264; Read time: 385; Write time: 2387 21:03:21 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193466880; Write bytes: 187111424; Read time: 17628; Write time: 398 21:03:21 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 36193792; Write bytes: 296147456; Read time: 366; Write time: 1955 21:03:21 INFO - Running post-run listener: _upload_blobber_files 21:03:21 INFO - Blob upload gear active. 21:03:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:03:21 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 21:03:21 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'] 21:03:21 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 21:03:21 INFO - (blobuploader) - INFO - Open directory for files ... 21:03:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:03:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:03:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:03:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:03:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:03:22 INFO - (blobuploader) - INFO - Done attempting. 21:03:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:03:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:03:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:03:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:03:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:03:23 INFO - (blobuploader) - INFO - Done attempting. 21:03:23 INFO - (blobuploader) - INFO - Iteration through files over. 21:03:23 INFO - Return code: 0 21:03:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:03:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:03:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d60d6ed86cba96d439274b422f9909cf70863431e957b37d8266ce3431f365c8e1dc466a9d493cae6963bfe78d1ccfe0ba9df0038aaeebd114e0b7db81cf332d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e80e51143d4be2ef8802b28681f642b288ad9538f39161abfc3c4dd92f633cf3be100e4e6e15618539a6f278d6e5d3ab753c8148e1814e8101835e3c5c676f32"} 21:03:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:03:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:03:23 INFO - Contents: 21:03:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d60d6ed86cba96d439274b422f9909cf70863431e957b37d8266ce3431f365c8e1dc466a9d493cae6963bfe78d1ccfe0ba9df0038aaeebd114e0b7db81cf332d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e80e51143d4be2ef8802b28681f642b288ad9538f39161abfc3c4dd92f633cf3be100e4e6e15618539a6f278d6e5d3ab753c8148e1814e8101835e3c5c676f32"} 21:03:23 INFO - Running post-run listener: copy_logs_to_upload_dir 21:03:23 INFO - Copying logs to upload dir... 21:03:23 INFO - mkdir: /builds/slave/test/build/upload/logs 21:03:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.361129 ========= master_lag: 2.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-07 21:03:26.513084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 21:03:26.516199) ========= 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.25UdZSOlla/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.U313Q1azTP/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d60d6ed86cba96d439274b422f9909cf70863431e957b37d8266ce3431f365c8e1dc466a9d493cae6963bfe78d1ccfe0ba9df0038aaeebd114e0b7db81cf332d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e80e51143d4be2ef8802b28681f642b288ad9538f39161abfc3c4dd92f633cf3be100e4e6e15618539a6f278d6e5d3ab753c8148e1814e8101835e3c5c676f32"} build_url:https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/Hk5F6rk7RyCc1aE7wM7Zug/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d60d6ed86cba96d439274b422f9909cf70863431e957b37d8266ce3431f365c8e1dc466a9d493cae6963bfe78d1ccfe0ba9df0038aaeebd114e0b7db81cf332d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e80e51143d4be2ef8802b28681f642b288ad9538f39161abfc3c4dd92f633cf3be100e4e6e15618539a6f278d6e5d3ab753c8148e1814e8101835e3c5c676f32"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 21:03:26.550731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 21:03:26.551101) ========= 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.25UdZSOlla/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.U313Q1azTP/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.005019 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 21:03:26.601028) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 21:03:26.601387) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 21:03:26.601821) ========= ========= Total master_lag: 2.79 =========