builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0004 starttime: 1463793932.01 results: success (0) buildid: 20160520162531 builduid: 52232ad07fdb41a8b8de524ba83c227a revision: bcc547cc6eec10f7b37ac8e5c2c66b50bd915b45 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 18:25:32.005757) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 18:25:32.006265) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 18:25:32.006604) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 18:25:32.028583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 18:25:32.029261) ========= 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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-20 18:25:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 214M=0s 2016-05-20 18:25:32 (214 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092070 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 18:25:32.148464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 18:25:32.148813) ========= 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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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.027183 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 18:25:32.200430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 18:25:32.200889) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bcc547cc6eec10f7b37ac8e5c2c66b50bd915b45 --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 bcc547cc6eec10f7b37ac8e5c2c66b50bd915b45 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O0OwHdmKdG/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.6fnlKsMQDq/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-20 18:25:32,278 truncating revision to first 12 chars 2016-05-20 18:25:32,278 Setting DEBUG logging. 2016-05-20 18:25:32,278 attempt 1/10 2016-05-20 18:25:32,278 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bcc547cc6eec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 18:25:33,858 unpacking tar archive at: mozilla-beta-bcc547cc6eec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.828364 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 18:25:34.048735) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 18:25:34.049116) ========= script_repo_revision: bcc547cc6eec10f7b37ac8e5c2c66b50bd915b45 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 18:25:34.049584) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 18:25:34.049886) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 18:25:34.065749) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-20 18:25:34.066108) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O0OwHdmKdG/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.6fnlKsMQDq/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 18:25:34 INFO - MultiFileLogger online at 20160520 18:25:34 in /builds/slave/test 18:25:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 18:25:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:25:34 INFO - {'append_to_log': False, 18:25:34 INFO - 'base_work_dir': '/builds/slave/test', 18:25:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:25:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:25:34 INFO - 'branch': 'Mozilla-Beta', 18:25:34 INFO - 'buildbot_json_path': 'buildprops.json', 18:25:34 INFO - 'config_files': ('talos/mac_config.py',), 18:25:34 INFO - 'default_actions': ('clobber', 18:25:34 INFO - 'read-buildbot-config', 18:25:34 INFO - 'download-and-extract', 18:25:34 INFO - 'populate-webroot', 18:25:34 INFO - 'create-virtualenv', 18:25:34 INFO - 'install', 18:25:34 INFO - 'run-tests'), 18:25:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:25:34 INFO - 'download_minidump_stackwalk': True, 18:25:34 INFO - 'download_symbols': 'ondemand', 18:25:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:25:34 INFO - 'tooltool.py': '/tools/tooltool.py', 18:25:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:25:34 INFO - '/tools/misc-python/virtualenv.py')}, 18:25:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:25:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:25:34 INFO - 'installer_path': 'installer.exe', 18:25:34 INFO - 'log_level': 'info', 18:25:34 INFO - 'log_name': 'talos', 18:25:34 INFO - 'log_to_console': True, 18:25:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:25:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:25:34 INFO - 'opt_config_files': (), 18:25:34 INFO - 'pip_index': False, 18:25:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:25:34 INFO - 'cmd': ('bash', 18:25:34 INFO - '-c', 18:25:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:25:34 INFO - 'enabled': True, 18:25:34 INFO - 'halt_on_failure': False, 18:25:34 INFO - 'name': 'check_screen_resolution'},), 18:25:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:25:34 INFO - 'cmd': ('bash', 18:25:34 INFO - '-c', 18:25:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:25:34 INFO - 'enabled': True, 18:25:34 INFO - 'halt_on_failure': False, 18:25:34 INFO - 'name': 'check_screen_resolution'},), 18:25:34 INFO - 'run_cmd_checks_enabled': True, 18:25:34 INFO - 'sps_profile': False, 18:25:34 INFO - 'sps_profile_interval': 0, 18:25:34 INFO - 'suite': 'dromaeojs-e10s', 18:25:34 INFO - 'system_bits': '32', 18:25:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:25:34 INFO - 'title': 't-yosemite-r7-0004', 18:25:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:25:34 INFO - 'use_talos_json': True, 18:25:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:25:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:25:34 INFO - 'work_dir': 'build'} 18:25:34 INFO - ##### 18:25:34 INFO - ##### Running clobber step. 18:25:34 INFO - ##### 18:25:34 INFO - Running pre-action listener: _resource_record_pre_action 18:25:34 INFO - Running main action method: clobber 18:25:34 INFO - rmtree: /builds/slave/test/build 18:25:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:25:36 INFO - Running post-action listener: _resource_record_post_action 18:25:36 INFO - ##### 18:25:36 INFO - ##### Running read-buildbot-config step. 18:25:36 INFO - ##### 18:25:36 INFO - Running pre-action listener: _resource_record_pre_action 18:25:36 INFO - Running main action method: read_buildbot_config 18:25:36 INFO - Using buildbot properties: 18:25:36 INFO - { 18:25:36 INFO - "project": "", 18:25:36 INFO - "product": "firefox", 18:25:36 INFO - "script_repo_revision": "production", 18:25:36 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 18:25:36 INFO - "repository": "", 18:25:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 18:25:36 INFO - "buildid": "20160520162531", 18:25:36 INFO - "pgo_build": "False", 18:25:36 INFO - "basedir": "/builds/slave/test", 18:25:36 INFO - "buildnumber": 30, 18:25:36 INFO - "slavename": "t-yosemite-r7-0004", 18:25:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:25:36 INFO - "platform": "yosemite_r7", 18:25:36 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 18:25:36 INFO - "branch": "mozilla-beta", 18:25:36 INFO - "repo_path": "releases/mozilla-beta", 18:25:36 INFO - "revision": "bcc547cc6eec10f7b37ac8e5c2c66b50bd915b45", 18:25:36 INFO - "stage_platform": "macosx64", 18:25:36 INFO - "builduid": "52232ad07fdb41a8b8de524ba83c227a", 18:25:36 INFO - "slavebuilddir": "test" 18:25:36 INFO - } 18:25:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 18:25:36 INFO - Running post-action listener: _resource_record_post_action 18:25:36 INFO - ##### 18:25:36 INFO - ##### Running download-and-extract step. 18:25:36 INFO - ##### 18:25:36 INFO - Running pre-action listener: _resource_record_pre_action 18:25:36 INFO - Running main action method: download_and_extract 18:25:36 INFO - mkdir: /builds/slave/test/build/tests 18:25: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')]} 18:25:36 INFO - https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 18:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 18:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 18:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 18:25:39 INFO - Downloaded 1241 bytes. 18:25:39 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 18:25:39 INFO - Using the following test package requirements: 18:25:39 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 18:25:39 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:25:39 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 18:25:39 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:25:39 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 18:25:39 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 18:25:39 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:25:39 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 18:25:39 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 18:25:39 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:25:39 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 18:25:39 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:25:39 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 18:25:39 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:25:39 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 18:25:39 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 18:25:39 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:25:39 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 18:25:39 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 18:25:39 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')]} 18:25:39 INFO - https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:25:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 18:25:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 18:25:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 18:25:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 18:25:40 INFO - Downloaded 17747774 bytes. 18:25:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:25:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:25:43 INFO - Return code: 0 18:25:44 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 18:25:44 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')]} 18:25:44 INFO - https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:25:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 18:25:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 18:25:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 18:25:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 18:25:45 INFO - Downloaded 17747774 bytes. 18:25:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:25:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:25:48 INFO - Return code: 0 18:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:48 INFO - https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:25:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 18:25:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 18:25:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 18:25:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 18:25:49 INFO - Downloaded 10845194 bytes. 18:25:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:25:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:25:50 INFO - Return code: 0 18:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:50 INFO - https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 18:25:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.dmg 18:25:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.dmg 18:25:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 18:25:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 18:25:53 INFO - Downloaded 88423719 bytes. 18:25:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.dmg 18:25:53 INFO - mkdir: /builds/slave/test/properties 18:25:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:25:53 INFO - Writing to file /builds/slave/test/properties/build_url 18:25:53 INFO - Contents: 18:25:53 INFO - build_url:https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.dmg 18:25:55 INFO - Running post-action listener: _resource_record_post_action 18:25:55 INFO - Running post-action listener: set_extra_try_arguments 18:25:55 INFO - ##### 18:25:55 INFO - ##### Running populate-webroot step. 18:25:55 INFO - ##### 18:25:55 INFO - Running pre-action listener: _resource_record_pre_action 18:25:55 INFO - Running main action method: populate_webroot 18:25:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:25:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:25:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:25:55 INFO - '--tppagecycles', 18:25:55 INFO - '7'], 18:25:55 INFO - 'tests': ['tsvgm']}}, 18:25:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:25:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:25:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:25:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:25:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:25:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:25:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:55 INFO - 'talos_options': ['--e10s'], 18:25:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:55 INFO - 'tests': ['damp', 'tps']}, 18:25:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:55 INFO - 'talos_options': ['--e10s'], 18:25:55 INFO - 'tests': ['damp', 'tps']}, 18:25:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:25:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:25:55 INFO - 'other': {'tests': ['a11yr', 18:25:55 INFO - 'ts_paint', 18:25:55 INFO - 'tpaint', 18:25:55 INFO - 'sessionrestore', 18:25:55 INFO - 'sessionrestore_no_auto_restore', 18:25:55 INFO - 'tabpaint']}, 18:25:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:25:55 INFO - 'tests': ['a11yr', 18:25:55 INFO - 'ts_paint', 18:25:55 INFO - 'tpaint', 18:25:55 INFO - 'sessionrestore', 18:25:55 INFO - 'sessionrestore_no_auto_restore', 18:25:55 INFO - 'tabpaint']}, 18:25:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:25:55 INFO - 'tests': ['a11yr', 18:25:55 INFO - 'ts_paint', 18:25:55 INFO - 'tpaint', 18:25:55 INFO - 'sessionrestore', 18:25:55 INFO - 'sessionrestore_no_auto_restore', 18:25:55 INFO - 'tabpaint']}, 18:25:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:25:55 INFO - 'tests': ['a11yr', 18:25:55 INFO - 'ts_paint', 18:25:55 INFO - 'tpaint', 18:25:55 INFO - 'sessionrestore', 18:25:55 INFO - 'sessionrestore_no_auto_restore', 18:25:55 INFO - 'tabpaint']}, 18:25:55 INFO - 'other_l64': {'tests': ['a11yr', 18:25:55 INFO - 'ts_paint', 18:25:55 INFO - 'tpaint', 18:25:55 INFO - 'sessionrestore', 18:25:55 INFO - 'sessionrestore_no_auto_restore', 18:25:55 INFO - 'tabpaint']}, 18:25:55 INFO - 'other_nol64': {'tests': ['a11yr', 18:25:55 INFO - 'ts_paint', 18:25:55 INFO - 'tpaint', 18:25:55 INFO - 'sessionrestore', 18:25:55 INFO - 'sessionrestore_no_auto_restore', 18:25:55 INFO - 'tabpaint']}, 18:25:55 INFO - 'svgr': {'tests': ['tsvgx', 18:25:55 INFO - 'tsvgr_opacity', 18:25:55 INFO - 'tart', 18:25:55 INFO - 'tscrollx', 18:25:55 INFO - 'cart']}, 18:25:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:25:55 INFO - 'tests': ['tsvgx', 18:25:55 INFO - 'tsvgr_opacity', 18:25:55 INFO - 'tart', 18:25:55 INFO - 'tscrollx', 18:25:55 INFO - 'cart']}, 18:25:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:55 INFO - 'tests': ['tp5o']}, 18:25:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:55 INFO - 'talos_options': ['--e10s'], 18:25:55 INFO - 'tests': ['tp5o']}, 18:25:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:55 INFO - 'talos_options': ['--xperf_path', 18:25:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:55 INFO - 'tests': ['tp5n']}, 18:25:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:55 INFO - 'talos_options': ['--e10s', 18:25:55 INFO - '--xperf_path', 18:25:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:55 INFO - 'tests': ['tp5n']}}, 18:25:55 INFO - 'talos.zip': {'path': '', 18:25:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:25:55 INFO - Running post-action listener: _resource_record_post_action 18:25:55 INFO - ##### 18:25:55 INFO - ##### Running create-virtualenv step. 18:25:55 INFO - ##### 18:25:55 INFO - Running pre-action listener: _resource_record_pre_action 18:25:55 INFO - Running main action method: create_virtualenv 18:25:55 INFO - Creating virtualenv /builds/slave/test/build/venv 18:25:55 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 18:25:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:25:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:25:55 INFO - Using real prefix '/tools/python27' 18:25:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:25:55 INFO - Installing distribute.............................................................................................................................................................................................done. 18:25:58 INFO - Installing pip.................done. 18:25:58 INFO - Return code: 0 18:25:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25: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')]} 18:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb699ddb380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aded30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad5b20>, '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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 18:25: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', 'pip>=1.5'] in /builds/slave/test/build 18:25: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 pip>=1.5 18:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O0OwHdmKdG/Render', 18:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:25:58 INFO - 'HOME': '/Users/cltbld', 18:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:25:58 INFO - 'LOGNAME': 'cltbld', 18:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:58 INFO - 'MOZ_NO_REMOTE': '1', 18:25:58 INFO - 'NO_EM_RESTART': '1', 18:25:58 INFO - 'PAGER': '/bin/cat', 18:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:58 INFO - 'PWD': '/builds/slave/test', 18:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:25:58 INFO - 'SHELL': '/bin/bash', 18:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6fnlKsMQDq/Listeners', 18:25:58 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 18:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:25:58 INFO - 'USER': 'cltbld', 18:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:58 INFO - 'XPC_FLAGS': '0x0', 18:25:58 INFO - 'XPC_SERVICE_NAME': '0', 18:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:59 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 18:25:59 INFO - Cleaning up... 18:25:59 INFO - Return code: 0 18:25:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:25:59 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')]} 18:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:59 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')]} 18:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:59 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 0x106c3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb699ddb380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aded30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad5b20>, '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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 18:25:59 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 18:25:59 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 18:25:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O0OwHdmKdG/Render', 18:25:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:25:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:25:59 INFO - 'HOME': '/Users/cltbld', 18:25:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:25:59 INFO - 'LOGNAME': 'cltbld', 18:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:59 INFO - 'MOZ_NO_REMOTE': '1', 18:25:59 INFO - 'NO_EM_RESTART': '1', 18:25:59 INFO - 'PAGER': '/bin/cat', 18:25:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:59 INFO - 'PWD': '/builds/slave/test', 18:25:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:25:59 INFO - 'SHELL': '/bin/bash', 18:25:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6fnlKsMQDq/Listeners', 18:25:59 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 18:25:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:25:59 INFO - 'USER': 'cltbld', 18:25:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:25:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:59 INFO - 'XPC_FLAGS': '0x0', 18:25:59 INFO - 'XPC_SERVICE_NAME': '0', 18:25:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:59 INFO - Downloading/unpacking psutil>=0.7.1 18:25:59 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 18:25:59 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 18:25:59 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 18:25:59 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 18:25:59 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 18:25:59 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 18:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:26:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:02 INFO - Installing collected packages: psutil 18:26:02 INFO - Running setup.py install for psutil 18:26:02 INFO - building 'psutil._psutil_osx' extension 18:26:02 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 18:26:02 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 18:26:02 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 18:26:02 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 18:26:02 INFO - building 'psutil._psutil_posix' extension 18:26:02 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 18:26:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:26:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:26:02 INFO - ^ 18:26:03 INFO - 1 warning generated. 18:26:03 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 18:26:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:03 INFO - Successfully installed psutil 18:26:03 INFO - Cleaning up... 18:26:03 INFO - Return code: 0 18:26:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:03 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 0x106c3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb699ddb380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aded30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad5b20>, '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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 18:26:03 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 18:26:03 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 18:26:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O0OwHdmKdG/Render', 18:26:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:26:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:26:03 INFO - 'HOME': '/Users/cltbld', 18:26:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:26:03 INFO - 'LOGNAME': 'cltbld', 18:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:03 INFO - 'MOZ_NO_REMOTE': '1', 18:26:03 INFO - 'NO_EM_RESTART': '1', 18:26:03 INFO - 'PAGER': '/bin/cat', 18:26:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:03 INFO - 'PWD': '/builds/slave/test', 18:26:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:26:03 INFO - 'SHELL': '/bin/bash', 18:26:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6fnlKsMQDq/Listeners', 18:26:03 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 18:26:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:26:03 INFO - 'USER': 'cltbld', 18:26:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:26:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:03 INFO - 'XPC_FLAGS': '0x0', 18:26:03 INFO - 'XPC_SERVICE_NAME': '0', 18:26:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:26:03 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 18:26:03 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 18:26:03 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 18:26:03 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 18:26:03 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 18:26:03 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 18:26:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:26:06 INFO - Installing collected packages: mozsystemmonitor 18:26:06 INFO - Running setup.py install for mozsystemmonitor 18:26:06 INFO - Successfully installed mozsystemmonitor 18:26:06 INFO - Cleaning up... 18:26:06 INFO - Return code: 0 18:26:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:06 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 0x106c3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb699ddb380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aded30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad5b20>, '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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 18:26:06 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 18:26:06 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 18:26:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O0OwHdmKdG/Render', 18:26:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:26:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:26:06 INFO - 'HOME': '/Users/cltbld', 18:26:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:26:06 INFO - 'LOGNAME': 'cltbld', 18:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:06 INFO - 'MOZ_NO_REMOTE': '1', 18:26:06 INFO - 'NO_EM_RESTART': '1', 18:26:06 INFO - 'PAGER': '/bin/cat', 18:26:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:06 INFO - 'PWD': '/builds/slave/test', 18:26:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:26:06 INFO - 'SHELL': '/bin/bash', 18:26:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6fnlKsMQDq/Listeners', 18:26:06 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 18:26:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:26:06 INFO - 'USER': 'cltbld', 18:26:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:26:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:06 INFO - 'XPC_FLAGS': '0x0', 18:26:06 INFO - 'XPC_SERVICE_NAME': '0', 18:26:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:06 INFO - Downloading/unpacking blobuploader==1.2.4 18:26:06 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 18:26:06 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 18:26:06 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 18:26:06 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 18:26:06 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 18:26:06 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 18:26:09 INFO - Downloading blobuploader-1.2.4.tar.gz 18:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:26:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:26:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:10 INFO - Downloading docopt-0.6.1.tar.gz 18:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:26:10 INFO - Installing collected packages: blobuploader, requests, docopt 18:26:10 INFO - Running setup.py install for blobuploader 18:26:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:26:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:26:10 INFO - Running setup.py install for requests 18:26:11 INFO - Running setup.py install for docopt 18:26:11 INFO - Successfully installed blobuploader requests docopt 18:26:11 INFO - Cleaning up... 18:26:11 INFO - Return code: 0 18:26:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:11 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 0x106c3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb699ddb380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aded30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad5b20>, '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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 18:26:11 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 18:26:11 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 18:26:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O0OwHdmKdG/Render', 18:26:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:26:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:26:11 INFO - 'HOME': '/Users/cltbld', 18:26:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:26:11 INFO - 'LOGNAME': 'cltbld', 18:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:11 INFO - 'MOZ_NO_REMOTE': '1', 18:26:11 INFO - 'NO_EM_RESTART': '1', 18:26:11 INFO - 'PAGER': '/bin/cat', 18:26:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:11 INFO - 'PWD': '/builds/slave/test', 18:26:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:26:11 INFO - 'SHELL': '/bin/bash', 18:26:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6fnlKsMQDq/Listeners', 18:26:11 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 18:26:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:26:11 INFO - 'USER': 'cltbld', 18:26:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:26:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:11 INFO - 'XPC_FLAGS': '0x0', 18:26:11 INFO - 'XPC_SERVICE_NAME': '0', 18:26:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:11 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-APUkpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:11 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-Agdtqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:11 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-IpEGDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:11 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-XQwJO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:11 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-GAcAHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-xUnpNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-Dx6Ngf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-xg87DQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-VtZwIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-5U_S1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-e0CSdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-M0GHVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-JY1a6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-KKVTsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-rrNRgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:13 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-Dc2RIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:13 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-2eIMzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:26:13 INFO - Running setup.py install for manifestparser 18:26:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:26:13 INFO - Running setup.py install for mozcrash 18:26:13 INFO - Running setup.py install for mozdebug 18:26:13 INFO - Running setup.py install for mozdevice 18:26:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:26:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:26:13 INFO - Running setup.py install for mozfile 18:26:14 INFO - Running setup.py install for mozhttpd 18:26:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:26:14 INFO - Running setup.py install for mozinfo 18:26:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:26:14 INFO - Running setup.py install for mozInstall 18:26:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:26:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:26:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:26:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:26:14 INFO - Running setup.py install for mozleak 18:26:14 INFO - Running setup.py install for mozlog 18:26:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:26:14 INFO - Running setup.py install for moznetwork 18:26:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:26:14 INFO - Running setup.py install for mozprocess 18:26:15 INFO - Running setup.py install for mozprofile 18:26:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:26:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:26:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:26:15 INFO - Running setup.py install for mozrunner 18:26:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:26:15 INFO - Running setup.py install for mozscreenshot 18:26:15 INFO - Running setup.py install for moztest 18:26:15 INFO - Running setup.py install for mozversion 18:26:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:26:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:26:15 INFO - Cleaning up... 18:26:15 INFO - Return code: 0 18:26:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:15 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 0x106c3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb699ddb380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aded30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad5b20>, '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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 18:26:15 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 18:26:15 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 18:26:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O0OwHdmKdG/Render', 18:26:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:26:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:26:15 INFO - 'HOME': '/Users/cltbld', 18:26:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:26:15 INFO - 'LOGNAME': 'cltbld', 18:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:15 INFO - 'MOZ_NO_REMOTE': '1', 18:26:15 INFO - 'NO_EM_RESTART': '1', 18:26:15 INFO - 'PAGER': '/bin/cat', 18:26:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:15 INFO - 'PWD': '/builds/slave/test', 18:26:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:26:15 INFO - 'SHELL': '/bin/bash', 18:26:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6fnlKsMQDq/Listeners', 18:26:15 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 18:26:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:26:15 INFO - 'USER': 'cltbld', 18:26:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:26:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:15 INFO - 'XPC_FLAGS': '0x0', 18:26:15 INFO - 'XPC_SERVICE_NAME': '0', 18:26:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-wvM1Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:16 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)) 18:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-JiuHkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:16 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)) 18:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-4hnn7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:16 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)) 18:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-DXh2qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:16 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)) 18:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-vzNRU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:16 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)) 18:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-xSZvos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:16 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)) 18:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-6pEjLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:16 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)) 18:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-Oc5txK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:16 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)) 18:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-c7HmoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:17 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)) 18:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-qnQSFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:17 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)) 18:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-ggdP5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:17 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)) 18:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-kqcAXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:17 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)) 18:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-aQJ5Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:17 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)) 18:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-_7q5en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:17 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)) 18:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-odGW2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:17 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)) 18:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-l7RKne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:17 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)) 18:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-9KOAGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26:20 INFO - Downloading blessings-1.6.tar.gz 18:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:26:20 INFO - Installing collected packages: blessings 18:26:20 INFO - Running setup.py install for blessings 18:26:20 INFO - Successfully installed blessings 18:26:20 INFO - Cleaning up... 18:26:20 INFO - Return code: 0 18:26:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:26:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:21 INFO - Reading from file tmpfile_stdout 18:26:21 INFO - Current package versions: 18:26:21 INFO - blessings == 1.6 18:26:21 INFO - blobuploader == 1.2.4 18:26:21 INFO - docopt == 0.6.1 18:26:21 INFO - manifestparser == 1.1 18:26:21 INFO - mozInstall == 1.12 18:26:21 INFO - mozcrash == 0.17 18:26:21 INFO - mozdebug == 0.1 18:26:21 INFO - mozdevice == 0.48 18:26:21 INFO - mozfile == 1.2 18:26:21 INFO - mozhttpd == 0.7 18:26:21 INFO - mozinfo == 0.9 18:26:21 INFO - mozleak == 0.1 18:26:21 INFO - mozlog == 3.1 18:26:21 INFO - moznetwork == 0.27 18:26:21 INFO - mozprocess == 0.22 18:26:21 INFO - mozprofile == 0.28 18:26:21 INFO - mozrunner == 6.11 18:26:21 INFO - mozscreenshot == 0.1 18:26:21 INFO - mozsystemmonitor == 0.0 18:26:21 INFO - moztest == 0.7 18:26:21 INFO - mozversion == 1.4 18:26:21 INFO - psutil == 3.1.1 18:26:21 INFO - requests == 1.2.3 18:26:21 INFO - wsgiref == 0.1.2 18:26:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:21 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 0x106c3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb699ddb380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aded30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad5b20>, '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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 18:26:21 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 18:26:21 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 18:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O0OwHdmKdG/Render', 18:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:26:21 INFO - 'HOME': '/Users/cltbld', 18:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:26:21 INFO - 'LOGNAME': 'cltbld', 18:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:21 INFO - 'MOZ_NO_REMOTE': '1', 18:26:21 INFO - 'NO_EM_RESTART': '1', 18:26:21 INFO - 'PAGER': '/bin/cat', 18:26:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:21 INFO - 'PWD': '/builds/slave/test', 18:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:26:21 INFO - 'SHELL': '/bin/bash', 18:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6fnlKsMQDq/Listeners', 18:26:21 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 18:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:26:21 INFO - 'USER': 'cltbld', 18:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:21 INFO - 'XPC_FLAGS': '0x0', 18:26:21 INFO - 'XPC_SERVICE_NAME': '0', 18:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:21 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)) 18:26:21 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)) 18:26:21 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)) 18:26:21 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)) 18:26:21 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)) 18:26:21 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)) 18:26:21 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)) 18:26:21 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)) 18:26:21 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)) 18:26:21 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)) 18:26:21 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)) 18:26:21 INFO - Cleaning up... 18:26:21 INFO - Return code: 0 18:26:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb699ddb380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aded30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad5b20>, '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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 18:26: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', 'jsonschema'] in /builds/slave/test/build 18:26: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 jsonschema 18:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O0OwHdmKdG/Render', 18:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:26:21 INFO - 'HOME': '/Users/cltbld', 18:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:26:21 INFO - 'LOGNAME': 'cltbld', 18:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:21 INFO - 'MOZ_NO_REMOTE': '1', 18:26:21 INFO - 'NO_EM_RESTART': '1', 18:26:21 INFO - 'PAGER': '/bin/cat', 18:26:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:21 INFO - 'PWD': '/builds/slave/test', 18:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:26:21 INFO - 'SHELL': '/bin/bash', 18:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6fnlKsMQDq/Listeners', 18:26:21 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 18:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:26:21 INFO - 'USER': 'cltbld', 18:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:21 INFO - 'XPC_FLAGS': '0x0', 18:26:21 INFO - 'XPC_SERVICE_NAME': '0', 18:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:21 INFO - Downloading/unpacking jsonschema 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:26:23 INFO - Downloading/unpacking functools32 (from jsonschema) 18:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:24 INFO - Downloading functools32-3.2.3-2.tar.gz 18:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:26:24 INFO - warning: no files found matching '*.txt' 18:26:24 INFO - no previously-included directories found matching 'build' 18:26:24 INFO - no previously-included directories found matching 'dist' 18:26:24 INFO - no previously-included directories found matching '.git*' 18:26:24 INFO - Installing collected packages: jsonschema, functools32 18:26:24 INFO - Running setup.py install for functools32 18:26:24 INFO - warning: no files found matching '*.txt' 18:26:24 INFO - no previously-included directories found matching 'build' 18:26:24 INFO - no previously-included directories found matching 'dist' 18:26:24 INFO - no previously-included directories found matching '.git*' 18:26:24 INFO - Successfully installed jsonschema functools32 18:26:24 INFO - Cleaning up... 18:26:24 INFO - Return code: 0 18:26:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:26:24 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')]} 18:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:24 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')]} 18:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:24 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 0x106c3aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb699ddb380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aded30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad5b20>, '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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 18:26:24 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 18:26:24 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 18:26:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O0OwHdmKdG/Render', 18:26:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:26:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:26:24 INFO - 'HOME': '/Users/cltbld', 18:26:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:26:24 INFO - 'LOGNAME': 'cltbld', 18:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:24 INFO - 'MOZ_NO_REMOTE': '1', 18:26:24 INFO - 'NO_EM_RESTART': '1', 18:26:24 INFO - 'PAGER': '/bin/cat', 18:26:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:24 INFO - 'PWD': '/builds/slave/test', 18:26:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:26:24 INFO - 'SHELL': '/bin/bash', 18:26:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6fnlKsMQDq/Listeners', 18:26:24 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 18:26:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:26:24 INFO - 'USER': 'cltbld', 18:26:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:26:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:24 INFO - 'XPC_FLAGS': '0x0', 18:26:24 INFO - 'XPC_SERVICE_NAME': '0', 18:26:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:24 INFO - Downloading/unpacking flake8 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:26:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:26:27 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 18:26:27 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 18:26:27 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 18:26:27 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 18:26:27 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 18:26:27 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 18:26:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:26:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:26:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:26:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:26:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:26:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:26:29 INFO - no previously-included directories found matching 'docs/_build' 18:26:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:26:29 INFO - Running setup.py install for pep8 18:26:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:26:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:26:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:26:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:26:29 INFO - no previously-included directories found matching 'docs/_build' 18:26:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:26:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:26:29 INFO - Cleaning up... 18:26:29 INFO - Return code: 0 18:26:29 INFO - Running post-action listener: _resource_record_post_action 18:26:29 INFO - Running post-action listener: _start_resource_monitoring 18:26:29 INFO - Starting resource monitoring. 18:26:29 INFO - ##### 18:26:29 INFO - ##### Running install step. 18:26:29 INFO - ##### 18:26:29 INFO - Running pre-action listener: _resource_record_pre_action 18:26:29 INFO - Running main action method: install 18:26:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:29 INFO - Reading from file tmpfile_stdout 18:26:29 INFO - Detecting whether we're running mozinstall >=1.0... 18:26:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:26:29 INFO - Reading from file tmpfile_stdout 18:26:29 INFO - Output received: 18:26:29 INFO - Usage: mozinstall [options] installer 18:26:29 INFO - Options: 18:26:29 INFO - -h, --help show this help message and exit 18:26:29 INFO - -d DEST, --destination=DEST 18:26:29 INFO - Directory to install application into. [default: 18:26:29 INFO - "/builds/slave/test"] 18:26:29 INFO - --app=APP Application being installed. [default: firefox] 18:26:29 INFO - mkdir: /builds/slave/test/build/application 18:26:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 18:26:52 INFO - Reading from file tmpfile_stdout 18:26:52 INFO - Output received: 18:26:52 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 18:26:52 INFO - Running post-action listener: _resource_record_post_action 18:26:52 INFO - ##### 18:26:52 INFO - ##### Running run-tests step. 18:26:52 INFO - ##### 18:26:52 INFO - Running pre-action listener: _resource_record_pre_action 18:26:52 INFO - Running main action method: run_tests 18:26:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:26:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:26:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:26:52 INFO - 2016-05-20 18:26:52.252 screenresolution[1639:7524] starting screenresolution argv=screenresolution get 18:26:52 INFO - 2016-05-20 18:26:52.255 screenresolution[1639:7524] Display 0: 1600x1200x32@60 18:26:52 INFO - 2016-05-20 18:26:52.261 screenresolution[1640:7526] starting screenresolution argv=screenresolution list 18:26:52 INFO - Available Modes on Display 0 18:26:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:26:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:26:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:26:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:26:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:26:52 INFO - Intel Iris: 18:26:52 INFO - Chipset Model: Intel Iris 18:26:52 INFO - Type: GPU 18:26:52 INFO - Bus: Built-In 18:26:52 INFO - VRAM (Dynamic, Max): 1536 MB 18:26:52 INFO - Vendor: Intel (0x8086) 18:26:52 INFO - Device ID: 0x0a2e 18:26:52 INFO - Revision ID: 0x0009 18:26:52 INFO - Displays: 18:26:52 INFO - Display: 18:26:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:26:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:26:52 INFO - Display Serial Number: 1600x1200 60 18:26:52 INFO - Main Display: Yes 18:26:52 INFO - Mirror: Off 18:26:52 INFO - Online: Yes 18:26:52 INFO - Rotation: Supported 18:26:52 INFO - Return code: 0 18:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:26:52 INFO - Python 2.7.3 18:26:52 INFO - Return code: 0 18:26:52 INFO - grabbing minidump binary from tooltool 18:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:52 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 0x106aded30>, '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 0x106942db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:26:52 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 18:26:52 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 18:26:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:26:52 INFO - Return code: 0 18:26:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:26:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:26:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:26:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:26:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:26:53 INFO - Return code: 0 18:26:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:26:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O0OwHdmKdG/Render', 18:26:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:26:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:26:53 INFO - 'HOME': '/Users/cltbld', 18:26:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:26:53 INFO - 'LOGNAME': 'cltbld', 18:26:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:26:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:53 INFO - 'MOZ_NO_REMOTE': '1', 18:26:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:26:53 INFO - 'NO_EM_RESTART': '1', 18:26:53 INFO - 'PAGER': '/bin/cat', 18:26:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:53 INFO - 'PWD': '/builds/slave/test', 18:26:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:26:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:26:53 INFO - 'SHELL': '/bin/bash', 18:26:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6fnlKsMQDq/Listeners', 18:26:53 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 18:26:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:26:53 INFO - 'USER': 'cltbld', 18:26:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:26:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:53 INFO - 'XPC_FLAGS': '0x0', 18:26:53 INFO - 'XPC_SERVICE_NAME': '0', 18:26:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:26:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:26:53 INFO - mozversion application_buildid: 20160520162531 18:26:53 INFO - mozversion application_changeset: bcc547cc6eec10f7b37ac8e5c2c66b50bd915b45 18:26:53 INFO - mozversion application_display_name: Firefox 18:26:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:26:53 INFO - mozversion application_name: Firefox 18:26:53 INFO - mozversion application_remotingname: firefox 18:26:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:26:53 INFO - mozversion application_vendor: Mozilla 18:26:53 INFO - mozversion application_version: 47.0 18:26:53 INFO - mozversion platform_buildid: 20160520162531 18:26:53 INFO - mozversion platform_changeset: bcc547cc6eec10f7b37ac8e5c2c66b50bd915b45 18:26:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:26:53 INFO - mozversion platform_version: 47.0 18:26:53 INFO - using testdate: 1463794013 18:26:53 INFO - actual date: 1463794013 18:26:53 INFO - starting webserver on 'localhost:49273' 18:26:53 INFO - SUITE-START | Running 2 tests 18:26:53 INFO - TEST-START | dromaeo_css 18:26:53 INFO - operating with platform_type : mac_ 18:26:53 INFO - Initialising browser for dromaeo_css test... 18:26:54 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmpVhUnho/profile http://localhost:49273/getInfo.html) 18:26:56 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 18:26:56 INFO - PROCESS | 1658 | colorDepth:24 18:26:56 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 18:26:56 INFO - PROCESS | 1658 | __metrics 18:26:56 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 18:26:57 INFO - TEST-INFO | 1658: exit 0 18:26:57 INFO - Browser initialized. 18:26:57 INFO - Running cycle 1/1 for dromaeo_css test... 18:26:57 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmpVhUnho/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:27:09 INFO - PROCESS | 1662 | RSS: Main: 167772160 18:27:09 INFO - PROCESS | 1662 | 18:27:58 INFO - PROCESS | 1662 | 1463794078904 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] 18:30:08 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 18:30:09 INFO - PROCESS | 1662 | RSS: Main: 178651136 18:30:09 INFO - PROCESS | 1662 | 18:33:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 18:33:12 INFO - PROCESS | 1662 | RSS: Main: 190095360 18:33:12 INFO - PROCESS | 1662 | 18:36:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 18:36:14 INFO - PROCESS | 1662 | RSS: Main: 192135168 18:36:14 INFO - PROCESS | 1662 | 18:39:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 18:39:16 INFO - PROCESS | 1662 | RSS: Main: 195489792 18:39:16 INFO - PROCESS | 1662 | 18:42:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 18:42:19 INFO - PROCESS | 1662 | RSS: Main: 194711552 18:42:19 INFO - PROCESS | 1662 | 18:45:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 18:45:22 INFO - PROCESS | 1662 | RSS: Main: 200327168 18:45:22 INFO - PROCESS | 1662 | 18:45:22 INFO - PROCESS | 1662 | __start_tp_report 18:45:22 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 18:45:22 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 18:45:22 INFO - PROCESS | 1662 | |i|pagename|runs| 18:45:22 INFO - PROCESS | 1662 | |0;dojo.html;2819.9718002819973;3407.846646900889;3593.802340871251;3636.799976001319;3651.72612054096;4678.953210467895;5829.970850145749;5838.357780644136;5840.517779943523;5843.678597677132;5818;5842.357340692521;5848.766049358021;5855.092460668592;5856.385079566648;5262.763175657095;5275.155975043994;5376.327959005124;5392.245085688007;5395.973020134894;4420.668449866257;5288.603354748409;5357.651752636066;5393.622446428752;5402.621816472849;5330.973345133289;5355.036093503168;5378.757955891974;5391.946080539204;5446.346438427394;4340.43574335336;5383.4616538346245;5404.945950540484;5407.648502847342;5420.430854760233;4511.774411279455;5252.23842542833;5344.786208551692;5355.196720491918;5394.676319420808;5555.111182210827;5732.0255556555485;5781.739821708034;5829.300483941955;5847.561432892508;6216;6233.87532249357;6239.064140378934;6251.156093927307;6260.624362538217;6263.4362907338555;6292.087647291117;6307.621542707452;6338.429541341301;6379.872402551923;4511.842085526991;5987.161797348374;6039.486643635296;6066.969665151646;6119.143319935257;6309.33751956038;6315.084312774714;6349.714262858182;6364.936350636434;6365.522585806083;4937.506249375034;6231.3145553989025;6233.189685340877;6239.876822171962;6248.781292654826;6223.159873417121;6261.24865016201;6341.397567231198;6349.428551430394;6363;6214.937850621526;6232.688365581794;6237.688115594202;6248.031555108965;6276.748930042839;5113.590912726973;6110.133516259585;6262.1546091278005;6274.309825919146;6288.842778930563;4987.501249875056;4989.101961646866;5019.347484826949;5047.596192304607;5094.847154585368;4503.121891231244;4533.52397998212;4565.657575681837;4570.268756998864;4597.655175861757;5989.940100598938;6022.909656355158;6089.604175728564;6136.417040381157;6155.446009859134;6254.499640028786;6336.1762970814425;6377.872442551123;6405.071264666691;6416.647084410402;6134.754609815646;6154.938450615526;6160.784372546939;6183.628982261079;6190.938090619126;5428.321459817523;5444.700541470257;5464.754086066137;5560.193771903051;5594.021046316879;6595.538312318092;6606.405423511907;6643.833904152339;6648.700808463631;6651.102101216371;6374.330695276929;6391.680415979089;6429.099926010269;6450.8064758057335;6465.709043092978;6406.871862562816;6536.379043990813;6586.637734924625;6613.834654133685;6671.266160722414;6269.341719119427;6278.843028924313;6287.2140982377205;6294.622322660655;6298.527610429144;6330.620162790247;6335.619862808247;6347.460465860268;6370.076338930921;6381;5321.441248668834;5467.043267428264;5930.703464826827;6066.241719785027;6164.506839452923;4450.6884518083425;5028.396592408934;6168.568200225941;6194.101855230876;6213.068039794067;5977.551683623658;6133.018717005258;6136.079588061648;6138.754449822136;6167.352427995175;5346.663334166458;5406.83779486616;5515.972420138034;5768.53851691872;6026.487748541423;6129.908051379322;6160.9383906160365;6190.7214175363115;6190.7523699051535;6202.255729312511 18:45:22 INFO - PROCESS | 1662 | |1;ext.html;488.12869028783604;569.4959960435013;593.2495393327441;654.3358491131501;673.5891106425079;42310.78844605776;43326.783366083124;43330.783346083306;43335.78332108339;43412.782936085314;44905.55094449055;45479;45509.63471095872;45531;45783.54216457834;9942.602295908155;10112.949435252813;10136.391816491034;10142.087212150906;10207.132393746504;10036.397816131019;10119.139873110795;10163.237757168205;10177.287589868713;10190.133838623726;10110.595576176944;10179.745506362326;10206.591736330538;10237.232207584424;10257.538410771533;10111.595536178544;10175.389476631426;10193.133583645398;10197.18422526196;10224.642137525225;9849;9942.453165075918;9999.75000624983;10026.749331266778;10147.594096236142;41957.58042419567;42031.73904782861;42372;42508;42564;3507.9824600877087;3564;3669.8715544956067;3973.5827738087664;3997.2205419943125;30159.547606785916;30403;30752;30972;31496.055118346485;2808.5225511663066;2811.7047709990566;2845.601615773793;2854.0581608069288;2877.0505733108025;412625;507961.4601927004;508221;509167;511321;76107;76584;76631.2336876624;76770;76925;70496.64751676311;80704.59647701724;82684;82844.3431131374;82992;18754.81245187558;18840.528986775167;18863.81136188648;19086.33197838069;19147.80852191488;14363.64090897715;14457.132572045712;14475.78286325706;14529.200893950934;14546.636334091732;23510.82445877699;23877.16429924944;23918.402039949142;23966;24512.387190320384;9245.537723113817;9505;9571.330006899589;9573.617055317849;9603.743120366707;990.9653162139291;1027.0345874877592;1027.928045036855;1044.5926088825365;1135.3471753741633;31449.37101257962;31677;31835.363292734015;31903.39721774427;31955.881544145843;1150.292570069418;1153.3598852636699;1187.0562902492538;1200.1359021504502;1207.335965219126;16122.193890305438;16208.51374458768;16214.837851621332;16243.350265989464;16597;478390.6080469575;523138;543162.5683743112;545764;549931;65183.34816651868;65539.34460655332;65760;65764.67117664477;65980;1300.7967629942266;1367.500862185315;1531.2879511027427;1539.491967650695;1576.2434031664636;30032.69967300299;31045.379092417574;31448.84275578699;31746.206344841565;31851.84074079615;57417.71291143518;57633.42366576448;58035.709821450626;58264.12603811031;58287;458188;460666;461963;462327;462394;35479.29041419209;36323.45514817333;36516.26967460689;37268.6273137276;37281.440778387805;33693.66306336905;34591.481127783605;34618.65381346154;34766.13084672904;35171.82414087913;40154.795356139366;40823.79588102041;40833.38749918813;41060;41571.7921410391;38639.03402414962;39753.2049359017;39823.40264895971;39875;40686.79656601698;40573.39139912845;41407.1718565621;42124;42796.572034279256;43092.78453607712;32666.34667306593;34423;34875.65124348724;35179.648203518664;35341.64658353384;25527.14577589164;25558.233253001697;25627.743722562536;25844.741552584233;26084 18:45:22 INFO - PROCESS | 1662 | |2;jquery.html;301.99435878524514;364.54614005563076;379.26233475889387;389.72329645951373;394.11324519830384;20544.589108217828;20935.16259349626;21265.36203913881;22125.336239912787;22595.322140335815;21887.6716849247;22194.223202187928;22208;22591;22797.658035129443;5919.881602367961;5926.674032928187;6229.719662615171;6235.376462353774;6262.185915830958;6048.667323297217;6124.326324104345;6128.20333356663;6135.386461353851;6154.107654390111;5861.3552509223955;6097.359777223394;6129.049997250433;6129.785457508988;6140;5160.819371322004;5374.811881584164;6038;6080.422359875804;6121.143039974407;5208.5572726318305;5226.346706661668;5238.5809135269465;5315.415304316522;5344.171653393731;23129.768702313097;26544.60183097255;27280.863595682094;27897.442051159065;28135.577966330522;2346.2374728213226;2418.8669623170717;2768.8754006069776;2989.088328059941;3003.6996300370006;12444.875551244462;13692.178469291874;15626.218689065501;15652.765208521882;15792.763108553381;1702.3445973300245;1814.5010122216363;1870.4014715291112;1884.8115188481179;1902.3436914264557;102908.48545757298;103830;104484.47757761239;105502.47248763783;105680;11062.78744251153;11195.552177912956;11559.537618495335;11746.119041071954;11761.176717629854;12489.625311240678;14271.001029927806;14361.425542978373;14392.496262630757;14392.992490525772;8856.114388561093;8912.420692654956;8940.821183576292;8994.955025224832;9087.318451116193;9192.58633361487;9306;9357.719268421959;9375.859362109573;9433;4639.605633521121;4642.373279607277;4672.976635116803;4712.293156026623;4725.976370118127;1939.8254157125925;1942.0872190070927;1955.6870900655827;1980.2475059477306;2014.4863059919626;885.6324625280565;943.7451887990204;1038.7091614347994;1070.566420599643;1100.9559617615205;16710.749338759928;20853.061612227488;21446.281818000014;21519.246826361003;21777.455563611038;951.6288647427509;990.346371394876;992.1814503035025;992.3153024413132;1073.8174510333263;8760.036395996436;11036.392998385167;11435.221721626738;11518.769624607628;11548.711282217844;608666;644989;690821;701912;703570;126949;127042.72957270493;128207.65762399459;128642.35678821546;132485;799.3085980626716;1064.5156453813497;1105.5190991918541;1124.983125253122;1125.2067292558727;19246.133923973175;19444.611107778048;19448.930308832583;19464.31874884372;19487.317943871898;52458.47541524536;54062;54541.18188227259;54884.451155487935;55168.172477413675;75334;76804.2319576797;76804.2319576797;77747.61126194333;79291.60354198192;8147.592620369076;8220.547869866976;8377.90462492707;8634.956825216084;8849.380543361904;12243.449044792827;12549.121561490972;12813.718628137485;13497.797533037208;13909.37407816671;10577.894221057999;10956.835647465454;11258.268212566158;11830.645080647595;12040.157188997036;11177.217594768288;11629.360385178896;11770.88229117732;11794.587189448328;12038.75922481563;11879.881201187878;11896;12091.39543022863;12179.39103044862;12184.451699673358;7308.707651693872;8361.623726932425;8487.957560212159;8565;8602.741917742227;10424.905384934473;10839.458027098455;11154.553817847196;11164.54860868082;11810.40947952616 18:45:22 INFO - PROCESS | 1662 | |3;mootools.html;1677.0859881364659;1693.5427434592664;1826.4794633282627;2055.136842526139;2138.5295235048284;8280.296174825133;8939.508327042011;8998.145176208258;9180.770480737985;9233.12285332894;8992.190702836744;9009.864852027225;9020.188183063523;9117.68088116916;9140;2508.749125087486;2529.178017144426;2533.607290869918;2540.657011303469;2550.60465627828;2534.531111744324;2592.572225582786;2605.296569926119;2606.2051074422293;2606.517794208068;2568.704598971114;2584.2247325802277;2595.441979974305;2597;2602.6096085587124;2542.9618555721586;2543.618457231421;2566.8588227647474;2571.832830865988;2582.3544113971507;2197.3847322749657;2550.2221822344177;2577.420080481895;2581.5095131925063;2619.58086706128;9056.954715226448;9170.954145229298;9215.907840921573;9241.49171795551;9249.815003699889;5567.081431563827;5741.45456181662;5774.5091667208335;5795.217645617872;5809.215755872945;3656.762310449839;3758.1919887224103;3793.5827059023486;3796;3800.6959443244473;1078.6170909327234;1090.0462095666292;1097.7145942055042;1137.1357768096307;1138.829175623663;10302.33034852732;12213.511459541607;12249.265044097294;12304;12442.315672638002;4892.779824907888;4937.407511098691;5006.6495345325475;5029.371328583927;5099.97450012755;10593;10635.415052172204;10650.147988160928;10682.145428365868;10782.514786834612;5609;5626.352969408488;5634.6337488063145;5661.924234395452;5673.375928647845;4635.513271106553;5027.773750181251;5153.948460515347;5169.069567477815;5213.452587478336;4108.91782164355;4160.54234034256;4163.479565054368;4175.373693945871;4183.686223533186;1325.7945018522144;1352.114365090867;1355.7053014371252;1362.3664995776812;1365.487942021742;1396.0088337280645;1418.3900922603173;1433.104309806371;1441.1137150652273;1459.3505889878902;8455.323574114056;8569.828603427897;8626.741197764077;8632.007319158378;8732.694355697648;527.8863862434408;536.4635364635365;537.3176066395656;537.7902617978991;546.3662151903773;6269.247690277196;6393.232812062489;6412.935870641327;6427.967860160669;6463.6768161591735;10919.235653504178;11175;11219.831702524469;11225.66323010311;11311.095112391153;10702.197335199891;10913.781724365468;11112.44437778108;11112.499937502831;11163.106951443864;8672.392932494791;8675.132486751274;8754.737357879147;8818.51498167594;8863.778405539784;7984;8025.317847982987;8156.755297341089;8276.544790036365;8294;9581.712548623553;9901.504924753877;9923.40459572428;9998.550065246936;9998.80014398277;9960.55177516999;10276.17790576737;10344.534495947852;10356.482175891024;10420.166386689198;7608.087029556488;7703.845923081395;7821;7873.803154921173;7889.2110788920645;8650.221480066824;8715.215630593277;8746.081661425458;8751.649934002824;8801.603927823135;7625.923740762743;7680.155182929985;7775.377969762519;7787.727429539939;7839.294463498312;6482.643454610042;7454.515456495311;7545;7629.427792915664;7670.348020418327;7232.529885557422;7632.923670763444;8085.514869107872;8089.069756978023;8119.269265766109;5860.443257890493;7295.927040729524;7309.305615966475;7319.74380896666;7345.853082938418;6528.477721782341;7134.108236470442;7382.3724983377015;7425.628718563942;7452.701891924479 18:45:22 INFO - PROCESS | 1662 | |4;prototype.html;264.60045331549355;285.037996760932;312.5015600117812;334.7380375982546;346.62910685566425;6054.910116179091;6601.141851559302;6622.8675426491445;6696.9665151674235;6762.594244345337;6600.702968366423;6805.931940680592;6812.727490900371;6843.931560684392;6919.2042915064785;4823.372961514998;4876.122297986361;4967.900641987158;5076.72078035707;5087.160618497944;4016.678665706751;4910.950890491103;4934.777934992934;4968.552830245278;4998.425181104183;4862.805487780484;4919.188333924898;4935.235038569028;5010.398752149747;5012.223105418666;4991.975040124812;5017.673851199678;5021.096202683516;5025.623078269108;5035.571976382012;4239.872803815891;4248.08666136779;4255.361695745632;4257.382679511485;4264.061906380592;6366.458850997625;6601.966990165019;6649.60102393858;6655.700493477757;6672.2994085621285;5965.582409231312;5974.193483879664;6069.635821850703;6086.117512960596;6109.725062372159;7328;7348.265173482662;7363.595002274873;7388.2242364551485;7393.408527317855;4886.511348865085;4887.804487820483;4895.755212239374;4900.946296546224;4910.238912968495;7676.769696909102;7741.535507869489;7764.661195685853;7771;7775.883361749578;4013.9598604013586;4740.407449068866;4819.108464933998;4864.467692676795;4930.7288099154175;5006.4492905780335;5007.198848184273;5010.749462526859;5015.673981191211;5029.924551131736;4327;5895.115732640053;5898.705064746746;5905.911411328833;5906.468417842415;7080.964595177094;7231.89152162718;7238.276172382825;7240.4569657275915;7261.273872612802;1664.2261348473019;1703.8551723103428;1738.765266689006;1742.6514697060638;1764.4971183212979;941.9576119074658;1127.577158565538;1137.0903277378065;1147.5639257082423;1157.6237722740143;5254.92117618236;6313.747450102036;6326.873462530723;6918.204406493217;6951.721931122698;7524.887126693104;7559.735409260649;7560.773176804704;7562.958001339607;7582.658780354897;6930.272321406281;6933.0293758873795;6947.89578156328;6976.511644184859;6987.755428559976;3767.113073045614;3975.662068724133;3998.7000974926414;4000.2799496090984;4012.4382586437923;6370.4903607712195;6608.537402381883;7911.802204944807;8031.397645176635;8114.43198976066;6340.556161068773;7972.800679983046;7974.641141148662;7988.720394786154;7999.480033797785;8088.555129467818;8091.271785539329;8102.569229231207;8107.310878575269;8123.268905798506;7414.647769321958;7684.769456916301;7696.960910277041;7700.3454706350585;7759.534427934342;7493.400527957641;7540.132884718328;7542.849143017219;7543.358814500829;7563.584002879675;8035.67857285702;8053.436259462016;8059.677612895419;8070.757877263692;8072.9101571289475;5031.522005409626;5041.218611115283;5048.192289233705;5049.141645920276;5057.671251368649;7283.526570772883;7564.470487066073;7591.609956930641;7617.771466856003;7661;7283.635818209174;7339.61462524671;7350.669219885011;7404.407647388303;7431.182569917413;5943.970280148572;5989.940100598938;7278.563286202845;7300.050993370828;7370.815729606803;5928.851778705394;7179.74354487973;7205.315495027964;7235.384992275715;7240.96379518099;6207.472364848858;7057.7176912922905;7315.195328513965;7330.486865919334;7373.963130184529;5811.738471768866;6503.2846386898345;6846.5892046477375;7235.819104522429;7262.3826974707745 18:45:22 INFO - PROCESS | 1662 | |5;yui.html;727.7962170592234;749.1497150733919;749.2582343479957;754.3135746470713;791.6358475101453;15613.921930390346;15815.92092039541;15850.84149158508;15867.285972131252;15891.523254302361;13314.600561983132;13469.326533673326;14655.41378344865;14718.969672122956;14725.705485890276;873.3668090634303;952.314333679753;977.604070351507;979.9755006124868;995.044757033249;896.1441823058996;939.8684184214216;944.7449188719041;980.882294124706;981.131698446876;992.4392718114278;1021.1320377678951;1023.0741179232806;1026.240581969341;1031.5564307347838;996.2229461020415;999.3903718731605;1023.6724248240566;1029.0635521675276;1029.583018877352;767.7044337929938;770.0605261580862;771;774.1639029847751;776.0222120128678;13534.187948723009;13644.93177534116;13791.448342066406;13887.58337249884;13928.651783705387;12396.07029472784;12468.417826548472;12498.25010499373;12516.186447880858;12654.746905061847;11027.1729620278;11044.171687123417;11091.889081109166;11260.436978151141;11318.547258109666;3611.656892595199;3903.882883513499;4100.425940368351;4108.075682971337;4347.826086956518;69664;76954.6152269235;77489;78731.21268787296;79568.20431795724;8091.959540202261;9824.01759824012;9892.851607225897;10019.649312274036;10416.895831041593;18661.066946652612;22597.548049038927;22787.886060569923;22791.430214244447;22848;6796.626185559841;7899.486533375312;8026.959865200637;8045.798855028554;8101.513909165469;4257.10600773841;4287.442632457761;4297.333913243452;4345.521992580813;4357.237483440449;3388.711959483422;3393.6267010628812;3415.9146021349666;3440.9483857742152;3468.8785892493643;626.7179769103922;644.0628884972353;645.8256270806855;683.6513378177166;706.6961206681176;483.76537379371683;559.4768891086846;587.6004317064437;594.7026486756622;660.920689517261;8571.357148213909;8574.657013719381;8600.698975535952;8702.6518939243;8741.956290218508;515.7567643673354;625.8404106952698;628.955973081889;643.3405759096963;657.8684263147294;3992.7005474589523;4025.094353770437;4075.2053349597136;4104.434728294816;4241.27898257297;95981;97542.02457975471;98019.54951126278;98157;98727.50636246773;68927;80375;81001;82816;84713.30573388498;64516;67895.66052169708;69851;69912;71256.287437126;7850.2542258485355;8063.6774529018185;8485.193906578865;8699.13008699125;8790.296776257755;46597.3010404851;47839;48184;48567;48767;69104;69257;69370.65314673394;70252.64873675599;70738.64630676813;10982.0665243452;11421.600243991752;11592.594259200887;11640.825387619361;11678.182527223013;12014.159008869296;12035.518579256732;12190.75618487643;12244.632661020183;12371.876281237073;10372.792544149226;10425.635102771366;10538.631147909786;10833.945830270799;10834.512446940063;11699.940768614293;11735.765284694087;11825.290482571074;11843.58547450835;11935.281774878125;11486.540538378371;11710.72776871796;11741.11941604366;11750.359608387684;11916.463759131033;9991.200703943521;9993.700188994342;10089.142422893843;10328.793424131625;10418.895811042095;9949.253805964727;9969.252306077218;10075.143612792996;10098.747531311483;10124.493775311057 18:45:22 INFO - PROCESS | 1662 | __end_tp_report 18:45:22 INFO - PROCESS | 1662 | __start_cc_report 18:45:22 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,355 18:45:22 INFO - PROCESS | 1662 | __end_cc_report 18:45:22 INFO - PROCESS | 1662 | __startTimestamp1463795122046__endTimestamp 18:45:22 INFO - PROCESS | 1662 | 18:45:22 INFO - PROCESS | 1662 | ------- Summary: start ------- 18:45:22 INFO - PROCESS | 1662 | Number of tests: 6 18:45:22 INFO - PROCESS | 1662 | 18:45:22 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5796.75 Median:6119.14 stddev:702.13 (11.5%) stddev-sans-first:664.31 18:45:22 INFO - PROCESS | 1662 | Values: 2820.0 3407.8 3593.8 3636.8 3651.7 4679.0 5830.0 5838.4 5840.5 5843.7 5818.0 5842.4 5848.8 5855.1 5856.4 5262.8 5275.2 5376.3 5392.2 5396.0 4420.7 5288.6 5357.7 5393.6 5402.6 5331.0 5355.0 5378.8 5391.9 5446.3 4340.4 5383.5 5404.9 5407.6 5420.4 4511.8 5252.2 5344.8 5355.2 5394.7 5555.1 5732.0 5781.7 5829.3 5847.6 6216.0 6233.9 6239.1 6251.2 6260.6 6263.4 6292.1 6307.6 6338.4 6379.9 4511.8 5987.2 6039.5 6067.0 6119.1 6309.3 6315.1 6349.7 6364.9 6365.5 4937.5 6231.3 6233.2 6239.9 6248.8 6223.2 6261.2 6341.4 6349.4 6363.0 6214.9 6232.7 6237.7 6248.0 6276.7 5113.6 6110.1 6262.2 6274.3 6288.8 4987.5 4989.1 5019.3 5047.6 5094.8 4503.1 4533.5 4565.7 4570.3 4597.7 5989.9 6022.9 6089.6 6136.4 6155.4 6254.5 6336.2 6377.9 6405.1 6416.6 6134.8 6154.9 6160.8 6183.6 6190.9 5428.3 5444.7 5464.8 5560.2 5594.0 6595.5 6606.4 6643.8 6648.7 6651.1 6374.3 6391.7 6429.1 6450.8 6465.7 6406.9 6536.4 6586.6 6613.8 6671.3 6269.3 6278.8 6287.2 6294.6 6298.5 6330.6 6335.6 6347.5 6370.1 6381.0 5321.4 5467.0 5930.7 6066.2 6164.5 4450.7 5028.4 6168.6 6194.1 6213.1 5977.6 6133.0 6136.1 6138.8 6167.4 5346.7 5406.8 5516.0 5768.5 6026.5 6129.9 6160.9 6190.7 6190.8 6202.3 18:45:22 INFO - PROCESS | 1662 | 18:45:22 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:66178.42 Median:35410.47 stddev:131175.82 (370.4%) stddev-sans-first:131451.08 18:45:22 INFO - PROCESS | 1662 | Values: 488.1 569.5 593.2 654.3 673.6 42310.8 43326.8 43330.8 43335.8 43412.8 44905.6 45479.0 45509.6 45531.0 45783.5 9942.6 10112.9 10136.4 10142.1 10207.1 10036.4 10119.1 10163.2 10177.3 10190.1 10110.6 10179.7 10206.6 10237.2 10257.5 10111.6 10175.4 10193.1 10197.2 10224.6 9849.0 9942.5 9999.8 10026.7 10147.6 41957.6 42031.7 42372.0 42508.0 42564.0 3508.0 3564.0 3669.9 3973.6 3997.2 30159.5 30403.0 30752.0 30972.0 31496.1 2808.5 2811.7 2845.6 2854.1 2877.1 412625.0 507961.5 508221.0 509167.0 511321.0 76107.0 76584.0 76631.2 76770.0 76925.0 70496.6 80704.6 82684.0 82844.3 82992.0 18754.8 18840.5 18863.8 19086.3 19147.8 14363.6 14457.1 14475.8 14529.2 14546.6 23510.8 23877.2 23918.4 23966.0 24512.4 9245.5 9505.0 9571.3 9573.6 9603.7 991.0 1027.0 1027.9 1044.6 1135.3 31449.4 31677.0 31835.4 31903.4 31955.9 1150.3 1153.4 1187.1 1200.1 1207.3 16122.2 16208.5 16214.8 16243.4 16597.0 478390.6 523138.0 543162.6 545764.0 549931.0 65183.3 65539.3 65760.0 65764.7 65980.0 1300.8 1367.5 1531.3 1539.5 1576.2 30032.7 31045.4 31448.8 31746.2 31851.8 57417.7 57633.4 58035.7 58264.1 58287.0 458188.0 460666.0 461963.0 462327.0 462394.0 35479.3 36323.5 36516.3 37268.6 37281.4 33693.7 34591.5 34618.7 34766.1 35171.8 40154.8 40823.8 40833.4 41060.0 41571.8 38639.0 39753.2 39823.4 39875.0 40686.8 40573.4 41407.2 42124.0 42796.6 43092.8 32666.3 34423.0 34875.7 35179.6 35341.6 25527.1 25558.2 25627.7 25844.7 26084.0 18:45:22 INFO - PROCESS | 1662 | 18:45:22 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:37052.39 Median:22696.49 stddev:111063.13 (489.3%) stddev-sans-first:111340.41 18:45:22 INFO - PROCESS | 1662 | Values: 302.0 364.5 379.3 389.7 394.1 20544.6 20935.2 21265.4 22125.3 22595.3 21887.7 22194.2 22208.0 22591.0 22797.7 5919.9 5926.7 6229.7 6235.4 6262.2 6048.7 6124.3 6128.2 6135.4 6154.1 5861.4 6097.4 6129.0 6129.8 6140.0 5160.8 5374.8 6038.0 6080.4 6121.1 5208.6 5226.3 5238.6 5315.4 5344.2 23129.8 26544.6 27280.9 27897.4 28135.6 2346.2 2418.9 2768.9 2989.1 3003.7 12444.9 13692.2 15626.2 15652.8 15792.8 1702.3 1814.5 1870.4 1884.8 1902.3 102908.5 103830.0 104484.5 105502.5 105680.0 11062.8 11195.6 11559.5 11746.1 11761.2 12489.6 14271.0 14361.4 14392.5 14393.0 8856.1 8912.4 8940.8 8995.0 9087.3 9192.6 9306.0 9357.7 9375.9 9433.0 4639.6 4642.4 4673.0 4712.3 4726.0 1939.8 1942.1 1955.7 1980.2 2014.5 885.6 943.7 1038.7 1070.6 1101.0 16710.7 20853.1 21446.3 21519.2 21777.5 951.6 990.3 992.2 992.3 1073.8 8760.0 11036.4 11435.2 11518.8 11548.7 608666.0 644989.0 690821.0 701912.0 703570.0 126949.0 127042.7 128207.7 128642.4 132485.0 799.3 1064.5 1105.5 1125.0 1125.2 19246.1 19444.6 19448.9 19464.3 19487.3 52458.5 54062.0 54541.2 54884.5 55168.2 75334.0 76804.2 76804.2 77747.6 79291.6 8147.6 8220.5 8377.9 8635.0 8849.4 12243.4 12549.1 12813.7 13497.8 13909.4 10577.9 10956.8 11258.3 11830.6 12040.2 11177.2 11629.4 11770.9 11794.6 12038.8 11879.9 11896.0 12091.4 12179.4 12184.5 7308.7 8361.6 8488.0 8565.0 8602.7 10424.9 10839.5 11154.6 11164.5 11810.4 18:45:22 INFO - PROCESS | 1662 | 18:45:22 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6278.68 Median:536.89 stddev:3310.51 (616.6%) stddev-sans-first:3301.73 18:45:22 INFO - PROCESS | 1662 | Values: 1677.1 1693.5 1826.5 2055.1 2138.5 8280.3 8939.5 8998.1 9180.8 9233.1 8992.2 9009.9 9020.2 9117.7 9140.0 2508.7 2529.2 2533.6 2540.7 2550.6 2534.5 2592.6 2605.3 2606.2 2606.5 2568.7 2584.2 2595.4 2597.0 2602.6 2543.0 2543.6 2566.9 2571.8 2582.4 2197.4 2550.2 2577.4 2581.5 2619.6 9057.0 9171.0 9215.9 9241.5 9249.8 5567.1 5741.5 5774.5 5795.2 5809.2 3656.8 3758.2 3793.6 3796.0 3800.7 1078.6 1090.0 1097.7 1137.1 1138.8 10302.3 12213.5 12249.3 12304.0 12442.3 4892.8 4937.4 5006.6 5029.4 5100.0 10593.0 10635.4 10650.1 10682.1 10782.5 5609.0 5626.4 5634.6 5661.9 5673.4 4635.5 5027.8 5153.9 5169.1 5213.5 4108.9 4160.5 4163.5 4175.4 4183.7 1325.8 1352.1 1355.7 1362.4 1365.5 1396.0 1418.4 1433.1 1441.1 1459.4 8455.3 8569.8 8626.7 8632.0 8732.7 527.9 536.5 537.3 537.8 546.4 6269.2 6393.2 6412.9 6428.0 6463.7 10919.2 11175.0 11219.8 11225.7 11311.1 10702.2 10913.8 11112.4 11112.5 11163.1 8672.4 8675.1 8754.7 8818.5 8863.8 7984.0 8025.3 8156.8 8276.5 8294.0 9581.7 9901.5 9923.4 9998.6 9998.8 9960.6 10276.2 10344.5 10356.5 10420.2 7608.1 7703.8 7821.0 7873.8 7889.2 8650.2 8715.2 8746.1 8751.6 8801.6 7625.9 7680.2 7775.4 7787.7 7839.3 6482.6 7454.5 7545.0 7629.4 7670.3 7232.5 7632.9 8085.5 8089.1 8119.3 5860.4 7295.9 7309.3 7319.7 7345.9 6528.5 7134.1 7382.4 7425.6 7452.7 18:45:22 INFO - PROCESS | 1662 | 18:45:22 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5951.52 Median:6615.70 stddev:1919.60 (29.0%) stddev-sans-first:1876.93 18:45:22 INFO - PROCESS | 1662 | Values: 264.6 285.0 312.5 334.7 346.6 6054.9 6601.1 6622.9 6697.0 6762.6 6600.7 6805.9 6812.7 6843.9 6919.2 4823.4 4876.1 4967.9 5076.7 5087.2 4016.7 4911.0 4934.8 4968.6 4998.4 4862.8 4919.2 4935.2 5010.4 5012.2 4992.0 5017.7 5021.1 5025.6 5035.6 4239.9 4248.1 4255.4 4257.4 4264.1 6366.5 6602.0 6649.6 6655.7 6672.3 5965.6 5974.2 6069.6 6086.1 6109.7 7328.0 7348.3 7363.6 7388.2 7393.4 4886.5 4887.8 4895.8 4900.9 4910.2 7676.8 7741.5 7764.7 7771.0 7775.9 4014.0 4740.4 4819.1 4864.5 4930.7 5006.4 5007.2 5010.7 5015.7 5029.9 4327.0 5895.1 5898.7 5905.9 5906.5 7081.0 7231.9 7238.3 7240.5 7261.3 1664.2 1703.9 1738.8 1742.7 1764.5 942.0 1127.6 1137.1 1147.6 1157.6 5254.9 6313.7 6326.9 6918.2 6951.7 7524.9 7559.7 7560.8 7563.0 7582.7 6930.3 6933.0 6947.9 6976.5 6987.8 3767.1 3975.7 3998.7 4000.3 4012.4 6370.5 6608.5 7911.8 8031.4 8114.4 6340.6 7972.8 7974.6 7988.7 7999.5 8088.6 8091.3 8102.6 8107.3 8123.3 7414.6 7684.8 7697.0 7700.3 7759.5 7493.4 7540.1 7542.8 7543.4 7563.6 8035.7 8053.4 8059.7 8070.8 8072.9 5031.5 5041.2 5048.2 5049.1 5057.7 7283.5 7564.5 7591.6 7617.8 7661.0 7283.6 7339.6 7350.7 7404.4 7431.2 5944.0 5989.9 7278.6 7300.1 7370.8 5928.9 7179.7 7205.3 7235.4 7241.0 6207.5 7057.7 7315.2 7330.5 7374.0 5811.7 6503.3 6846.6 7235.8 7262.4 18:45:22 INFO - PROCESS | 1662 | 18:45:22 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18473.65 Median:47218.15 stddev:25902.41 (54.9%) stddev-sans-first:25940.80 18:45:22 INFO - PROCESS | 1662 | Values: 727.8 749.1 749.3 754.3 791.6 15613.9 15815.9 15850.8 15867.3 15891.5 13314.6 13469.3 14655.4 14719.0 14725.7 873.4 952.3 977.6 980.0 995.0 896.1 939.9 944.7 980.9 981.1 992.4 1021.1 1023.1 1026.2 1031.6 996.2 999.4 1023.7 1029.1 1029.6 767.7 770.1 771.0 774.2 776.0 13534.2 13644.9 13791.4 13887.6 13928.7 12396.1 12468.4 12498.3 12516.2 12654.7 11027.2 11044.2 11091.9 11260.4 11318.5 3611.7 3903.9 4100.4 4108.1 4347.8 69664.0 76954.6 77489.0 78731.2 79568.2 8092.0 9824.0 9892.9 10019.6 10416.9 18661.1 22597.5 22787.9 22791.4 22848.0 6796.6 7899.5 8027.0 8045.8 8101.5 4257.1 4287.4 4297.3 4345.5 4357.2 3388.7 3393.6 3415.9 3440.9 3468.9 626.7 644.1 645.8 683.7 706.7 483.8 559.5 587.6 594.7 660.9 8571.4 8574.7 8600.7 8702.7 8742.0 515.8 625.8 629.0 643.3 657.9 3992.7 4025.1 4075.2 4104.4 4241.3 95981.0 97542.0 98019.5 98157.0 98727.5 68927.0 80375.0 81001.0 82816.0 84713.3 64516.0 67895.7 69851.0 69912.0 71256.3 7850.3 8063.7 8485.2 8699.1 8790.3 46597.3 47839.0 48184.0 48567.0 48767.0 69104.0 69257.0 69370.7 70252.6 70738.6 10982.1 11421.6 11592.6 11640.8 11678.2 12014.2 12035.5 12190.8 12244.6 12371.9 10372.8 10425.6 10538.6 10833.9 10834.5 11699.9 11735.8 11825.3 11843.6 11935.3 11486.5 11710.7 11741.1 11750.4 11916.5 9991.2 9993.7 10089.1 10328.8 10418.9 9949.3 9969.3 10075.1 10098.7 10124.5 18:45:22 INFO - PROCESS | 1662 | -------- Summary: end -------- 18:45:22 INFO - PROCESS | 1662 | 18:45:22 INFO - TEST-INFO | 1662: exit 0 18:45:22 INFO - TEST-OK | dromaeo_css | took 1108546ms 18:45:22 INFO - TEST-START | kraken 18:45:22 INFO - operating with platform_type : mac_ 18:45:22 INFO - Initialising browser for kraken test... 18:45:22 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmpHti85N/profile http://localhost:49273/getInfo.html) 18:45:24 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 18:45:24 INFO - PROCESS | 1675 | colorDepth:24 18:45:24 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 18:45:24 INFO - PROCESS | 1675 | __metrics 18:45:24 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 18:45:25 INFO - TEST-INFO | 1675: exit 0 18:45:25 INFO - Browser initialized. 18:45:25 INFO - Running cycle 1/1 for kraken test... 18:45:25 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmpHti85N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:37 INFO - PROCESS | 1679 | RSS: Main: 168308736 18:45:37 INFO - PROCESS | 1679 | 18:45:40 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 18:45:40 INFO - PROCESS | 1679 | RSS: Main: 179941376 18:45:40 INFO - PROCESS | 1679 | 18:45:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 18:45:44 INFO - PROCESS | 1679 | RSS: Main: 189460480 18:45:44 INFO - PROCESS | 1679 | 18:45:47 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 18:45:47 INFO - PROCESS | 1679 | RSS: Main: 192778240 18:45:47 INFO - PROCESS | 1679 | 18:45:49 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 18:45:50 INFO - PROCESS | 1679 | RSS: Main: 193462272 18:45:50 INFO - PROCESS | 1679 | 18:45:52 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:45:53 INFO - PROCESS | 1679 | RSS: Main: 193458176 18:45:53 INFO - PROCESS | 1679 | 18:45:55 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 18:45:56 INFO - PROCESS | 1679 | RSS: Main: 195514368 18:45:56 INFO - PROCESS | 1679 | 18:45:59 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 18:46:00 INFO - PROCESS | 1679 | RSS: Main: 195264512 18:46:00 INFO - PROCESS | 1679 | 18:46:02 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 18:46:03 INFO - PROCESS | 1679 | RSS: Main: 195235840 18:46:03 INFO - PROCESS | 1679 | 18:46:04 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:46:05 INFO - PROCESS | 1679 | RSS: Main: 194445312 18:46:05 INFO - PROCESS | 1679 | 18:46:07 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:46:08 INFO - PROCESS | 1679 | RSS: Main: 194547712 18:46:08 INFO - PROCESS | 1679 | 18:46:10 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:46:10 INFO - PROCESS | 1679 | RSS: Main: 194748416 18:46:10 INFO - PROCESS | 1679 | 18:46:13 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:46:13 INFO - PROCESS | 1679 | RSS: Main: 194826240 18:46:13 INFO - PROCESS | 1679 | 18:46:16 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:46:16 INFO - PROCESS | 1679 | RSS: Main: 194957312 18:46:16 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 18:46:18 INFO - PROCESS | 1679 | RSS: Main: 196485120 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | __start_tp_report 18:46:18 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 18:46:18 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 18:46:18 INFO - PROCESS | 1679 | |i|pagename|runs| 18:46:18 INFO - PROCESS | 1679 | |0;ai-astar;114;118;165;115;115;129;114;117;115;115 18:46:18 INFO - PROCESS | 1679 | |1;audio-beat-detection;177;123;177;187;111;140;174;154;198;126 18:46:18 INFO - PROCESS | 1679 | |2;audio-dft;171;207;282;259;195;197;194;198;198;193 18:46:18 INFO - PROCESS | 1679 | |3;audio-fft;66;79;94;101;64;74;88;84;131;61 18:46:18 INFO - PROCESS | 1679 | |4;audio-oscillator;86;85;126;76;83;80;116;79;78;117 18:46:18 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;102;128;88;86;89;85;90;88;89;86 18:46:18 INFO - PROCESS | 1679 | |6;imaging-darkroom;95;95;94;95;130;152;95;95;94;95 18:46:18 INFO - PROCESS | 1679 | |7;imaging-desaturate;91;91;89;90;92;88;90;119;77;144 18:46:18 INFO - PROCESS | 1679 | |8;json-parse-financial;56;60;61;59;60;57;60;60;61;56 18:46:18 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;65;65;64;71;67;66;64;66;79;98 18:46:18 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;80;85;81;86;83;82;84;81;89;109 18:46:18 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;118;119;119;116;129;124;113;126;142;121 18:46:18 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;154;132;136;132;138;129;137;134;131;128 18:46:18 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;68;70;68;65;68;66;68;67;68;76 18:46:18 INFO - PROCESS | 1679 | __end_tp_report 18:46:18 INFO - PROCESS | 1679 | __start_cc_report 18:46:18 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,904 18:46:18 INFO - PROCESS | 1679 | __end_cc_report 18:46:18 INFO - PROCESS | 1679 | __startTimestamp1463795178760__endTimestamp 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | ------- Summary: start ------- 18:46:18 INFO - PROCESS | 1679 | Number of tests: 14 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:121.70 Median:116.00 stddev:15.85 (13.7%) stddev-sans-first:16.57 18:46:18 INFO - PROCESS | 1679 | Values: 114.0 118.0 165.0 115.0 115.0 129.0 114.0 117.0 115.0 115.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:156.70 Median:175.50 stddev:30.18 (17.2%) stddev-sans-first:31.11 18:46:18 INFO - PROCESS | 1679 | Values: 177.0 123.0 177.0 187.0 111.0 140.0 174.0 154.0 198.0 126.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:209.40 Median:198.00 stddev:33.89 (17.1%) stddev-sans-first:32.98 18:46:18 INFO - PROCESS | 1679 | Values: 171.0 207.0 282.0 259.0 195.0 197.0 194.0 198.0 198.0 193.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.50 stddev:21.06 (27.5%) stddev-sans-first:21.28 18:46:18 INFO - PROCESS | 1679 | Values: 66.0 79.0 94.0 101.0 64.0 74.0 88.0 84.0 131.0 61.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:79.50 stddev:19.10 (24.0%) stddev-sans-first:20.11 18:46:18 INFO - PROCESS | 1679 | Values: 86.0 85.0 126.0 76.0 83.0 80.0 116.0 79.0 78.0 117.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:88.00 stddev:13.16 (15.0%) stddev-sans-first:13.56 18:46:18 INFO - PROCESS | 1679 | Values: 102.0 128.0 88.0 86.0 89.0 85.0 90.0 88.0 89.0 86.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:104.00 Median:95.00 stddev:20.18 (21.2%) stddev-sans-first:21.14 18:46:18 INFO - PROCESS | 1679 | Values: 95.0 95.0 94.0 95.0 130.0 152.0 95.0 95.0 94.0 95.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:90.00 stddev:19.53 (21.7%) stddev-sans-first:20.59 18:46:18 INFO - PROCESS | 1679 | Values: 91.0 91.0 89.0 90.0 92.0 88.0 90.0 119.0 77.0 144.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:60.00 stddev:1.94 (3.2%) stddev-sans-first:1.73 18:46:18 INFO - PROCESS | 1679 | Values: 56.0 60.0 61.0 59.0 60.0 57.0 60.0 60.0 61.0 56.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:66.50 stddev:10.68 (16.1%) stddev-sans-first:11.14 18:46:18 INFO - PROCESS | 1679 | Values: 65.0 65.0 64.0 71.0 67.0 66.0 64.0 66.0 79.0 98.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:83.50 stddev:8.52 (10.2%) stddev-sans-first:8.76 18:46:18 INFO - PROCESS | 1679 | Values: 80.0 85.0 81.0 86.0 83.0 82.0 84.0 81.0 89.0 109.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:122.50 stddev:8.27 (6.8%) stddev-sans-first:8.60 18:46:18 INFO - PROCESS | 1679 | Values: 118.0 119.0 119.0 116.0 129.0 124.0 113.0 126.0 142.0 121.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.10 Median:135.00 stddev:7.42 (5.5%) stddev-sans-first:3.50 18:46:18 INFO - PROCESS | 1679 | Values: 154.0 132.0 136.0 132.0 138.0 129.0 137.0 134.0 131.0 128.0 18:46:18 INFO - PROCESS | 1679 | 18:46:18 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:2.99 (4.4%) stddev-sans-first:3.17 18:46:18 INFO - PROCESS | 1679 | Values: 68.0 70.0 68.0 65.0 68.0 66.0 68.0 67.0 68.0 76.0 18:46:18 INFO - PROCESS | 1679 | -------- Summary: end -------- 18:46:18 INFO - PROCESS | 1679 | 18:46:19 INFO - TEST-INFO | 1679: exit 0 18:46:19 INFO - TEST-OK | kraken | took 56949ms 18:46:19 INFO - SUITE-END | took 1165s 18:46:19 INFO - Completed test suite (00:19:25) 18:46:19 INFO - javascript benchmark 18:46:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2819.9718002819973, 3407.846646900889, 3593.802340871251, 3636.799976001319, 3651.72612054096, 4678.953210467895, 5829.970850145749, 5838.357780644136, 5840.517779943523, 5843.678597677132, 5818.0, 5842.357340692521, 5848.766049358021, 5855.092460668592, 5856.385079566648, 5262.763175657095, 5275.155975043994, 5376.327959005124, 5392.245085688007, 5395.973020134894, 4420.668449866257, 5288.603354748409, 5357.651752636066, 5393.622446428752, 5402.621816472849, 5330.973345133289, 5355.036093503168, 5378.757955891974, 5391.946080539204, 5446.346438427394, 4340.43574335336, 5383.4616538346245, 5404.945950540484, 5407.648502847342, 5420.430854760233, 4511.774411279455, 5252.23842542833, 5344.786208551692, 5355.196720491918, 5394.676319420808, 5555.111182210827, 5732.0255556555485, 5781.739821708034, 5829.300483941955, 5847.561432892508, 6216.0, 6233.87532249357, 6239.064140378934, 6251.156093927307, 6260.624362538217, 6263.4362907338555, 6292.087647291117, 6307.621542707452, 6338.429541341301, 6379.872402551923, 4511.842085526991, 5987.161797348374, 6039.486643635296, 6066.969665151646, 6119.143319935257, 6309.33751956038, 6315.084312774714, 6349.714262858182, 6364.936350636434, 6365.522585806083, 4937.506249375034, 6231.3145553989025, 6233.189685340877, 6239.876822171962, 6248.781292654826, 6223.159873417121, 6261.24865016201, 6341.397567231198, 6349.428551430394, 6363.0, 6214.937850621526, 6232.688365581794, 6237.688115594202, 6248.031555108965, 6276.748930042839, 5113.590912726973, 6110.133516259585, 6262.1546091278005, 6274.309825919146, 6288.842778930563, 4987.501249875056, 4989.101961646866, 5019.347484826949, 5047.596192304607, 5094.847154585368, 4503.121891231244, 4533.52397998212, 4565.657575681837, 4570.268756998864, 4597.655175861757, 5989.940100598938, 6022.909656355158, 6089.604175728564, 6136.417040381157, 6155.446009859134, 6254.499640028786, 6336.1762970814425, 6377.872442551123, 6405.071264666691, 6416.647084410402, 6134.754609815646, 6154.938450615526, 6160.784372546939, 6183.628982261079, 6190.938090619126, 5428.321459817523, 5444.700541470257, 5464.754086066137, 5560.193771903051, 5594.021046316879, 6595.538312318092, 6606.405423511907, 6643.833904152339, 6648.700808463631, 6651.102101216371, 6374.330695276929, 6391.680415979089, 6429.099926010269, 6450.8064758057335, 6465.709043092978, 6406.871862562816, 6536.379043990813, 6586.637734924625, 6613.834654133685, 6671.266160722414, 6269.341719119427, 6278.843028924313, 6287.2140982377205, 6294.622322660655, 6298.527610429144, 6330.620162790247, 6335.619862808247, 6347.460465860268, 6370.076338930921, 6381.0, 5321.441248668834, 5467.043267428264, 5930.703464826827, 6066.241719785027, 6164.506839452923, 4450.6884518083425, 5028.396592408934, 6168.568200225941, 6194.101855230876, 6213.068039794067, 5977.551683623658, 6133.018717005258, 6136.079588061648, 6138.754449822136, 6167.352427995175, 5346.663334166458, 5406.83779486616, 5515.972420138034, 5768.53851691872, 6026.487748541423, 6129.908051379322, 6160.9383906160365, 6190.7214175363115, 6190.7523699051535, 6202.255729312511], "unit": "score", "name": "dojo.html", "value": 5754.534053096681}, {"lowerIsBetter": false, "replicates": [488.12869028783604, 569.4959960435013, 593.2495393327441, 654.3358491131501, 673.5891106425079, 42310.78844605776, 43326.783366083124, 43330.783346083306, 43335.78332108339, 43412.782936085314, 44905.55094449055, 45479.0, 45509.63471095872, 45531.0, 45783.54216457834, 9942.602295908155, 10112.949435252813, 10136.391816491034, 10142.087212150906, 10207.132393746504, 10036.397816131019, 10119.139873110795, 10163.237757168205, 10177.287589868713, 10190.133838623726, 10110.595576176944, 10179.745506362326, 10206.591736330538, 10237.232207584424, 10257.538410771533, 10111.595536178544, 10175.389476631426, 10193.133583645398, 10197.18422526196, 10224.642137525225, 9849.0, 9942.453165075918, 9999.75000624983, 10026.749331266778, 10147.594096236142, 41957.58042419567, 42031.73904782861, 42372.0, 42508.0, 42564.0, 3507.9824600877087, 3564.0, 3669.8715544956067, 3973.5827738087664, 3997.2205419943125, 30159.547606785916, 30403.0, 30752.0, 30972.0, 31496.055118346485, 2808.5225511663066, 2811.7047709990566, 2845.601615773793, 2854.0581608069288, 2877.0505733108025, 412625.0, 507961.4601927004, 508221.0, 509167.0, 511321.0, 76107.0, 76584.0, 76631.2336876624, 76770.0, 76925.0, 70496.64751676311, 80704.59647701724, 82684.0, 82844.3431131374, 82992.0, 18754.81245187558, 18840.528986775167, 18863.81136188648, 19086.33197838069, 19147.80852191488, 14363.64090897715, 14457.132572045712, 14475.78286325706, 14529.200893950934, 14546.636334091732, 23510.82445877699, 23877.16429924944, 23918.402039949142, 23966.0, 24512.387190320384, 9245.537723113817, 9505.0, 9571.330006899589, 9573.617055317849, 9603.743120366707, 990.9653162139291, 1027.0345874877592, 1027.928045036855, 1044.5926088825365, 1135.3471753741633, 31449.37101257962, 31677.0, 31835.363292734015, 31903.39721774427, 31955.881544145843, 1150.292570069418, 1153.3598852636699, 1187.0562902492538, 1200.1359021504502, 1207.335965219126, 16122.193890305438, 16208.51374458768, 16214.837851621332, 16243.350265989464, 16597.0, 478390.6080469575, 523138.0, 543162.5683743112, 545764.0, 549931.0, 65183.34816651868, 65539.34460655332, 65760.0, 65764.67117664477, 65980.0, 1300.7967629942266, 1367.500862185315, 1531.2879511027427, 1539.491967650695, 1576.2434031664636, 30032.69967300299, 31045.379092417574, 31448.84275578699, 31746.206344841565, 31851.84074079615, 57417.71291143518, 57633.42366576448, 58035.709821450626, 58264.12603811031, 58287.0, 458188.0, 460666.0, 461963.0, 462327.0, 462394.0, 35479.29041419209, 36323.45514817333, 36516.26967460689, 37268.6273137276, 37281.440778387805, 33693.66306336905, 34591.481127783605, 34618.65381346154, 34766.13084672904, 35171.82414087913, 40154.795356139366, 40823.79588102041, 40833.38749918813, 41060.0, 41571.7921410391, 38639.03402414962, 39753.2049359017, 39823.40264895971, 39875.0, 40686.79656601698, 40573.39139912845, 41407.1718565621, 42124.0, 42796.572034279256, 43092.78453607712, 32666.34667306593, 34423.0, 34875.65124348724, 35179.648203518664, 35341.64658353384, 25527.14577589164, 25558.233253001697, 25627.743722562536, 25844.741552584233, 26084.0], "unit": "score", "name": "ext.html", "value": 21302.836440318162}, {"lowerIsBetter": false, "replicates": [301.99435878524514, 364.54614005563076, 379.26233475889387, 389.72329645951373, 394.11324519830384, 20544.589108217828, 20935.16259349626, 21265.36203913881, 22125.336239912787, 22595.322140335815, 21887.6716849247, 22194.223202187928, 22208.0, 22591.0, 22797.658035129443, 5919.881602367961, 5926.674032928187, 6229.719662615171, 6235.376462353774, 6262.185915830958, 6048.667323297217, 6124.326324104345, 6128.20333356663, 6135.386461353851, 6154.107654390111, 5861.3552509223955, 6097.359777223394, 6129.049997250433, 6129.785457508988, 6140.0, 5160.819371322004, 5374.811881584164, 6038.0, 6080.422359875804, 6121.143039974407, 5208.5572726318305, 5226.346706661668, 5238.5809135269465, 5315.415304316522, 5344.171653393731, 23129.768702313097, 26544.60183097255, 27280.863595682094, 27897.442051159065, 28135.577966330522, 2346.2374728213226, 2418.8669623170717, 2768.8754006069776, 2989.088328059941, 3003.6996300370006, 12444.875551244462, 13692.178469291874, 15626.218689065501, 15652.765208521882, 15792.763108553381, 1702.3445973300245, 1814.5010122216363, 1870.4014715291112, 1884.8115188481179, 1902.3436914264557, 102908.48545757298, 103830.0, 104484.47757761239, 105502.47248763783, 105680.0, 11062.78744251153, 11195.552177912956, 11559.537618495335, 11746.119041071954, 11761.176717629854, 12489.625311240678, 14271.001029927806, 14361.425542978373, 14392.496262630757, 14392.992490525772, 8856.114388561093, 8912.420692654956, 8940.821183576292, 8994.955025224832, 9087.318451116193, 9192.58633361487, 9306.0, 9357.719268421959, 9375.859362109573, 9433.0, 4639.605633521121, 4642.373279607277, 4672.976635116803, 4712.293156026623, 4725.976370118127, 1939.8254157125925, 1942.0872190070927, 1955.6870900655827, 1980.2475059477306, 2014.4863059919626, 885.6324625280565, 943.7451887990204, 1038.7091614347994, 1070.566420599643, 1100.9559617615205, 16710.749338759928, 20853.061612227488, 21446.281818000014, 21519.246826361003, 21777.455563611038, 951.6288647427509, 990.346371394876, 992.1814503035025, 992.3153024413132, 1073.8174510333263, 8760.036395996436, 11036.392998385167, 11435.221721626738, 11518.769624607628, 11548.711282217844, 608666.0, 644989.0, 690821.0, 701912.0, 703570.0, 126949.0, 127042.72957270493, 128207.65762399459, 128642.35678821546, 132485.0, 799.3085980626716, 1064.5156453813497, 1105.5190991918541, 1124.983125253122, 1125.2067292558727, 19246.133923973175, 19444.611107778048, 19448.930308832583, 19464.31874884372, 19487.317943871898, 52458.47541524536, 54062.0, 54541.18188227259, 54884.451155487935, 55168.172477413675, 75334.0, 76804.2319576797, 76804.2319576797, 77747.61126194333, 79291.60354198192, 8147.592620369076, 8220.547869866976, 8377.90462492707, 8634.956825216084, 8849.380543361904, 12243.449044792827, 12549.121561490972, 12813.718628137485, 13497.797533037208, 13909.37407816671, 10577.894221057999, 10956.835647465454, 11258.268212566158, 11830.645080647595, 12040.157188997036, 11177.217594768288, 11629.360385178896, 11770.88229117732, 11794.587189448328, 12038.75922481563, 11879.881201187878, 11896.0, 12091.39543022863, 12179.39103044862, 12184.451699673358, 7308.707651693872, 8361.623726932425, 8487.957560212159, 8565.0, 8602.741917742227, 10424.905384934473, 10839.458027098455, 11154.553817847196, 11164.54860868082, 11810.40947952616], "unit": "score", "name": "jquery.html", "value": 9936.888921382299}, {"lowerIsBetter": false, "replicates": [1677.0859881364659, 1693.5427434592664, 1826.4794633282627, 2055.136842526139, 2138.5295235048284, 8280.296174825133, 8939.508327042011, 8998.145176208258, 9180.770480737985, 9233.12285332894, 8992.190702836744, 9009.864852027225, 9020.188183063523, 9117.68088116916, 9140.0, 2508.749125087486, 2529.178017144426, 2533.607290869918, 2540.657011303469, 2550.60465627828, 2534.531111744324, 2592.572225582786, 2605.296569926119, 2606.2051074422293, 2606.517794208068, 2568.704598971114, 2584.2247325802277, 2595.441979974305, 2597.0, 2602.6096085587124, 2542.9618555721586, 2543.618457231421, 2566.8588227647474, 2571.832830865988, 2582.3544113971507, 2197.3847322749657, 2550.2221822344177, 2577.420080481895, 2581.5095131925063, 2619.58086706128, 9056.954715226448, 9170.954145229298, 9215.907840921573, 9241.49171795551, 9249.815003699889, 5567.081431563827, 5741.45456181662, 5774.5091667208335, 5795.217645617872, 5809.215755872945, 3656.762310449839, 3758.1919887224103, 3793.5827059023486, 3796.0, 3800.6959443244473, 1078.6170909327234, 1090.0462095666292, 1097.7145942055042, 1137.1357768096307, 1138.829175623663, 10302.33034852732, 12213.511459541607, 12249.265044097294, 12304.0, 12442.315672638002, 4892.779824907888, 4937.407511098691, 5006.6495345325475, 5029.371328583927, 5099.97450012755, 10593.0, 10635.415052172204, 10650.147988160928, 10682.145428365868, 10782.514786834612, 5609.0, 5626.352969408488, 5634.6337488063145, 5661.924234395452, 5673.375928647845, 4635.513271106553, 5027.773750181251, 5153.948460515347, 5169.069567477815, 5213.452587478336, 4108.91782164355, 4160.54234034256, 4163.479565054368, 4175.373693945871, 4183.686223533186, 1325.7945018522144, 1352.114365090867, 1355.7053014371252, 1362.3664995776812, 1365.487942021742, 1396.0088337280645, 1418.3900922603173, 1433.104309806371, 1441.1137150652273, 1459.3505889878902, 8455.323574114056, 8569.828603427897, 8626.741197764077, 8632.007319158378, 8732.694355697648, 527.8863862434408, 536.4635364635365, 537.3176066395656, 537.7902617978991, 546.3662151903773, 6269.247690277196, 6393.232812062489, 6412.935870641327, 6427.967860160669, 6463.6768161591735, 10919.235653504178, 11175.0, 11219.831702524469, 11225.66323010311, 11311.095112391153, 10702.197335199891, 10913.781724365468, 11112.44437778108, 11112.499937502831, 11163.106951443864, 8672.392932494791, 8675.132486751274, 8754.737357879147, 8818.51498167594, 8863.778405539784, 7984.0, 8025.317847982987, 8156.755297341089, 8276.544790036365, 8294.0, 9581.712548623553, 9901.504924753877, 9923.40459572428, 9998.550065246936, 9998.80014398277, 9960.55177516999, 10276.17790576737, 10344.534495947852, 10356.482175891024, 10420.166386689198, 7608.087029556488, 7703.845923081395, 7821.0, 7873.803154921173, 7889.2110788920645, 8650.221480066824, 8715.215630593277, 8746.081661425458, 8751.649934002824, 8801.603927823135, 7625.923740762743, 7680.155182929985, 7775.377969762519, 7787.727429539939, 7839.294463498312, 6482.643454610042, 7454.515456495311, 7545.0, 7629.427792915664, 7670.348020418327, 7232.529885557422, 7632.923670763444, 8085.514869107872, 8089.069756978023, 8119.269265766109, 5860.443257890493, 7295.927040729524, 7309.305615966475, 7319.74380896666, 7345.853082938418, 6528.477721782341, 7134.108236470442, 7382.3724983377015, 7425.628718563942, 7452.701891924479], "unit": "score", "name": "mootools.html", "value": 5052.879341115646}, {"lowerIsBetter": false, "replicates": [264.60045331549355, 285.037996760932, 312.5015600117812, 334.7380375982546, 346.62910685566425, 6054.910116179091, 6601.141851559302, 6622.8675426491445, 6696.9665151674235, 6762.594244345337, 6600.702968366423, 6805.931940680592, 6812.727490900371, 6843.931560684392, 6919.2042915064785, 4823.372961514998, 4876.122297986361, 4967.900641987158, 5076.72078035707, 5087.160618497944, 4016.678665706751, 4910.950890491103, 4934.777934992934, 4968.552830245278, 4998.425181104183, 4862.805487780484, 4919.188333924898, 4935.235038569028, 5010.398752149747, 5012.223105418666, 4991.975040124812, 5017.673851199678, 5021.096202683516, 5025.623078269108, 5035.571976382012, 4239.872803815891, 4248.08666136779, 4255.361695745632, 4257.382679511485, 4264.061906380592, 6366.458850997625, 6601.966990165019, 6649.60102393858, 6655.700493477757, 6672.2994085621285, 5965.582409231312, 5974.193483879664, 6069.635821850703, 6086.117512960596, 6109.725062372159, 7328.0, 7348.265173482662, 7363.595002274873, 7388.2242364551485, 7393.408527317855, 4886.511348865085, 4887.804487820483, 4895.755212239374, 4900.946296546224, 4910.238912968495, 7676.769696909102, 7741.535507869489, 7764.661195685853, 7771.0, 7775.883361749578, 4013.9598604013586, 4740.407449068866, 4819.108464933998, 4864.467692676795, 4930.7288099154175, 5006.4492905780335, 5007.198848184273, 5010.749462526859, 5015.673981191211, 5029.924551131736, 4327.0, 5895.115732640053, 5898.705064746746, 5905.911411328833, 5906.468417842415, 7080.964595177094, 7231.89152162718, 7238.276172382825, 7240.4569657275915, 7261.273872612802, 1664.2261348473019, 1703.8551723103428, 1738.765266689006, 1742.6514697060638, 1764.4971183212979, 941.9576119074658, 1127.577158565538, 1137.0903277378065, 1147.5639257082423, 1157.6237722740143, 5254.92117618236, 6313.747450102036, 6326.873462530723, 6918.204406493217, 6951.721931122698, 7524.887126693104, 7559.735409260649, 7560.773176804704, 7562.958001339607, 7582.658780354897, 6930.272321406281, 6933.0293758873795, 6947.89578156328, 6976.511644184859, 6987.755428559976, 3767.113073045614, 3975.662068724133, 3998.7000974926414, 4000.2799496090984, 4012.4382586437923, 6370.4903607712195, 6608.537402381883, 7911.802204944807, 8031.397645176635, 8114.43198976066, 6340.556161068773, 7972.800679983046, 7974.641141148662, 7988.720394786154, 7999.480033797785, 8088.555129467818, 8091.271785539329, 8102.569229231207, 8107.310878575269, 8123.268905798506, 7414.647769321958, 7684.769456916301, 7696.960910277041, 7700.3454706350585, 7759.534427934342, 7493.400527957641, 7540.132884718328, 7542.849143017219, 7543.358814500829, 7563.584002879675, 8035.67857285702, 8053.436259462016, 8059.677612895419, 8070.757877263692, 8072.9101571289475, 5031.522005409626, 5041.218611115283, 5048.192289233705, 5049.141645920276, 5057.671251368649, 7283.526570772883, 7564.470487066073, 7591.609956930641, 7617.771466856003, 7661.0, 7283.635818209174, 7339.61462524671, 7350.669219885011, 7404.407647388303, 7431.182569917413, 5943.970280148572, 5989.940100598938, 7278.563286202845, 7300.050993370828, 7370.815729606803, 5928.851778705394, 7179.74354487973, 7205.315495027964, 7235.384992275715, 7240.96379518099, 6207.472364848858, 7057.7176912922905, 7315.195328513965, 7330.486865919334, 7373.963130184529, 5811.738471768866, 6503.2846386898345, 6846.5892046477375, 7235.819104522429, 7262.3826974707745], "unit": "score", "name": "prototype.html", "value": 5303.515824803438}, {"lowerIsBetter": false, "replicates": [727.7962170592234, 749.1497150733919, 749.2582343479957, 754.3135746470713, 791.6358475101453, 15613.921930390346, 15815.92092039541, 15850.84149158508, 15867.285972131252, 15891.523254302361, 13314.600561983132, 13469.326533673326, 14655.41378344865, 14718.969672122956, 14725.705485890276, 873.3668090634303, 952.314333679753, 977.604070351507, 979.9755006124868, 995.044757033249, 896.1441823058996, 939.8684184214216, 944.7449188719041, 980.882294124706, 981.131698446876, 992.4392718114278, 1021.1320377678951, 1023.0741179232806, 1026.240581969341, 1031.5564307347838, 996.2229461020415, 999.3903718731605, 1023.6724248240566, 1029.0635521675276, 1029.583018877352, 767.7044337929938, 770.0605261580862, 771.0, 774.1639029847751, 776.0222120128678, 13534.187948723009, 13644.93177534116, 13791.448342066406, 13887.58337249884, 13928.651783705387, 12396.07029472784, 12468.417826548472, 12498.25010499373, 12516.186447880858, 12654.746905061847, 11027.1729620278, 11044.171687123417, 11091.889081109166, 11260.436978151141, 11318.547258109666, 3611.656892595199, 3903.882883513499, 4100.425940368351, 4108.075682971337, 4347.826086956518, 69664.0, 76954.6152269235, 77489.0, 78731.21268787296, 79568.20431795724, 8091.959540202261, 9824.01759824012, 9892.851607225897, 10019.649312274036, 10416.895831041593, 18661.066946652612, 22597.548049038927, 22787.886060569923, 22791.430214244447, 22848.0, 6796.626185559841, 7899.486533375312, 8026.959865200637, 8045.798855028554, 8101.513909165469, 4257.10600773841, 4287.442632457761, 4297.333913243452, 4345.521992580813, 4357.237483440449, 3388.711959483422, 3393.6267010628812, 3415.9146021349666, 3440.9483857742152, 3468.8785892493643, 626.7179769103922, 644.0628884972353, 645.8256270806855, 683.6513378177166, 706.6961206681176, 483.76537379371683, 559.4768891086846, 587.6004317064437, 594.7026486756622, 660.920689517261, 8571.357148213909, 8574.657013719381, 8600.698975535952, 8702.6518939243, 8741.956290218508, 515.7567643673354, 625.8404106952698, 628.955973081889, 643.3405759096963, 657.8684263147294, 3992.7005474589523, 4025.094353770437, 4075.2053349597136, 4104.434728294816, 4241.27898257297, 95981.0, 97542.02457975471, 98019.54951126278, 98157.0, 98727.50636246773, 68927.0, 80375.0, 81001.0, 82816.0, 84713.30573388498, 64516.0, 67895.66052169708, 69851.0, 69912.0, 71256.287437126, 7850.2542258485355, 8063.6774529018185, 8485.193906578865, 8699.13008699125, 8790.296776257755, 46597.3010404851, 47839.0, 48184.0, 48567.0, 48767.0, 69104.0, 69257.0, 69370.65314673394, 70252.64873675599, 70738.64630676813, 10982.0665243452, 11421.600243991752, 11592.594259200887, 11640.825387619361, 11678.182527223013, 12014.159008869296, 12035.518579256732, 12190.75618487643, 12244.632661020183, 12371.876281237073, 10372.792544149226, 10425.635102771366, 10538.631147909786, 10833.945830270799, 10834.512446940063, 11699.940768614293, 11735.765284694087, 11825.290482571074, 11843.58547450835, 11935.281774878125, 11486.540538378371, 11710.72776871796, 11741.11941604366, 11750.359608387684, 11916.463759131033, 9991.200703943521, 9993.700188994342, 10089.142422893843, 10328.793424131625, 10418.895811042095, 9949.253805964727, 9969.252306077218, 10075.143612792996, 10098.747531311483, 10124.493775311057], "unit": "score", "name": "yui.html", "value": 7106.777921142423}], "name": "dromaeo_css", "value": 7838.8365612933385}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 118.0, 165.0, 115.0, 115.0, 129.0, 114.0, 117.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 121.7}, {"lowerIsBetter": true, "replicates": [177.0, 123.0, 177.0, 187.0, 111.0, 140.0, 174.0, 154.0, 198.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 156.7}, {"lowerIsBetter": true, "replicates": [171.0, 207.0, 282.0, 259.0, 195.0, 197.0, 194.0, 198.0, 198.0, 193.0], "unit": "score", "name": "audio-dft", "value": 209.4}, {"lowerIsBetter": true, "replicates": [66.0, 79.0, 94.0, 101.0, 64.0, 74.0, 88.0, 84.0, 131.0, 61.0], "unit": "score", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 126.0, 76.0, 83.0, 80.0, 116.0, 79.0, 78.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 92.6}, {"lowerIsBetter": true, "replicates": [102.0, 128.0, 88.0, 86.0, 89.0, 85.0, 90.0, 88.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 94.0, 95.0, 130.0, 152.0, 95.0, 95.0, 94.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 104.0}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 89.0, 90.0, 92.0, 88.0, 90.0, 119.0, 77.0, 144.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [56.0, 60.0, 61.0, 59.0, 60.0, 57.0, 60.0, 60.0, 61.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 71.0, 67.0, 66.0, 64.0, 66.0, 79.0, 98.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.5}, {"lowerIsBetter": true, "replicates": [80.0, 85.0, 81.0, 86.0, 83.0, 82.0, 84.0, 81.0, 89.0, 109.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 119.0, 116.0, 129.0, 124.0, 113.0, 126.0, 142.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [154.0, 132.0, 136.0, 132.0, 138.0, 129.0, 137.0, 134.0, 131.0, 128.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.1}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 65.0, 68.0, 66.0, 68.0, 67.0, 68.0, 76.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1500.5000000000002}]} 18:46:19 INFO - Return code: 0 18:46:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:46:20 ERROR - # TBPL SUCCESS # 18:46:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:46:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:46:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:46:20 INFO - 2016-05-20 18:46:20.059 screenresolution[1684:10514] starting screenresolution argv=screenresolution get 18:46:20 INFO - 2016-05-20 18:46:20.062 screenresolution[1684:10514] Display 0: 1600x1200x32@60 18:46:20 INFO - 2016-05-20 18:46:20.068 screenresolution[1685:10517] starting screenresolution argv=screenresolution list 18:46:20 INFO - Available Modes on Display 0 18:46:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:46:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:46:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:46:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:46:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:46:20 INFO - Intel Iris: 18:46:20 INFO - Chipset Model: Intel Iris 18:46:20 INFO - Type: GPU 18:46:20 INFO - Bus: Built-In 18:46:20 INFO - VRAM (Dynamic, Max): 1536 MB 18:46:20 INFO - Vendor: Intel (0x8086) 18:46:20 INFO - Device ID: 0x0a2e 18:46:20 INFO - Revision ID: 0x0009 18:46:20 INFO - Displays: 18:46:20 INFO - Display: 18:46:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:46:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:46:20 INFO - Display Serial Number: 1600x1200 60 18:46:20 INFO - Main Display: Yes 18:46:20 INFO - Mirror: Off 18:46:20 INFO - Online: Yes 18:46:20 INFO - Rotation: Supported 18:46:20 INFO - Return code: 0 18:46:20 INFO - Running post-action listener: _resource_record_post_action 18:46:20 INFO - Running post-run listener: _resource_record_post_run 18:46:21 INFO - Total resource usage - Wall time: 1190s; CPU: 53.0%; Read bytes: 38192640; Write bytes: 511203328; Read time: 442; Write time: 1802 18:46:21 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 197100032; Write bytes: 198277120; Read time: 18065; Write time: 381 18:46:21 INFO - run-tests - Wall time: 1168s; CPU: 53.0%; Read bytes: 37221888; Write bytes: 302968832; Read time: 419; Write time: 1381 18:46:21 INFO - Running post-run listener: _upload_blobber_files 18:46:21 INFO - Blob upload gear active. 18:46:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:46: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 18:46: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'] 18:46: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 18:46:21 INFO - (blobuploader) - INFO - Open directory for files ... 18:46:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:46:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:46:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:22 INFO - (blobuploader) - INFO - Done attempting. 18:46:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:46:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:46:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:23 INFO - (blobuploader) - INFO - Done attempting. 18:46:23 INFO - (blobuploader) - INFO - Iteration through files over. 18:46:23 INFO - Return code: 0 18:46:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:46:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:46:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e8cfafc04e2f322ca049d323dc5c782fedc66ec148d7c0024d133910f8d11c95a66f76c8c9999c14f5c8fa8b1130f4110dcaee1be593262552aa8b2de186bc97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a36b1108433f41cfcce5bae9a9e13d67b2498f7721cda1b48a0e88a01734dc28df4f3f61326bcb3d05551aa598bc68e6c445cb31145e5302b568914ddf803580"} 18:46:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:46:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:46:23 INFO - Contents: 18:46:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e8cfafc04e2f322ca049d323dc5c782fedc66ec148d7c0024d133910f8d11c95a66f76c8c9999c14f5c8fa8b1130f4110dcaee1be593262552aa8b2de186bc97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a36b1108433f41cfcce5bae9a9e13d67b2498f7721cda1b48a0e88a01734dc28df4f3f61326bcb3d05551aa598bc68e6c445cb31145e5302b568914ddf803580"} 18:46:23 INFO - Running post-run listener: copy_logs_to_upload_dir 18:46:23 INFO - Copying logs to upload dir... 18:46:23 INFO - mkdir: /builds/slave/test/build/upload/logs 18:46:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.584001 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-20 18:46:23.687850) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 18:46:23.691758) ========= 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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e8cfafc04e2f322ca049d323dc5c782fedc66ec148d7c0024d133910f8d11c95a66f76c8c9999c14f5c8fa8b1130f4110dcaee1be593262552aa8b2de186bc97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a36b1108433f41cfcce5bae9a9e13d67b2498f7721cda1b48a0e88a01734dc28df4f3f61326bcb3d05551aa598bc68e6c445cb31145e5302b568914ddf803580"} build_url:https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011097 build_url: 'https://queue.taskcluster.net/v1/task/AjT65HXcS2mXLSLQeOx63g/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e8cfafc04e2f322ca049d323dc5c782fedc66ec148d7c0024d133910f8d11c95a66f76c8c9999c14f5c8fa8b1130f4110dcaee1be593262552aa8b2de186bc97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a36b1108433f41cfcce5bae9a9e13d67b2498f7721cda1b48a0e88a01734dc28df4f3f61326bcb3d05551aa598bc68e6c445cb31145e5302b568914ddf803580"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 18:46:23.721245) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 18:46:23.721665) ========= 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.O0OwHdmKdG/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.6fnlKsMQDq/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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.005181 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 18:46:23.770560) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 18:46:23.770917) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 18:46:23.771323) ========= ========= Total master_lag: 0.17 =========