builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0030 starttime: 1467042123.52 results: success (0) buildid: 20160627064925 builduid: 96e5c251132847da8a26a4cfa95a6d96 revision: 34281fb8a330ef0731305992a25bd88c66a8cfe8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:03.519955) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:03.520345) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:03.520616) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:03.674269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:03.674553) ========= 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.NIgAI2elmI/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.6qsUpMxCcI/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-27 08:42:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.7M=0s 2016-06-27 08:42:04 (24.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.453741 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:04.165229) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:04.165544) ========= 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.NIgAI2elmI/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.6qsUpMxCcI/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.020064 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:04.218245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:04.218639) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 34281fb8a330ef0731305992a25bd88c66a8cfe8 --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 34281fb8a330ef0731305992a25bd88c66a8cfe8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NIgAI2elmI/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.6qsUpMxCcI/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-27 08:42:04,316 truncating revision to first 12 chars 2016-06-27 08:42:04,317 Setting DEBUG logging. 2016-06-27 08:42:04,317 attempt 1/10 2016-06-27 08:42:04,317 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/34281fb8a330?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 08:42:04,693 unpacking tar archive at: mozilla-beta-34281fb8a330/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626243 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:04.908414) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:04.908727) ========= script_repo_revision: 34281fb8a330ef0731305992a25bd88c66a8cfe8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:04.909187) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:04.909503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:42:04.938296) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-27 08:42:04.938975) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NIgAI2elmI/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.6qsUpMxCcI/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 08:42:05 INFO - MultiFileLogger online at 20160627 08:42:05 in /builds/slave/test 08:42:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:42:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:05 INFO - {'append_to_log': False, 08:42:05 INFO - 'base_work_dir': '/builds/slave/test', 08:42:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:42:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:05 INFO - 'branch': 'Mozilla-Beta', 08:42:05 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:05 INFO - 'config_files': ('talos/mac_config.py',), 08:42:05 INFO - 'default_actions': ('clobber', 08:42:05 INFO - 'read-buildbot-config', 08:42:05 INFO - 'download-and-extract', 08:42:05 INFO - 'populate-webroot', 08:42:05 INFO - 'create-virtualenv', 08:42:05 INFO - 'install', 08:42:05 INFO - 'run-tests'), 08:42:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:05 INFO - 'download_minidump_stackwalk': True, 08:42:05 INFO - 'download_symbols': 'ondemand', 08:42:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:05 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:05 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:05 INFO - 'installer_path': 'installer.exe', 08:42:05 INFO - 'log_level': 'info', 08:42:05 INFO - 'log_name': 'talos', 08:42:05 INFO - 'log_to_console': True, 08:42:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:42:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:42:05 INFO - 'opt_config_files': (), 08:42:05 INFO - 'pip_index': False, 08:42:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:42:05 INFO - 'cmd': ('bash', 08:42:05 INFO - '-c', 08:42:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:42:05 INFO - 'enabled': True, 08:42:05 INFO - 'halt_on_failure': False, 08:42:05 INFO - 'name': 'check_screen_resolution'},), 08:42:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:42:05 INFO - 'cmd': ('bash', 08:42:05 INFO - '-c', 08:42:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:42:05 INFO - 'enabled': True, 08:42:05 INFO - 'halt_on_failure': False, 08:42:05 INFO - 'name': 'check_screen_resolution'},), 08:42:05 INFO - 'run_cmd_checks_enabled': True, 08:42:05 INFO - 'sps_profile': False, 08:42:05 INFO - 'sps_profile_interval': 0, 08:42:05 INFO - 'suite': 'dromaeojs', 08:42:05 INFO - 'system_bits': '32', 08:42:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:05 INFO - 'title': 't-yosemite-r7-0030', 08:42:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:05 INFO - 'use_talos_json': True, 08:42:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:05 INFO - 'work_dir': 'build'} 08:42:05 INFO - ##### 08:42:05 INFO - ##### Running clobber step. 08:42:05 INFO - ##### 08:42:05 INFO - Running pre-action listener: _resource_record_pre_action 08:42:05 INFO - Running main action method: clobber 08:42:05 INFO - rmtree: /builds/slave/test/build 08:42:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:06 INFO - Running post-action listener: _resource_record_post_action 08:42:06 INFO - ##### 08:42:06 INFO - ##### Running read-buildbot-config step. 08:42:06 INFO - ##### 08:42:06 INFO - Running pre-action listener: _resource_record_pre_action 08:42:06 INFO - Running main action method: read_buildbot_config 08:42:06 INFO - Using buildbot properties: 08:42:06 INFO - { 08:42:06 INFO - "project": "", 08:42:06 INFO - "product": "firefox", 08:42:06 INFO - "script_repo_revision": "production", 08:42:06 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:42:06 INFO - "repository": "", 08:42:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:42:06 INFO - "buildid": "20160627064925", 08:42:06 INFO - "pgo_build": "False", 08:42:06 INFO - "basedir": "/builds/slave/test", 08:42:06 INFO - "buildnumber": 15, 08:42:06 INFO - "slavename": "t-yosemite-r7-0030", 08:42:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:42:06 INFO - "platform": "yosemite_r7", 08:42:06 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:42:06 INFO - "branch": "mozilla-beta", 08:42:06 INFO - "repo_path": "releases/mozilla-beta", 08:42:06 INFO - "revision": "34281fb8a330ef0731305992a25bd88c66a8cfe8", 08:42:06 INFO - "stage_platform": "macosx64", 08:42:06 INFO - "builduid": "96e5c251132847da8a26a4cfa95a6d96", 08:42:06 INFO - "slavebuilddir": "test" 08:42:06 INFO - } 08:42:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 08:42:06 INFO - Running post-action listener: _resource_record_post_action 08:42:06 INFO - ##### 08:42:06 INFO - ##### Running download-and-extract step. 08:42:06 INFO - ##### 08:42:06 INFO - Running pre-action listener: _resource_record_pre_action 08:42:06 INFO - Running main action method: download_and_extract 08:42:06 INFO - mkdir: /builds/slave/test/build/tests 08:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:06 INFO - https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:42:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:42:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:42:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/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 08:42:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/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 08:42:07 INFO - Downloaded 1165 bytes. 08:42:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:42:07 INFO - Using the following test package requirements: 08:42:07 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:42:07 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 08:42:07 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 08:42:07 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:42:07 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 08:42:07 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:42:07 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 08:42:07 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 08:42:07 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 08:42:07 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 08:42:07 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 08:42: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')]} 08:42:07 INFO - https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:42:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:42:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:42:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/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 08:42:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/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 08:42:09 INFO - Downloaded 18350342 bytes. 08:42:09 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'] 08:42:09 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 08:42:12 INFO - Return code: 0 08:42:12 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 08:42: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')]} 08:42:12 INFO - https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:42:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:42:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:42:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/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 08:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/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 08:42:16 INFO - Downloaded 18350342 bytes. 08:42:16 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'] 08:42:16 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 08:42:20 INFO - Return code: 0 08:42:20 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')]} 08:42:20 INFO - https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:42:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:42:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:42:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/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 08:42:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/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 08:42:21 INFO - Downloaded 10840145 bytes. 08:42:21 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'] 08:42:21 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 08:42:22 INFO - Return code: 0 08:42: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')]} 08:42:22 INFO - https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 08:42:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:42:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:42:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 08:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H75F0ySGS9GwdMIjnqWHtg/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 08:42:28 INFO - Downloaded 86229946 bytes. 08:42:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:42:28 INFO - mkdir: /builds/slave/test/properties 08:42:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:28 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:28 INFO - Contents: 08:42:28 INFO - build_url:https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:42:30 INFO - Running post-action listener: _resource_record_post_action 08:42:30 INFO - Running post-action listener: set_extra_try_arguments 08:42:30 INFO - ##### 08:42:30 INFO - ##### Running populate-webroot step. 08:42:30 INFO - ##### 08:42:30 INFO - Running pre-action listener: _resource_record_pre_action 08:42:30 INFO - Running main action method: populate_webroot 08:42:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:30 INFO - '--tppagecycles', 08:42:30 INFO - '7'], 08:42:30 INFO - 'tests': ['tsvgm']}}, 08:42:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:30 INFO - 'talos_options': ['--disable-e10s'], 08:42:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:30 INFO - 'talos_options': ['--disable-e10s'], 08:42:30 INFO - 'tests': ['damp', 'tps']}, 08:42:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:30 INFO - 'tests': ['damp', 'tps']}, 08:42:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:30 INFO - 'tests': ['dromaeo_dom']}, 08:42:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:30 INFO - 'tests': ['a11yr', 08:42:30 INFO - 'ts_paint', 08:42:30 INFO - 'tpaint', 08:42:30 INFO - 'sessionrestore', 08:42:30 INFO - 'sessionrestore_no_auto_restore', 08:42:30 INFO - 'tabpaint']}, 08:42:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:30 INFO - 'ts_paint', 08:42:30 INFO - 'tpaint', 08:42:30 INFO - 'sessionrestore', 08:42:30 INFO - 'sessionrestore_no_auto_restore', 08:42:30 INFO - 'tabpaint']}, 08:42:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:30 INFO - 'ts_paint', 08:42:30 INFO - 'tpaint', 08:42:30 INFO - 'sessionrestore', 08:42:30 INFO - 'sessionrestore_no_auto_restore', 08:42:30 INFO - 'tabpaint']}, 08:42:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:30 INFO - 'ts_paint', 08:42:30 INFO - 'tpaint', 08:42:30 INFO - 'sessionrestore', 08:42:30 INFO - 'sessionrestore_no_auto_restore', 08:42:30 INFO - 'tabpaint']}, 08:42:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:30 INFO - 'tests': ['a11yr', 08:42:30 INFO - 'ts_paint', 08:42:30 INFO - 'tpaint', 08:42:30 INFO - 'sessionrestore', 08:42:30 INFO - 'sessionrestore_no_auto_restore', 08:42:30 INFO - 'tabpaint']}, 08:42:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:30 INFO - 'tests': ['a11yr', 08:42:30 INFO - 'ts_paint', 08:42:30 INFO - 'tpaint', 08:42:30 INFO - 'sessionrestore', 08:42:30 INFO - 'sessionrestore_no_auto_restore', 08:42:30 INFO - 'tabpaint']}, 08:42:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:30 INFO - 'tests': ['tsvgx', 08:42:30 INFO - 'tsvgr_opacity', 08:42:30 INFO - 'tart', 08:42:30 INFO - 'tscrollx', 08:42:30 INFO - 'cart']}, 08:42:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:30 INFO - 'tsvgr_opacity', 08:42:30 INFO - 'tart', 08:42:30 INFO - 'tscrollx', 08:42:30 INFO - 'cart']}, 08:42:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:30 INFO - 'talos_options': ['--disable-e10s'], 08:42:30 INFO - 'tests': ['tp5o']}, 08:42:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:30 INFO - 'tests': ['tp5o']}, 08:42:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:30 INFO - 'talos_options': ['--disable-e10s', 08:42:30 INFO - '--xperf_path', 08:42:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:30 INFO - 'tests': ['tp5n']}, 08:42:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:30 INFO - 'talos_options': ['--xperf_path', 08:42:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:30 INFO - 'tests': ['tp5n']}}, 08:42:30 INFO - 'talos.zip': {'path': '', 08:42:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:30 INFO - Running post-action listener: _resource_record_post_action 08:42:30 INFO - ##### 08:42:30 INFO - ##### Running create-virtualenv step. 08:42:30 INFO - ##### 08:42:30 INFO - Running pre-action listener: _resource_record_pre_action 08:42:30 INFO - Running main action method: create_virtualenv 08:42:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:30 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 08:42:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:30 INFO - Using real prefix '/tools/python27' 08:42:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:33 INFO - Installing pip.................done. 08:42:33 INFO - Return code: 0 08:42:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:33 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 0x100a98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aa8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9734bdbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100937e00>, '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 0x1007a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100932b20>, '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.NIgAI2elmI/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.6qsUpMxCcI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 08:42:33 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 08:42:33 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 08:42:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIgAI2elmI/Render', 08:42:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:33 INFO - 'HOME': '/Users/cltbld', 08:42:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:33 INFO - 'LOGNAME': 'cltbld', 08:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:33 INFO - 'MOZ_NO_REMOTE': '1', 08:42:33 INFO - 'NO_EM_RESTART': '1', 08:42:33 INFO - 'PAGER': '/bin/cat', 08:42:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:33 INFO - 'PWD': '/builds/slave/test', 08:42:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:33 INFO - 'SHELL': '/bin/bash', 08:42:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qsUpMxCcI/Listeners', 08:42:33 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:33 INFO - 'USER': 'cltbld', 08:42:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:33 INFO - 'XPC_FLAGS': '0x0', 08:42:33 INFO - 'XPC_SERVICE_NAME': '0', 08:42:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:34 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 08:42:34 INFO - Cleaning up... 08:42:34 INFO - Return code: 0 08:42:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:34 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 0x100a98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aa8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9734bdbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100937e00>, '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 0x1007a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100932b20>, '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.NIgAI2elmI/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.6qsUpMxCcI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 08:42:34 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 08:42:34 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 08:42:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIgAI2elmI/Render', 08:42:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:34 INFO - 'HOME': '/Users/cltbld', 08:42:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:34 INFO - 'LOGNAME': 'cltbld', 08:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:34 INFO - 'MOZ_NO_REMOTE': '1', 08:42:34 INFO - 'NO_EM_RESTART': '1', 08:42:34 INFO - 'PAGER': '/bin/cat', 08:42:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:34 INFO - 'PWD': '/builds/slave/test', 08:42:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:34 INFO - 'SHELL': '/bin/bash', 08:42:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qsUpMxCcI/Listeners', 08:42:34 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:34 INFO - 'USER': 'cltbld', 08:42:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:34 INFO - 'XPC_FLAGS': '0x0', 08:42:34 INFO - 'XPC_SERVICE_NAME': '0', 08:42:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:34 INFO - Downloading/unpacking psutil>=0.7.1 08:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:36 INFO - Installing collected packages: psutil 08:42:36 INFO - Running setup.py install for psutil 08:42:36 INFO - building 'psutil._psutil_osx' extension 08:42:36 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 08:42:37 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 08:42:37 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 08:42:37 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 08:42:37 INFO - building 'psutil._psutil_posix' extension 08:42:37 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 08:42:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:42:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:42:37 INFO - ^ 08:42:37 INFO - 1 warning generated. 08:42:37 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 08:42:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:37 INFO - Successfully installed psutil 08:42:37 INFO - Cleaning up... 08:42:37 INFO - Return code: 0 08:42:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:42:37 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')]} 08:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:37 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')]} 08:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:37 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 0x100a98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aa8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9734bdbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100937e00>, '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 0x1007a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100932b20>, '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.NIgAI2elmI/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.6qsUpMxCcI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 08:42:37 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 08:42:37 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 08:42:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIgAI2elmI/Render', 08:42:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:37 INFO - 'HOME': '/Users/cltbld', 08:42:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:37 INFO - 'LOGNAME': 'cltbld', 08:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:37 INFO - 'MOZ_NO_REMOTE': '1', 08:42:37 INFO - 'NO_EM_RESTART': '1', 08:42:37 INFO - 'PAGER': '/bin/cat', 08:42:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:37 INFO - 'PWD': '/builds/slave/test', 08:42:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:37 INFO - 'SHELL': '/bin/bash', 08:42:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qsUpMxCcI/Listeners', 08:42:37 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:37 INFO - 'USER': 'cltbld', 08:42:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:37 INFO - 'XPC_FLAGS': '0x0', 08:42:37 INFO - 'XPC_SERVICE_NAME': '0', 08:42:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:42:40 INFO - Installing collected packages: mozsystemmonitor 08:42:40 INFO - Running setup.py install for mozsystemmonitor 08:42:40 INFO - Successfully installed mozsystemmonitor 08:42:40 INFO - Cleaning up... 08:42:40 INFO - Return code: 0 08:42:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aa8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9734bdbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100937e00>, '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 0x1007a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100932b20>, '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.NIgAI2elmI/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.6qsUpMxCcI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 08:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:42:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIgAI2elmI/Render', 08:42:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:40 INFO - 'HOME': '/Users/cltbld', 08:42:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:40 INFO - 'LOGNAME': 'cltbld', 08:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:40 INFO - 'MOZ_NO_REMOTE': '1', 08:42:40 INFO - 'NO_EM_RESTART': '1', 08:42:40 INFO - 'PAGER': '/bin/cat', 08:42:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:40 INFO - 'PWD': '/builds/slave/test', 08:42:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:40 INFO - 'SHELL': '/bin/bash', 08:42:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qsUpMxCcI/Listeners', 08:42:40 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:40 INFO - 'USER': 'cltbld', 08:42:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:40 INFO - 'XPC_FLAGS': '0x0', 08:42:40 INFO - 'XPC_SERVICE_NAME': '0', 08:42:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:42:41 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 08:42:41 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 08:42:41 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 08:42:41 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 08:42:41 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 08:42:41 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 08:42:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42:44 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 08:42:44 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 08:42:44 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 08:42:44 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 08:42:44 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 08:42:44 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 08:42:44 INFO - Downloading docopt-0.6.1.tar.gz 08:42:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:44 INFO - Running setup.py install for blobuploader 08:42:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:44 INFO - Running setup.py install for requests 08:42:45 INFO - Running setup.py install for docopt 08:42:45 INFO - Successfully installed blobuploader requests docopt 08:42:45 INFO - Cleaning up... 08:42:45 INFO - Return code: 0 08:42:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:45 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 0x100a98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aa8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9734bdbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100937e00>, '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 0x1007a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100932b20>, '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.NIgAI2elmI/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.6qsUpMxCcI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 08:42:45 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 08:42:45 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 08:42:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIgAI2elmI/Render', 08:42:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:45 INFO - 'HOME': '/Users/cltbld', 08:42:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:45 INFO - 'LOGNAME': 'cltbld', 08:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:45 INFO - 'MOZ_NO_REMOTE': '1', 08:42:45 INFO - 'NO_EM_RESTART': '1', 08:42:45 INFO - 'PAGER': '/bin/cat', 08:42:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:45 INFO - 'PWD': '/builds/slave/test', 08:42:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:45 INFO - 'SHELL': '/bin/bash', 08:42:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qsUpMxCcI/Listeners', 08:42:45 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:45 INFO - 'USER': 'cltbld', 08:42:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:45 INFO - 'XPC_FLAGS': '0x0', 08:42:45 INFO - 'XPC_SERVICE_NAME': '0', 08:42:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:45 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Ow7ALM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:45 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-GJiRh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:46 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-DnurTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:46 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-02e5bX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:46 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-jzShEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:46 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-HAlXHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:46 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Wl1NAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:46 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Dfs4dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:46 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-TnKDIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:46 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-dIAgY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:46 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-kmmFZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:47 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Z3rSL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:47 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-jsWOez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:47 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-yqIhaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:47 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-2Ncobn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:47 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-luAUff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:47 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-wtUYGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:47 INFO - Running setup.py install for manifestparser 08:42:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:47 INFO - Running setup.py install for mozcrash 08:42:47 INFO - Running setup.py install for mozdebug 08:42:48 INFO - Running setup.py install for mozdevice 08:42:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:48 INFO - Running setup.py install for mozfile 08:42:48 INFO - Running setup.py install for mozhttpd 08:42:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:48 INFO - Running setup.py install for mozinfo 08:42:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:48 INFO - Running setup.py install for mozInstall 08:42:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:48 INFO - Running setup.py install for mozleak 08:42:48 INFO - Running setup.py install for mozlog 08:42:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:49 INFO - Running setup.py install for moznetwork 08:42:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:49 INFO - Running setup.py install for mozprocess 08:42:49 INFO - Running setup.py install for mozprofile 08:42:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:49 INFO - Running setup.py install for mozrunner 08:42:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:49 INFO - Running setup.py install for mozscreenshot 08:42:49 INFO - Running setup.py install for moztest 08:42:50 INFO - Running setup.py install for mozversion 08:42:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:50 INFO - Cleaning up... 08:42:50 INFO - Return code: 0 08:42:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 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 0x100a98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aa8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9734bdbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100937e00>, '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 0x1007a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100932b20>, '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.NIgAI2elmI/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.6qsUpMxCcI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 08:42:50 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 08:42:50 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 08:42:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIgAI2elmI/Render', 08:42:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:50 INFO - 'HOME': '/Users/cltbld', 08:42:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:50 INFO - 'LOGNAME': 'cltbld', 08:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:50 INFO - 'MOZ_NO_REMOTE': '1', 08:42:50 INFO - 'NO_EM_RESTART': '1', 08:42:50 INFO - 'PAGER': '/bin/cat', 08:42:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:50 INFO - 'PWD': '/builds/slave/test', 08:42:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:50 INFO - 'SHELL': '/bin/bash', 08:42:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qsUpMxCcI/Listeners', 08:42:50 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:50 INFO - 'USER': 'cltbld', 08:42:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:50 INFO - 'XPC_FLAGS': '0x0', 08:42:50 INFO - 'XPC_SERVICE_NAME': '0', 08:42:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:50 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Qk9wxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:50 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)) 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:50 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-xp4xXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:50 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)) 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:50 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-VfNOxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:50 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)) 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:50 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-P_mmLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:50 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)) 08:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:50 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8t0y3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:51 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)) 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-1tSaau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:51 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)) 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-BsxnTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:51 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)) 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-_BLcqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:51 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)) 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-K2MZZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:51 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)) 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-qGxrp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:51 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)) 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-xtAxXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:51 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)) 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-YmAG3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:51 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)) 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-mC03er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:51 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)) 08:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-teqwEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:52 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)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:52 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Wn4Rlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:52 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)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:52 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-sZg_Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:52 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)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:52 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Ic8Nio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:52 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)) 08:42:52 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)) 08:42:52 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)) 08:42:52 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)) 08:42:52 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)) 08:42:52 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)) 08:42:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:52 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 08:42:52 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 08:42:52 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 08:42:52 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 08:42:52 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 08:42:52 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 08:42:54 INFO - Downloading blessings-1.6.tar.gz 08:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:54 INFO - Installing collected packages: blessings 08:42:54 INFO - Running setup.py install for blessings 08:42:55 INFO - Successfully installed blessings 08:42:55 INFO - Cleaning up... 08:42:55 INFO - Return code: 0 08:42:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:55 INFO - Reading from file tmpfile_stdout 08:42:55 INFO - Current package versions: 08:42:55 INFO - blessings == 1.6 08:42:55 INFO - blobuploader == 1.2.4 08:42:55 INFO - docopt == 0.6.1 08:42:55 INFO - manifestparser == 1.1 08:42:55 INFO - mozInstall == 1.12 08:42:55 INFO - mozcrash == 0.17 08:42:55 INFO - mozdebug == 0.1 08:42:55 INFO - mozdevice == 0.48 08:42:55 INFO - mozfile == 1.2 08:42:55 INFO - mozhttpd == 0.7 08:42:55 INFO - mozinfo == 0.9 08:42:55 INFO - mozleak == 0.1 08:42:55 INFO - mozlog == 3.1 08:42:55 INFO - moznetwork == 0.27 08:42:55 INFO - mozprocess == 0.22 08:42:55 INFO - mozprofile == 0.28 08:42:55 INFO - mozrunner == 6.11 08:42:55 INFO - mozscreenshot == 0.1 08:42:55 INFO - mozsystemmonitor == 0.0 08:42:55 INFO - moztest == 0.7 08:42:55 INFO - mozversion == 1.4 08:42:55 INFO - psutil == 3.1.1 08:42:55 INFO - requests == 1.2.3 08:42:55 INFO - wsgiref == 0.1.2 08:42:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:55 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')]} 08:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:55 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')]} 08:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:55 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 0x100a98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aa8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9734bdbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100937e00>, '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 0x1007a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100932b20>, '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.NIgAI2elmI/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.6qsUpMxCcI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 08:42:55 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 08:42:55 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 08:42:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIgAI2elmI/Render', 08:42:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:55 INFO - 'HOME': '/Users/cltbld', 08:42:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:55 INFO - 'LOGNAME': 'cltbld', 08:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:55 INFO - 'MOZ_NO_REMOTE': '1', 08:42:55 INFO - 'NO_EM_RESTART': '1', 08:42:55 INFO - 'PAGER': '/bin/cat', 08:42:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:55 INFO - 'PWD': '/builds/slave/test', 08:42:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:55 INFO - 'SHELL': '/bin/bash', 08:42:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qsUpMxCcI/Listeners', 08:42:55 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:55 INFO - 'USER': 'cltbld', 08:42:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:55 INFO - 'XPC_FLAGS': '0x0', 08:42:55 INFO - 'XPC_SERVICE_NAME': '0', 08:42:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 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)) 08:42:55 INFO - Cleaning up... 08:42:55 INFO - Return code: 0 08:42:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42:55 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')]} 08:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:55 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')]} 08:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:55 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 0x100a98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aa8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9734bdbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100937e00>, '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 0x1007a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100932b20>, '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.NIgAI2elmI/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.6qsUpMxCcI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 08:42:55 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 08:42:55 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 08:42:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIgAI2elmI/Render', 08:42:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:55 INFO - 'HOME': '/Users/cltbld', 08:42:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:55 INFO - 'LOGNAME': 'cltbld', 08:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:55 INFO - 'MOZ_NO_REMOTE': '1', 08:42:55 INFO - 'NO_EM_RESTART': '1', 08:42:55 INFO - 'PAGER': '/bin/cat', 08:42:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:55 INFO - 'PWD': '/builds/slave/test', 08:42:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:55 INFO - 'SHELL': '/bin/bash', 08:42:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qsUpMxCcI/Listeners', 08:42:55 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:55 INFO - 'USER': 'cltbld', 08:42:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:55 INFO - 'XPC_FLAGS': '0x0', 08:42:55 INFO - 'XPC_SERVICE_NAME': '0', 08:42:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:55 INFO - Downloading/unpacking jsonschema 08:42:55 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 08:42:55 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 08:42:55 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 08:42:55 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 08:42:55 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 08:42:55 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 08:42:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:58 INFO - Downloading/unpacking functools32 (from jsonschema) 08:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:58 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:58 INFO - warning: no files found matching '*.txt' 08:42:58 INFO - no previously-included directories found matching 'build' 08:42:58 INFO - no previously-included directories found matching 'dist' 08:42:58 INFO - no previously-included directories found matching '.git*' 08:42:58 INFO - Installing collected packages: jsonschema, functools32 08:42:58 INFO - Running setup.py install for functools32 08:42:58 INFO - warning: no files found matching '*.txt' 08:42:58 INFO - no previously-included directories found matching 'build' 08:42:58 INFO - no previously-included directories found matching 'dist' 08:42:58 INFO - no previously-included directories found matching '.git*' 08:42:58 INFO - Successfully installed jsonschema functools32 08:42:58 INFO - Cleaning up... 08:42:59 INFO - Return code: 0 08:42:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aa8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9734bdbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100937e00>, '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 0x1007a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100932b20>, '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.NIgAI2elmI/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.6qsUpMxCcI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 08:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIgAI2elmI/Render', 08:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:59 INFO - 'HOME': '/Users/cltbld', 08:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:59 INFO - 'LOGNAME': 'cltbld', 08:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:59 INFO - 'MOZ_NO_REMOTE': '1', 08:42:59 INFO - 'NO_EM_RESTART': '1', 08:42:59 INFO - 'PAGER': '/bin/cat', 08:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:59 INFO - 'PWD': '/builds/slave/test', 08:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:59 INFO - 'SHELL': '/bin/bash', 08:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qsUpMxCcI/Listeners', 08:42:59 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:59 INFO - 'USER': 'cltbld', 08:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:59 INFO - 'XPC_FLAGS': '0x0', 08:42:59 INFO - 'XPC_SERVICE_NAME': '0', 08:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:59 INFO - Downloading/unpacking flake8 08:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:43:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:43:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:43:02 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 08:43:02 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 08:43:02 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 08:43:02 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 08:43:02 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 08:43:02 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 08:43:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:43:02 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 08:43:02 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 08:43:02 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 08:43:02 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 08:43:02 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 08:43:02 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 08:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:43:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:03 INFO - no previously-included directories found matching 'docs/_build' 08:43:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:43:03 INFO - Running setup.py install for pep8 08:43:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:03 INFO - no previously-included directories found matching 'docs/_build' 08:43:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:43:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:43:03 INFO - Cleaning up... 08:43:03 INFO - Return code: 0 08:43:03 INFO - Running post-action listener: _resource_record_post_action 08:43:03 INFO - Running post-action listener: _start_resource_monitoring 08:43:03 INFO - Starting resource monitoring. 08:43:03 INFO - ##### 08:43:03 INFO - ##### Running install step. 08:43:03 INFO - ##### 08:43:03 INFO - Running pre-action listener: _resource_record_pre_action 08:43:03 INFO - Running main action method: install 08:43:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:03 INFO - Reading from file tmpfile_stdout 08:43:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:03 INFO - Reading from file tmpfile_stdout 08:43:03 INFO - Output received: 08:43:03 INFO - Usage: mozinstall [options] installer 08:43:03 INFO - Options: 08:43:03 INFO - -h, --help show this help message and exit 08:43:03 INFO - -d DEST, --destination=DEST 08:43:03 INFO - Directory to install application into. [default: 08:43:03 INFO - "/builds/slave/test"] 08:43:03 INFO - --app=APP Application being installed. [default: firefox] 08:43:03 INFO - mkdir: /builds/slave/test/build/application 08:43:03 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'] 08:43:03 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 08:43:25 INFO - Reading from file tmpfile_stdout 08:43:25 INFO - Output received: 08:43:25 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:43:25 INFO - Running post-action listener: _resource_record_post_action 08:43:25 INFO - ##### 08:43:25 INFO - ##### Running run-tests step. 08:43:25 INFO - ##### 08:43:25 INFO - Running pre-action listener: _resource_record_pre_action 08:43:25 INFO - Running main action method: run_tests 08:43:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:43:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:43:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:43:25 INFO - 2016-06-27 08:43:25.501 screenresolution[1980:13785] starting screenresolution argv=screenresolution get 08:43:25 INFO - 2016-06-27 08:43:25.504 screenresolution[1980:13785] Display 0: 1600x1200x32@60 08:43:25 INFO - 2016-06-27 08:43:25.509 screenresolution[1981:13787] starting screenresolution argv=screenresolution list 08:43:25 INFO - Available Modes on Display 0 08:43:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:43:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:43:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:43:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:43:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:43:25 INFO - Intel Iris: 08:43:25 INFO - Chipset Model: Intel Iris 08:43:25 INFO - Type: GPU 08:43:25 INFO - Bus: Built-In 08:43:25 INFO - VRAM (Dynamic, Max): 1536 MB 08:43:25 INFO - Vendor: Intel (0x8086) 08:43:25 INFO - Device ID: 0x0a2e 08:43:25 INFO - Revision ID: 0x0009 08:43:25 INFO - Displays: 08:43:25 INFO - Display: 08:43:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:43:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:43:25 INFO - Display Serial Number: 1600x1200 60 08:43:25 INFO - Main Display: Yes 08:43:25 INFO - Mirror: Off 08:43:25 INFO - Online: Yes 08:43:25 INFO - Rotation: Supported 08:43:25 INFO - Return code: 0 08:43:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:25 INFO - Python 2.7.3 08:43:25 INFO - Return code: 0 08:43:25 INFO - grabbing minidump binary from tooltool 08:43: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')]} 08:43:25 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 0x100937e00>, '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 0x1007a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100932b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:25 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 08:43:25 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 08:43:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:25 INFO - Return code: 0 08:43:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:43:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:43:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:43:26 INFO - Return code: 0 08:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIgAI2elmI/Render', 08:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:26 INFO - 'HOME': '/Users/cltbld', 08:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:26 INFO - 'LOGNAME': 'cltbld', 08:43:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:26 INFO - 'MOZ_NO_REMOTE': '1', 08:43:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:26 INFO - 'NO_EM_RESTART': '1', 08:43:26 INFO - 'PAGER': '/bin/cat', 08:43:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:26 INFO - 'PWD': '/builds/slave/test', 08:43:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:26 INFO - 'SHELL': '/bin/bash', 08:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qsUpMxCcI/Listeners', 08:43:26 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:26 INFO - 'USER': 'cltbld', 08:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:26 INFO - 'XPC_FLAGS': '0x0', 08:43:26 INFO - 'XPC_SERVICE_NAME': '0', 08:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:43:27 INFO - mozversion application_buildid: 20160627064925 08:43:27 INFO - mozversion application_changeset: 34281fb8a330ef0731305992a25bd88c66a8cfe8 08:43:27 INFO - mozversion application_display_name: Firefox 08:43:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:27 INFO - mozversion application_name: Firefox 08:43:27 INFO - mozversion application_remotingname: firefox 08:43:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:43:27 INFO - mozversion application_vendor: Mozilla 08:43:27 INFO - mozversion application_version: 48.0 08:43:27 INFO - mozversion platform_buildid: 20160627064925 08:43:27 INFO - mozversion platform_changeset: 34281fb8a330ef0731305992a25bd88c66a8cfe8 08:43:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:43:27 INFO - mozversion platform_version: 48.0 08:43:27 INFO - using testdate: 1467042207 08:43:27 INFO - actual date: 1467042207 08:43:27 INFO - starting webserver on 'localhost:51307' 08:43:27 INFO - SUITE-START | Running 2 tests 08:43:27 INFO - TEST-START | dromaeo_css 08:43:27 INFO - operating with platform_type : mac_ 08:43:27 INFO - Initialising browser for dromaeo_css test... 08:43:27 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpZjQiwj/profile http://localhost:51307/getInfo.html) 08:43:29 INFO - PROCESS | 1999 | __metrics Screen width/height:1600/1200 08:43:29 INFO - PROCESS | 1999 | colorDepth:24 08:43:29 INFO - PROCESS | 1999 | Browser inner width/height: 1024/689 08:43:29 INFO - PROCESS | 1999 | __metrics 08:43:29 INFO - PROCESS | 1999 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:43:29 ERROR - PROCESS | 1999 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:43:30 INFO - TEST-INFO | 1999: exit 0 08:43:30 INFO - Browser initialized. 08:43:30 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:30 INFO - TEST-INFO | started process 2002 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpZjQiwj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:41 INFO - PROCESS | 2002 | RSS: Main: 161894400 08:43:41 INFO - PROCESS | 2002 | 08:44:32 INFO - PROCESS | 2002 | 1467042272961 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] 08:46:42 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:51307/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51307/tests/dromaeo/cssquery-ext.html) 08:46:44 INFO - PROCESS | 2002 | RSS: Main: 262426624 08:46:44 INFO - PROCESS | 2002 | 08:49:46 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:51307/tests/dromaeo/cssquery-ext.html (next: http://localhost:51307/tests/dromaeo/cssquery-jquery.html) 08:49:47 INFO - PROCESS | 2002 | RSS: Main: 301355008 08:49:47 INFO - PROCESS | 2002 | 08:52:49 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:51307/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51307/tests/dromaeo/cssquery-mootools.html) 08:52:49 INFO - PROCESS | 2002 | RSS: Main: 298967040 08:52:49 INFO - PROCESS | 2002 | 08:55:51 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:51307/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51307/tests/dromaeo/cssquery-prototype.html) 08:55:52 INFO - PROCESS | 2002 | RSS: Main: 300642304 08:55:52 INFO - PROCESS | 2002 | 08:58:55 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:51307/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51307/tests/dromaeo/cssquery-yui.html) 08:58:56 INFO - PROCESS | 2002 | RSS: Main: 268795904 08:58:56 INFO - PROCESS | 2002 | 09:01:58 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:51307/tests/dromaeo/cssquery-yui.html (next: http://localhost:51307/tests/dromaeo/cssquery-dojo.html) 09:01:58 INFO - PROCESS | 2002 | RSS: Main: 315994112 09:01:59 INFO - PROCESS | 2002 | 09:01:59 INFO - PROCESS | 2002 | __start_tp_report 09:01:59 INFO - PROCESS | 2002 | _x_x_mozilla_page_load 09:01:59 INFO - PROCESS | 2002 | _x_x_mozilla_page_load_details 09:01:59 INFO - PROCESS | 2002 | |i|pagename|runs| 09:01:59 INFO - PROCESS | 2002 | |0;dojo.html;3499.160201551628;3565.1800085980226;3574.731895107864;3582.820858957053;3628.60085390607;5879.735411906464;5880.656676643432;5882.000059989801;5884.705764711758;5953.107033944905;5882.705864706769;5951.077582974635;5953.613015154012;5960.821175364736;5963.642181469104;5207.088759467097;5252.107141785887;5273.920891186635;5325.440828712987;5343.759530821103;5320.680759154444;5363.839084827461;5367.06076436624;5380.381256155553;5388.7305634718305;5265.605079619044;5310.92033619496;5329.920051199235;5344.652597581145;5365.543928766059;5328.706921119337;5370.838874833761;5373.59698022646;5375.838724838261;5416.052190866582;5153.407358153823;5199.610029247784;5291.206319052135;5310.070737620939;5315.973420132913;5687.914681279784;5762.683052432115;5770.3652598214585;5795.420457954213;5800.564957628152;5275.498827611371;6165.84585385369;6226.034964580452;6251.249850017982;6291.559590828644;6237.781677641261;6257;6335.239771227482;6338.619682819046;6344.555881088326;5883.470487656089;5944.851378715567;5955.196048533479;5965.850853728692;5983.222181116427;6404.199475065617;6411.4229719325485;6413.134226879405;6415.582987105917;6418.454431373386;5046.369203849519;6196.8760624787255;6266.624002559861;6306.905396419057;6317.526185536103;6293.842653933597;6306.905396419057;6314.905276420857;6316.810495685137;6331.461825744863;5222.242774797709;6310.747570097236;6329.810105696836;6337.176167098248;6341.904871426932;4679.602233810097;6234.251889773165;6269.279032911182;6353.142325786052;6362.809115726535;4952.70283782967;4974.8756281093265;4983.476734942778;5031.22016087507;5063.443021267658;4527.615152712056;4542.613877820422;4551.613112885442;4564.0871825635;4567.862964111082;5792.189093526909;5894.793682221101;5923.851903702356;5930.7924222652;6045.546584006217;6294.937050629526;6321.96839015802;6331.588446751039;6331.620102793847;6332;6042.4561789438285;6052.273727152769;6053.7578496860515;6061.151438798572;6072.544559158081;5345.957538279998;5428.212909128154;5440.401555828856;5521.751521181556;5543.750531226105;6509.511786616117;6513.674316284167;6558.508111891531;6559.376859198369;6565.638889861008;6306.558540902093;6312.684365781784;6315.210598675166;6315.400036996478;6323.525735569759;6363.809085727436;6464.5151613630105;6516.283208846929;6576.44100251484;6589.341065893373;6256.624602523863;6278.497720182283;6292.087647291209;6292.528060395397;6298.370162983665;6285.182926219562;6299.590526615755;6301.842453938688;6310.7791227306825;6324.841878953063;6111.419415155553;6167.753289868355;6250.9062364065485;6275.905861411991;6277.2781130170615;4720.669553131248;6226.59527130735;6239.407256310643;6249.1563638908165;6284.905726414016;5973.193618861572;6120.969395152996;6163.229596300463;6172.135900973957;6201.720922558406;6112.969435152796;6136.938630613637;6171.814845554641;6255.53083518747;6295.779647712308;6101.725422355916;6104.816855494342;6106.175666284995;6109.327973922954;6120.326764056039 09:01:59 INFO - PROCESS | 2002 | |1;ext.html;525.5742848292881;551.9254900588421;574.6437208930463;612.693653173413;638.1130228981714;31913.680863191392;40559.79720101403;40591.39112913305;40592.18815623686;40597;42855.78572107143;43428.13143737123;43486.91282717926;43548.564514354846;43648;9097.499637519933;9570.808583828337;9803.36278141922;9807.215422766161;11625.069994400428;11592.826107608393;11713.941430292836;11716.707082322968;11721.824172637418;11729.296242225451;11684;11761.470733817;11762.411879406038;11765.058795296356;11771.823422648624;11689.29864208146;11735.941320293345;11739.765204695943;11749.236299640581;11753.294802311888;11575.42122893852;11688.883111168865;11694.356810375426;11996.040316774637;11996.100292478099;39304;41976.58023419757;42404.57595424037;42411.363829542584;42569.78715106435;3296.2000617228473;3410.471376936579;3411.6076651185185;3484.2160513884173;3874.1864208516245;26864.328391790164;29066.854665726536;29093.41813163725;29098.272543186376;29908.252293692833;2761;2772.5286701260834;2812.9296767580768;2851.9144425667055;2912.7524160446387;380314;381987;382746.08626956685;382941;385699;63347.6832615834;64558;64568.354316457175;64590.35409645937;64662.676686617204;68631.97052044224;68696;68904;69033;69093.96359054618;18048.819511804715;18373.908130459262;18463.723044154347;18474.353397631017;18482.353117640818;12980.35098245084;13097.21416714981;13109.475620975245;13126.474941002443;14061.578152655436;12835.037372197123;16433.671326573403;16516.091614961293;16541.421050263183;16659.33362665504;6762.425193858478;6768.69540870662;6799.456043516507;6815.318468153145;6885.518013739091;990.9355891867006;1055.1875056206677;1082.8700555933337;1151.9193656443967;1155.7457359380924;22953.426164346023;30343.241418964262;31257.062288131394;31273.8436307817;32001.359972800878;1047.930931824951;1064.2284343850802;1152.0553146419854;1179.5399794080315;1248.9250644961332;15722.606934826721;15999.680006399807;16053.117078560792;16101;16440.177991100398;614704;615337;615684.9215753892;618713;619646;63743.68128159329;64159.67920160369;64219;64236.71526569442;64286;1516.105497756329;1561.3910574875808;1578.684263147375;1602.7595860620768;1604.2299696145683;29472;29994.850025749733;30010.399792004475;31289.11263940735;31421.057368278987;49093.50906491032;50196.74901625468;50726.49273507218;50778.984420312125;51015.74492127515;449826;451918;452501;452984;453125.46874530835;35389.646103539664;41072.79463602663;41862.37206441845;42270.365944511475;42544.44733316011;43938.34092488551;43990;45111.54888451205;45447.31829022501;45870.54129458663;34949.8252508746;36022.27955440824;36623;36670.8166459166;37501.812490938464;36062.09844753902;36298.4555231677;36726;37630;38101.016531062705;37746.43380349242;37762.67830625915;38912.02719932024;39038.02404939899;39040.41439378355;31922.201944950633;32706.345873082882;33750.49374259339;33769;33988;25318.240452786446;25744.61383079293;25785.226443206735;25825.483490330465;26162.607560886223 09:01:59 INFO - PROCESS | 2002 | |2;jquery.html;423.71611020616183;424.1622794979917;425.6828662646328;425.8743670617168;435.12539795012015;20243.392698219057;20280.89859550704;21006.36980890574;22277;22284.554308913812;17048;21031.579368412622;21204.25785097522;21252.89373553134;21292.680609790867;5169.870753231171;5490.670559766407;5493.862653433656;5495.175723641466;5499.092649712793;4111.71218014739;4176.770277634729;5401.756920938547;5486.698231597281;6132.969335153318;6195.2565692117005;6197;6209.782657606985;6230.190075290206;6233.438990490855;6203.069539569078;6328.240611126671;6872.278410766898;6884.552504087218;6893.586384816927;4152.91694166118;5834.358220595731;6129.662868542228;6155.569110162291;6170.660613666247;13952.860471395257;14149.363278652485;14174.645633859132;14193.006489545736;26932.865335673196;2096.612126756555;2213.6015517206897;2234.994252586326;2286.27982185611;2376.196503441186;10035.54840032193;10039.196864250842;10096.848547271797;10362.740931476774;10375.584976600927;1822.9453116406528;1844.9538761530935;1891.3096719697348;1908.6659834529041;1935.3032908153195;122415;124263;125262.37368813189;127372;127686.72313276841;11669.59156429521;11778.646640600795;11869.347185904686;11899.762004759856;12044.096692748079;15630.06219626826;15642.921785391;15658.608534786721;15684.294206760494;15692.372305107669;7243.203247642755;7271.381932535794;8665.610047547876;9033.954830225806;9043.005269420359;9115.589798458952;9121.589528471235;9127.22418594427;9164.8625270621;9289.442633442015;3852.2102968891872;3926.646601805794;4744.786484608201;4752.263399173134;4805.783739731721;1823.575733862926;1969.458398940303;2019.6263691217173;2063.535704466483;2071.637463443891;918.8943271523726;986.5215370545279;1020.6172685243034;1045.6444808764904;1066.5627092891878;19084.61830763377;20483.897580512003;21171.68242476364;21442.463938401666;21519;935.6912218967724;961.9134277914882;1033.116685234114;1038.901304376098;1064.9627263045757;11273.436328183558;11548.76902461946;11636.534538618529;11641.53433862636;11655.76688466243;538759;542751;546215;583522;631407;120048.79951200551;121257;124682;131757.34121329332;132922;1052.8420736889527;1067.5569638599893;1086.3481910853582;1089.1831126655009;1092.4592326798286;14705.117692938458;18340;18800.34198803035;18896.905515472336;19058.04709764534;32918;51634.450966471064;52516.47483525116;52520.737396312776;54535.18197227124;78219.60890195513;79882;80147.19852801398;82456;82839.75740363779;8070.152633973348;8204.302634276153;8321.542315172723;8381.706640267561;8481.40630155883;9677.322587418814;11988.820167697317;13029.348532573524;13185.670358241121;13345.599632011055;11362.14783891195;11482.373070189413;11505.884941150482;11517.654470365902;11626.651200463999;11050.557977680803;11216.610706493015;11228.55085796559;11366.431678416211;11587;11574.88425115738;11619.186656934271;11825.645230643095;11971.10216733731;11995.520179192734;7908.169642187488;8049.637766300413;8109.635066421907;8283.130271321425;8842.381033327605;7873.25204105609;7896.052473702963;7979.44143909944;8322.916770832215;8582.97004359456 09:01:59 INFO - PROCESS | 2002 | |3;mootools.html;1477.1284941884287;1628.340522088554;1644.6710657868423;1921.2027008791351;2024.6558085125519;8035.357171426286;8746.868796968043;8877.955610221956;8881.46711197327;8892.333075019367;8502.149785021495;8736.301095912328;8739.956300218506;8755.781105472366;8756.95621521893;2516.937076573091;2545.440003199293;2546.2743118211315;2546.5161619292276;2550.1202085280547;2464.2607217834666;2547.2740269023334;2547.6688030556093;2549.974500254992;2553.6807899012624;2465.8890349934204;2503.1864643990684;2505.1607711416696;2510.723820379757;2513.45960618467;2131.7761635028255;2508.159766478223;2538.352720056392;2543.046357615894;2553.5531282025663;2500.2624225853415;2539.263613552068;2550.744925507453;2552.897884084653;2562.705288891783;8648.610812513389;8814.338924580683;8866.86699699505;8884.555772211364;8901.910980890238;5494.09347457673;5649.830505084854;5661.179129026268;5666.291713535808;5708.886767080421;3562.8040457775073;3669.7247706422127;3684.6499582539614;3708.8145592720257;3732.085639018431;916.2303664921498;1038.6832016235046;1059.3220338983058;1070.4487189097622;1071.2394200117926;11942.641720748392;12098;12116.394180291038;12127.878721212763;12140.575079872251;3885.2812229737588;4697.95302046982;4740.834070807505;4812.494688057704;4815.903681926342;9524.428534287965;9540.998195189544;9541.2367010639;9544.141027307576;9552;5472;5515.227868098469;5516.310461192351;5524.475174858382;5532.889342213214;4605.585497305258;4698.3187437821325;5009.924851127236;5031.572316353151;5144.871378215575;3987.760734355948;4013.2976729072298;4063.674906007512;4089.591040895946;4106.527749308808;1208.4863932828512;1272.4401263444056;1276.5340650662442;1287.9613611591667;1288.4459682336499;927.7495076329488;955.1069749783974;960.1694534227843;964.5225613321311;1000.0299709281985;6079.300880398722;6081.148639190517;6106.877862442815;6216.720247588869;6237.251529816361;483.2196003454396;483.94192696875893;484.85696719467137;485.6479052686774;493.575525048458;3958.960410395917;3959.8416063357145;4051.4125451809323;4077.4699289092227;4088.919832902292;10594.947025264824;10773.407462589634;10972.451377431096;11071.778564428667;11090.722731931766;10937.890621093688;10940.726481838017;10949.781004379867;10952;10997.835032474519;7944.364450843918;8308.335333173332;8321.500709957301;8440;8518.23335899772;5905.40945905406;5974.342822289458;6071.210742603434;6116.602420842631;6181.289151747606;9759.51202439861;9793;9799.559019844266;9961.551730172016;10017.69946901594;7904.249096335839;8454.619542120496;10158;10202.642907498202;10229.590816367261;7031.261717519586;7132.928670713434;7138.393236574741;7746.612669366622;7910.485818421784;7848.646810893638;8267.875981860398;8377.539235342114;8413.368997325348;8477.98264208299;6160.3223645398075;7343.37581305595;7410.5183163094225;7547.0943486781935;7569.621518924142;7291.08861392326;7338.596377199306;7357;7368.4842061055215;7411.8147046324275;6936.965315173392;7007.894881576883;7010.123734533184;7020.824479388056;7034.929650703428;4834.274858771212;4876.317315575751;4883.706977581356;4899.3385892904;4988.6757360771435;4776;4793.472718001087;4858.562729354375;4903.31353610502;5042.722650254272 09:01:59 INFO - PROCESS | 2002 | |4;prototype.html;312.21166554450014;335.64757005144594;344.8482667626244;348.0428820742957;353.5050928699818;6483.740650373979;6692.063111164435;6696.598204107757;6698.933010669892;6722.663866806664;6390.201224846895;6693.39759421652;6729.663516824152;6731.9326806731915;6745.662716864162;4773.713577185371;4871.658983871131;4874.634402419815;4968.627352948525;4992.450830408652;4895.706257624536;4966.9751651241695;4974.950250497503;4975.104481193383;4995.175795993657;4906.779194936219;4910.975445122769;4914.582260507843;4915.754212289389;4953.876153096184;4719.9292010619865;4793.90412191756;4918.901621967577;4919.4834542373255;4923.901521969577;3669.9082522936874;4078.898697351728;4225.323948168279;4240.936385954213;4243.53321134678;5234.6335756497065;6425.100485931974;6442.387973142544;6499.967500162469;6501.739930402779;4819.614430845559;5891.440313170285;5909.911351329733;5918.615290006136;5919.49684276837;6536.54244202906;6822.522423430361;6927.688254028581;7164.605946672931;7165.89251161233;4807.879803004917;4815.6388270879825;4816.301636262758;4822.252550854623;4834.637402194814;5952;7504.737334193332;7588;7590.203028682019;7611.20082391352;4712.552307530779;4902.093112774148;4902.681325713817;4903.264510323409;4907.214845624683;4093.9181216375505;4119.443875076826;4547.1815073287125;4973.1297023020825;4979.029089327619;5879.882402352015;5894.793682221188;5896.380880007538;5903.144044113579;5913.645181289136;6838.931610683929;6844.486663500257;6881.277465866012;7166.104236970379;7211.963940180265;1704.1649591699977;1710.9230084645972;1727.9827201728074;1730.558707529597;1732.644807814395;1039.7452624107143;1056.566807608892;1085.2294870641933;1096.8848270931596;1115.7935781880378;6766.49251306154;6882.139732533434;6895.5173137879865;6908.309169083152;6913.516053876281;7578.924210757932;7581.50720203196;7583.658735356922;7587.089549254015;7589.316961473494;6219.968900155471;6444;6969.16370035599;6980.581165130108;6981.127359080115;3828.1003964068423;3951.8024098794945;3988.6809055275507;3992.760434373889;3995.2409042282457;6710.530262881649;7828.843423131506;7890.842183156305;7967.920320796834;7968.482048666818;7747.147813740484;7751.108622508371;7751.224877512203;7757.456978011485;7765.572893490912;7889.644965976545;7904.525728456196;7914.089879663912;7915.16890726477;7917.2874441300555;7213.783586492414;7497.325240728361;7545.50954187976;7546.24537546241;7564.962175189309;7314.561126332437;7343.522671026366;7361.2638736125955;7362.300581444754;7394.260573942778;6331.810045698637;6453.580517266362;7892;7892.881606775788;7908.802279943047;4620.052889157648;4696.342512048384;4709.458412282632;4711.811527538997;4715.316279139574;7156.3559279662995;7417.962910185414;7423.257674232534;7424.851502970018;7432.3310902019075;7200.1719802223415;7209.963950180216;7243.5653860768525;7250.41996640257;7281.235470275545;7248.238934911969;7261.237570055068;7267.927320726725;7269.382102521345;7269.854602908018;7097.893531597134;7100.112485939258;7105.46708996817;7109.395701365442;7113.6443177839865;6277.874442511033;6754.155730533684;6913.827154321182;7233.132024156925;7264.273572642694;6812.182538095461;6934.583924964519;6980.371766541036;7064.682089306097;7128.180259270043 09:01:59 INFO - PROCESS | 2002 | |5;yui.html;729.2124505534022;765.1392183793232;796.3032346696644;796.5181065455399;812.3501199040768;15716.214189290547;15963.52109436716;15977.360905563792;15993.440229591952;16066.437674681374;14712.970092093557;14742.63143421415;14761.92619036906;14767.261636918165;14809.629759256024;762.477702773599;771.6874665760348;775.3758224629171;949.8480243161113;962.7496850818802;770.5222761887637;773.408342617895;943.3349488610513;968.6416026070364;970.8058388322364;993.9353941993784;1008.606643409071;1008.8940661230575;1010.5200029985734;1010.8584798128268;1007.6926537406089;1008.6671398438498;1009.081735620589;1010.1312870930993;1011.3274672342883;601.3835818286248;605.6093819486407;608.5679167790873;609.4667166229549;744.3747252308033;15463.922680386639;15521.611959701098;15531.922340388339;15532.534023979299;15558.922205389013;13182.274974876378;13200.20798752078;13337.599872003855;13373.063885528018;13720.382582783699;9277.35058545902;9583.808323833555;9864.556094975744;9960.95019524905;10081.848772268422;3200.815698191661;3549.4498352755363;3646.74472786905;3689.8893033209047;3704.573973992998;66987.66506167487;72456.7394467245;82752;83620.16379836245;83690;9652.71041868731;9821.80356392868;9866.722281809893;9939.55272012761;9940.502974851228;22212;22482.32553023412;22489.775102249096;22497.662535061987;22502.66246006311;7773.106092799288;7861.842763144705;7912.683492660229;7948.721794737156;7964;4242.703010789215;4260.998665313648;4274.316109422478;4358.956410435855;4559.224931761542;3650.178709790276;3818.4845045919;3888.844446222176;3889.474920885644;3894.084890050836;683.781190019199;687.5874475314771;711.9501634885612;712.618748969299;715.3418854653731;578.9652620842763;586.5864565481326;592.2567178191429;602.108878859282;616.3435940723116;6981.930180698229;7713.190115037953;8227.382946279053;8271.751847444586;8286.544240066854;489.7967343552386;577.0795581048221;582.4466756581264;590.3004939147124;598.5062323582974;3795.69634429245;3864.942025869614;3912.39357899526;3914.393269043303;4052.959470405317;94458.52770736102;96269;96819;97140.0285997131;98273.50863245782;78725;79129.20870791333;79344;79957;80744;62106.37893621096;62915.370846291866;63673.68163159247;63980.99999999907;65038.67480662661;6411.935880641134;6948.652567371712;7520.511166774142;7806;8053.31546818527;49859.501404986935;50453.24320135274;50590.49409506005;51118.74440627773;51499;55936.44063559312;60512.697436512535;64936.0259596097;66141.00788488273;71895.64052179706;11363.48864301125;11444.313341199555;11504.36725980079;11718.06255499541;11925.701857453632;12056.879431205576;12111.636650900487;12260.26438413698;12467.127301088836;12971.610851674464;9745.512724363613;11988.580399685969;12033.4584943676;12131.21147125434;12311.44598493052;11965.700857478632;12043.156979011384;12057.15599908033;12068.879311206776;12086.697832554257;11505.686758721396;11805.468753905923;11825.940870295593;12216.205946613798;12551.686207844512;9984.650537231453;10086.79826403453;10172.542235599267;10175.236857235588;10283.897161028293;10111.292209545261;10235.078842903877;10237.641682541076;10259.435731034566;10271.84592231132 09:01:59 INFO - PROCESS | 2002 | __end_tp_report 09:01:59 INFO - PROCESS | 2002 | __start_cc_report 09:01:59 INFO - PROCESS | 2002 | _x_x_mozilla_cycle_collect,1021 09:01:59 INFO - PROCESS | 2002 | __end_cc_report 09:01:59 INFO - PROCESS | 2002 | __startTimestamp1467043318999__endTimestamp 09:01:59 INFO - PROCESS | 2002 | 09:01:59 INFO - PROCESS | 2002 | ------- Summary: start ------- 09:01:59 INFO - PROCESS | 2002 | Number of tests: 6 09:01:59 INFO - PROCESS | 2002 | 09:01:59 INFO - PROCESS | 2002 | [#0] dojo.html Cycles:165 Average:5840.58 Median:6104.82 stddev:646.87 (10.6%) stddev-sans-first:622.23 09:01:59 INFO - PROCESS | 2002 | Values: 3499.2 3565.2 3574.7 3582.8 3628.6 5879.7 5880.7 5882.0 5884.7 5953.1 5882.7 5951.1 5953.6 5960.8 5963.6 5207.1 5252.1 5273.9 5325.4 5343.8 5320.7 5363.8 5367.1 5380.4 5388.7 5265.6 5310.9 5329.9 5344.7 5365.5 5328.7 5370.8 5373.6 5375.8 5416.1 5153.4 5199.6 5291.2 5310.1 5316.0 5687.9 5762.7 5770.4 5795.4 5800.6 5275.5 6165.8 6226.0 6251.2 6291.6 6237.8 6257.0 6335.2 6338.6 6344.6 5883.5 5944.9 5955.2 5965.9 5983.2 6404.2 6411.4 6413.1 6415.6 6418.5 5046.4 6196.9 6266.6 6306.9 6317.5 6293.8 6306.9 6314.9 6316.8 6331.5 5222.2 6310.7 6329.8 6337.2 6341.9 4679.6 6234.3 6269.3 6353.1 6362.8 4952.7 4974.9 4983.5 5031.2 5063.4 4527.6 4542.6 4551.6 4564.1 4567.9 5792.2 5894.8 5923.9 5930.8 6045.5 6294.9 6322.0 6331.6 6331.6 6332.0 6042.5 6052.3 6053.8 6061.2 6072.5 5346.0 5428.2 5440.4 5521.8 5543.8 6509.5 6513.7 6558.5 6559.4 6565.6 6306.6 6312.7 6315.2 6315.4 6323.5 6363.8 6464.5 6516.3 6576.4 6589.3 6256.6 6278.5 6292.1 6292.5 6298.4 6285.2 6299.6 6301.8 6310.8 6324.8 6111.4 6167.8 6250.9 6275.9 6277.3 4720.7 6226.6 6239.4 6249.2 6284.9 5973.2 6121.0 6163.2 6172.1 6201.7 6113.0 6136.9 6171.8 6255.5 6295.8 6101.7 6104.8 6106.2 6109.3 6120.3 09:01:59 INFO - PROCESS | 2002 | 09:01:59 INFO - PROCESS | 2002 | [#1] ext.html Cycles:180 Average:64066.31 Median:35169.74 stddev:131413.65 (373.7%) stddev-sans-first:131695.71 09:01:59 INFO - PROCESS | 2002 | Values: 525.6 551.9 574.6 612.7 638.1 31913.7 40559.8 40591.4 40592.2 40597.0 42855.8 43428.1 43486.9 43548.6 43648.0 9097.5 9570.8 9803.4 9807.2 11625.1 11592.8 11713.9 11716.7 11721.8 11729.3 11684.0 11761.5 11762.4 11765.1 11771.8 11689.3 11735.9 11739.8 11749.2 11753.3 11575.4 11688.9 11694.4 11996.0 11996.1 39304.0 41976.6 42404.6 42411.4 42569.8 3296.2 3410.5 3411.6 3484.2 3874.2 26864.3 29066.9 29093.4 29098.3 29908.3 2761.0 2772.5 2812.9 2851.9 2912.8 380314.0 381987.0 382746.1 382941.0 385699.0 63347.7 64558.0 64568.4 64590.4 64662.7 68632.0 68696.0 68904.0 69033.0 69094.0 18048.8 18373.9 18463.7 18474.4 18482.4 12980.4 13097.2 13109.5 13126.5 14061.6 12835.0 16433.7 16516.1 16541.4 16659.3 6762.4 6768.7 6799.5 6815.3 6885.5 990.9 1055.2 1082.9 1151.9 1155.7 22953.4 30343.2 31257.1 31273.8 32001.4 1047.9 1064.2 1152.1 1179.5 1248.9 15722.6 15999.7 16053.1 16101.0 16440.2 614704.0 615337.0 615684.9 618713.0 619646.0 63743.7 64159.7 64219.0 64236.7 64286.0 1516.1 1561.4 1578.7 1602.8 1604.2 29472.0 29994.9 30010.4 31289.1 31421.1 49093.5 50196.7 50726.5 50779.0 51015.7 449826.0 451918.0 452501.0 452984.0 453125.5 35389.6 41072.8 41862.4 42270.4 42544.4 43938.3 43990.0 45111.5 45447.3 45870.5 34949.8 36022.3 36623.0 36670.8 37501.8 36062.1 36298.5 36726.0 37630.0 38101.0 37746.4 37762.7 38912.0 39038.0 39040.4 31922.2 32706.3 33750.5 33769.0 33988.0 25318.2 25744.6 25785.2 25825.5 26162.6 09:01:59 INFO - PROCESS | 2002 | 09:01:59 INFO - PROCESS | 2002 | [#2] jquery.html Cycles:180 Average:34105.43 Median:21367.57 stddev:95557.12 (447.2%) stddev-sans-first:95791.72 09:01:59 INFO - PROCESS | 2002 | Values: 423.7 424.2 425.7 425.9 435.1 20243.4 20280.9 21006.4 22277.0 22284.6 17048.0 21031.6 21204.3 21252.9 21292.7 5169.9 5490.7 5493.9 5495.2 5499.1 4111.7 4176.8 5401.8 5486.7 6133.0 6195.3 6197.0 6209.8 6230.2 6233.4 6203.1 6328.2 6872.3 6884.6 6893.6 4152.9 5834.4 6129.7 6155.6 6170.7 13952.9 14149.4 14174.6 14193.0 26932.9 2096.6 2213.6 2235.0 2286.3 2376.2 10035.5 10039.2 10096.8 10362.7 10375.6 1822.9 1845.0 1891.3 1908.7 1935.3 122415.0 124263.0 125262.4 127372.0 127686.7 11669.6 11778.6 11869.3 11899.8 12044.1 15630.1 15642.9 15658.6 15684.3 15692.4 7243.2 7271.4 8665.6 9034.0 9043.0 9115.6 9121.6 9127.2 9164.9 9289.4 3852.2 3926.6 4744.8 4752.3 4805.8 1823.6 1969.5 2019.6 2063.5 2071.6 918.9 986.5 1020.6 1045.6 1066.6 19084.6 20483.9 21171.7 21442.5 21519.0 935.7 961.9 1033.1 1038.9 1065.0 11273.4 11548.8 11636.5 11641.5 11655.8 538759.0 542751.0 546215.0 583522.0 631407.0 120048.8 121257.0 124682.0 131757.3 132922.0 1052.8 1067.6 1086.3 1089.2 1092.5 14705.1 18340.0 18800.3 18896.9 19058.0 32918.0 51634.5 52516.5 52520.7 54535.2 78219.6 79882.0 80147.2 82456.0 82839.8 8070.2 8204.3 8321.5 8381.7 8481.4 9677.3 11988.8 13029.3 13185.7 13345.6 11362.1 11482.4 11505.9 11517.7 11626.7 11050.6 11216.6 11228.6 11366.4 11587.0 11574.9 11619.2 11825.6 11971.1 11995.5 7908.2 8049.6 8109.6 8283.1 8842.4 7873.3 7896.1 7979.4 8322.9 8583.0 09:01:59 INFO - PROCESS | 2002 | 09:01:59 INFO - PROCESS | 2002 | [#3] mootools.html Cycles:180 Average:5746.98 Median:4891.52 stddev:3190.60 (65.2%) stddev-sans-first:3183.42 09:01:59 INFO - PROCESS | 2002 | Values: 1477.1 1628.3 1644.7 1921.2 2024.7 8035.4 8746.9 8878.0 8881.5 8892.3 8502.1 8736.3 8740.0 8755.8 8757.0 2516.9 2545.4 2546.3 2546.5 2550.1 2464.3 2547.3 2547.7 2550.0 2553.7 2465.9 2503.2 2505.2 2510.7 2513.5 2131.8 2508.2 2538.4 2543.0 2553.6 2500.3 2539.3 2550.7 2552.9 2562.7 8648.6 8814.3 8866.9 8884.6 8901.9 5494.1 5649.8 5661.2 5666.3 5708.9 3562.8 3669.7 3684.6 3708.8 3732.1 916.2 1038.7 1059.3 1070.4 1071.2 11942.6 12098.0 12116.4 12127.9 12140.6 3885.3 4698.0 4740.8 4812.5 4815.9 9524.4 9541.0 9541.2 9544.1 9552.0 5472.0 5515.2 5516.3 5524.5 5532.9 4605.6 4698.3 5009.9 5031.6 5144.9 3987.8 4013.3 4063.7 4089.6 4106.5 1208.5 1272.4 1276.5 1288.0 1288.4 927.7 955.1 960.2 964.5 1000.0 6079.3 6081.1 6106.9 6216.7 6237.3 483.2 483.9 484.9 485.6 493.6 3959.0 3959.8 4051.4 4077.5 4088.9 10594.9 10773.4 10972.5 11071.8 11090.7 10937.9 10940.7 10949.8 10952.0 10997.8 7944.4 8308.3 8321.5 8440.0 8518.2 5905.4 5974.3 6071.2 6116.6 6181.3 9759.5 9793.0 9799.6 9961.6 10017.7 7904.2 8454.6 10158.0 10202.6 10229.6 7031.3 7132.9 7138.4 7746.6 7910.5 7848.6 8267.9 8377.5 8413.4 8478.0 6160.3 7343.4 7410.5 7547.1 7569.6 7291.1 7338.6 7357.0 7368.5 7411.8 6937.0 7007.9 7010.1 7020.8 7034.9 4834.3 4876.3 4883.7 4899.3 4988.7 4776.0 4793.5 4858.6 4903.3 5042.7 09:01:59 INFO - PROCESS | 2002 | 09:01:59 INFO - PROCESS | 2002 | [#4] prototype.html Cycles:180 Average:5875.22 Median:6695.00 stddev:1881.91 (28.1%) stddev-sans-first:1840.29 09:01:59 INFO - PROCESS | 2002 | Values: 312.2 335.6 344.8 348.0 353.5 6483.7 6692.1 6696.6 6698.9 6722.7 6390.2 6693.4 6729.7 6731.9 6745.7 4773.7 4871.7 4874.6 4968.6 4992.5 4895.7 4967.0 4975.0 4975.1 4995.2 4906.8 4911.0 4914.6 4915.8 4953.9 4719.9 4793.9 4918.9 4919.5 4923.9 3669.9 4078.9 4225.3 4240.9 4243.5 5234.6 6425.1 6442.4 6500.0 6501.7 4819.6 5891.4 5909.9 5918.6 5919.5 6536.5 6822.5 6927.7 7164.6 7165.9 4807.9 4815.6 4816.3 4822.3 4834.6 5952.0 7504.7 7588.0 7590.2 7611.2 4712.6 4902.1 4902.7 4903.3 4907.2 4093.9 4119.4 4547.2 4973.1 4979.0 5879.9 5894.8 5896.4 5903.1 5913.6 6838.9 6844.5 6881.3 7166.1 7212.0 1704.2 1710.9 1728.0 1730.6 1732.6 1039.7 1056.6 1085.2 1096.9 1115.8 6766.5 6882.1 6895.5 6908.3 6913.5 7578.9 7581.5 7583.7 7587.1 7589.3 6220.0 6444.0 6969.2 6980.6 6981.1 3828.1 3951.8 3988.7 3992.8 3995.2 6710.5 7828.8 7890.8 7967.9 7968.5 7747.1 7751.1 7751.2 7757.5 7765.6 7889.6 7904.5 7914.1 7915.2 7917.3 7213.8 7497.3 7545.5 7546.2 7565.0 7314.6 7343.5 7361.3 7362.3 7394.3 6331.8 6453.6 7892.0 7892.9 7908.8 4620.1 4696.3 4709.5 4711.8 4715.3 7156.4 7418.0 7423.3 7424.9 7432.3 7200.2 7210.0 7243.6 7250.4 7281.2 7248.2 7261.2 7267.9 7269.4 7269.9 7097.9 7100.1 7105.5 7109.4 7113.6 6277.9 6754.2 6913.8 7233.1 7264.3 6812.2 6934.6 6980.4 7064.7 7128.2 09:01:59 INFO - PROCESS | 2002 | 09:01:59 INFO - PROCESS | 2002 | [#5] yui.html Cycles:180 Average:18322.69 Median:50521.87 stddev:25439.85 (50.4%) stddev-sans-first:25476.91 09:01:59 INFO - PROCESS | 2002 | Values: 729.2 765.1 796.3 796.5 812.4 15716.2 15963.5 15977.4 15993.4 16066.4 14713.0 14742.6 14761.9 14767.3 14809.6 762.5 771.7 775.4 949.8 962.7 770.5 773.4 943.3 968.6 970.8 993.9 1008.6 1008.9 1010.5 1010.9 1007.7 1008.7 1009.1 1010.1 1011.3 601.4 605.6 608.6 609.5 744.4 15463.9 15521.6 15531.9 15532.5 15558.9 13182.3 13200.2 13337.6 13373.1 13720.4 9277.4 9583.8 9864.6 9961.0 10081.8 3200.8 3549.4 3646.7 3689.9 3704.6 66987.7 72456.7 82752.0 83620.2 83690.0 9652.7 9821.8 9866.7 9939.6 9940.5 22212.0 22482.3 22489.8 22497.7 22502.7 7773.1 7861.8 7912.7 7948.7 7964.0 4242.7 4261.0 4274.3 4359.0 4559.2 3650.2 3818.5 3888.8 3889.5 3894.1 683.8 687.6 712.0 712.6 715.3 579.0 586.6 592.3 602.1 616.3 6981.9 7713.2 8227.4 8271.8 8286.5 489.8 577.1 582.4 590.3 598.5 3795.7 3864.9 3912.4 3914.4 4053.0 94458.5 96269.0 96819.0 97140.0 98273.5 78725.0 79129.2 79344.0 79957.0 80744.0 62106.4 62915.4 63673.7 63981.0 65038.7 6411.9 6948.7 7520.5 7806.0 8053.3 49859.5 50453.2 50590.5 51118.7 51499.0 55936.4 60512.7 64936.0 66141.0 71895.6 11363.5 11444.3 11504.4 11718.1 11925.7 12056.9 12111.6 12260.3 12467.1 12971.6 9745.5 11988.6 12033.5 12131.2 12311.4 11965.7 12043.2 12057.2 12068.9 12086.7 11505.7 11805.5 11825.9 12216.2 12551.7 9984.7 10086.8 10172.5 10175.2 10283.9 10111.3 10235.1 10237.6 10259.4 10271.8 09:01:59 INFO - PROCESS | 2002 | -------- Summary: end -------- 09:01:59 INFO - PROCESS | 2002 | 09:01:59 INFO - TEST-INFO | 2002: exit 0 09:01:59 INFO - TEST-OK | dromaeo_css | took 1112418ms 09:01:59 INFO - TEST-START | kraken 09:01:59 INFO - operating with platform_type : mac_ 09:01:59 INFO - Initialising browser for kraken test... 09:01:59 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpzXCENF/profile http://localhost:51307/getInfo.html) 09:02:01 INFO - PROCESS | 2005 | __metrics Screen width/height:1600/1200 09:02:01 INFO - PROCESS | 2005 | colorDepth:24 09:02:01 INFO - PROCESS | 2005 | Browser inner width/height: 1024/689 09:02:01 INFO - PROCESS | 2005 | __metrics 09:02:01 INFO - PROCESS | 2005 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:02:01 ERROR - PROCESS | 2005 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:02:02 INFO - TEST-INFO | 2005: exit 0 09:02:02 INFO - Browser initialized. 09:02:02 INFO - Running cycle 1/1 for kraken test... 09:02:02 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpzXCENF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:14 INFO - PROCESS | 2008 | RSS: Main: 161828864 09:02:14 INFO - PROCESS | 2008 | 09:02:16 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51307/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:17 INFO - PROCESS | 2008 | RSS: Main: 225198080 09:02:17 INFO - PROCESS | 2008 | 09:02:20 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51307/tests/kraken/driver.html?testName=audio-dft) 09:02:20 INFO - PROCESS | 2008 | RSS: Main: 240123904 09:02:20 INFO - PROCESS | 2008 | 09:02:23 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51307/tests/kraken/driver.html?testName=audio-fft) 09:02:24 INFO - PROCESS | 2008 | RSS: Main: 327815168 09:02:24 INFO - PROCESS | 2008 | 09:02:26 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51307/tests/kraken/driver.html?testName=audio-oscillator) 09:02:27 INFO - PROCESS | 2008 | RSS: Main: 231964672 09:02:27 INFO - PROCESS | 2008 | 09:02:29 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51307/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:29 INFO - PROCESS | 2008 | RSS: Main: 232419328 09:02:29 INFO - PROCESS | 2008 | 09:02:32 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51307/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:33 INFO - PROCESS | 2008 | RSS: Main: 271159296 09:02:33 INFO - PROCESS | 2008 | 09:02:36 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51307/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:36 INFO - PROCESS | 2008 | RSS: Main: 271364096 09:02:36 INFO - PROCESS | 2008 | 09:02:39 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51307/tests/kraken/driver.html?testName=json-parse-financial) 09:02:40 INFO - PROCESS | 2008 | RSS: Main: 270696448 09:02:40 INFO - PROCESS | 2008 | 09:02:41 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51307/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:42 INFO - PROCESS | 2008 | RSS: Main: 260526080 09:02:42 INFO - PROCESS | 2008 | 09:02:44 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51307/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:44 INFO - PROCESS | 2008 | RSS: Main: 268079104 09:02:44 INFO - PROCESS | 2008 | 09:02:46 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51307/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:47 INFO - PROCESS | 2008 | RSS: Main: 270934016 09:02:47 INFO - PROCESS | 2008 | 09:02:50 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:50 INFO - PROCESS | 2008 | RSS: Main: 278118400 09:02:50 INFO - PROCESS | 2008 | 09:02:53 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:54 INFO - PROCESS | 2008 | RSS: Main: 275202048 09:02:54 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:51307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51307/tests/kraken/driver.html?testName=ai-astar) 09:02:56 INFO - PROCESS | 2008 | RSS: Main: 336379904 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | __start_tp_report 09:02:56 INFO - PROCESS | 2008 | _x_x_mozilla_page_load 09:02:56 INFO - PROCESS | 2008 | _x_x_mozilla_page_load_details 09:02:56 INFO - PROCESS | 2008 | |i|pagename|runs| 09:02:56 INFO - PROCESS | 2008 | |0;ai-astar;115;113;121;111;109;111;113;113;110;134 09:02:56 INFO - PROCESS | 2008 | |1;audio-beat-detection;159;122;156;165;118;142;116;153;156;117 09:02:56 INFO - PROCESS | 2008 | |2;audio-dft;186;186;187;182;185;186;186;184;185;186 09:02:56 INFO - PROCESS | 2008 | |3;audio-fft;68;79;71;159;55;55;56;62;133;55 09:02:56 INFO - PROCESS | 2008 | |4;audio-oscillator;93;92;140;78;79;80;121;79;76;128 09:02:56 INFO - PROCESS | 2008 | |5;imaging-gaussian-blur;87;84;93;130;86;70;135;131;95;83 09:02:56 INFO - PROCESS | 2008 | |6;imaging-darkroom;91;92;92;92;92;92;92;93;88;140 09:02:56 INFO - PROCESS | 2008 | |7;imaging-desaturate;84;86;87;84;85;85;85;86;84;85 09:02:56 INFO - PROCESS | 2008 | |8;json-parse-financial;56;60;61;60;62;63;61;76;58;55 09:02:56 INFO - PROCESS | 2008 | |9;json-stringify-tinderbox;60;63;65;79;78;71;66;67;66;66 09:02:56 INFO - PROCESS | 2008 | |10;stanford-crypto-aes;81;79;80;77;80;79;82;93;104;107 09:02:56 INFO - PROCESS | 2008 | |11;stanford-crypto-ccm;127;128;138;142;115;138;139;142;151;140 09:02:56 INFO - PROCESS | 2008 | |12;stanford-crypto-pbkdf2;162;162;162;163;163;164;162;161;174;197 09:02:56 INFO - PROCESS | 2008 | |13;stanford-crypto-sha256-iterative;56;81;94;94;66;66;68;74;93;98 09:02:56 INFO - PROCESS | 2008 | __end_tp_report 09:02:56 INFO - PROCESS | 2008 | __start_cc_report 09:02:56 INFO - PROCESS | 2008 | _x_x_mozilla_cycle_collect,1906 09:02:56 INFO - PROCESS | 2008 | __end_cc_report 09:02:56 INFO - PROCESS | 2008 | __startTimestamp1467043376502__endTimestamp 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | ------- Summary: start ------- 09:02:56 INFO - PROCESS | 2008 | Number of tests: 14 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#0] ai-astar Cycles:10 Average:115.00 Median:113.00 stddev:7.47 (6.6%) stddev-sans-first:7.92 09:02:56 INFO - PROCESS | 2008 | Values: 115.0 113.0 121.0 111.0 109.0 111.0 113.0 113.0 110.0 134.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:154.50 stddev:19.95 (12.9%) stddev-sans-first:19.99 09:02:56 INFO - PROCESS | 2008 | Values: 159.0 122.0 156.0 165.0 118.0 142.0 116.0 153.0 156.0 117.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#2] audio-dft Cycles:10 Average:185.30 Median:186.00 stddev:1.42 (0.8%) stddev-sans-first:1.48 09:02:56 INFO - PROCESS | 2008 | Values: 186.0 186.0 187.0 182.0 185.0 186.0 186.0 184.0 185.0 186.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#3] audio-fft Cycles:10 Average:79.30 Median:59.00 stddev:36.58 (62.0%) stddev-sans-first:38.57 09:02:56 INFO - PROCESS | 2008 | Values: 68.0 79.0 71.0 159.0 55.0 55.0 56.0 62.0 133.0 55.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:79.00 stddev:23.95 (30.3%) stddev-sans-first:25.37 09:02:56 INFO - PROCESS | 2008 | Values: 93.0 92.0 140.0 78.0 79.0 80.0 121.0 79.0 76.0 128.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#5] imaging-gaussian-blur Cycles:10 Average:99.40 Median:85.00 stddev:23.49 (27.6%) stddev-sans-first:24.48 09:02:56 INFO - PROCESS | 2008 | Values: 87.0 84.0 93.0 130.0 86.0 70.0 135.0 131.0 95.0 83.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:92.00 stddev:15.38 (16.7%) stddev-sans-first:16.19 09:02:56 INFO - PROCESS | 2008 | Values: 91.0 92.0 92.0 92.0 92.0 92.0 92.0 93.0 88.0 140.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.99 (1.2%) stddev-sans-first:0.97 09:02:56 INFO - PROCESS | 2008 | Values: 84.0 86.0 87.0 84.0 85.0 85.0 85.0 86.0 84.0 85.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.00 stddev:5.79 (9.5%) stddev-sans-first:5.83 09:02:56 INFO - PROCESS | 2008 | Values: 56.0 60.0 61.0 60.0 62.0 63.0 61.0 76.0 58.0 55.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:66.50 stddev:6.15 (9.3%) stddev-sans-first:5.79 09:02:56 INFO - PROCESS | 2008 | Values: 60.0 63.0 65.0 79.0 78.0 71.0 66.0 67.0 66.0 66.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:80.00 stddev:11.08 (13.9%) stddev-sans-first:11.60 09:02:56 INFO - PROCESS | 2008 | Values: 81.0 79.0 80.0 77.0 80.0 79.0 82.0 93.0 104.0 107.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:139.50 stddev:10.09 (7.2%) stddev-sans-first:10.16 09:02:56 INFO - PROCESS | 2008 | Values: 127.0 128.0 138.0 142.0 115.0 138.0 139.0 142.0 151.0 140.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:163.00 stddev:11.19 (6.9%) stddev-sans-first:11.72 09:02:56 INFO - PROCESS | 2008 | Values: 162.0 162.0 162.0 163.0 163.0 164.0 162.0 161.0 174.0 197.0 09:02:56 INFO - PROCESS | 2008 | 09:02:56 INFO - PROCESS | 2008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.00 Median:87.00 stddev:15.00 (17.2%) stddev-sans-first:13.40 09:02:56 INFO - PROCESS | 2008 | Values: 56.0 81.0 94.0 94.0 66.0 66.0 68.0 74.0 93.0 98.0 09:02:56 INFO - PROCESS | 2008 | -------- Summary: end -------- 09:02:56 INFO - PROCESS | 2008 | 09:02:57 INFO - TEST-INFO | 2008: exit 0 09:02:57 INFO - TEST-OK | kraken | took 57723ms 09:02:57 INFO - SUITE-END | took 1170s 09:02:57 INFO - Completed test suite (00:19:30) 09:02:57 INFO - javascript benchmark 09:02:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3499.160201551628, 3565.1800085980226, 3574.731895107864, 3582.820858957053, 3628.60085390607, 5879.735411906464, 5880.656676643432, 5882.000059989801, 5884.705764711758, 5953.107033944905, 5882.705864706769, 5951.077582974635, 5953.613015154012, 5960.821175364736, 5963.642181469104, 5207.088759467097, 5252.107141785887, 5273.920891186635, 5325.440828712987, 5343.759530821103, 5320.680759154444, 5363.839084827461, 5367.06076436624, 5380.381256155553, 5388.7305634718305, 5265.605079619044, 5310.92033619496, 5329.920051199235, 5344.652597581145, 5365.543928766059, 5328.706921119337, 5370.838874833761, 5373.59698022646, 5375.838724838261, 5416.052190866582, 5153.407358153823, 5199.610029247784, 5291.206319052135, 5310.070737620939, 5315.973420132913, 5687.914681279784, 5762.683052432115, 5770.3652598214585, 5795.420457954213, 5800.564957628152, 5275.498827611371, 6165.84585385369, 6226.034964580452, 6251.249850017982, 6291.559590828644, 6237.781677641261, 6257.0, 6335.239771227482, 6338.619682819046, 6344.555881088326, 5883.470487656089, 5944.851378715567, 5955.196048533479, 5965.850853728692, 5983.222181116427, 6404.199475065617, 6411.4229719325485, 6413.134226879405, 6415.582987105917, 6418.454431373386, 5046.369203849519, 6196.8760624787255, 6266.624002559861, 6306.905396419057, 6317.526185536103, 6293.842653933597, 6306.905396419057, 6314.905276420857, 6316.810495685137, 6331.461825744863, 5222.242774797709, 6310.747570097236, 6329.810105696836, 6337.176167098248, 6341.904871426932, 4679.602233810097, 6234.251889773165, 6269.279032911182, 6353.142325786052, 6362.809115726535, 4952.70283782967, 4974.8756281093265, 4983.476734942778, 5031.22016087507, 5063.443021267658, 4527.615152712056, 4542.613877820422, 4551.613112885442, 4564.0871825635, 4567.862964111082, 5792.189093526909, 5894.793682221101, 5923.851903702356, 5930.7924222652, 6045.546584006217, 6294.937050629526, 6321.96839015802, 6331.588446751039, 6331.620102793847, 6332.0, 6042.4561789438285, 6052.273727152769, 6053.7578496860515, 6061.151438798572, 6072.544559158081, 5345.957538279998, 5428.212909128154, 5440.401555828856, 5521.751521181556, 5543.750531226105, 6509.511786616117, 6513.674316284167, 6558.508111891531, 6559.376859198369, 6565.638889861008, 6306.558540902093, 6312.684365781784, 6315.210598675166, 6315.400036996478, 6323.525735569759, 6363.809085727436, 6464.5151613630105, 6516.283208846929, 6576.44100251484, 6589.341065893373, 6256.624602523863, 6278.497720182283, 6292.087647291209, 6292.528060395397, 6298.370162983665, 6285.182926219562, 6299.590526615755, 6301.842453938688, 6310.7791227306825, 6324.841878953063, 6111.419415155553, 6167.753289868355, 6250.9062364065485, 6275.905861411991, 6277.2781130170615, 4720.669553131248, 6226.59527130735, 6239.407256310643, 6249.1563638908165, 6284.905726414016, 5973.193618861572, 6120.969395152996, 6163.229596300463, 6172.135900973957, 6201.720922558406, 6112.969435152796, 6136.938630613637, 6171.814845554641, 6255.53083518747, 6295.779647712308, 6101.725422355916, 6104.816855494342, 6106.175666284995, 6109.327973922954, 6120.326764056039], "value": 5803.134895417029, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.5742848292881, 551.9254900588421, 574.6437208930463, 612.693653173413, 638.1130228981714, 31913.680863191392, 40559.79720101403, 40591.39112913305, 40592.18815623686, 40597.0, 42855.78572107143, 43428.13143737123, 43486.91282717926, 43548.564514354846, 43648.0, 9097.499637519933, 9570.808583828337, 9803.36278141922, 9807.215422766161, 11625.069994400428, 11592.826107608393, 11713.941430292836, 11716.707082322968, 11721.824172637418, 11729.296242225451, 11684.0, 11761.470733817, 11762.411879406038, 11765.058795296356, 11771.823422648624, 11689.29864208146, 11735.941320293345, 11739.765204695943, 11749.236299640581, 11753.294802311888, 11575.42122893852, 11688.883111168865, 11694.356810375426, 11996.040316774637, 11996.100292478099, 39304.0, 41976.58023419757, 42404.57595424037, 42411.363829542584, 42569.78715106435, 3296.2000617228473, 3410.471376936579, 3411.6076651185185, 3484.2160513884173, 3874.1864208516245, 26864.328391790164, 29066.854665726536, 29093.41813163725, 29098.272543186376, 29908.252293692833, 2761.0, 2772.5286701260834, 2812.9296767580768, 2851.9144425667055, 2912.7524160446387, 380314.0, 381987.0, 382746.08626956685, 382941.0, 385699.0, 63347.6832615834, 64558.0, 64568.354316457175, 64590.35409645937, 64662.676686617204, 68631.97052044224, 68696.0, 68904.0, 69033.0, 69093.96359054618, 18048.819511804715, 18373.908130459262, 18463.723044154347, 18474.353397631017, 18482.353117640818, 12980.35098245084, 13097.21416714981, 13109.475620975245, 13126.474941002443, 14061.578152655436, 12835.037372197123, 16433.671326573403, 16516.091614961293, 16541.421050263183, 16659.33362665504, 6762.425193858478, 6768.69540870662, 6799.456043516507, 6815.318468153145, 6885.518013739091, 990.9355891867006, 1055.1875056206677, 1082.8700555933337, 1151.9193656443967, 1155.7457359380924, 22953.426164346023, 30343.241418964262, 31257.062288131394, 31273.8436307817, 32001.359972800878, 1047.930931824951, 1064.2284343850802, 1152.0553146419854, 1179.5399794080315, 1248.9250644961332, 15722.606934826721, 15999.680006399807, 16053.117078560792, 16101.0, 16440.177991100398, 614704.0, 615337.0, 615684.9215753892, 618713.0, 619646.0, 63743.68128159329, 64159.67920160369, 64219.0, 64236.71526569442, 64286.0, 1516.105497756329, 1561.3910574875808, 1578.684263147375, 1602.7595860620768, 1604.2299696145683, 29472.0, 29994.850025749733, 30010.399792004475, 31289.11263940735, 31421.057368278987, 49093.50906491032, 50196.74901625468, 50726.49273507218, 50778.984420312125, 51015.74492127515, 449826.0, 451918.0, 452501.0, 452984.0, 453125.46874530835, 35389.646103539664, 41072.79463602663, 41862.37206441845, 42270.365944511475, 42544.44733316011, 43938.34092488551, 43990.0, 45111.54888451205, 45447.31829022501, 45870.54129458663, 34949.8252508746, 36022.27955440824, 36623.0, 36670.8166459166, 37501.812490938464, 36062.09844753902, 36298.4555231677, 36726.0, 37630.0, 38101.016531062705, 37746.43380349242, 37762.67830625915, 38912.02719932024, 39038.02404939899, 39040.41439378355, 31922.201944950633, 32706.345873082882, 33750.49374259339, 33769.0, 33988.0, 25318.240452786446, 25744.61383079293, 25785.226443206735, 25825.483490330465, 26162.607560886223], "value": 20606.066424616973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.71611020616183, 424.1622794979917, 425.6828662646328, 425.8743670617168, 435.12539795012015, 20243.392698219057, 20280.89859550704, 21006.36980890574, 22277.0, 22284.554308913812, 17048.0, 21031.579368412622, 21204.25785097522, 21252.89373553134, 21292.680609790867, 5169.870753231171, 5490.670559766407, 5493.862653433656, 5495.175723641466, 5499.092649712793, 4111.71218014739, 4176.770277634729, 5401.756920938547, 5486.698231597281, 6132.969335153318, 6195.2565692117005, 6197.0, 6209.782657606985, 6230.190075290206, 6233.438990490855, 6203.069539569078, 6328.240611126671, 6872.278410766898, 6884.552504087218, 6893.586384816927, 4152.91694166118, 5834.358220595731, 6129.662868542228, 6155.569110162291, 6170.660613666247, 13952.860471395257, 14149.363278652485, 14174.645633859132, 14193.006489545736, 26932.865335673196, 2096.612126756555, 2213.6015517206897, 2234.994252586326, 2286.27982185611, 2376.196503441186, 10035.54840032193, 10039.196864250842, 10096.848547271797, 10362.740931476774, 10375.584976600927, 1822.9453116406528, 1844.9538761530935, 1891.3096719697348, 1908.6659834529041, 1935.3032908153195, 122415.0, 124263.0, 125262.37368813189, 127372.0, 127686.72313276841, 11669.59156429521, 11778.646640600795, 11869.347185904686, 11899.762004759856, 12044.096692748079, 15630.06219626826, 15642.921785391, 15658.608534786721, 15684.294206760494, 15692.372305107669, 7243.203247642755, 7271.381932535794, 8665.610047547876, 9033.954830225806, 9043.005269420359, 9115.589798458952, 9121.589528471235, 9127.22418594427, 9164.8625270621, 9289.442633442015, 3852.2102968891872, 3926.646601805794, 4744.786484608201, 4752.263399173134, 4805.783739731721, 1823.575733862926, 1969.458398940303, 2019.6263691217173, 2063.535704466483, 2071.637463443891, 918.8943271523726, 986.5215370545279, 1020.6172685243034, 1045.6444808764904, 1066.5627092891878, 19084.61830763377, 20483.897580512003, 21171.68242476364, 21442.463938401666, 21519.0, 935.6912218967724, 961.9134277914882, 1033.116685234114, 1038.901304376098, 1064.9627263045757, 11273.436328183558, 11548.76902461946, 11636.534538618529, 11641.53433862636, 11655.76688466243, 538759.0, 542751.0, 546215.0, 583522.0, 631407.0, 120048.79951200551, 121257.0, 124682.0, 131757.34121329332, 132922.0, 1052.8420736889527, 1067.5569638599893, 1086.3481910853582, 1089.1831126655009, 1092.4592326798286, 14705.117692938458, 18340.0, 18800.34198803035, 18896.905515472336, 19058.04709764534, 32918.0, 51634.450966471064, 52516.47483525116, 52520.737396312776, 54535.18197227124, 78219.60890195513, 79882.0, 80147.19852801398, 82456.0, 82839.75740363779, 8070.152633973348, 8204.302634276153, 8321.542315172723, 8381.706640267561, 8481.40630155883, 9677.322587418814, 11988.820167697317, 13029.348532573524, 13185.670358241121, 13345.599632011055, 11362.14783891195, 11482.373070189413, 11505.884941150482, 11517.654470365902, 11626.651200463999, 11050.557977680803, 11216.610706493015, 11228.55085796559, 11366.431678416211, 11587.0, 11574.88425115738, 11619.186656934271, 11825.645230643095, 11971.10216733731, 11995.520179192734, 7908.169642187488, 8049.637766300413, 8109.635066421907, 8283.130271321425, 8842.381033327605, 7873.25204105609, 7896.052473702963, 7979.44143909944, 8322.916770832215, 8582.97004359456], "value": 9539.81222401084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.1284941884287, 1628.340522088554, 1644.6710657868423, 1921.2027008791351, 2024.6558085125519, 8035.357171426286, 8746.868796968043, 8877.955610221956, 8881.46711197327, 8892.333075019367, 8502.149785021495, 8736.301095912328, 8739.956300218506, 8755.781105472366, 8756.95621521893, 2516.937076573091, 2545.440003199293, 2546.2743118211315, 2546.5161619292276, 2550.1202085280547, 2464.2607217834666, 2547.2740269023334, 2547.6688030556093, 2549.974500254992, 2553.6807899012624, 2465.8890349934204, 2503.1864643990684, 2505.1607711416696, 2510.723820379757, 2513.45960618467, 2131.7761635028255, 2508.159766478223, 2538.352720056392, 2543.046357615894, 2553.5531282025663, 2500.2624225853415, 2539.263613552068, 2550.744925507453, 2552.897884084653, 2562.705288891783, 8648.610812513389, 8814.338924580683, 8866.86699699505, 8884.555772211364, 8901.910980890238, 5494.09347457673, 5649.830505084854, 5661.179129026268, 5666.291713535808, 5708.886767080421, 3562.8040457775073, 3669.7247706422127, 3684.6499582539614, 3708.8145592720257, 3732.085639018431, 916.2303664921498, 1038.6832016235046, 1059.3220338983058, 1070.4487189097622, 1071.2394200117926, 11942.641720748392, 12098.0, 12116.394180291038, 12127.878721212763, 12140.575079872251, 3885.2812229737588, 4697.95302046982, 4740.834070807505, 4812.494688057704, 4815.903681926342, 9524.428534287965, 9540.998195189544, 9541.2367010639, 9544.141027307576, 9552.0, 5472.0, 5515.227868098469, 5516.310461192351, 5524.475174858382, 5532.889342213214, 4605.585497305258, 4698.3187437821325, 5009.924851127236, 5031.572316353151, 5144.871378215575, 3987.760734355948, 4013.2976729072298, 4063.674906007512, 4089.591040895946, 4106.527749308808, 1208.4863932828512, 1272.4401263444056, 1276.5340650662442, 1287.9613611591667, 1288.4459682336499, 927.7495076329488, 955.1069749783974, 960.1694534227843, 964.5225613321311, 1000.0299709281985, 6079.300880398722, 6081.148639190517, 6106.877862442815, 6216.720247588869, 6237.251529816361, 483.2196003454396, 483.94192696875893, 484.85696719467137, 485.6479052686774, 493.575525048458, 3958.960410395917, 3959.8416063357145, 4051.4125451809323, 4077.4699289092227, 4088.919832902292, 10594.947025264824, 10773.407462589634, 10972.451377431096, 11071.778564428667, 11090.722731931766, 10937.890621093688, 10940.726481838017, 10949.781004379867, 10952.0, 10997.835032474519, 7944.364450843918, 8308.335333173332, 8321.500709957301, 8440.0, 8518.23335899772, 5905.40945905406, 5974.342822289458, 6071.210742603434, 6116.602420842631, 6181.289151747606, 9759.51202439861, 9793.0, 9799.559019844266, 9961.551730172016, 10017.69946901594, 7904.249096335839, 8454.619542120496, 10158.0, 10202.642907498202, 10229.590816367261, 7031.261717519586, 7132.928670713434, 7138.393236574741, 7746.612669366622, 7910.485818421784, 7848.646810893638, 8267.875981860398, 8377.539235342114, 8413.368997325348, 8477.98264208299, 6160.3223645398075, 7343.37581305595, 7410.5183163094225, 7547.0943486781935, 7569.621518924142, 7291.08861392326, 7338.596377199306, 7357.0, 7368.4842061055215, 7411.8147046324275, 6936.965315173392, 7007.894881576883, 7010.123734533184, 7020.824479388056, 7034.929650703428, 4834.274858771212, 4876.317315575751, 4883.706977581356, 4899.3385892904, 4988.6757360771435, 4776.0, 4793.472718001087, 4858.562729354375, 4903.31353610502, 5042.722650254272], "value": 4583.823792582464, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.21166554450014, 335.64757005144594, 344.8482667626244, 348.0428820742957, 353.5050928699818, 6483.740650373979, 6692.063111164435, 6696.598204107757, 6698.933010669892, 6722.663866806664, 6390.201224846895, 6693.39759421652, 6729.663516824152, 6731.9326806731915, 6745.662716864162, 4773.713577185371, 4871.658983871131, 4874.634402419815, 4968.627352948525, 4992.450830408652, 4895.706257624536, 4966.9751651241695, 4974.950250497503, 4975.104481193383, 4995.175795993657, 4906.779194936219, 4910.975445122769, 4914.582260507843, 4915.754212289389, 4953.876153096184, 4719.9292010619865, 4793.90412191756, 4918.901621967577, 4919.4834542373255, 4923.901521969577, 3669.9082522936874, 4078.898697351728, 4225.323948168279, 4240.936385954213, 4243.53321134678, 5234.6335756497065, 6425.100485931974, 6442.387973142544, 6499.967500162469, 6501.739930402779, 4819.614430845559, 5891.440313170285, 5909.911351329733, 5918.615290006136, 5919.49684276837, 6536.54244202906, 6822.522423430361, 6927.688254028581, 7164.605946672931, 7165.89251161233, 4807.879803004917, 4815.6388270879825, 4816.301636262758, 4822.252550854623, 4834.637402194814, 5952.0, 7504.737334193332, 7588.0, 7590.203028682019, 7611.20082391352, 4712.552307530779, 4902.093112774148, 4902.681325713817, 4903.264510323409, 4907.214845624683, 4093.9181216375505, 4119.443875076826, 4547.1815073287125, 4973.1297023020825, 4979.029089327619, 5879.882402352015, 5894.793682221188, 5896.380880007538, 5903.144044113579, 5913.645181289136, 6838.931610683929, 6844.486663500257, 6881.277465866012, 7166.104236970379, 7211.963940180265, 1704.1649591699977, 1710.9230084645972, 1727.9827201728074, 1730.558707529597, 1732.644807814395, 1039.7452624107143, 1056.566807608892, 1085.2294870641933, 1096.8848270931596, 1115.7935781880378, 6766.49251306154, 6882.139732533434, 6895.5173137879865, 6908.309169083152, 6913.516053876281, 7578.924210757932, 7581.50720203196, 7583.658735356922, 7587.089549254015, 7589.316961473494, 6219.968900155471, 6444.0, 6969.16370035599, 6980.581165130108, 6981.127359080115, 3828.1003964068423, 3951.8024098794945, 3988.6809055275507, 3992.760434373889, 3995.2409042282457, 6710.530262881649, 7828.843423131506, 7890.842183156305, 7967.920320796834, 7968.482048666818, 7747.147813740484, 7751.108622508371, 7751.224877512203, 7757.456978011485, 7765.572893490912, 7889.644965976545, 7904.525728456196, 7914.089879663912, 7915.16890726477, 7917.2874441300555, 7213.783586492414, 7497.325240728361, 7545.50954187976, 7546.24537546241, 7564.962175189309, 7314.561126332437, 7343.522671026366, 7361.2638736125955, 7362.300581444754, 7394.260573942778, 6331.810045698637, 6453.580517266362, 7892.0, 7892.881606775788, 7908.802279943047, 4620.052889157648, 4696.342512048384, 4709.458412282632, 4711.811527538997, 4715.316279139574, 7156.3559279662995, 7417.962910185414, 7423.257674232534, 7424.851502970018, 7432.3310902019075, 7200.1719802223415, 7209.963950180216, 7243.5653860768525, 7250.41996640257, 7281.235470275545, 7248.238934911969, 7261.237570055068, 7267.927320726725, 7269.382102521345, 7269.854602908018, 7097.893531597134, 7100.112485939258, 7105.46708996817, 7109.395701365442, 7113.6443177839865, 6277.874442511033, 6754.155730533684, 6913.827154321182, 7233.132024156925, 7264.273572642694, 6812.182538095461, 6934.583924964519, 6980.371766541036, 7064.682089306097, 7128.180259270043], "value": 5249.705197217633, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.2124505534022, 765.1392183793232, 796.3032346696644, 796.5181065455399, 812.3501199040768, 15716.214189290547, 15963.52109436716, 15977.360905563792, 15993.440229591952, 16066.437674681374, 14712.970092093557, 14742.63143421415, 14761.92619036906, 14767.261636918165, 14809.629759256024, 762.477702773599, 771.6874665760348, 775.3758224629171, 949.8480243161113, 962.7496850818802, 770.5222761887637, 773.408342617895, 943.3349488610513, 968.6416026070364, 970.8058388322364, 993.9353941993784, 1008.606643409071, 1008.8940661230575, 1010.5200029985734, 1010.8584798128268, 1007.6926537406089, 1008.6671398438498, 1009.081735620589, 1010.1312870930993, 1011.3274672342883, 601.3835818286248, 605.6093819486407, 608.5679167790873, 609.4667166229549, 744.3747252308033, 15463.922680386639, 15521.611959701098, 15531.922340388339, 15532.534023979299, 15558.922205389013, 13182.274974876378, 13200.20798752078, 13337.599872003855, 13373.063885528018, 13720.382582783699, 9277.35058545902, 9583.808323833555, 9864.556094975744, 9960.95019524905, 10081.848772268422, 3200.815698191661, 3549.4498352755363, 3646.74472786905, 3689.8893033209047, 3704.573973992998, 66987.66506167487, 72456.7394467245, 82752.0, 83620.16379836245, 83690.0, 9652.71041868731, 9821.80356392868, 9866.722281809893, 9939.55272012761, 9940.502974851228, 22212.0, 22482.32553023412, 22489.775102249096, 22497.662535061987, 22502.66246006311, 7773.106092799288, 7861.842763144705, 7912.683492660229, 7948.721794737156, 7964.0, 4242.703010789215, 4260.998665313648, 4274.316109422478, 4358.956410435855, 4559.224931761542, 3650.178709790276, 3818.4845045919, 3888.844446222176, 3889.474920885644, 3894.084890050836, 683.781190019199, 687.5874475314771, 711.9501634885612, 712.618748969299, 715.3418854653731, 578.9652620842763, 586.5864565481326, 592.2567178191429, 602.108878859282, 616.3435940723116, 6981.930180698229, 7713.190115037953, 8227.382946279053, 8271.751847444586, 8286.544240066854, 489.7967343552386, 577.0795581048221, 582.4466756581264, 590.3004939147124, 598.5062323582974, 3795.69634429245, 3864.942025869614, 3912.39357899526, 3914.393269043303, 4052.959470405317, 94458.52770736102, 96269.0, 96819.0, 97140.0285997131, 98273.50863245782, 78725.0, 79129.20870791333, 79344.0, 79957.0, 80744.0, 62106.37893621096, 62915.370846291866, 63673.68163159247, 63980.99999999907, 65038.67480662661, 6411.935880641134, 6948.652567371712, 7520.511166774142, 7806.0, 8053.31546818527, 49859.501404986935, 50453.24320135274, 50590.49409506005, 51118.74440627773, 51499.0, 55936.44063559312, 60512.697436512535, 64936.0259596097, 66141.00788488273, 71895.64052179706, 11363.48864301125, 11444.313341199555, 11504.36725980079, 11718.06255499541, 11925.701857453632, 12056.879431205576, 12111.636650900487, 12260.26438413698, 12467.127301088836, 12971.610851674464, 9745.512724363613, 11988.580399685969, 12033.4584943676, 12131.21147125434, 12311.44598493052, 11965.700857478632, 12043.156979011384, 12057.15599908033, 12068.879311206776, 12086.697832554257, 11505.686758721396, 11805.468753905923, 11825.940870295593, 12216.205946613798, 12551.686207844512, 9984.650537231453, 10086.79826403453, 10172.542235599267, 10175.236857235588, 10283.897161028293, 10111.292209545261, 10235.078842903877, 10237.641682541076, 10259.435731034566, 10271.84592231132], "value": 7029.178325139621, "unit": "score"}], "name": "dromaeo_css", "value": 7601.812389867046, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 121.0, 111.0, 109.0, 111.0, 113.0, 113.0, 110.0, 134.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 122.0, 156.0, 165.0, 118.0, 142.0, 116.0, 153.0, 156.0, 117.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 187.0, 182.0, 185.0, 186.0, 186.0, 184.0, 185.0, 186.0], "value": 185.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 79.0, 71.0, 159.0, 55.0, 55.0, 56.0, 62.0, 133.0, 55.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 140.0, 78.0, 79.0, 80.0, 121.0, 79.0, 76.0, 128.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 93.0, 130.0, 86.0, 70.0, 135.0, 131.0, 95.0, 83.0], "value": 99.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 92.0, 92.0, 92.0, 92.0, 92.0, 93.0, 88.0, 140.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 87.0, 84.0, 85.0, 85.0, 85.0, 86.0, 84.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 61.0, 60.0, 62.0, 63.0, 61.0, 76.0, 58.0, 55.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 65.0, 79.0, 78.0, 71.0, 66.0, 67.0, 66.0, 66.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 77.0, 80.0, 79.0, 82.0, 93.0, 104.0, 107.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 128.0, 138.0, 142.0, 115.0, 138.0, 139.0, 142.0, 151.0, 140.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 163.0, 164.0, 162.0, 161.0, 174.0, 197.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 81.0, 94.0, 94.0, 66.0, 66.0, 68.0, 74.0, 93.0, 98.0], "value": 79.0, "unit": "score"}], "name": "kraken", "value": 1495.0, "alertThreshold": 2.0}]} 09:02:57 INFO - Return code: 0 09:02:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:02:57 ERROR - # TBPL SUCCESS # 09:02:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:02:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:02:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:02:57 INFO - 2016-06-27 09:02:57.793 screenresolution[2012:15736] starting screenresolution argv=screenresolution get 09:02:57 INFO - 2016-06-27 09:02:57.796 screenresolution[2012:15736] Display 0: 1600x1200x32@60 09:02:57 INFO - 2016-06-27 09:02:57.801 screenresolution[2013:15739] starting screenresolution argv=screenresolution list 09:02:57 INFO - Available Modes on Display 0 09:02:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:02:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:02:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:02:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:02:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:02:58 INFO - Intel Iris: 09:02:58 INFO - Chipset Model: Intel Iris 09:02:58 INFO - Type: GPU 09:02:58 INFO - Bus: Built-In 09:02:58 INFO - VRAM (Dynamic, Max): 1536 MB 09:02:58 INFO - Vendor: Intel (0x8086) 09:02:58 INFO - Device ID: 0x0a2e 09:02:58 INFO - Revision ID: 0x0009 09:02:58 INFO - Displays: 09:02:58 INFO - Display: 09:02:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:02:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:02:58 INFO - Display Serial Number: 1600x1200 60 09:02:58 INFO - Main Display: Yes 09:02:58 INFO - Mirror: Off 09:02:58 INFO - Online: Yes 09:02:58 INFO - Rotation: Supported 09:02:58 INFO - Return code: 0 09:02:58 INFO - Running post-action listener: _resource_record_post_action 09:02:58 INFO - Running post-run listener: _resource_record_post_run 09:02:59 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 958976; Write bytes: 494058496; Read time: 13; Write time: 1544 09:02:59 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194658816; Write bytes: 194760704; Read time: 17572; Write time: 393 09:02:59 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 913920; Write bytes: 298421248; Read time: 12; Write time: 1148 09:02:59 INFO - Running post-run listener: _upload_blobber_files 09:02:59 INFO - Blob upload gear active. 09:02:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:59 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 09:02:59 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'] 09:02:59 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 09:02:59 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:02:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:03:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:00 INFO - (blobuploader) - INFO - Done attempting. 09:03:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:03:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:03:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:01 INFO - (blobuploader) - INFO - Done attempting. 09:03:01 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:01 INFO - Return code: 0 09:03:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5b0d456161210ddee0ef5df74b085e67f64bef3aacf034e50eb001e8e03241d7601076c080a4266f50cba0fd188ee58f19efcb854dbd69fe1932577f58966f7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/70a8b22abf34b5fe8c0a711cdaee7968c5fa0d04be7aae24d7e534a3d3d4b3441cd318ff2825f25ac3f24692bccceaedeea65a8ecd0a647dcccf76a521a36895"} 09:03:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:01 INFO - Contents: 09:03:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5b0d456161210ddee0ef5df74b085e67f64bef3aacf034e50eb001e8e03241d7601076c080a4266f50cba0fd188ee58f19efcb854dbd69fe1932577f58966f7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/70a8b22abf34b5fe8c0a711cdaee7968c5fa0d04be7aae24d7e534a3d3d4b3441cd318ff2825f25ac3f24692bccceaedeea65a8ecd0a647dcccf76a521a36895"} 09:03:01 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:01 INFO - Copying logs to upload dir... 09:03:01 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.311404 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-27 09:03:01.291127) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 09:03:01.294569) ========= 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.NIgAI2elmI/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.6qsUpMxCcI/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5b0d456161210ddee0ef5df74b085e67f64bef3aacf034e50eb001e8e03241d7601076c080a4266f50cba0fd188ee58f19efcb854dbd69fe1932577f58966f7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/70a8b22abf34b5fe8c0a711cdaee7968c5fa0d04be7aae24d7e534a3d3d4b3441cd318ff2825f25ac3f24692bccceaedeea65a8ecd0a647dcccf76a521a36895"} build_url:https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/H75F0ySGS9GwdMIjnqWHtg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5b0d456161210ddee0ef5df74b085e67f64bef3aacf034e50eb001e8e03241d7601076c080a4266f50cba0fd188ee58f19efcb854dbd69fe1932577f58966f7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/70a8b22abf34b5fe8c0a711cdaee7968c5fa0d04be7aae24d7e534a3d3d4b3441cd318ff2825f25ac3f24692bccceaedeea65a8ecd0a647dcccf76a521a36895"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 09:03:01.327934) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:03:01.328317) ========= 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.NIgAI2elmI/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.6qsUpMxCcI/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.005157 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:03:01.377266) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 09:03:01.377636) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 09:03:01.378041) ========= ========= Total master_lag: 0.24 =========