builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0235 starttime: 1467102030.23 results: success (0) buildid: 20160627053125 builduid: 91d531b5383642ed8679b7f776c5ef70 revision: 8664ad5c52883cb66cb9b46879eb062fb6600756 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:20:30.232854) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:20:30.233370) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:20:30.233675) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:20:30.258193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:20:30.258567) ========= 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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-28 01:20:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.34M=0.001s 2016-06-28 01:20:30 (8.34 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125059 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:20:30.406154) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:20:30.406467) ========= 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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.021101 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:20:30.455817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 01:20:30.456230) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8664ad5c52883cb66cb9b46879eb062fb6600756 --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 8664ad5c52883cb66cb9b46879eb062fb6600756 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V3PI2HQ8a8/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.QHjcEZUU56/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-28 01:20:30,534 truncating revision to first 12 chars 2016-06-28 01:20:30,534 Setting DEBUG logging. 2016-06-28 01:20:30,534 attempt 1/10 2016-06-28 01:20:30,535 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8664ad5c5288?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 01:20:31,513 unpacking tar archive at: mozilla-beta-8664ad5c5288/testing/mozharness/ program finished with exit code 0 elapsedTime=1.253351 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 01:20:31.731710) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:20:31.732081) ========= script_repo_revision: 8664ad5c52883cb66cb9b46879eb062fb6600756 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:20:31.732506) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:20:31.732802) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:20:31.751696) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 10 secs) (at 2016-06-28 01:20:31.752105) ========= /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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 01:20:31 INFO - MultiFileLogger online at 20160628 01:20:31 in /builds/slave/test 01:20:31 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 01:20:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:20:31 INFO - {'append_to_log': False, 01:20:31 INFO - 'base_work_dir': '/builds/slave/test', 01:20:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:20:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:20:31 INFO - 'branch': 'Mozilla-Beta', 01:20:31 INFO - 'buildbot_json_path': 'buildprops.json', 01:20:31 INFO - 'config_files': ('talos/mac_config.py',), 01:20:31 INFO - 'default_actions': ('clobber', 01:20:31 INFO - 'read-buildbot-config', 01:20:31 INFO - 'download-and-extract', 01:20:31 INFO - 'populate-webroot', 01:20:31 INFO - 'create-virtualenv', 01:20:31 INFO - 'install', 01:20:31 INFO - 'run-tests'), 01:20:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:20:31 INFO - 'download_minidump_stackwalk': True, 01:20:31 INFO - 'download_symbols': 'ondemand', 01:20:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:20:31 INFO - 'tooltool.py': '/tools/tooltool.py', 01:20:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:20:31 INFO - '/tools/misc-python/virtualenv.py')}, 01:20:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:20:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:20:31 INFO - 'installer_path': 'installer.exe', 01:20:31 INFO - 'log_level': 'info', 01:20:31 INFO - 'log_name': 'talos', 01:20:31 INFO - 'log_to_console': True, 01:20:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:20:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:20:31 INFO - 'opt_config_files': (), 01:20:31 INFO - 'pip_index': False, 01:20:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:20:31 INFO - 'cmd': ('bash', 01:20:31 INFO - '-c', 01:20:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:20:31 INFO - 'enabled': True, 01:20:31 INFO - 'halt_on_failure': False, 01:20:31 INFO - 'name': 'check_screen_resolution'},), 01:20:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:20:31 INFO - 'cmd': ('bash', 01:20:31 INFO - '-c', 01:20:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:20:31 INFO - 'enabled': True, 01:20:31 INFO - 'halt_on_failure': False, 01:20:31 INFO - 'name': 'check_screen_resolution'},), 01:20:31 INFO - 'run_cmd_checks_enabled': True, 01:20:31 INFO - 'sps_profile': False, 01:20:31 INFO - 'sps_profile_interval': 0, 01:20:31 INFO - 'suite': 'dromaeojs-e10s', 01:20:31 INFO - 'system_bits': '32', 01:20:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:20:31 INFO - 'title': 't-yosemite-r7-0235', 01:20:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:20:31 INFO - 'use_talos_json': True, 01:20:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:20:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:20:31 INFO - 'work_dir': 'build'} 01:20:31 INFO - ##### 01:20:31 INFO - ##### Running clobber step. 01:20:31 INFO - ##### 01:20:31 INFO - Running pre-action listener: _resource_record_pre_action 01:20:31 INFO - Running main action method: clobber 01:20:31 INFO - rmtree: /builds/slave/test/build 01:20:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:20:33 INFO - Running post-action listener: _resource_record_post_action 01:20:33 INFO - ##### 01:20:33 INFO - ##### Running read-buildbot-config step. 01:20:33 INFO - ##### 01:20:33 INFO - Running pre-action listener: _resource_record_pre_action 01:20:33 INFO - Running main action method: read_buildbot_config 01:20:33 INFO - Using buildbot properties: 01:20:33 INFO - { 01:20:33 INFO - "project": "", 01:20:33 INFO - "product": "firefox", 01:20:33 INFO - "script_repo_revision": "production", 01:20:33 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 01:20:33 INFO - "repository": "", 01:20:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 01:20:33 INFO - "buildid": "20160627053125", 01:20:33 INFO - "pgo_build": "False", 01:20:33 INFO - "basedir": "/builds/slave/test", 01:20:33 INFO - "buildnumber": 41, 01:20:33 INFO - "slavename": "t-yosemite-r7-0235", 01:20:33 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:20:33 INFO - "platform": "yosemite_r7", 01:20:33 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:20:33 INFO - "branch": "mozilla-beta", 01:20:33 INFO - "repo_path": "releases/mozilla-beta", 01:20:33 INFO - "revision": "8664ad5c52883cb66cb9b46879eb062fb6600756", 01:20:33 INFO - "stage_platform": "macosx64", 01:20:33 INFO - "builduid": "91d531b5383642ed8679b7f776c5ef70", 01:20:33 INFO - "slavebuilddir": "test" 01:20:33 INFO - } 01:20:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 01:20:33 INFO - Running post-action listener: _resource_record_post_action 01:20:33 INFO - ##### 01:20:33 INFO - ##### Running download-and-extract step. 01:20:33 INFO - ##### 01:20:33 INFO - Running pre-action listener: _resource_record_pre_action 01:20:33 INFO - Running main action method: download_and_extract 01:20:33 INFO - mkdir: /builds/slave/test/build/tests 01:20:33 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')]} 01:20:33 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:20:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:20:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:20:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:20:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 01:20:34 INFO - Downloaded 1165 bytes. 01:20:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:20:34 INFO - Using the following test package requirements: 01:20:34 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:20:34 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:20:34 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 01:20:34 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:20:34 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 01:20:34 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:20:34 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:20:34 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 01:20:34 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:20:34 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:20:34 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 01:20:34 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:20:34 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 01:20:34 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:20:34 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 01:20:34 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:20:34 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 01:20:34 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 01:20:34 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')]} 01:20:34 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:20:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:20:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:20:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:20:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:20:37 INFO - Downloaded 18344127 bytes. 01:20:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:20:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:20:40 INFO - Return code: 0 01:20:40 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 01:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:40 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:20:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:20:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:20:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:20:42 INFO - Downloaded 18344127 bytes. 01:20:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:20:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:20:45 INFO - Return code: 0 01:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:45 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:20:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:20:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:20:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 01:20:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 01:20:47 INFO - Downloaded 10840145 bytes. 01:20:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:20:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:20:47 INFO - Return code: 0 01:20:47 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')]} 01:20:47 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 01:20:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:20:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:20:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 01:20:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 01:20:55 INFO - Downloaded 86228614 bytes. 01:20:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:20:55 INFO - mkdir: /builds/slave/test/properties 01:20:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:20:55 INFO - Writing to file /builds/slave/test/properties/build_url 01:20:55 INFO - Contents: 01:20:55 INFO - build_url:https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:20:56 INFO - Running post-action listener: _resource_record_post_action 01:20:56 INFO - Running post-action listener: set_extra_try_arguments 01:20:56 INFO - ##### 01:20:56 INFO - ##### Running populate-webroot step. 01:20:56 INFO - ##### 01:20:56 INFO - Running pre-action listener: _resource_record_pre_action 01:20:56 INFO - Running main action method: populate_webroot 01:20:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:20:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:20:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:20:56 INFO - '--tppagecycles', 01:20:56 INFO - '7'], 01:20:56 INFO - 'tests': ['tsvgm']}}, 01:20:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:20:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:20:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:20:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:20:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:20:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:20:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:56 INFO - 'talos_options': ['--disable-e10s'], 01:20:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:20:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:20:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:56 INFO - 'talos_options': ['--disable-e10s'], 01:20:56 INFO - 'tests': ['damp', 'tps']}, 01:20:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:56 INFO - 'tests': ['damp', 'tps']}, 01:20:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:20:56 INFO - 'tests': ['dromaeo_dom']}, 01:20:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:20:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:20:56 INFO - 'tests': ['a11yr', 01:20:56 INFO - 'ts_paint', 01:20:56 INFO - 'tpaint', 01:20:56 INFO - 'sessionrestore', 01:20:56 INFO - 'sessionrestore_no_auto_restore', 01:20:56 INFO - 'tabpaint']}, 01:20:56 INFO - 'other-e10s': {'tests': ['a11yr', 01:20:56 INFO - 'ts_paint', 01:20:56 INFO - 'tpaint', 01:20:56 INFO - 'sessionrestore', 01:20:56 INFO - 'sessionrestore_no_auto_restore', 01:20:56 INFO - 'tabpaint']}, 01:20:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:20:56 INFO - 'ts_paint', 01:20:56 INFO - 'tpaint', 01:20:56 INFO - 'sessionrestore', 01:20:56 INFO - 'sessionrestore_no_auto_restore', 01:20:56 INFO - 'tabpaint']}, 01:20:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:20:56 INFO - 'ts_paint', 01:20:56 INFO - 'tpaint', 01:20:56 INFO - 'sessionrestore', 01:20:56 INFO - 'sessionrestore_no_auto_restore', 01:20:56 INFO - 'tabpaint']}, 01:20:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:20:56 INFO - 'tests': ['a11yr', 01:20:56 INFO - 'ts_paint', 01:20:56 INFO - 'tpaint', 01:20:56 INFO - 'sessionrestore', 01:20:56 INFO - 'sessionrestore_no_auto_restore', 01:20:56 INFO - 'tabpaint']}, 01:20:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:20:56 INFO - 'tests': ['a11yr', 01:20:56 INFO - 'ts_paint', 01:20:56 INFO - 'tpaint', 01:20:56 INFO - 'sessionrestore', 01:20:56 INFO - 'sessionrestore_no_auto_restore', 01:20:56 INFO - 'tabpaint']}, 01:20:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:20:56 INFO - 'tests': ['tsvgx', 01:20:56 INFO - 'tsvgr_opacity', 01:20:56 INFO - 'tart', 01:20:56 INFO - 'tscrollx', 01:20:56 INFO - 'cart']}, 01:20:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:20:56 INFO - 'tsvgr_opacity', 01:20:56 INFO - 'tart', 01:20:56 INFO - 'tscrollx', 01:20:56 INFO - 'cart']}, 01:20:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:56 INFO - 'talos_options': ['--disable-e10s'], 01:20:56 INFO - 'tests': ['tp5o']}, 01:20:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:56 INFO - 'tests': ['tp5o']}, 01:20:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:56 INFO - 'talos_options': ['--disable-e10s', 01:20:56 INFO - '--xperf_path', 01:20:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:20:56 INFO - 'tests': ['tp5n']}, 01:20:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:20:56 INFO - 'talos_options': ['--xperf_path', 01:20:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:20:56 INFO - 'tests': ['tp5n']}}, 01:20:56 INFO - 'talos.zip': {'path': '', 01:20:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:20:56 INFO - Running post-action listener: _resource_record_post_action 01:20:56 INFO - ##### 01:20:56 INFO - ##### Running create-virtualenv step. 01:20:56 INFO - ##### 01:20:56 INFO - Running pre-action listener: _resource_record_pre_action 01:20:56 INFO - Running main action method: create_virtualenv 01:20:56 INFO - Creating virtualenv /builds/slave/test/build/venv 01:20:56 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 01:20:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:20:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:20:57 INFO - Using real prefix '/tools/python27' 01:20:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:20:57 INFO - Installing distribute.............................................................................................................................................................................................done. 01:21:00 INFO - Installing pip.................done. 01:21:00 INFO - Return code: 0 01:21:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:00 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 0x10c32ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8235df760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1cae00>, '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 0x10c033db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c5b20>, '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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 01:21:00 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 01:21:00 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 01:21:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V3PI2HQ8a8/Render', 01:21:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:00 INFO - 'HOME': '/Users/cltbld', 01:21:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:00 INFO - 'LOGNAME': 'cltbld', 01:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:00 INFO - 'MOZ_NO_REMOTE': '1', 01:21:00 INFO - 'NO_EM_RESTART': '1', 01:21:00 INFO - 'PAGER': '/bin/cat', 01:21:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:00 INFO - 'PWD': '/builds/slave/test', 01:21:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:00 INFO - 'SHELL': '/bin/bash', 01:21:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QHjcEZUU56/Listeners', 01:21:00 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 01:21:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:00 INFO - 'USER': 'cltbld', 01:21:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:00 INFO - 'XPC_FLAGS': '0x0', 01:21:00 INFO - 'XPC_SERVICE_NAME': '0', 01:21:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:00 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 01:21:00 INFO - Cleaning up... 01:21:00 INFO - Return code: 0 01:21:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:00 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 0x10c32ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8235df760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1cae00>, '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 0x10c033db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c5b20>, '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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 01:21:00 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 01:21:00 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 01:21:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V3PI2HQ8a8/Render', 01:21:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:00 INFO - 'HOME': '/Users/cltbld', 01:21:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:00 INFO - 'LOGNAME': 'cltbld', 01:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:00 INFO - 'MOZ_NO_REMOTE': '1', 01:21:00 INFO - 'NO_EM_RESTART': '1', 01:21:00 INFO - 'PAGER': '/bin/cat', 01:21:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:00 INFO - 'PWD': '/builds/slave/test', 01:21:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:00 INFO - 'SHELL': '/bin/bash', 01:21:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QHjcEZUU56/Listeners', 01:21:00 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 01:21:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:00 INFO - 'USER': 'cltbld', 01:21:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:00 INFO - 'XPC_FLAGS': '0x0', 01:21:00 INFO - 'XPC_SERVICE_NAME': '0', 01:21:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:01 INFO - Downloading/unpacking psutil>=0.7.1 01:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:21:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:21:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:21:03 INFO - Installing collected packages: psutil 01:21:03 INFO - Running setup.py install for psutil 01:21:03 INFO - building 'psutil._psutil_osx' extension 01:21:03 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 01:21:04 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 01:21:04 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 01:21:04 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 01:21:04 INFO - building 'psutil._psutil_posix' extension 01:21:04 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 01:21:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:21:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:21:04 INFO - ^ 01:21:04 INFO - 1 warning generated. 01:21:04 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 01:21:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:21:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:21:04 INFO - Successfully installed psutil 01:21:04 INFO - Cleaning up... 01:21:04 INFO - Return code: 0 01:21:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:21:04 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')]} 01:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:04 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')]} 01:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:04 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 0x10c32ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8235df760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1cae00>, '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 0x10c033db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c5b20>, '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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 01:21:04 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 01:21:04 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 01:21:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V3PI2HQ8a8/Render', 01:21:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:04 INFO - 'HOME': '/Users/cltbld', 01:21:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:04 INFO - 'LOGNAME': 'cltbld', 01:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:04 INFO - 'MOZ_NO_REMOTE': '1', 01:21:04 INFO - 'NO_EM_RESTART': '1', 01:21:04 INFO - 'PAGER': '/bin/cat', 01:21:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:04 INFO - 'PWD': '/builds/slave/test', 01:21:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:04 INFO - 'SHELL': '/bin/bash', 01:21:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QHjcEZUU56/Listeners', 01:21:04 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 01:21:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:04 INFO - 'USER': 'cltbld', 01:21:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:04 INFO - 'XPC_FLAGS': '0x0', 01:21:04 INFO - 'XPC_SERVICE_NAME': '0', 01:21:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:21:07 INFO - Installing collected packages: mozsystemmonitor 01:21:07 INFO - Running setup.py install for mozsystemmonitor 01:21:07 INFO - Successfully installed mozsystemmonitor 01:21:07 INFO - Cleaning up... 01:21:07 INFO - Return code: 0 01:21:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:21:07 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')]} 01:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:07 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')]} 01:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:07 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 0x10c32ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8235df760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1cae00>, '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 0x10c033db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c5b20>, '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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 01:21:07 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 01:21:07 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 01:21:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V3PI2HQ8a8/Render', 01:21:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:07 INFO - 'HOME': '/Users/cltbld', 01:21:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:07 INFO - 'LOGNAME': 'cltbld', 01:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:07 INFO - 'MOZ_NO_REMOTE': '1', 01:21:07 INFO - 'NO_EM_RESTART': '1', 01:21:07 INFO - 'PAGER': '/bin/cat', 01:21:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:07 INFO - 'PWD': '/builds/slave/test', 01:21:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:07 INFO - 'SHELL': '/bin/bash', 01:21:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QHjcEZUU56/Listeners', 01:21:07 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 01:21:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:07 INFO - 'USER': 'cltbld', 01:21:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:07 INFO - 'XPC_FLAGS': '0x0', 01:21:07 INFO - 'XPC_SERVICE_NAME': '0', 01:21:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:07 INFO - Downloading/unpacking blobuploader==1.2.4 01:21:07 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 01:21:07 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 01:21:07 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 01:21:07 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 01:21:07 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 01:21:07 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 01:21:10 INFO - Downloading blobuploader-1.2.4.tar.gz 01:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:21:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:21:10 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 01:21:10 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 01:21:10 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 01:21:10 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 01:21:10 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 01:21:10 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 01:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:21:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:11 INFO - Downloading docopt-0.6.1.tar.gz 01:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:21:11 INFO - Installing collected packages: blobuploader, requests, docopt 01:21:11 INFO - Running setup.py install for blobuploader 01:21:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:21:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:21:11 INFO - Running setup.py install for requests 01:21:12 INFO - Running setup.py install for docopt 01:21:12 INFO - Successfully installed blobuploader requests docopt 01:21:12 INFO - Cleaning up... 01:21:12 INFO - Return code: 0 01:21:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:12 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 0x10c32ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8235df760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1cae00>, '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 0x10c033db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c5b20>, '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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 01:21:12 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 01:21:12 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 01:21:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V3PI2HQ8a8/Render', 01:21:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:12 INFO - 'HOME': '/Users/cltbld', 01:21:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:12 INFO - 'LOGNAME': 'cltbld', 01:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:12 INFO - 'MOZ_NO_REMOTE': '1', 01:21:12 INFO - 'NO_EM_RESTART': '1', 01:21:12 INFO - 'PAGER': '/bin/cat', 01:21:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:12 INFO - 'PWD': '/builds/slave/test', 01:21:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:12 INFO - 'SHELL': '/bin/bash', 01:21:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QHjcEZUU56/Listeners', 01:21:12 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 01:21:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:12 INFO - 'USER': 'cltbld', 01:21:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:12 INFO - 'XPC_FLAGS': '0x0', 01:21:12 INFO - 'XPC_SERVICE_NAME': '0', 01:21:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:21:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-LfI5SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:21:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-hUjLkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:21:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-6RbDO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:21:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-9qAtm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:21:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-4fD7Q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:21:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-f4wO4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:21:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-xYpqt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:21:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-OfjIV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:21:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-PhZgyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:21:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-5INH6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:21:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-_eNCxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:21:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-_ZlGhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:21:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-SB0zdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:21:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-waRim3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:21:14 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-YTM6Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:21:14 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-pAF__I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:21:14 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-rN5U9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:21:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:21:14 INFO - Running setup.py install for manifestparser 01:21:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:21:14 INFO - Running setup.py install for mozcrash 01:21:14 INFO - Running setup.py install for mozdebug 01:21:14 INFO - Running setup.py install for mozdevice 01:21:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:21:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:21:15 INFO - Running setup.py install for mozfile 01:21:15 INFO - Running setup.py install for mozhttpd 01:21:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:21:15 INFO - Running setup.py install for mozinfo 01:21:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:21:15 INFO - Running setup.py install for mozInstall 01:21:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:21:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:21:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:21:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:21:15 INFO - Running setup.py install for mozleak 01:21:15 INFO - Running setup.py install for mozlog 01:21:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:21:15 INFO - Running setup.py install for moznetwork 01:21:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:21:16 INFO - Running setup.py install for mozprocess 01:21:16 INFO - Running setup.py install for mozprofile 01:21:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:21:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:21:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:21:16 INFO - Running setup.py install for mozrunner 01:21:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:21:16 INFO - Running setup.py install for mozscreenshot 01:21:16 INFO - Running setup.py install for moztest 01:21:16 INFO - Running setup.py install for mozversion 01:21:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:21:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:21:16 INFO - Cleaning up... 01:21:16 INFO - Return code: 0 01:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:16 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 0x10c32ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8235df760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1cae00>, '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 0x10c033db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c5b20>, '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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 01:21:16 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 01:21:16 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 01:21:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V3PI2HQ8a8/Render', 01:21:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:16 INFO - 'HOME': '/Users/cltbld', 01:21:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:16 INFO - 'LOGNAME': 'cltbld', 01:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:16 INFO - 'MOZ_NO_REMOTE': '1', 01:21:16 INFO - 'NO_EM_RESTART': '1', 01:21:16 INFO - 'PAGER': '/bin/cat', 01:21:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:16 INFO - 'PWD': '/builds/slave/test', 01:21:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:16 INFO - 'SHELL': '/bin/bash', 01:21:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QHjcEZUU56/Listeners', 01:21:16 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 01:21:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:16 INFO - 'USER': 'cltbld', 01:21:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:16 INFO - 'XPC_FLAGS': '0x0', 01:21:16 INFO - 'XPC_SERVICE_NAME': '0', 01:21:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:21:17 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-US5pNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:21:17 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)) 01:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:21:17 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-0_DxIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:21:17 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)) 01:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:21:17 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-xeQVUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:21:17 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)) 01:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:21:17 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-c9rkBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:21:17 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)) 01:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:21:17 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-b_Hi4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:21:17 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)) 01:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:21:17 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-BJKivz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:21:17 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)) 01:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:21:17 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-rPbGab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:21:17 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)) 01:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:21:17 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-GldnZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:21:18 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)) 01:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:21:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-1KR96L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:21:18 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)) 01:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:21:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-eu31dC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:21:18 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)) 01:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:21:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-bJrTko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:21:18 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)) 01:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:21:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-PDhfZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:21:18 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)) 01:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:21:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ovwlD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:21:18 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)) 01:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:21:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-KbvJRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:21:18 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)) 01:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:21:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-h97res-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:21:18 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)) 01:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:21:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-zkcXUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:21:18 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)) 01:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:21:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-K5bVS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:21:19 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)) 01:21:19 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)) 01:21:19 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)) 01:21:19 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)) 01:21:19 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)) 01:21:19 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)) 01:21:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:21 INFO - Downloading blessings-1.6.tar.gz 01:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:21:21 INFO - Installing collected packages: blessings 01:21:21 INFO - Running setup.py install for blessings 01:21:21 INFO - Successfully installed blessings 01:21:21 INFO - Cleaning up... 01:21:21 INFO - Return code: 0 01:21:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:21:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:21:22 INFO - Reading from file tmpfile_stdout 01:21:22 INFO - Current package versions: 01:21:22 INFO - blessings == 1.6 01:21:22 INFO - blobuploader == 1.2.4 01:21:22 INFO - docopt == 0.6.1 01:21:22 INFO - manifestparser == 1.1 01:21:22 INFO - mozInstall == 1.12 01:21:22 INFO - mozcrash == 0.17 01:21:22 INFO - mozdebug == 0.1 01:21:22 INFO - mozdevice == 0.48 01:21:22 INFO - mozfile == 1.2 01:21:22 INFO - mozhttpd == 0.7 01:21:22 INFO - mozinfo == 0.9 01:21:22 INFO - mozleak == 0.1 01:21:22 INFO - mozlog == 3.1 01:21:22 INFO - moznetwork == 0.27 01:21:22 INFO - mozprocess == 0.22 01:21:22 INFO - mozprofile == 0.28 01:21:22 INFO - mozrunner == 6.11 01:21:22 INFO - mozscreenshot == 0.1 01:21:22 INFO - mozsystemmonitor == 0.0 01:21:22 INFO - moztest == 0.7 01:21:22 INFO - mozversion == 1.4 01:21:22 INFO - psutil == 3.1.1 01:21:22 INFO - requests == 1.2.3 01:21:22 INFO - wsgiref == 0.1.2 01:21:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:22 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 0x10c32ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8235df760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1cae00>, '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 0x10c033db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c5b20>, '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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 01:21:22 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 01:21:22 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 01:21:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V3PI2HQ8a8/Render', 01:21:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:22 INFO - 'HOME': '/Users/cltbld', 01:21:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:22 INFO - 'LOGNAME': 'cltbld', 01:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:22 INFO - 'MOZ_NO_REMOTE': '1', 01:21:22 INFO - 'NO_EM_RESTART': '1', 01:21:22 INFO - 'PAGER': '/bin/cat', 01:21:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:22 INFO - 'PWD': '/builds/slave/test', 01:21:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:22 INFO - 'SHELL': '/bin/bash', 01:21:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QHjcEZUU56/Listeners', 01:21:22 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 01:21:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:22 INFO - 'USER': 'cltbld', 01:21:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:22 INFO - 'XPC_FLAGS': '0x0', 01:21:22 INFO - 'XPC_SERVICE_NAME': '0', 01:21:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:22 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)) 01:21:22 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)) 01:21:22 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)) 01:21:22 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)) 01:21:22 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)) 01:21:22 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)) 01:21:22 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)) 01:21:22 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)) 01:21:22 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)) 01:21:22 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)) 01:21:22 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)) 01:21:22 INFO - Cleaning up... 01:21:22 INFO - Return code: 0 01:21:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:22 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 0x10c32ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8235df760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1cae00>, '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 0x10c033db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c5b20>, '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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 01:21:22 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 01:21:22 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 01:21:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V3PI2HQ8a8/Render', 01:21:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:22 INFO - 'HOME': '/Users/cltbld', 01:21:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:22 INFO - 'LOGNAME': 'cltbld', 01:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:22 INFO - 'MOZ_NO_REMOTE': '1', 01:21:22 INFO - 'NO_EM_RESTART': '1', 01:21:22 INFO - 'PAGER': '/bin/cat', 01:21:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:22 INFO - 'PWD': '/builds/slave/test', 01:21:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:22 INFO - 'SHELL': '/bin/bash', 01:21:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QHjcEZUU56/Listeners', 01:21:22 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 01:21:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:22 INFO - 'USER': 'cltbld', 01:21:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:22 INFO - 'XPC_FLAGS': '0x0', 01:21:22 INFO - 'XPC_SERVICE_NAME': '0', 01:21:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:22 INFO - Downloading/unpacking jsonschema 01:21:22 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 01:21:22 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 01:21:22 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 01:21:22 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 01:21:22 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 01:21:22 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 01:21:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:21:25 INFO - Downloading/unpacking functools32 (from jsonschema) 01:21:25 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 01:21:25 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 01:21:25 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 01:21:25 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 01:21:25 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 01:21:25 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 01:21:25 INFO - Downloading functools32-3.2.3-2.tar.gz 01:21:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:21:25 INFO - warning: no files found matching '*.txt' 01:21:25 INFO - no previously-included directories found matching 'build' 01:21:25 INFO - no previously-included directories found matching 'dist' 01:21:25 INFO - no previously-included directories found matching '.git*' 01:21:25 INFO - Installing collected packages: jsonschema, functools32 01:21:25 INFO - Running setup.py install for functools32 01:21:25 INFO - warning: no files found matching '*.txt' 01:21:25 INFO - no previously-included directories found matching 'build' 01:21:25 INFO - no previously-included directories found matching 'dist' 01:21:25 INFO - no previously-included directories found matching '.git*' 01:21:25 INFO - Successfully installed jsonschema functools32 01:21:25 INFO - Cleaning up... 01:21:25 INFO - Return code: 0 01:21:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:21:25 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')]} 01:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:25 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')]} 01:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:25 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 0x10c32ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8235df760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1cae00>, '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 0x10c033db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c5b20>, '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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 01:21:25 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 01:21:25 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 01:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V3PI2HQ8a8/Render', 01:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:25 INFO - 'HOME': '/Users/cltbld', 01:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:25 INFO - 'LOGNAME': 'cltbld', 01:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:25 INFO - 'MOZ_NO_REMOTE': '1', 01:21:25 INFO - 'NO_EM_RESTART': '1', 01:21:25 INFO - 'PAGER': '/bin/cat', 01:21:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:25 INFO - 'PWD': '/builds/slave/test', 01:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:25 INFO - 'SHELL': '/bin/bash', 01:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QHjcEZUU56/Listeners', 01:21:25 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 01:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:25 INFO - 'USER': 'cltbld', 01:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:25 INFO - 'XPC_FLAGS': '0x0', 01:21:25 INFO - 'XPC_SERVICE_NAME': '0', 01:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:26 INFO - Downloading/unpacking flake8 01:21:26 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 01:21:26 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 01:21:26 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 01:21:26 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 01:21:26 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 01:21:26 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 01:21:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:21:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:21: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 01:21: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 01:21: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 01:21: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 01:21: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 01:21: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 01:21:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:21:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:21: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 01:21: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 01:21: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 01:21: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 01:21: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 01:21: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 01:21:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:21:29 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 01:21:29 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 01:21:29 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 01:21:29 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 01:21:29 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 01:21:29 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 01:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:21:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:21:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:21:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:21:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:21:29 INFO - no previously-included directories found matching 'docs/_build' 01:21:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:21:29 INFO - Running setup.py install for pep8 01:21:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:21:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:21:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:21:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:21:29 INFO - no previously-included directories found matching 'docs/_build' 01:21:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:21:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:21:29 INFO - Cleaning up... 01:21:30 INFO - Return code: 0 01:21:30 INFO - Running post-action listener: _resource_record_post_action 01:21:30 INFO - Running post-action listener: _start_resource_monitoring 01:21:30 INFO - Starting resource monitoring. 01:21:30 INFO - ##### 01:21:30 INFO - ##### Running install step. 01:21:30 INFO - ##### 01:21:30 INFO - Running pre-action listener: _resource_record_pre_action 01:21:30 INFO - Running main action method: install 01:21:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:21:30 INFO - Reading from file tmpfile_stdout 01:21:30 INFO - Detecting whether we're running mozinstall >=1.0... 01:21:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:21:30 INFO - Reading from file tmpfile_stdout 01:21:30 INFO - Output received: 01:21:30 INFO - Usage: mozinstall [options] installer 01:21:30 INFO - Options: 01:21:30 INFO - -h, --help show this help message and exit 01:21:30 INFO - -d DEST, --destination=DEST 01:21:30 INFO - Directory to install application into. [default: 01:21:30 INFO - "/builds/slave/test"] 01:21:30 INFO - --app=APP Application being installed. [default: firefox] 01:21:30 INFO - mkdir: /builds/slave/test/build/application 01:21:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 01:21:52 INFO - Reading from file tmpfile_stdout 01:21:52 INFO - Output received: 01:21:52 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:21:52 INFO - Running post-action listener: _resource_record_post_action 01:21:52 INFO - ##### 01:21:52 INFO - ##### Running run-tests step. 01:21:52 INFO - ##### 01:21:52 INFO - Running pre-action listener: _resource_record_pre_action 01:21:52 INFO - Running main action method: run_tests 01:21:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:21:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:21:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:21:52 INFO - 2016-06-28 01:21:52.165 screenresolution[2169:20185] starting screenresolution argv=screenresolution get 01:21:52 INFO - 2016-06-28 01:21:52.168 screenresolution[2169:20185] Display 0: 1600x1200x32@60 01:21:52 INFO - 2016-06-28 01:21:52.174 screenresolution[2170:20188] starting screenresolution argv=screenresolution list 01:21:52 INFO - Available Modes on Display 0 01:21:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:21:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:21:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:21:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:21:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:21:52 INFO - Intel Iris: 01:21:52 INFO - Chipset Model: Intel Iris 01:21:52 INFO - Type: GPU 01:21:52 INFO - Bus: Built-In 01:21:52 INFO - VRAM (Dynamic, Max): 1536 MB 01:21:52 INFO - Vendor: Intel (0x8086) 01:21:52 INFO - Device ID: 0x0a2e 01:21:52 INFO - Revision ID: 0x0009 01:21:52 INFO - Displays: 01:21:52 INFO - Display: 01:21:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:21:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:21:52 INFO - Display Serial Number: 1600x1200 60 01:21:52 INFO - Main Display: Yes 01:21:52 INFO - Mirror: Off 01:21:52 INFO - Online: Yes 01:21:52 INFO - Rotation: Supported 01:21:52 INFO - Return code: 0 01:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:21:52 INFO - Python 2.7.3 01:21:52 INFO - Return code: 0 01:21:52 INFO - grabbing minidump binary from tooltool 01:21: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')]} 01:21: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 0x10c1cae00>, '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 0x10c033db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:21: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 01:21: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 01:21:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:21:52 INFO - Return code: 0 01:21:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:21:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:21:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:21:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:21:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:21:53 INFO - Return code: 0 01:21: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/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 01:21: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/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0235 --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 01:21:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V3PI2HQ8a8/Render', 01:21:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:21:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:21:53 INFO - 'HOME': '/Users/cltbld', 01:21:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:21:53 INFO - 'LOGNAME': 'cltbld', 01:21:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:21:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:53 INFO - 'MOZ_NO_REMOTE': '1', 01:21:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:21:53 INFO - 'NO_EM_RESTART': '1', 01:21:53 INFO - 'PAGER': '/bin/cat', 01:21:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:53 INFO - 'PWD': '/builds/slave/test', 01:21:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:21:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:21:53 INFO - 'SHELL': '/bin/bash', 01:21:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QHjcEZUU56/Listeners', 01:21:53 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 01:21:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:21:53 INFO - 'USER': 'cltbld', 01:21:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:21:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:53 INFO - 'XPC_FLAGS': '0x0', 01:21:53 INFO - 'XPC_SERVICE_NAME': '0', 01:21:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:21: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/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 01:21:53 INFO - mozversion application_buildid: 20160627053125 01:21:53 INFO - mozversion application_changeset: 8664ad5c52883cb66cb9b46879eb062fb6600756 01:21:53 INFO - mozversion application_display_name: Firefox 01:21:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:21:53 INFO - mozversion application_name: Firefox 01:21:53 INFO - mozversion application_remotingname: firefox 01:21:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:21:53 INFO - mozversion application_vendor: Mozilla 01:21:53 INFO - mozversion application_version: 48.0 01:21:53 INFO - mozversion platform_buildid: 20160627053125 01:21:53 INFO - mozversion platform_changeset: 8664ad5c52883cb66cb9b46879eb062fb6600756 01:21:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:21:53 INFO - mozversion platform_version: 48.0 01:21:53 INFO - using testdate: 1467102113 01:21:53 INFO - actual date: 1467102113 01:21:53 INFO - starting webserver on 'localhost:55974' 01:21:53 INFO - SUITE-START | Running 2 tests 01:21:53 INFO - TEST-START | dromaeo_css 01:21:53 INFO - operating with platform_type : mac_ 01:21:53 INFO - Initialising browser for dromaeo_css test... 01:21:53 INFO - TEST-INFO | started process 2188 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpt9OTCs/profile http://localhost:55974/getInfo.html) 01:21:56 INFO - PROCESS | 2188 | __metrics Screen width/height:1600/1200 01:21:56 INFO - PROCESS | 2188 | colorDepth:24 01:21:56 INFO - PROCESS | 2188 | Browser inner width/height: 1024/689 01:21:56 INFO - PROCESS | 2188 | __metrics 01:21:56 ERROR - PROCESS | 2188 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 01:21:57 INFO - TEST-INFO | 2188: exit 0 01:21:57 INFO - Browser initialized. 01:21:57 INFO - Running cycle 1/1 for dromaeo_css test... 01:21:57 INFO - TEST-INFO | started process 2192 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpt9OTCs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:22:09 INFO - PROCESS | 2192 | RSS: Main: 171479040 01:22:09 INFO - PROCESS | 2192 | 01:22:58 INFO - PROCESS | 2192 | 1467102178746 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] 01:25:08 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:55974/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55974/tests/dromaeo/cssquery-ext.html) 01:25:10 INFO - PROCESS | 2192 | RSS: Main: 182009856 01:25:10 INFO - PROCESS | 2192 | 01:28:12 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:55974/tests/dromaeo/cssquery-ext.html (next: http://localhost:55974/tests/dromaeo/cssquery-jquery.html) 01:28:12 INFO - PROCESS | 2192 | RSS: Main: 192593920 01:28:12 INFO - PROCESS | 2192 | 01:31:14 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:55974/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55974/tests/dromaeo/cssquery-mootools.html) 01:31:15 INFO - PROCESS | 2192 | RSS: Main: 194674688 01:31:15 INFO - PROCESS | 2192 | 01:34:16 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:55974/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55974/tests/dromaeo/cssquery-prototype.html) 01:34:17 INFO - PROCESS | 2192 | RSS: Main: 198647808 01:34:17 INFO - PROCESS | 2192 | 01:37:19 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:55974/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55974/tests/dromaeo/cssquery-yui.html) 01:37:20 INFO - PROCESS | 2192 | RSS: Main: 197828608 01:37:20 INFO - PROCESS | 2192 | 01:40:22 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:55974/tests/dromaeo/cssquery-yui.html (next: http://localhost:55974/tests/dromaeo/cssquery-dojo.html) 01:40:22 INFO - PROCESS | 2192 | RSS: Main: 203214848 01:40:22 INFO - PROCESS | 2192 | 01:40:22 INFO - PROCESS | 2192 | __start_tp_report 01:40:22 INFO - PROCESS | 2192 | _x_x_mozilla_page_load 01:40:22 INFO - PROCESS | 2192 | _x_x_mozilla_page_load_details 01:40:22 INFO - PROCESS | 2192 | |i|pagename|runs| 01:40:22 INFO - PROCESS | 2192 | |0;dojo.html;3043.254402671346;3575.9642403575963;3649.288388764192;3689.391250443677;3693.2982733280674;5926.970365148179;5931.466168044875;5952.642841429517;5962.64224146551;5966.5226781857455;5722.971385143079;5937.64374137552;5943.078822782465;6000.219971403722;6003.789867354643;5386.91919621205;5415.13357862742;5418.593605479585;5518.227448157261;5527.336719593654;5321.255024296602;5418.674879507223;5466.9179962300595;5516.089845175541;5527.55779537636;5494.450554944514;5523.613347065707;5529.557635389179;5541.556675465953;5549.528290095347;5446.2647542582035;5472.781088756445;5485.286912701363;5511.4213007634025;5520.420355862617;5252.3171987641745;5293.39126000511;5324.760385782649;5365.624406291561;5396.136618141118;4641.885947372606;5761.366249712528;5765.509931655814;5778.566607504454;5862.50168735658;6120.904292401164;6261.311255761862;6305.527085468608;6309.242890853081;6330.272018717815;6287.276963149205;6304.747810087591;6362.809115726489;6395.680215989229;6423.8394040148905;6124.050772130327;6127.938720612826;6142.846428839315;6150.50795936324;6166.784162554289;6306.779262725782;6449.935500644933;6510.707018184098;6524;6534.901976470357;6179.073139029092;6249.312575616678;6253.843653908598;6263.217097862767;6279.7488100476385;6371.872562548723;6380;6397.10440538325;6428.614283142932;6431.356864313625;6149.385061493905;6200.543402812169;6216.906746398808;6265.342139075423;6268.310485846553;6262.342454042351;6287.559870808999;6295.874082518324;6301.054841773679;6308.526860485482;4974.701517908937;5101.234814777738;5121.28302037715;5127.2052831811125;5128.410232823198;4493.955060449419;4541.704789188692;4600.079984003212;4616.330632058332;4666.673332866734;5882.264716910387;6003.699815009232;6054.152418661391;6090.817275481742;6111.5309653553995;6324.557280990287;6367.363263673688;6388.5528013039575;6413.134226879311;6413.198350206224;4992.950070499249;5860.238169037998;6027.547933904887;6117;6143.877122457615;5050.242463630485;5059.797608095709;5605.243292155588;5618.241537392481;5628.577856660767;5967.8209653710455;6361.872762544724;6675.132232809704;6704.564203326768;6705.731770729214;6225.719842607185;6315.147455093504;6342.112104305494;6378.87242255143;6385.96807015962;6618;6634.5024123191915;6634.668266586555;6639.568428052161;6683.231428385798;6308.243010838729;6310.968445157745;6311;6312.779052733133;6319.715612797527;6221;6295.3389894060465;6338.492920566436;6372.713227904848;6400.839979000562;6165.167702360124;6226.688665566794;6249.531285153541;6250.781222657185;6264.342244064308;6141.700809433504;6183.258009038944;6230.844228894132;6234.1583886174785;6259.593126446766;6012.6392416455155;6150.169727086786;6159.29168145669;6239.875202495834;6258.249010118815;6217.253929528486;6259;6268.811935641938;6269.5611307208055;6272.341404152681;6136.825445958321;6146.846328841814;6242.3133455320785;6259.937400625936;6292.748290068529 01:40:22 INFO - PROCESS | 2192 | |1;ext.html;510.15059925224506;545.0298468725668;575.8827873924587;578.884223155369;602.1209034809178;36063.63936360636;41720.37419438711;41760.16479670405;41849.37225941606;41917.79041104794;43334.34998475025;43757.34363984535;43814.56185438145;43910.12179756411;43965.34051989223;8584.527850968194;9752.073553012488;9879;9960.402375857435;10002.59989600415;9828.262880283972;10057.145142662846;10062.849057264148;10080.344777589433;10108.292419530635;10085.041921017491;10109.696709098738;10114.44370559619;10121.595136194543;10143.949280253588;9034.45793252407;9769.632251484762;10031.69904902854;10068.597256109746;10092.444915529642;9986.300958932878;10026.649067282682;10064.496775161213;10101.292909496338;10105.646302379382;41962.79018604887;42099;42443.36334954978;42554.1489170218;42710;2849.387381712921;2932.88268469261;3266.869325227012;3372.308676721291;3919.9216015679813;22694.773052269433;29056.709432905824;29231.41537169266;29240.830366785303;30154.09537713872;2776.5973933779487;2785.637867077267;2787.916362509128;2860.699626539225;2879.3809330993936;297932;363130;367386;367956.9999999973;368097;67109.32890671128;67275;67601;67710.3228967704;67835;64657.67671161614;75380.62309688417;76695.61652191814;77295;77635.22364776392;18386.632267354576;18827.435176944713;18933.90533047326;19134.61730765377;19218.13518391676;14245.216513091673;14486.927565362106;14514.274286285643;14567.980241383213;14677.77983330251;21262.362129136152;21357.14571417157;21448;21534.13863445476;21873.67189492159;8740.78148046304;8840.115988401109;8888.60001299943;8912.598933048028;8939.971903231082;885.2652298592153;976.7216343342113;1072.3619446429361;1137.9317240965568;1156.525824411987;31228.531572026437;31310.843445782626;31374.52938205929;31896.681033189834;32052.67947320497;1160.3328086350214;1183.9348835813942;1204.030755242021;1265.9936700316623;1294.8575656677758;15340.696040836654;15919.363225470852;16266.512004639642;16297.918510407371;16422.1788910554;591557.0422147862;641627;646801;654867;654939;65330.67334663296;65674.34325656778;66294.66852665802;66428.66785666041;66448;1533.4249656378859;1559.485369827954;1561.9467481884492;1570.8115026196701;1579.4156162219822;30699.38601227918;30981.8450907744;30998.380032399677;31538;31657.525137122502;57285.71357143188;57568.4243157563;57761;57877;57878.131828021775;484373;485474;488429;488824.5558772183;489552;27938.16185514438;44681.32978005397;44765.328520071576;47057.29414058723;47185.52814471811;45056.873578159495;45337.54662453333;45878.85302867455;46649.766751166026;47292;38597;39218.607813921495;39621;39843.00392490211;40319.79840100781;37886.43170352502;38676.41985370278;39056;39661.00847478836;39907;33670.98987030393;38877;39781.40327895142;39884.40173397459;40537.391939121524;28824.84700612036;30516.389672205987;32684.346313074082;34048.82975585106;34083.488747669304;22779.08883644702;25154.62268065944;25542.489150217265;25872.870635647454;26143.08499202519 01:40:22 INFO - PROCESS | 2192 | |2;jquery.html;419.4819398043416;420.8127383314425;425.4766637036443;428.93780401841735;430.8836614114189;19270.51823704408;19806.207751689934;21512.432146299307;22204.222852200175;22608.208712695057;20922.89538552309;21080.262190823323;21121.15515379387;21486.785132148674;21660.133594656196;5246.816361427351;5501.834944951638;5631.831045068634;5636.15457681347;5640.605157638967;4321.330193819947;5533.6403133796375;5600.355959064698;6362.713677884506;7063.788086357417;6919.757808476705;6928.9307106929045;6934.237233904267;6985.266547012567;6993.055937448456;6963.617001064939;7496.212897645751;7822.647980840876;7837.608119593998;7980.162082981319;7602.50583712057;7642.617869106522;7656.693732250703;7718.073831140299;7750.7674769756995;29367;30667.926622568102;30698.693013069806;31414.528782068286;31517.684823151703;2409.807215422762;2496.3509487533192;2870.7559857412143;3243.50178616804;3255.4953982132806;16138.677226455522;16398.344066237336;16764;17190.398336058304;17219.483415497554;1948.3375652278294;1950.3271371376852;1954.7556555430572;1960.4739955290984;1986.2452268138015;131506.6849331504;134837;142980.28509857488;145047.27476362657;146405.26797366052;15550.455734049254;22975.42561435944;22994;23132.53734925292;23170.7682923172;37015;37022.8148859254;37189.88430347094;38811;38858.80570597129;10158.187345012382;11383.203175777782;12015.639530814089;12088.09339299556;12186.146969712212;10071.496425178711;10076;10125.240606954509;10128.240381971382;10228.335158214692;8567.657293708182;8707.259882910024;10626.840597391045;10727.678169654766;10852.348859068481;3417.572803399575;4069.084455997436;4116.279651061052;4189.455370801777;4332.653387729038;957.2724729205854;992.1071036067597;1032;1092.8032954068344;1106.372365631625;19663.508412289808;20328.186872525228;21004.159833606485;21060.946952652306;21372.931353432577;1004.5735056220185;1019.4036488654073;1033.1579762493543;1076.2573824061374;1077.9191560632828;9206.539673016323;10550.786659534251;11180.608678696206;11467.910548497879;11480.311181329147;520104;526253;526939;568120;612643;139557;144909;147301;147382.26308868386;152582;1035.5805898611075;1078.946052697362;1083.0793825248477;1085.6634443322596;1092.0280949954547;17549.859259148114;17601.471955841345;18491.72262416038;18817.965011924476;19497.512562186057;57911.710441447525;58714;58773.706131469065;58947.11579326399;59142.70428647829;84851;86551;86921;87583;90533;8311.875321870057;8362.707305244287;8417;8457.619407126816;8464.111268316738;10615.628453004108;12389.93805030969;12686.302253376152;12821.807672885101;13069.869301306866;10953.288036277616;11002.394868282321;11029;11169;11196.776064478829;10893.836592450962;10948.124150068135;10949.616763413562;11223.270487418291;11271.985521302795;10929.289596176222;11305.773884522428;11548.191626586058;11595.942020289845;11621.477033533341;6944.722211111499;8034.879476807736;8381.91035165449;8394.58027098655;8486.957565212135;10441.68674939753;11465.312081274817;11658.242214256046;11765.941065304163;11834.46744896499 01:40:22 INFO - PROCESS | 2192 | |3;mootools.html;1631.6422769098654;1649.224864313772;1908.6564418404682;1988.2444671025016;2066.7106605075282;8267.214614611603;8972.551372431368;9085.863712044316;9211.355205135644;9277.489738064403;8929.419587726794;8995.640174393016;9096.727098187048;9102.089791020895;9112.815334006586;2537.644729737829;2542.3517003164166;2546;2547.2740269023334;2571.54997875372;2512.9748702513016;2570.370259286468;2572.7555882191164;2582.0575489946127;2588.7281835407293;2171.4896999205175;2535.518251532203;2591.1190195333584;2601.5967525033557;2604.1406335909105;2550.4899020196035;2569.5117927593697;2570.794336453098;2587.236765154284;2589.4303253284343;2546.3506805764596;2552.2470871093074;2564.9615255771178;2575.407656239057;2591.6242144889075;9140.085991400872;9205.493697846683;9234.445933244027;9236.21492173166;9250.167484926389;5587.469190426944;5602.075657516546;5616.98894199044;5627.437256274381;5730.484256416901;3623.2572322673786;3738.9065273368383;3775.528058992626;3782.205736795276;3792.924141517154;1040.4433628008978;1060.6158962553864;1070.5610699613198;1073.8174510333183;1080.0603474976742;12033.097517686208;12343.567975120828;12384.62846114618;12417.317047562381;12428.627141185689;4978.800847966113;5045.167547354646;5073.188289873677;5111.718855462911;5155.716435596003;10375;10418.11446027081;10541.683749487527;10541.736456588493;10572.471376431147;5588.329400471969;5592.804251851166;5616.269884914935;5638.464345887134;5790.594658373958;4642.558956899089;5058.342415485963;5117.078925793318;5142.434332223453;5145.9193569350855;4201.474815648044;4205;4302.67729920251;4311.784410779448;4330.242207613655;1384.5915454940816;1414.724128794875;1418.1136789506559;1422.879055280292;1426.5720283914784;782.2099679323924;832.3715594725943;851.9616617252238;856.208007592974;858.4891989266376;5285.312909321764;5306.92039619406;5351.331083614548;5479.150731636602;5480.808171713971;454.4682721216119;479.03235464361796;480.5607206416804;482.4692837878376;482.5150723522837;3238.2713889374704;3867.7722190109894;3983.5817239190046;3996.84012639497;4006.338954072545;9306.395084319498;9538.236941044699;10708.946455267675;10711.73220669474;11164.776704466027;10778.730531736612;10825.945870270756;10955.4522273886;10991.780164396667;11014.229003969805;8190.140035296208;8385.790355241168;8476.576171191293;8517.190866867637;8613.483191008434;5817.912731308949;5856.092305692625;5866.149408335853;5912.881742365214;5923.229980102731;9701.514924253901;9759.072888075621;9874.975629995977;9966.800663986825;10095.949520252352;9578.760530986503;10027.44849033281;10095.7476063099;10124.443155626512;10263.973602639677;6449.290578036318;7023.29767023314;7528.774136775905;7679.577623230776;7710.807229819299;8386.874196886929;8437.578121093798;8502;8617.224449799549;8664.176903194186;7522.473426860286;7684.884726729216;7712.845743084995;7789.221077892165;7795.805104872424;7516.774496765106;7597.962010189914;7605.277498637621;7639.732609358646;7691.807769795467;7231.963840180765;7293.270672932665;7314.37827784623;7339.669714862951;7346.485745997943;4938.234573641092;4977.228529577921;5057.064443078042;5077.974610126926;5156.329677141947;5029.572486338556;5111.361079865017;5144.30551875492;5147.6654017488745;5344.3586769586345 01:40:22 INFO - PROCESS | 2192 | |4;prototype.html;341.25095415562834;342.4862705941088;344.56412638012904;347.9947800782988;353.15243415802087;6303.464205542528;6927.792166235021;6966.198887127982;6971.790846274607;6975.511714180009;6298.02380631003;6483.448906842924;6821.8402871511835;6850.82872928177;6886;4158.792060396976;4984.32711583937;5120.15517439622;5131.3842338919385;5138.922916156261;5052.494750524955;5096.974515127437;5136.178211486163;5136.58907287418;5137.101007323722;4225.7887105644595;4942.233953737176;5050.242463630448;5053.242013697938;5083.720395378253;5077.096088966638;5080.110980578403;5091.287219789232;5102.413222479426;5138.511841375063;4391.231534481453;4413.713108647959;4414.668899832525;4434.312681534368;4436.689431739779;6387.872242555123;6698.665066746643;6702.162229721285;6804.761833335859;6850.623215723133;4928.866360737051;5969.104634304846;5969.701514924236;6001.48987336077;6005.249343832021;6308.211473565804;6891.345322194384;7514.6618402172035;7532.8116797079965;7549.0563679540055;4790.185668436374;4806.687565308279;4809.687370320953;4812.0375924814825;4814.807407703687;7623.771286861458;7874.448788584801;7934.206579342077;7963.243491868321;7977.960110199412;4813.687110337817;4839.758012099381;4883.316335713003;4883.755812209446;4899.461059283476;4971.925421118686;4971.950280497221;4983.875403114951;4991.550760431506;5005.874853128628;5937.732802023919;5943.405659434022;5943.465088142088;5973.820785376446;6004.279486461653;6127.938720612737;7537.736179233701;7565.356944659656;7590.544567325867;7602.391808655294;1639.7048531264486;1706.7269236922034;1737.1487970894423;1737.7393390991454;1741.8780685351903;901.3014913442134;1085.1373158338981;1089.128697042363;1089.6622047165404;1094.7482079121687;5678.659280443104;6519.087327774116;7037.120359955005;7051.576905385591;7059;6240.875182496416;6311.936880631227;7581.355584775246;7717.382609391235;7820.296173344426;7133.785986420416;7138.072050633385;7162.46281528877;7163.032990546314;7211;3195.1852277669045;3557.48416479609;3742.045778326509;4028.113814960704;4177.060161463646;8265.586720663943;8296.751097467086;8305.916940830515;8321.251087402163;8343.249107580346;7850.960745196352;7881.487703299267;8102.878456823152;8169.387295952827;8192.631331589973;8185.79535511617;8239.505629662359;8257.133001034805;8263.553878071194;8281.503109813431;7860.9213907860185;7882.921170788219;7886;7886.605669716606;7923.049234091715;7470.402367810453;7684.346830519468;7721.884171737541;7733.419993500397;7734.149243583089;7188.28117188277;7317.15852676949;8199.754007379788;8200.343972482067;8204.876926846222;3963.445117683584;4911.115999120049;4922.827701030446;4923.606111511142;4944.802207911644;6322.913438565354;7059.399951004222;7834.334081603128;7852.803679908048;7858.960705196666;5885.47030767233;6252.062190671436;7361.631918404166;7519.872019196945;7572.924270757442;6372.267189273108;7282.235365286569;7499.88750168737;7532.698692052257;7579.621018949141;6161.767646470634;7094.574325540484;7353.191148973501;7372.815679608053;7403.851922961619;7545.773626791205;7553.4712570121765;7571.3942884568005;7571.772846814604;7590.924090759022;7099.148102227766;7387.519811212254;7397.223291554309;7401.59291238987;7425.257474252531 01:40:22 INFO - PROCESS | 2192 | |5;yui.html;696.7039008421419;706.0538877903608;738.7968308715102;787.9921200787994;805.5448671500602;13058.804117938238;15775.290111944976;16065.95571287867;16088.954217975823;16093.678126437464;14365.569032929028;14399.28003599821;14703.779443308358;14825.406983720639;14827.184504852255;766.8044648614596;946.6828612414849;952.0384411744136;967.1634036558362;968.4576637083221;938.2259635800458;938.7324612485443;954.9045095490465;962.0908241711585;963.2534785541227;1031.0926384781383;1031.829748091564;1031.891651376606;1033.405791669789;1033.6588925654553;993.1359717046143;993.9006099390075;1004.5379125602232;1027.4862568715641;1027.825269704152;742.4394582090487;754.3022703998834;762.9084509858797;764.7361660227212;766.9616519174075;15721.528354149279;15777.763333550007;16005.919970400073;16041.117738524377;16089.275982580812;13572.321383930863;13604;13604.727905441934;13610.387532560959;13704.314784260747;8206.548639824807;9110.134537218953;10233.334833235891;10556.10273126785;10576.259661823675;3593.4070878305047;3599.3881040222964;3623.5832879218965;3640.690541303992;3817.1602247505502;66282.66858665676;86500.70248946271;87223.69164462601;87578;88226;9825.606975721033;10009.849852252222;10070.144037756727;10081.647142349982;10323.432211228455;23865.7613423867;23877.641835372484;23883.164089256792;23937.880310598684;23990.04039838422;7598.962005189938;7683.577403242875;7741.303282704471;7893.486923349964;7936.682532698743;3920.2159568086495;4236.639885609696;4240.427542281815;4240.809163587646;4323.178596066738;3818.904527386782;3877.6703980161437;3880.5149356330458;3899.083715326896;3908.8241029153755;672.2235817630644;686.6223577032612;690.5442408010789;692.0657112897649;694.5624256718235;591.4558606082414;595.5414330965133;611.5871786544154;612.8130920069333;619.2074145094286;8154.592270386457;8574.399792014623;8592.8711069334;8678.522681252465;8692.130786921258;552.5717568884066;558.5615291995764;589.8967680655868;615.9753609855645;619.2352444730753;3617.981910090433;3755.8122093895195;3820.9426858597144;3849.4610754494392;4144.191882582867;90446;94116.52941735247;94616.10767784606;94637.58043629352;94981;80184.39631207343;80859.59570202228;81447.37105257862;82201.53395398147;82373;58928.82142357129;63185.368146317946;70809.58380832354;70929;71373;7096.7516136934955;7310.853782924205;7344.045274114331;7385.5937923412575;7429.962850185714;47358.86885090248;50836.983260333844;51299.48700512947;51557.9999999985;51762.482375175765;66617.66691166513;71018.64490677514;71336;71945.6402718004;72409;10563.577456901638;10568.260221784709;10729.892701073202;10807.243492955418;10820.134389248684;11052.336859788438;11256.7748645025;11270.49282782293;11300;12023.819642705192;10356.792864142826;10397.012283833024;10431.68704938853;10442.112420444348;10865.07646849995;10569.894301057198;10663.786724265627;10850.023497885228;10869.565217391215;11127.054200393057;10147.086762191439;10309.896901030894;10497.580096796042;10657.840132397865;10953.671389858317;8529.872051919103;8930.732078037669;9172.403793753385;9203.907960920573;9211.585478653342;8041.477303975223;8323.625436855235;9220.400673956172;9252;9267.073292670679 01:40:22 INFO - PROCESS | 2192 | __end_tp_report 01:40:22 INFO - PROCESS | 2192 | __start_cc_report 01:40:22 INFO - PROCESS | 2192 | _x_x_mozilla_cycle_collect,395 01:40:22 INFO - PROCESS | 2192 | __end_cc_report 01:40:22 INFO - PROCESS | 2192 | __startTimestamp1467103222978__endTimestamp 01:40:22 INFO - PROCESS | 2192 | 01:40:22 INFO - PROCESS | 2192 | ------- Summary: start ------- 01:40:22 INFO - PROCESS | 2192 | Number of tests: 6 01:40:22 INFO - PROCESS | 2192 | 01:40:22 INFO - PROCESS | 2192 | [#0] dojo.html Cycles:165 Average:5911.17 Median:6159.29 stddev:644.87 (10.5%) stddev-sans-first:606.33 01:40:22 INFO - PROCESS | 2192 | Values: 3043.3 3576.0 3649.3 3689.4 3693.3 5927.0 5931.5 5952.6 5962.6 5966.5 5723.0 5937.6 5943.1 6000.2 6003.8 5386.9 5415.1 5418.6 5518.2 5527.3 5321.3 5418.7 5466.9 5516.1 5527.6 5494.5 5523.6 5529.6 5541.6 5549.5 5446.3 5472.8 5485.3 5511.4 5520.4 5252.3 5293.4 5324.8 5365.6 5396.1 4641.9 5761.4 5765.5 5778.6 5862.5 6120.9 6261.3 6305.5 6309.2 6330.3 6287.3 6304.7 6362.8 6395.7 6423.8 6124.1 6127.9 6142.8 6150.5 6166.8 6306.8 6449.9 6510.7 6524.0 6534.9 6179.1 6249.3 6253.8 6263.2 6279.7 6371.9 6380.0 6397.1 6428.6 6431.4 6149.4 6200.5 6216.9 6265.3 6268.3 6262.3 6287.6 6295.9 6301.1 6308.5 4974.7 5101.2 5121.3 5127.2 5128.4 4494.0 4541.7 4600.1 4616.3 4666.7 5882.3 6003.7 6054.2 6090.8 6111.5 6324.6 6367.4 6388.6 6413.1 6413.2 4993.0 5860.2 6027.5 6117.0 6143.9 5050.2 5059.8 5605.2 5618.2 5628.6 5967.8 6361.9 6675.1 6704.6 6705.7 6225.7 6315.1 6342.1 6378.9 6386.0 6618.0 6634.5 6634.7 6639.6 6683.2 6308.2 6311.0 6311.0 6312.8 6319.7 6221.0 6295.3 6338.5 6372.7 6400.8 6165.2 6226.7 6249.5 6250.8 6264.3 6141.7 6183.3 6230.8 6234.2 6259.6 6012.6 6150.2 6159.3 6239.9 6258.2 6217.3 6259.0 6268.8 6269.6 6272.3 6136.8 6146.8 6242.3 6259.9 6292.7 01:40:22 INFO - PROCESS | 2192 | 01:40:22 INFO - PROCESS | 2192 | [#1] ext.html Cycles:180 Average:65662.73 Median:368027.00 stddev:135071.29 (36.7%) stddev-sans-first:135361.62 01:40:22 INFO - PROCESS | 2192 | Values: 510.2 545.0 575.9 578.9 602.1 36063.6 41720.4 41760.2 41849.4 41917.8 43334.3 43757.3 43814.6 43910.1 43965.3 8584.5 9752.1 9879.0 9960.4 10002.6 9828.3 10057.1 10062.8 10080.3 10108.3 10085.0 10109.7 10114.4 10121.6 10143.9 9034.5 9769.6 10031.7 10068.6 10092.4 9986.3 10026.6 10064.5 10101.3 10105.6 41962.8 42099.0 42443.4 42554.1 42710.0 2849.4 2932.9 3266.9 3372.3 3919.9 22694.8 29056.7 29231.4 29240.8 30154.1 2776.6 2785.6 2787.9 2860.7 2879.4 297932.0 363130.0 367386.0 367957.0 368097.0 67109.3 67275.0 67601.0 67710.3 67835.0 64657.7 75380.6 76695.6 77295.0 77635.2 18386.6 18827.4 18933.9 19134.6 19218.1 14245.2 14486.9 14514.3 14568.0 14677.8 21262.4 21357.1 21448.0 21534.1 21873.7 8740.8 8840.1 8888.6 8912.6 8940.0 885.3 976.7 1072.4 1137.9 1156.5 31228.5 31310.8 31374.5 31896.7 32052.7 1160.3 1183.9 1204.0 1266.0 1294.9 15340.7 15919.4 16266.5 16297.9 16422.2 591557.0 641627.0 646801.0 654867.0 654939.0 65330.7 65674.3 66294.7 66428.7 66448.0 1533.4 1559.5 1561.9 1570.8 1579.4 30699.4 30981.8 30998.4 31538.0 31657.5 57285.7 57568.4 57761.0 57877.0 57878.1 484373.0 485474.0 488429.0 488824.6 489552.0 27938.2 44681.3 44765.3 47057.3 47185.5 45056.9 45337.5 45878.9 46649.8 47292.0 38597.0 39218.6 39621.0 39843.0 40319.8 37886.4 38676.4 39056.0 39661.0 39907.0 33671.0 38877.0 39781.4 39884.4 40537.4 28824.8 30516.4 32684.3 34048.8 34083.5 22779.1 25154.6 25542.5 25872.9 26143.1 01:40:22 INFO - PROCESS | 2192 | 01:40:22 INFO - PROCESS | 2192 | [#2] jquery.html Cycles:180 Average:37044.39 Median:21429.86 stddev:93611.93 (436.8%) stddev-sans-first:93834.15 01:40:22 INFO - PROCESS | 2192 | Values: 419.5 420.8 425.5 428.9 430.9 19270.5 19806.2 21512.4 22204.2 22608.2 20922.9 21080.3 21121.2 21486.8 21660.1 5246.8 5501.8 5631.8 5636.2 5640.6 4321.3 5533.6 5600.4 6362.7 7063.8 6919.8 6928.9 6934.2 6985.3 6993.1 6963.6 7496.2 7822.6 7837.6 7980.2 7602.5 7642.6 7656.7 7718.1 7750.8 29367.0 30667.9 30698.7 31414.5 31517.7 2409.8 2496.4 2870.8 3243.5 3255.5 16138.7 16398.3 16764.0 17190.4 17219.5 1948.3 1950.3 1954.8 1960.5 1986.2 131506.7 134837.0 142980.3 145047.3 146405.3 15550.5 22975.4 22994.0 23132.5 23170.8 37015.0 37022.8 37189.9 38811.0 38858.8 10158.2 11383.2 12015.6 12088.1 12186.1 10071.5 10076.0 10125.2 10128.2 10228.3 8567.7 8707.3 10626.8 10727.7 10852.3 3417.6 4069.1 4116.3 4189.5 4332.7 957.3 992.1 1032.0 1092.8 1106.4 19663.5 20328.2 21004.2 21060.9 21372.9 1004.6 1019.4 1033.2 1076.3 1077.9 9206.5 10550.8 11180.6 11467.9 11480.3 520104.0 526253.0 526939.0 568120.0 612643.0 139557.0 144909.0 147301.0 147382.3 152582.0 1035.6 1078.9 1083.1 1085.7 1092.0 17549.9 17601.5 18491.7 18818.0 19497.5 57911.7 58714.0 58773.7 58947.1 59142.7 84851.0 86551.0 86921.0 87583.0 90533.0 8311.9 8362.7 8417.0 8457.6 8464.1 10615.6 12389.9 12686.3 12821.8 13069.9 10953.3 11002.4 11029.0 11169.0 11196.8 10893.8 10948.1 10949.6 11223.3 11272.0 10929.3 11305.8 11548.2 11595.9 11621.5 6944.7 8034.9 8381.9 8394.6 8487.0 10441.7 11465.3 11658.2 11765.9 11834.5 01:40:22 INFO - PROCESS | 2192 | 01:40:22 INFO - PROCESS | 2192 | [#3] mootools.html Cycles:180 Average:5862.10 Median:5065.77 stddev:3258.77 (64.3%) stddev-sans-first:3252.41 01:40:22 INFO - PROCESS | 2192 | Values: 1631.6 1649.2 1908.7 1988.2 2066.7 8267.2 8972.6 9085.9 9211.4 9277.5 8929.4 8995.6 9096.7 9102.1 9112.8 2537.6 2542.4 2546.0 2547.3 2571.5 2513.0 2570.4 2572.8 2582.1 2588.7 2171.5 2535.5 2591.1 2601.6 2604.1 2550.5 2569.5 2570.8 2587.2 2589.4 2546.4 2552.2 2565.0 2575.4 2591.6 9140.1 9205.5 9234.4 9236.2 9250.2 5587.5 5602.1 5617.0 5627.4 5730.5 3623.3 3738.9 3775.5 3782.2 3792.9 1040.4 1060.6 1070.6 1073.8 1080.1 12033.1 12343.6 12384.6 12417.3 12428.6 4978.8 5045.2 5073.2 5111.7 5155.7 10375.0 10418.1 10541.7 10541.7 10572.5 5588.3 5592.8 5616.3 5638.5 5790.6 4642.6 5058.3 5117.1 5142.4 5145.9 4201.5 4205.0 4302.7 4311.8 4330.2 1384.6 1414.7 1418.1 1422.9 1426.6 782.2 832.4 852.0 856.2 858.5 5285.3 5306.9 5351.3 5479.2 5480.8 454.5 479.0 480.6 482.5 482.5 3238.3 3867.8 3983.6 3996.8 4006.3 9306.4 9538.2 10708.9 10711.7 11164.8 10778.7 10825.9 10955.5 10991.8 11014.2 8190.1 8385.8 8476.6 8517.2 8613.5 5817.9 5856.1 5866.1 5912.9 5923.2 9701.5 9759.1 9875.0 9966.8 10095.9 9578.8 10027.4 10095.7 10124.4 10264.0 6449.3 7023.3 7528.8 7679.6 7710.8 8386.9 8437.6 8502.0 8617.2 8664.2 7522.5 7684.9 7712.8 7789.2 7795.8 7516.8 7598.0 7605.3 7639.7 7691.8 7232.0 7293.3 7314.4 7339.7 7346.5 4938.2 4977.2 5057.1 5078.0 5156.3 5029.6 5111.4 5144.3 5147.7 5344.4 01:40:22 INFO - PROCESS | 2192 | 01:40:22 INFO - PROCESS | 2192 | [#4] prototype.html Cycles:180 Average:6037.89 Median:6753.46 stddev:1983.28 (29.4%) stddev-sans-first:1942.20 01:40:23 INFO - PROCESS | 2192 | Values: 341.3 342.5 344.6 348.0 353.2 6303.5 6927.8 6966.2 6971.8 6975.5 6298.0 6483.4 6821.8 6850.8 6886.0 4158.8 4984.3 5120.2 5131.4 5138.9 5052.5 5097.0 5136.2 5136.6 5137.1 4225.8 4942.2 5050.2 5053.2 5083.7 5077.1 5080.1 5091.3 5102.4 5138.5 4391.2 4413.7 4414.7 4434.3 4436.7 6387.9 6698.7 6702.2 6804.8 6850.6 4928.9 5969.1 5969.7 6001.5 6005.2 6308.2 6891.3 7514.7 7532.8 7549.1 4790.2 4806.7 4809.7 4812.0 4814.8 7623.8 7874.4 7934.2 7963.2 7978.0 4813.7 4839.8 4883.3 4883.8 4899.5 4971.9 4972.0 4983.9 4991.6 5005.9 5937.7 5943.4 5943.5 5973.8 6004.3 6127.9 7537.7 7565.4 7590.5 7602.4 1639.7 1706.7 1737.1 1737.7 1741.9 901.3 1085.1 1089.1 1089.7 1094.7 5678.7 6519.1 7037.1 7051.6 7059.0 6240.9 6311.9 7581.4 7717.4 7820.3 7133.8 7138.1 7162.5 7163.0 7211.0 3195.2 3557.5 3742.0 4028.1 4177.1 8265.6 8296.8 8305.9 8321.3 8343.2 7851.0 7881.5 8102.9 8169.4 8192.6 8185.8 8239.5 8257.1 8263.6 8281.5 7860.9 7882.9 7886.0 7886.6 7923.0 7470.4 7684.3 7721.9 7733.4 7734.1 7188.3 7317.2 8199.8 8200.3 8204.9 3963.4 4911.1 4922.8 4923.6 4944.8 6322.9 7059.4 7834.3 7852.8 7859.0 5885.5 6252.1 7361.6 7519.9 7572.9 6372.3 7282.2 7499.9 7532.7 7579.6 6161.8 7094.6 7353.2 7372.8 7403.9 7545.8 7553.5 7571.4 7571.8 7590.9 7099.1 7387.5 7397.2 7401.6 7425.3 01:40:23 INFO - PROCESS | 2192 | 01:40:23 INFO - PROCESS | 2192 | [#5] yui.html Cycles:180 Average:18559.05 Median:555.57 stddev:26290.21 (4732.1%) stddev-sans-first:26329.75 01:40:23 INFO - PROCESS | 2192 | Values: 696.7 706.1 738.8 788.0 805.5 13058.8 15775.3 16066.0 16089.0 16093.7 14365.6 14399.3 14703.8 14825.4 14827.2 766.8 946.7 952.0 967.2 968.5 938.2 938.7 954.9 962.1 963.3 1031.1 1031.8 1031.9 1033.4 1033.7 993.1 993.9 1004.5 1027.5 1027.8 742.4 754.3 762.9 764.7 767.0 15721.5 15777.8 16005.9 16041.1 16089.3 13572.3 13604.0 13604.7 13610.4 13704.3 8206.5 9110.1 10233.3 10556.1 10576.3 3593.4 3599.4 3623.6 3640.7 3817.2 66282.7 86500.7 87223.7 87578.0 88226.0 9825.6 10009.8 10070.1 10081.6 10323.4 23865.8 23877.6 23883.2 23937.9 23990.0 7599.0 7683.6 7741.3 7893.5 7936.7 3920.2 4236.6 4240.4 4240.8 4323.2 3818.9 3877.7 3880.5 3899.1 3908.8 672.2 686.6 690.5 692.1 694.6 591.5 595.5 611.6 612.8 619.2 8154.6 8574.4 8592.9 8678.5 8692.1 552.6 558.6 589.9 616.0 619.2 3618.0 3755.8 3820.9 3849.5 4144.2 90446.0 94116.5 94616.1 94637.6 94981.0 80184.4 80859.6 81447.4 82201.5 82373.0 58928.8 63185.4 70809.6 70929.0 71373.0 7096.8 7310.9 7344.0 7385.6 7430.0 47358.9 50837.0 51299.5 51558.0 51762.5 66617.7 71018.6 71336.0 71945.6 72409.0 10563.6 10568.3 10729.9 10807.2 10820.1 11052.3 11256.8 11270.5 11300.0 12023.8 10356.8 10397.0 10431.7 10442.1 10865.1 10569.9 10663.8 10850.0 10869.6 11127.1 10147.1 10309.9 10497.6 10657.8 10953.7 8529.9 8930.7 9172.4 9203.9 9211.6 8041.5 8323.6 9220.4 9252.0 9267.1 01:40:23 INFO - PROCESS | 2192 | -------- Summary: end -------- 01:40:23 INFO - PROCESS | 2192 | 01:40:23 INFO - TEST-INFO | 2192: exit 0 01:40:23 INFO - TEST-OK | dromaeo_css | took 1109706ms 01:40:23 INFO - TEST-START | kraken 01:40:23 INFO - operating with platform_type : mac_ 01:40:23 INFO - Initialising browser for kraken test... 01:40:23 INFO - TEST-INFO | started process 2312 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpmFRFem/profile http://localhost:55974/getInfo.html) 01:40:26 INFO - PROCESS | 2312 | __metrics Screen width/height:1600/1200 01:40:26 INFO - PROCESS | 2312 | colorDepth:24 01:40:26 INFO - PROCESS | 2312 | Browser inner width/height: 1024/689 01:40:26 INFO - PROCESS | 2312 | __metrics 01:40:26 ERROR - PROCESS | 2312 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 01:40:26 INFO - TEST-INFO | 2312: exit 0 01:40:26 INFO - Browser initialized. 01:40:26 INFO - Running cycle 1/1 for kraken test... 01:40:26 INFO - TEST-INFO | started process 2316 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpmFRFem/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:40:38 INFO - PROCESS | 2316 | RSS: Main: 171028480 01:40:38 INFO - PROCESS | 2316 | 01:40:41 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55974/tests/kraken/driver.html?testName=audio-beat-detection) 01:40:42 INFO - PROCESS | 2316 | RSS: Main: 183619584 01:40:42 INFO - PROCESS | 2316 | 01:40:45 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55974/tests/kraken/driver.html?testName=audio-dft) 01:40:45 INFO - PROCESS | 2316 | RSS: Main: 192315392 01:40:45 INFO - PROCESS | 2316 | 01:40:49 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55974/tests/kraken/driver.html?testName=audio-fft) 01:40:49 INFO - PROCESS | 2316 | RSS: Main: 196419584 01:40:49 INFO - PROCESS | 2316 | 01:40:51 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55974/tests/kraken/driver.html?testName=audio-oscillator) 01:40:52 INFO - PROCESS | 2316 | RSS: Main: 196521984 01:40:52 INFO - PROCESS | 2316 | 01:40:54 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55974/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:40:55 INFO - PROCESS | 2316 | RSS: Main: 198057984 01:40:55 INFO - PROCESS | 2316 | 01:40:58 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55974/tests/kraken/driver.html?testName=imaging-darkroom) 01:40:58 INFO - PROCESS | 2316 | RSS: Main: 197701632 01:40:58 INFO - PROCESS | 2316 | 01:41:01 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55974/tests/kraken/driver.html?testName=imaging-desaturate) 01:41:02 INFO - PROCESS | 2316 | RSS: Main: 197820416 01:41:02 INFO - PROCESS | 2316 | 01:41:04 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55974/tests/kraken/driver.html?testName=json-parse-financial) 01:41:05 INFO - PROCESS | 2316 | RSS: Main: 198504448 01:41:05 INFO - PROCESS | 2316 | 01:41:07 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55974/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:41:08 INFO - PROCESS | 2316 | RSS: Main: 197931008 01:41:08 INFO - PROCESS | 2316 | 01:41:09 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55974/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:41:10 INFO - PROCESS | 2316 | RSS: Main: 198316032 01:41:10 INFO - PROCESS | 2316 | 01:41:12 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55974/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:41:13 INFO - PROCESS | 2316 | RSS: Main: 197668864 01:41:13 INFO - PROCESS | 2316 | 01:41:16 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:41:16 INFO - PROCESS | 2316 | RSS: Main: 197799936 01:41:16 INFO - PROCESS | 2316 | 01:41:19 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:41:20 INFO - PROCESS | 2316 | RSS: Main: 197730304 01:41:20 INFO - PROCESS | 2316 | 01:41:21 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:55974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55974/tests/kraken/driver.html?testName=ai-astar) 01:41:22 INFO - PROCESS | 2316 | RSS: Main: 199467008 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | __start_tp_report 01:41:22 INFO - PROCESS | 2316 | _x_x_mozilla_page_load 01:41:22 INFO - PROCESS | 2316 | _x_x_mozilla_page_load_details 01:41:22 INFO - PROCESS | 2316 | |i|pagename|runs| 01:41:22 INFO - PROCESS | 2316 | |0;ai-astar;113;119;106;116;118;115;105;116;127;165 01:41:22 INFO - PROCESS | 2316 | |1;audio-beat-detection;150;121;140;159;122;168;153;158;165;146 01:41:22 INFO - PROCESS | 2316 | |2;audio-dft;199;204;263;280;197;198;198;194;197;191 01:41:22 INFO - PROCESS | 2316 | |3;audio-fft;66;82;110;185;45;55;71;90;142;58 01:41:22 INFO - PROCESS | 2316 | |4;audio-oscillator;77;81;128;77;80;79;122;80;81;115 01:41:22 INFO - PROCESS | 2316 | |5;imaging-gaussian-blur;136;127;88;85;89;85;89;86;107;129 01:41:22 INFO - PROCESS | 2316 | |6;imaging-darkroom;95;94;95;127;132;97;139;148;94;94 01:41:22 INFO - PROCESS | 2316 | |7;imaging-desaturate;91;92;96;91;90;86;89;90;91;84 01:41:22 INFO - PROCESS | 2316 | |8;json-parse-financial;59;62;68;97;97;95;98;107;89;60 01:41:22 INFO - PROCESS | 2316 | |9;json-stringify-tinderbox;73;92;90;97;101;77;70;80;68;65 01:41:22 INFO - PROCESS | 2316 | |10;stanford-crypto-aes;90;103;103;81;80;79;82;80;82;86 01:41:22 INFO - PROCESS | 2316 | |11;stanford-crypto-ccm;126;124;151;114;149;116;151;143;168;168 01:41:22 INFO - PROCESS | 2316 | |12;stanford-crypto-pbkdf2;161;164;164;163;166;161;160;163;165;163 01:41:22 INFO - PROCESS | 2316 | |13;stanford-crypto-sha256-iterative;67;65;66;67;74;61;57;93;90;93 01:41:22 INFO - PROCESS | 2316 | __end_tp_report 01:41:22 INFO - PROCESS | 2316 | __start_cc_report 01:41:22 INFO - PROCESS | 2316 | _x_x_mozilla_cycle_collect,1031 01:41:22 INFO - PROCESS | 2316 | __end_cc_report 01:41:22 INFO - PROCESS | 2316 | __startTimestamp1467103282201__endTimestamp 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | ------- Summary: start ------- 01:41:22 INFO - PROCESS | 2316 | Number of tests: 14 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#0] ai-astar Cycles:10 Average:120.00 Median:117.00 stddev:17.02 (14.5%) stddev-sans-first:17.86 01:41:22 INFO - PROCESS | 2316 | Values: 113.0 119.0 106.0 116.0 118.0 115.0 105.0 116.0 127.0 165.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:155.50 stddev:16.37 (10.5%) stddev-sans-first:17.35 01:41:22 INFO - PROCESS | 2316 | Values: 150.0 121.0 140.0 159.0 122.0 168.0 153.0 158.0 165.0 146.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#2] audio-dft Cycles:10 Average:212.10 Median:198.50 stddev:31.74 (16.0%) stddev-sans-first:33.31 01:41:22 INFO - PROCESS | 2316 | Values: 199.0 204.0 263.0 280.0 197.0 198.0 198.0 194.0 197.0 191.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#3] audio-fft Cycles:10 Average:90.40 Median:62.00 stddev:43.97 (70.9%) stddev-sans-first:45.75 01:41:22 INFO - PROCESS | 2316 | Values: 66.0 82.0 110.0 185.0 45.0 55.0 71.0 90.0 142.0 58.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:79.50 stddev:20.75 (26.1%) stddev-sans-first:21.28 01:41:22 INFO - PROCESS | 2316 | Values: 77.0 81.0 128.0 77.0 80.0 79.0 122.0 80.0 81.0 115.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#5] imaging-gaussian-blur Cycles:10 Average:102.10 Median:85.50 stddev:20.82 (24.4%) stddev-sans-first:18.12 01:41:22 INFO - PROCESS | 2316 | Values: 136.0 127.0 88.0 85.0 89.0 85.0 89.0 86.0 107.0 129.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#6] imaging-darkroom Cycles:10 Average:111.50 Median:94.00 stddev:22.17 (23.6%) stddev-sans-first:22.69 01:41:22 INFO - PROCESS | 2316 | Values: 95.0 94.0 95.0 127.0 132.0 97.0 139.0 148.0 94.0 94.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#7] imaging-desaturate Cycles:10 Average:90.00 Median:91.00 stddev:3.27 (3.6%) stddev-sans-first:3.44 01:41:22 INFO - PROCESS | 2316 | Values: 91.0 92.0 96.0 91.0 90.0 86.0 89.0 90.0 91.0 84.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#8] json-parse-financial Cycles:10 Average:83.20 Median:92.00 stddev:18.69 (20.3%) stddev-sans-first:17.65 01:41:22 INFO - PROCESS | 2316 | Values: 59.0 62.0 68.0 97.0 97.0 95.0 98.0 107.0 89.0 60.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:78.50 stddev:12.84 (16.4%) stddev-sans-first:13.26 01:41:22 INFO - PROCESS | 2316 | Values: 73.0 92.0 90.0 97.0 101.0 77.0 70.0 80.0 68.0 65.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:81.50 stddev:9.24 (11.3%) stddev-sans-first:9.72 01:41:22 INFO - PROCESS | 2316 | Values: 90.0 103.0 103.0 81.0 80.0 79.0 82.0 80.0 82.0 86.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:150.00 stddev:19.98 (13.3%) stddev-sans-first:20.45 01:41:22 INFO - PROCESS | 2316 | Values: 126.0 124.0 151.0 114.0 149.0 116.0 151.0 143.0 168.0 168.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:163.50 stddev:1.89 (1.2%) stddev-sans-first:1.86 01:41:22 INFO - PROCESS | 2316 | Values: 161.0 164.0 164.0 163.0 166.0 161.0 160.0 163.0 165.0 163.0 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - PROCESS | 2316 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:70.50 stddev:13.64 (19.3%) stddev-sans-first:14.27 01:41:22 INFO - PROCESS | 2316 | Values: 67.0 65.0 66.0 67.0 74.0 61.0 57.0 93.0 90.0 93.0 01:41:22 INFO - PROCESS | 2316 | -------- Summary: end -------- 01:41:22 INFO - PROCESS | 2316 | 01:41:22 INFO - TEST-INFO | 2316: exit 0 01:41:22 INFO - TEST-OK | kraken | took 59395ms 01:41:22 INFO - SUITE-END | took 1169s 01:41:23 INFO - Completed test suite (00:19:29) 01:41:23 INFO - javascript benchmark 01:41:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.254402671346, 3575.9642403575963, 3649.288388764192, 3689.391250443677, 3693.2982733280674, 5926.970365148179, 5931.466168044875, 5952.642841429517, 5962.64224146551, 5966.5226781857455, 5722.971385143079, 5937.64374137552, 5943.078822782465, 6000.219971403722, 6003.789867354643, 5386.91919621205, 5415.13357862742, 5418.593605479585, 5518.227448157261, 5527.336719593654, 5321.255024296602, 5418.674879507223, 5466.9179962300595, 5516.089845175541, 5527.55779537636, 5494.450554944514, 5523.613347065707, 5529.557635389179, 5541.556675465953, 5549.528290095347, 5446.2647542582035, 5472.781088756445, 5485.286912701363, 5511.4213007634025, 5520.420355862617, 5252.3171987641745, 5293.39126000511, 5324.760385782649, 5365.624406291561, 5396.136618141118, 4641.885947372606, 5761.366249712528, 5765.509931655814, 5778.566607504454, 5862.50168735658, 6120.904292401164, 6261.311255761862, 6305.527085468608, 6309.242890853081, 6330.272018717815, 6287.276963149205, 6304.747810087591, 6362.809115726489, 6395.680215989229, 6423.8394040148905, 6124.050772130327, 6127.938720612826, 6142.846428839315, 6150.50795936324, 6166.784162554289, 6306.779262725782, 6449.935500644933, 6510.707018184098, 6524.0, 6534.901976470357, 6179.073139029092, 6249.312575616678, 6253.843653908598, 6263.217097862767, 6279.7488100476385, 6371.872562548723, 6380.0, 6397.10440538325, 6428.614283142932, 6431.356864313625, 6149.385061493905, 6200.543402812169, 6216.906746398808, 6265.342139075423, 6268.310485846553, 6262.342454042351, 6287.559870808999, 6295.874082518324, 6301.054841773679, 6308.526860485482, 4974.701517908937, 5101.234814777738, 5121.28302037715, 5127.2052831811125, 5128.410232823198, 4493.955060449419, 4541.704789188692, 4600.079984003212, 4616.330632058332, 4666.673332866734, 5882.264716910387, 6003.699815009232, 6054.152418661391, 6090.817275481742, 6111.5309653553995, 6324.557280990287, 6367.363263673688, 6388.5528013039575, 6413.134226879311, 6413.198350206224, 4992.950070499249, 5860.238169037998, 6027.547933904887, 6117.0, 6143.877122457615, 5050.242463630485, 5059.797608095709, 5605.243292155588, 5618.241537392481, 5628.577856660767, 5967.8209653710455, 6361.872762544724, 6675.132232809704, 6704.564203326768, 6705.731770729214, 6225.719842607185, 6315.147455093504, 6342.112104305494, 6378.87242255143, 6385.96807015962, 6618.0, 6634.5024123191915, 6634.668266586555, 6639.568428052161, 6683.231428385798, 6308.243010838729, 6310.968445157745, 6311.0, 6312.779052733133, 6319.715612797527, 6221.0, 6295.3389894060465, 6338.492920566436, 6372.713227904848, 6400.839979000562, 6165.167702360124, 6226.688665566794, 6249.531285153541, 6250.781222657185, 6264.342244064308, 6141.700809433504, 6183.258009038944, 6230.844228894132, 6234.1583886174785, 6259.593126446766, 6012.6392416455155, 6150.169727086786, 6159.29168145669, 6239.875202495834, 6258.249010118815, 6217.253929528486, 6259.0, 6268.811935641938, 6269.5611307208055, 6272.341404152681, 6136.825445958321, 6146.846328841814, 6242.3133455320785, 6259.937400625936, 6292.748290068529], "value": 5871.7039073441565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.15059925224506, 545.0298468725668, 575.8827873924587, 578.884223155369, 602.1209034809178, 36063.63936360636, 41720.37419438711, 41760.16479670405, 41849.37225941606, 41917.79041104794, 43334.34998475025, 43757.34363984535, 43814.56185438145, 43910.12179756411, 43965.34051989223, 8584.527850968194, 9752.073553012488, 9879.0, 9960.402375857435, 10002.59989600415, 9828.262880283972, 10057.145142662846, 10062.849057264148, 10080.344777589433, 10108.292419530635, 10085.041921017491, 10109.696709098738, 10114.44370559619, 10121.595136194543, 10143.949280253588, 9034.45793252407, 9769.632251484762, 10031.69904902854, 10068.597256109746, 10092.444915529642, 9986.300958932878, 10026.649067282682, 10064.496775161213, 10101.292909496338, 10105.646302379382, 41962.79018604887, 42099.0, 42443.36334954978, 42554.1489170218, 42710.0, 2849.387381712921, 2932.88268469261, 3266.869325227012, 3372.308676721291, 3919.9216015679813, 22694.773052269433, 29056.709432905824, 29231.41537169266, 29240.830366785303, 30154.09537713872, 2776.5973933779487, 2785.637867077267, 2787.916362509128, 2860.699626539225, 2879.3809330993936, 297932.0, 363130.0, 367386.0, 367956.9999999973, 368097.0, 67109.32890671128, 67275.0, 67601.0, 67710.3228967704, 67835.0, 64657.67671161614, 75380.62309688417, 76695.61652191814, 77295.0, 77635.22364776392, 18386.632267354576, 18827.435176944713, 18933.90533047326, 19134.61730765377, 19218.13518391676, 14245.216513091673, 14486.927565362106, 14514.274286285643, 14567.980241383213, 14677.77983330251, 21262.362129136152, 21357.14571417157, 21448.0, 21534.13863445476, 21873.67189492159, 8740.78148046304, 8840.115988401109, 8888.60001299943, 8912.598933048028, 8939.971903231082, 885.2652298592153, 976.7216343342113, 1072.3619446429361, 1137.9317240965568, 1156.525824411987, 31228.531572026437, 31310.843445782626, 31374.52938205929, 31896.681033189834, 32052.67947320497, 1160.3328086350214, 1183.9348835813942, 1204.030755242021, 1265.9936700316623, 1294.8575656677758, 15340.696040836654, 15919.363225470852, 16266.512004639642, 16297.918510407371, 16422.1788910554, 591557.0422147862, 641627.0, 646801.0, 654867.0, 654939.0, 65330.67334663296, 65674.34325656778, 66294.66852665802, 66428.66785666041, 66448.0, 1533.4249656378859, 1559.485369827954, 1561.9467481884492, 1570.8115026196701, 1579.4156162219822, 30699.38601227918, 30981.8450907744, 30998.380032399677, 31538.0, 31657.525137122502, 57285.71357143188, 57568.4243157563, 57761.0, 57877.0, 57878.131828021775, 484373.0, 485474.0, 488429.0, 488824.5558772183, 489552.0, 27938.16185514438, 44681.32978005397, 44765.328520071576, 47057.29414058723, 47185.52814471811, 45056.873578159495, 45337.54662453333, 45878.85302867455, 46649.766751166026, 47292.0, 38597.0, 39218.607813921495, 39621.0, 39843.00392490211, 40319.79840100781, 37886.43170352502, 38676.41985370278, 39056.0, 39661.00847478836, 39907.0, 33670.98987030393, 38877.0, 39781.40327895142, 39884.40173397459, 40537.391939121524, 28824.84700612036, 30516.389672205987, 32684.346313074082, 34048.82975585106, 34083.488747669304, 22779.08883644702, 25154.62268065944, 25542.489150217265, 25872.870635647454, 26143.08499202519], "value": 20909.606216586897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.4819398043416, 420.8127383314425, 425.4766637036443, 428.93780401841735, 430.8836614114189, 19270.51823704408, 19806.207751689934, 21512.432146299307, 22204.222852200175, 22608.208712695057, 20922.89538552309, 21080.262190823323, 21121.15515379387, 21486.785132148674, 21660.133594656196, 5246.816361427351, 5501.834944951638, 5631.831045068634, 5636.15457681347, 5640.605157638967, 4321.330193819947, 5533.6403133796375, 5600.355959064698, 6362.713677884506, 7063.788086357417, 6919.757808476705, 6928.9307106929045, 6934.237233904267, 6985.266547012567, 6993.055937448456, 6963.617001064939, 7496.212897645751, 7822.647980840876, 7837.608119593998, 7980.162082981319, 7602.50583712057, 7642.617869106522, 7656.693732250703, 7718.073831140299, 7750.7674769756995, 29367.0, 30667.926622568102, 30698.693013069806, 31414.528782068286, 31517.684823151703, 2409.807215422762, 2496.3509487533192, 2870.7559857412143, 3243.50178616804, 3255.4953982132806, 16138.677226455522, 16398.344066237336, 16764.0, 17190.398336058304, 17219.483415497554, 1948.3375652278294, 1950.3271371376852, 1954.7556555430572, 1960.4739955290984, 1986.2452268138015, 131506.6849331504, 134837.0, 142980.28509857488, 145047.27476362657, 146405.26797366052, 15550.455734049254, 22975.42561435944, 22994.0, 23132.53734925292, 23170.7682923172, 37015.0, 37022.8148859254, 37189.88430347094, 38811.0, 38858.80570597129, 10158.187345012382, 11383.203175777782, 12015.639530814089, 12088.09339299556, 12186.146969712212, 10071.496425178711, 10076.0, 10125.240606954509, 10128.240381971382, 10228.335158214692, 8567.657293708182, 8707.259882910024, 10626.840597391045, 10727.678169654766, 10852.348859068481, 3417.572803399575, 4069.084455997436, 4116.279651061052, 4189.455370801777, 4332.653387729038, 957.2724729205854, 992.1071036067597, 1032.0, 1092.8032954068344, 1106.372365631625, 19663.508412289808, 20328.186872525228, 21004.159833606485, 21060.946952652306, 21372.931353432577, 1004.5735056220185, 1019.4036488654073, 1033.1579762493543, 1076.2573824061374, 1077.9191560632828, 9206.539673016323, 10550.786659534251, 11180.608678696206, 11467.910548497879, 11480.311181329147, 520104.0, 526253.0, 526939.0, 568120.0, 612643.0, 139557.0, 144909.0, 147301.0, 147382.26308868386, 152582.0, 1035.5805898611075, 1078.946052697362, 1083.0793825248477, 1085.6634443322596, 1092.0280949954547, 17549.859259148114, 17601.471955841345, 18491.72262416038, 18817.965011924476, 19497.512562186057, 57911.710441447525, 58714.0, 58773.706131469065, 58947.11579326399, 59142.70428647829, 84851.0, 86551.0, 86921.0, 87583.0, 90533.0, 8311.875321870057, 8362.707305244287, 8417.0, 8457.619407126816, 8464.111268316738, 10615.628453004108, 12389.93805030969, 12686.302253376152, 12821.807672885101, 13069.869301306866, 10953.288036277616, 11002.394868282321, 11029.0, 11169.0, 11196.776064478829, 10893.836592450962, 10948.124150068135, 10949.616763413562, 11223.270487418291, 11271.985521302795, 10929.289596176222, 11305.773884522428, 11548.191626586058, 11595.942020289845, 11621.477033533341, 6944.722211111499, 8034.879476807736, 8381.91035165449, 8394.58027098655, 8486.957565212135, 10441.68674939753, 11465.312081274817, 11658.242214256046, 11765.941065304163, 11834.46744896499], "value": 11363.65723012199, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1631.6422769098654, 1649.224864313772, 1908.6564418404682, 1988.2444671025016, 2066.7106605075282, 8267.214614611603, 8972.551372431368, 9085.863712044316, 9211.355205135644, 9277.489738064403, 8929.419587726794, 8995.640174393016, 9096.727098187048, 9102.089791020895, 9112.815334006586, 2537.644729737829, 2542.3517003164166, 2546.0, 2547.2740269023334, 2571.54997875372, 2512.9748702513016, 2570.370259286468, 2572.7555882191164, 2582.0575489946127, 2588.7281835407293, 2171.4896999205175, 2535.518251532203, 2591.1190195333584, 2601.5967525033557, 2604.1406335909105, 2550.4899020196035, 2569.5117927593697, 2570.794336453098, 2587.236765154284, 2589.4303253284343, 2546.3506805764596, 2552.2470871093074, 2564.9615255771178, 2575.407656239057, 2591.6242144889075, 9140.085991400872, 9205.493697846683, 9234.445933244027, 9236.21492173166, 9250.167484926389, 5587.469190426944, 5602.075657516546, 5616.98894199044, 5627.437256274381, 5730.484256416901, 3623.2572322673786, 3738.9065273368383, 3775.528058992626, 3782.205736795276, 3792.924141517154, 1040.4433628008978, 1060.6158962553864, 1070.5610699613198, 1073.8174510333183, 1080.0603474976742, 12033.097517686208, 12343.567975120828, 12384.62846114618, 12417.317047562381, 12428.627141185689, 4978.800847966113, 5045.167547354646, 5073.188289873677, 5111.718855462911, 5155.716435596003, 10375.0, 10418.11446027081, 10541.683749487527, 10541.736456588493, 10572.471376431147, 5588.329400471969, 5592.804251851166, 5616.269884914935, 5638.464345887134, 5790.594658373958, 4642.558956899089, 5058.342415485963, 5117.078925793318, 5142.434332223453, 5145.9193569350855, 4201.474815648044, 4205.0, 4302.67729920251, 4311.784410779448, 4330.242207613655, 1384.5915454940816, 1414.724128794875, 1418.1136789506559, 1422.879055280292, 1426.5720283914784, 782.2099679323924, 832.3715594725943, 851.9616617252238, 856.208007592974, 858.4891989266376, 5285.312909321764, 5306.92039619406, 5351.331083614548, 5479.150731636602, 5480.808171713971, 454.4682721216119, 479.03235464361796, 480.5607206416804, 482.4692837878376, 482.5150723522837, 3238.2713889374704, 3867.7722190109894, 3983.5817239190046, 3996.84012639497, 4006.338954072545, 9306.395084319498, 9538.236941044699, 10708.946455267675, 10711.73220669474, 11164.776704466027, 10778.730531736612, 10825.945870270756, 10955.4522273886, 10991.780164396667, 11014.229003969805, 8190.140035296208, 8385.790355241168, 8476.576171191293, 8517.190866867637, 8613.483191008434, 5817.912731308949, 5856.092305692625, 5866.149408335853, 5912.881742365214, 5923.229980102731, 9701.514924253901, 9759.072888075621, 9874.975629995977, 9966.800663986825, 10095.949520252352, 9578.760530986503, 10027.44849033281, 10095.7476063099, 10124.443155626512, 10263.973602639677, 6449.290578036318, 7023.29767023314, 7528.774136775905, 7679.577623230776, 7710.807229819299, 8386.874196886929, 8437.578121093798, 8502.0, 8617.224449799549, 8664.176903194186, 7522.473426860286, 7684.884726729216, 7712.845743084995, 7789.221077892165, 7795.805104872424, 7516.774496765106, 7597.962010189914, 7605.277498637621, 7639.732609358646, 7691.807769795467, 7231.963840180765, 7293.270672932665, 7314.37827784623, 7339.669714862951, 7346.485745997943, 4938.234573641092, 4977.228529577921, 5057.064443078042, 5077.974610126926, 5156.329677141947, 5029.572486338556, 5111.361079865017, 5144.30551875492, 5147.6654017488745, 5344.3586769586345], "value": 4662.069812628151, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.25095415562834, 342.4862705941088, 344.56412638012904, 347.9947800782988, 353.15243415802087, 6303.464205542528, 6927.792166235021, 6966.198887127982, 6971.790846274607, 6975.511714180009, 6298.02380631003, 6483.448906842924, 6821.8402871511835, 6850.82872928177, 6886.0, 4158.792060396976, 4984.32711583937, 5120.15517439622, 5131.3842338919385, 5138.922916156261, 5052.494750524955, 5096.974515127437, 5136.178211486163, 5136.58907287418, 5137.101007323722, 4225.7887105644595, 4942.233953737176, 5050.242463630448, 5053.242013697938, 5083.720395378253, 5077.096088966638, 5080.110980578403, 5091.287219789232, 5102.413222479426, 5138.511841375063, 4391.231534481453, 4413.713108647959, 4414.668899832525, 4434.312681534368, 4436.689431739779, 6387.872242555123, 6698.665066746643, 6702.162229721285, 6804.761833335859, 6850.623215723133, 4928.866360737051, 5969.104634304846, 5969.701514924236, 6001.48987336077, 6005.249343832021, 6308.211473565804, 6891.345322194384, 7514.6618402172035, 7532.8116797079965, 7549.0563679540055, 4790.185668436374, 4806.687565308279, 4809.687370320953, 4812.0375924814825, 4814.807407703687, 7623.771286861458, 7874.448788584801, 7934.206579342077, 7963.243491868321, 7977.960110199412, 4813.687110337817, 4839.758012099381, 4883.316335713003, 4883.755812209446, 4899.461059283476, 4971.925421118686, 4971.950280497221, 4983.875403114951, 4991.550760431506, 5005.874853128628, 5937.732802023919, 5943.405659434022, 5943.465088142088, 5973.820785376446, 6004.279486461653, 6127.938720612737, 7537.736179233701, 7565.356944659656, 7590.544567325867, 7602.391808655294, 1639.7048531264486, 1706.7269236922034, 1737.1487970894423, 1737.7393390991454, 1741.8780685351903, 901.3014913442134, 1085.1373158338981, 1089.128697042363, 1089.6622047165404, 1094.7482079121687, 5678.659280443104, 6519.087327774116, 7037.120359955005, 7051.576905385591, 7059.0, 6240.875182496416, 6311.936880631227, 7581.355584775246, 7717.382609391235, 7820.296173344426, 7133.785986420416, 7138.072050633385, 7162.46281528877, 7163.032990546314, 7211.0, 3195.1852277669045, 3557.48416479609, 3742.045778326509, 4028.113814960704, 4177.060161463646, 8265.586720663943, 8296.751097467086, 8305.916940830515, 8321.251087402163, 8343.249107580346, 7850.960745196352, 7881.487703299267, 8102.878456823152, 8169.387295952827, 8192.631331589973, 8185.79535511617, 8239.505629662359, 8257.133001034805, 8263.553878071194, 8281.503109813431, 7860.9213907860185, 7882.921170788219, 7886.0, 7886.605669716606, 7923.049234091715, 7470.402367810453, 7684.346830519468, 7721.884171737541, 7733.419993500397, 7734.149243583089, 7188.28117188277, 7317.15852676949, 8199.754007379788, 8200.343972482067, 8204.876926846222, 3963.445117683584, 4911.115999120049, 4922.827701030446, 4923.606111511142, 4944.802207911644, 6322.913438565354, 7059.399951004222, 7834.334081603128, 7852.803679908048, 7858.960705196666, 5885.47030767233, 6252.062190671436, 7361.631918404166, 7519.872019196945, 7572.924270757442, 6372.267189273108, 7282.235365286569, 7499.88750168737, 7532.698692052257, 7579.621018949141, 6161.767646470634, 7094.574325540484, 7353.191148973501, 7372.815679608053, 7403.851922961619, 7545.773626791205, 7553.4712570121765, 7571.3942884568005, 7571.772846814604, 7590.924090759022, 7099.148102227766, 7387.519811212254, 7397.223291554309, 7401.59291238987, 7425.257474252531], "value": 5375.808047263694, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.7039008421419, 706.0538877903608, 738.7968308715102, 787.9921200787994, 805.5448671500602, 13058.804117938238, 15775.290111944976, 16065.95571287867, 16088.954217975823, 16093.678126437464, 14365.569032929028, 14399.28003599821, 14703.779443308358, 14825.406983720639, 14827.184504852255, 766.8044648614596, 946.6828612414849, 952.0384411744136, 967.1634036558362, 968.4576637083221, 938.2259635800458, 938.7324612485443, 954.9045095490465, 962.0908241711585, 963.2534785541227, 1031.0926384781383, 1031.829748091564, 1031.891651376606, 1033.405791669789, 1033.6588925654553, 993.1359717046143, 993.9006099390075, 1004.5379125602232, 1027.4862568715641, 1027.825269704152, 742.4394582090487, 754.3022703998834, 762.9084509858797, 764.7361660227212, 766.9616519174075, 15721.528354149279, 15777.763333550007, 16005.919970400073, 16041.117738524377, 16089.275982580812, 13572.321383930863, 13604.0, 13604.727905441934, 13610.387532560959, 13704.314784260747, 8206.548639824807, 9110.134537218953, 10233.334833235891, 10556.10273126785, 10576.259661823675, 3593.4070878305047, 3599.3881040222964, 3623.5832879218965, 3640.690541303992, 3817.1602247505502, 66282.66858665676, 86500.70248946271, 87223.69164462601, 87578.0, 88226.0, 9825.606975721033, 10009.849852252222, 10070.144037756727, 10081.647142349982, 10323.432211228455, 23865.7613423867, 23877.641835372484, 23883.164089256792, 23937.880310598684, 23990.04039838422, 7598.962005189938, 7683.577403242875, 7741.303282704471, 7893.486923349964, 7936.682532698743, 3920.2159568086495, 4236.639885609696, 4240.427542281815, 4240.809163587646, 4323.178596066738, 3818.904527386782, 3877.6703980161437, 3880.5149356330458, 3899.083715326896, 3908.8241029153755, 672.2235817630644, 686.6223577032612, 690.5442408010789, 692.0657112897649, 694.5624256718235, 591.4558606082414, 595.5414330965133, 611.5871786544154, 612.8130920069333, 619.2074145094286, 8154.592270386457, 8574.399792014623, 8592.8711069334, 8678.522681252465, 8692.130786921258, 552.5717568884066, 558.5615291995764, 589.8967680655868, 615.9753609855645, 619.2352444730753, 3617.981910090433, 3755.8122093895195, 3820.9426858597144, 3849.4610754494392, 4144.191882582867, 90446.0, 94116.52941735247, 94616.10767784606, 94637.58043629352, 94981.0, 80184.39631207343, 80859.59570202228, 81447.37105257862, 82201.53395398147, 82373.0, 58928.82142357129, 63185.368146317946, 70809.58380832354, 70929.0, 71373.0, 7096.7516136934955, 7310.853782924205, 7344.045274114331, 7385.5937923412575, 7429.962850185714, 47358.86885090248, 50836.983260333844, 51299.48700512947, 51557.9999999985, 51762.482375175765, 66617.66691166513, 71018.64490677514, 71336.0, 71945.6402718004, 72409.0, 10563.577456901638, 10568.260221784709, 10729.892701073202, 10807.243492955418, 10820.134389248684, 11052.336859788438, 11256.7748645025, 11270.49282782293, 11300.0, 12023.819642705192, 10356.792864142826, 10397.012283833024, 10431.68704938853, 10442.112420444348, 10865.07646849995, 10569.894301057198, 10663.786724265627, 10850.023497885228, 10869.565217391215, 11127.054200393057, 10147.086762191439, 10309.896901030894, 10497.580096796042, 10657.840132397865, 10953.671389858317, 8529.872051919103, 8930.732078037669, 9172.403793753385, 9203.907960920573, 9211.585478653342, 8041.477303975223, 8323.625436855235, 9220.400673956172, 9252.0, 9267.073292670679], "value": 7013.343100635747, "unit": "score"}], "name": "dromaeo_css", "value": 7911.6888350015715, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 119.0, 106.0, 116.0, 118.0, 115.0, 105.0, 116.0, 127.0, 165.0], "value": 120.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 140.0, 159.0, 122.0, 168.0, 153.0, 158.0, 165.0, 146.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 204.0, 263.0, 280.0, 197.0, 198.0, 198.0, 194.0, 197.0, 191.0], "value": 212.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 82.0, 110.0, 185.0, 45.0, 55.0, 71.0, 90.0, 142.0, 58.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 128.0, 77.0, 80.0, 79.0, 122.0, 80.0, 81.0, 115.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 127.0, 88.0, 85.0, 89.0, 85.0, 89.0, 86.0, 107.0, 129.0], "value": 102.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 127.0, 132.0, 97.0, 139.0, 148.0, 94.0, 94.0], "value": 111.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 96.0, 91.0, 90.0, 86.0, 89.0, 90.0, 91.0, 84.0], "value": 90.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 68.0, 97.0, 97.0, 95.0, 98.0, 107.0, 89.0, 60.0], "value": 83.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 92.0, 90.0, 97.0, 101.0, 77.0, 70.0, 80.0, 68.0, 65.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 103.0, 103.0, 81.0, 80.0, 79.0, 82.0, 80.0, 82.0, 86.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 124.0, 151.0, 114.0, 149.0, 116.0, 151.0, 143.0, 168.0, 168.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 164.0, 163.0, 166.0, 161.0, 160.0, 163.0, 165.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 67.0, 74.0, 61.0, 57.0, 93.0, 90.0, 93.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1594.6999999999998, "alertThreshold": 2.0}]} 01:41:23 INFO - Return code: 0 01:41:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:41:23 ERROR - # TBPL SUCCESS # 01:41:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:41:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:41:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:41:23 INFO - 2016-06-28 01:41:23.492 screenresolution[2327:23063] starting screenresolution argv=screenresolution get 01:41:23 INFO - 2016-06-28 01:41:23.495 screenresolution[2327:23063] Display 0: 1600x1200x32@60 01:41:23 INFO - 2016-06-28 01:41:23.501 screenresolution[2328:23066] starting screenresolution argv=screenresolution list 01:41:23 INFO - Available Modes on Display 0 01:41:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:41:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:41:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:41:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:41:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:41:23 INFO - Intel Iris: 01:41:23 INFO - Chipset Model: Intel Iris 01:41:23 INFO - Type: GPU 01:41:23 INFO - Bus: Built-In 01:41:23 INFO - VRAM (Dynamic, Max): 1536 MB 01:41:23 INFO - Vendor: Intel (0x8086) 01:41:23 INFO - Device ID: 0x0a2e 01:41:23 INFO - Revision ID: 0x0009 01:41:23 INFO - Displays: 01:41:23 INFO - Display: 01:41:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:41:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:41:23 INFO - Display Serial Number: 1600x1200 60 01:41:23 INFO - Main Display: Yes 01:41:23 INFO - Mirror: Off 01:41:23 INFO - Online: Yes 01:41:23 INFO - Rotation: Supported 01:41:23 INFO - Return code: 0 01:41:23 INFO - Running post-action listener: _resource_record_post_action 01:41:23 INFO - Running post-run listener: _resource_record_post_run 01:41:24 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 1089536; Write bytes: 498768384; Read time: 10; Write time: 1544 01:41:24 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194650624; Write bytes: 197466112; Read time: 17596; Write time: 428 01:41:24 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 1089536; Write bytes: 299484672; Read time: 10; Write time: 1107 01:41:24 INFO - Running post-run listener: _upload_blobber_files 01:41:24 INFO - Blob upload gear active. 01:41:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:41:24 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 01:41:24 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'] 01:41:24 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 01:41:25 INFO - (blobuploader) - INFO - Open directory for files ... 01:41:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:41:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:41:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:41:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:41:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:41:25 INFO - (blobuploader) - INFO - Done attempting. 01:41:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:41:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:41:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:41:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:41:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:41:26 INFO - (blobuploader) - INFO - Done attempting. 01:41:26 INFO - (blobuploader) - INFO - Iteration through files over. 01:41:26 INFO - Return code: 0 01:41:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:41:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:41:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7c8e83976b3dbd0bdc8d2a43e426fa435bc0498514cbc9cb8e56c24e77958e5126aee0d553f7d7f3a39f7c515dd42539cb2307cdcfc99bba5ce9feb95fb43f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29b812e3e5869e8626f045a4dd6a94be55b0ae76e62678eafcd08b1f514ed483a966b9237f3ee4eabc214ec163d2a8573114f3fbf0dca1e526ab253a32402596"} 01:41:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:41:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:41:26 INFO - Contents: 01:41:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7c8e83976b3dbd0bdc8d2a43e426fa435bc0498514cbc9cb8e56c24e77958e5126aee0d553f7d7f3a39f7c515dd42539cb2307cdcfc99bba5ce9feb95fb43f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29b812e3e5869e8626f045a4dd6a94be55b0ae76e62678eafcd08b1f514ed483a966b9237f3ee4eabc214ec163d2a8573114f3fbf0dca1e526ab253a32402596"} 01:41:26 INFO - Running post-run listener: copy_logs_to_upload_dir 01:41:26 INFO - Copying logs to upload dir... 01:41:26 INFO - mkdir: /builds/slave/test/build/upload/logs 01:41:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.049533 ========= master_lag: 195.94 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 10 secs) (at 2016-06-28 01:44:42.743364) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-06-28 01:44:42.747554) ========= 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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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/d7c8e83976b3dbd0bdc8d2a43e426fa435bc0498514cbc9cb8e56c24e77958e5126aee0d553f7d7f3a39f7c515dd42539cb2307cdcfc99bba5ce9feb95fb43f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29b812e3e5869e8626f045a4dd6a94be55b0ae76e62678eafcd08b1f514ed483a966b9237f3ee4eabc214ec163d2a8573114f3fbf0dca1e526ab253a32402596"} build_url:https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011066 build_url: 'https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7c8e83976b3dbd0bdc8d2a43e426fa435bc0498514cbc9cb8e56c24e77958e5126aee0d553f7d7f3a39f7c515dd42539cb2307cdcfc99bba5ce9feb95fb43f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29b812e3e5869e8626f045a4dd6a94be55b0ae76e62678eafcd08b1f514ed483a966b9237f3ee4eabc214ec163d2a8573114f3fbf0dca1e526ab253a32402596"}' ========= master_lag: 2.65 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-06-28 01:44:45.404595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 01:44:45.404892) ========= 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.V3PI2HQ8a8/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.QHjcEZUU56/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.005876 ========= master_lag: 1.20 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 01:44:46.606958) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-06-28 01:44:46.607278) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-06-28 01:44:48.671128) ========= ========= Total master_lag: 199.86 =========