builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0126 starttime: 1467323276.18 results: success (0) buildid: 20160630123429 builduid: 4737dcbbbcfa46b9b8a66d658d87c2e0 revision: dd7af1fa4ece1cb3158d08c80dfcbf1c6ca830fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 14:47:56.179426) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 14:47:56.179871) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 14:47:56.180160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 14:47:56.205046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:47:56.205429) ========= 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.27e91DaMC3/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.bRP1Ne6yfT/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-30 14:47:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.4M=0.001s 2016-06-30 14:47:56 (14.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146085 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:47:56.373917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:47:56.374273) ========= 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.27e91DaMC3/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.bRP1Ne6yfT/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.029765 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:47:56.425356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 14:47:56.425707) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dd7af1fa4ece1cb3158d08c80dfcbf1c6ca830fb --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 dd7af1fa4ece1cb3158d08c80dfcbf1c6ca830fb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.27e91DaMC3/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.bRP1Ne6yfT/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-30 14:47:56,497 truncating revision to first 12 chars 2016-06-30 14:47:56,497 Setting DEBUG logging. 2016-06-30 14:47:56,497 attempt 1/10 2016-06-30 14:47:56,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dd7af1fa4ece?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 14:47:57,482 unpacking tar archive at: mozilla-beta-dd7af1fa4ece/testing/mozharness/ program finished with exit code 0 elapsedTime=1.255930 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 14:47:57.719091) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 14:47:57.719456) ========= script_repo_revision: dd7af1fa4ece1cb3158d08c80dfcbf1c6ca830fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 14:47:57.719897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 14:47:57.720173) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 14:47:57.739341) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-30 14:47:57.739642) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.27e91DaMC3/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.bRP1Ne6yfT/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:47:57 INFO - MultiFileLogger online at 20160630 14:47:57 in /builds/slave/test 14:47:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:47:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:47:57 INFO - {'append_to_log': False, 14:47:57 INFO - 'base_work_dir': '/builds/slave/test', 14:47:57 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:47:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:47:57 INFO - 'branch': 'Mozilla-Beta', 14:47:57 INFO - 'buildbot_json_path': 'buildprops.json', 14:47:57 INFO - 'config_files': ('talos/mac_config.py',), 14:47:57 INFO - 'default_actions': ('clobber', 14:47:57 INFO - 'read-buildbot-config', 14:47:57 INFO - 'download-and-extract', 14:47:57 INFO - 'populate-webroot', 14:47:57 INFO - 'create-virtualenv', 14:47:57 INFO - 'install', 14:47:57 INFO - 'run-tests'), 14:47:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:47:57 INFO - 'download_minidump_stackwalk': True, 14:47:57 INFO - 'download_symbols': 'ondemand', 14:47:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:47:57 INFO - 'tooltool.py': '/tools/tooltool.py', 14:47:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:47:57 INFO - '/tools/misc-python/virtualenv.py')}, 14:47:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:47:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:47:57 INFO - 'installer_path': 'installer.exe', 14:47:57 INFO - 'log_level': 'info', 14:47:57 INFO - 'log_name': 'talos', 14:47:57 INFO - 'log_to_console': True, 14:47:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:47:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:47:57 INFO - 'opt_config_files': (), 14:47:57 INFO - 'pip_index': False, 14:47:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:47:57 INFO - 'cmd': ('bash', 14:47:57 INFO - '-c', 14:47:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:47:57 INFO - 'enabled': True, 14:47:57 INFO - 'halt_on_failure': False, 14:47:57 INFO - 'name': 'check_screen_resolution'},), 14:47:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:47:57 INFO - 'cmd': ('bash', 14:47:57 INFO - '-c', 14:47:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:47:57 INFO - 'enabled': True, 14:47:57 INFO - 'halt_on_failure': False, 14:47:57 INFO - 'name': 'check_screen_resolution'},), 14:47:57 INFO - 'run_cmd_checks_enabled': True, 14:47:57 INFO - 'sps_profile': False, 14:47:57 INFO - 'sps_profile_interval': 0, 14:47:57 INFO - 'suite': 'dromaeojs-e10s', 14:47:57 INFO - 'system_bits': '32', 14:47:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:47:57 INFO - 'title': 't-yosemite-r7-0126', 14:47:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:47:57 INFO - 'use_talos_json': True, 14:47:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:47:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:47:57 INFO - 'work_dir': 'build'} 14:47:57 INFO - ##### 14:47:57 INFO - ##### Running clobber step. 14:47:57 INFO - ##### 14:47:57 INFO - Running pre-action listener: _resource_record_pre_action 14:47:57 INFO - Running main action method: clobber 14:47:57 INFO - rmtree: /builds/slave/test/build 14:47:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:47:59 INFO - Running post-action listener: _resource_record_post_action 14:47:59 INFO - ##### 14:47:59 INFO - ##### Running read-buildbot-config step. 14:47:59 INFO - ##### 14:47:59 INFO - Running pre-action listener: _resource_record_pre_action 14:47:59 INFO - Running main action method: read_buildbot_config 14:47:59 INFO - Using buildbot properties: 14:47:59 INFO - { 14:47:59 INFO - "project": "", 14:47:59 INFO - "product": "firefox", 14:47:59 INFO - "script_repo_revision": "production", 14:47:59 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:47:59 INFO - "repository": "", 14:47:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:47:59 INFO - "buildid": "20160630123429", 14:47:59 INFO - "pgo_build": "False", 14:47:59 INFO - "basedir": "/builds/slave/test", 14:47:59 INFO - "buildnumber": 48, 14:47:59 INFO - "slavename": "t-yosemite-r7-0126", 14:47:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:47:59 INFO - "platform": "yosemite_r7", 14:47:59 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:47:59 INFO - "branch": "mozilla-beta", 14:47:59 INFO - "repo_path": "releases/mozilla-beta", 14:47:59 INFO - "revision": "dd7af1fa4ece1cb3158d08c80dfcbf1c6ca830fb", 14:47:59 INFO - "stage_platform": "macosx64", 14:47:59 INFO - "builduid": "4737dcbbbcfa46b9b8a66d658d87c2e0", 14:47:59 INFO - "slavebuilddir": "test" 14:47:59 INFO - } 14:47:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 14:47:59 INFO - Running post-action listener: _resource_record_post_action 14:47:59 INFO - ##### 14:47:59 INFO - ##### Running download-and-extract step. 14:47:59 INFO - ##### 14:47:59 INFO - Running pre-action listener: _resource_record_pre_action 14:47:59 INFO - Running main action method: download_and_extract 14:47:59 INFO - mkdir: /builds/slave/test/build/tests 14:47: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')]} 14:47:59 INFO - https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:47:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 14:47:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 14:47:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/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 14:47:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/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 14:48:01 INFO - Downloaded 1165 bytes. 14:48:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 14:48:01 INFO - Using the following test package requirements: 14:48:01 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:48:01 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:48:01 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 14:48:01 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:48:01 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 14:48:01 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:48:01 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:48:01 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 14:48:01 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:48:01 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:48:01 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 14:48:01 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:48:01 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 14:48:01 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:48:01 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 14:48:01 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:48:01 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 14:48:01 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 14:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:01 INFO - https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:48:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:48:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:48:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/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 14:48:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/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 14:48:02 INFO - Downloaded 18351382 bytes. 14:48:02 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'] 14:48:02 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 14:48:05 INFO - Return code: 0 14:48:05 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 14:48:05 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')]} 14:48:05 INFO - https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:48:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:48:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:48:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/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 14:48:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/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 14:48:06 INFO - Downloaded 18351382 bytes. 14:48:06 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'] 14:48:06 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 14:48:10 INFO - Return code: 0 14:48:10 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')]} 14:48:10 INFO - https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:48:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 14:48:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 14:48:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/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 14:48:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/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 14:48:11 INFO - Downloaded 10840145 bytes. 14:48:11 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'] 14:48:11 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 14:48:11 INFO - Return code: 0 14:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:11 INFO - https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 14:48:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:48:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:48:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 14:48:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfhWK4UQT_2OPjyItseFPA/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 14:48:14 INFO - Downloaded 86193985 bytes. 14:48:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:48:14 INFO - mkdir: /builds/slave/test/properties 14:48:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:48:14 INFO - Writing to file /builds/slave/test/properties/build_url 14:48:14 INFO - Contents: 14:48:14 INFO - build_url:https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:48:15 INFO - Running post-action listener: _resource_record_post_action 14:48:15 INFO - Running post-action listener: set_extra_try_arguments 14:48:15 INFO - ##### 14:48:15 INFO - ##### Running populate-webroot step. 14:48:15 INFO - ##### 14:48:15 INFO - Running pre-action listener: _resource_record_pre_action 14:48:15 INFO - Running main action method: populate_webroot 14:48:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:48:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:48:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:48:15 INFO - '--tppagecycles', 14:48:15 INFO - '7'], 14:48:15 INFO - 'tests': ['tsvgm']}}, 14:48:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:48:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:48:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:48:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:48:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:48:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:48:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:15 INFO - 'talos_options': ['--disable-e10s'], 14:48:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:15 INFO - 'talos_options': ['--disable-e10s'], 14:48:15 INFO - 'tests': ['damp', 'tps']}, 14:48:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:15 INFO - 'tests': ['damp', 'tps']}, 14:48:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:48:15 INFO - 'tests': ['dromaeo_dom']}, 14:48:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:48:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:48:15 INFO - 'tests': ['a11yr', 14:48:15 INFO - 'ts_paint', 14:48:15 INFO - 'tpaint', 14:48:15 INFO - 'sessionrestore', 14:48:15 INFO - 'sessionrestore_no_auto_restore', 14:48:15 INFO - 'tabpaint']}, 14:48:15 INFO - 'other-e10s': {'tests': ['a11yr', 14:48:15 INFO - 'ts_paint', 14:48:15 INFO - 'tpaint', 14:48:15 INFO - 'sessionrestore', 14:48:15 INFO - 'sessionrestore_no_auto_restore', 14:48:15 INFO - 'tabpaint']}, 14:48:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:48:15 INFO - 'ts_paint', 14:48:15 INFO - 'tpaint', 14:48:15 INFO - 'sessionrestore', 14:48:15 INFO - 'sessionrestore_no_auto_restore', 14:48:15 INFO - 'tabpaint']}, 14:48:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:48:15 INFO - 'ts_paint', 14:48:15 INFO - 'tpaint', 14:48:15 INFO - 'sessionrestore', 14:48:15 INFO - 'sessionrestore_no_auto_restore', 14:48:15 INFO - 'tabpaint']}, 14:48:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:48:15 INFO - 'tests': ['a11yr', 14:48:15 INFO - 'ts_paint', 14:48:15 INFO - 'tpaint', 14:48:15 INFO - 'sessionrestore', 14:48:15 INFO - 'sessionrestore_no_auto_restore', 14:48:15 INFO - 'tabpaint']}, 14:48:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:48:15 INFO - 'tests': ['a11yr', 14:48:15 INFO - 'ts_paint', 14:48:15 INFO - 'tpaint', 14:48:15 INFO - 'sessionrestore', 14:48:15 INFO - 'sessionrestore_no_auto_restore', 14:48:15 INFO - 'tabpaint']}, 14:48:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:48:15 INFO - 'tests': ['tsvgx', 14:48:15 INFO - 'tsvgr_opacity', 14:48:15 INFO - 'tart', 14:48:15 INFO - 'tscrollx', 14:48:15 INFO - 'cart']}, 14:48:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:48:15 INFO - 'tsvgr_opacity', 14:48:15 INFO - 'tart', 14:48:15 INFO - 'tscrollx', 14:48:15 INFO - 'cart']}, 14:48:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:15 INFO - 'talos_options': ['--disable-e10s'], 14:48:15 INFO - 'tests': ['tp5o']}, 14:48:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:15 INFO - 'tests': ['tp5o']}, 14:48:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:15 INFO - 'talos_options': ['--disable-e10s', 14:48:15 INFO - '--xperf_path', 14:48:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:15 INFO - 'tests': ['tp5n']}, 14:48:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:15 INFO - 'talos_options': ['--xperf_path', 14:48:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:15 INFO - 'tests': ['tp5n']}}, 14:48:15 INFO - 'talos.zip': {'path': '', 14:48:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:48:15 INFO - Running post-action listener: _resource_record_post_action 14:48:15 INFO - ##### 14:48:15 INFO - ##### Running create-virtualenv step. 14:48:15 INFO - ##### 14:48:15 INFO - Running pre-action listener: _resource_record_pre_action 14:48:15 INFO - Running main action method: create_virtualenv 14:48:15 INFO - Creating virtualenv /builds/slave/test/build/venv 14:48:15 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 14:48:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:48:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:48:15 INFO - Using real prefix '/tools/python27' 14:48:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:48:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:48:18 INFO - Installing pip.................done. 14:48:18 INFO - Return code: 0 14:48:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba0601af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e071e00>, '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 0x10dedadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e06cb20>, '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.27e91DaMC3/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.bRP1Ne6yfT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:48:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:48:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27e91DaMC3/Render', 14:48:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:18 INFO - 'HOME': '/Users/cltbld', 14:48:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:18 INFO - 'LOGNAME': 'cltbld', 14:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:18 INFO - 'MOZ_NO_REMOTE': '1', 14:48:18 INFO - 'NO_EM_RESTART': '1', 14:48:18 INFO - 'PAGER': '/bin/cat', 14:48:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:18 INFO - 'PWD': '/builds/slave/test', 14:48:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:18 INFO - 'SHELL': '/bin/bash', 14:48:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRP1Ne6yfT/Listeners', 14:48:18 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:48:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:18 INFO - 'USER': 'cltbld', 14:48:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:18 INFO - 'XPC_FLAGS': '0x0', 14:48:18 INFO - 'XPC_SERVICE_NAME': '0', 14:48:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:19 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 14:48:19 INFO - Cleaning up... 14:48:19 INFO - Return code: 0 14:48:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:48:19 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')]} 14:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:19 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')]} 14:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:19 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 0x10e1d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba0601af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e071e00>, '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 0x10dedadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e06cb20>, '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.27e91DaMC3/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.bRP1Ne6yfT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:48:19 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 14:48:19 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 14:48:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27e91DaMC3/Render', 14:48:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:19 INFO - 'HOME': '/Users/cltbld', 14:48:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:19 INFO - 'LOGNAME': 'cltbld', 14:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:19 INFO - 'MOZ_NO_REMOTE': '1', 14:48:19 INFO - 'NO_EM_RESTART': '1', 14:48:19 INFO - 'PAGER': '/bin/cat', 14:48:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:19 INFO - 'PWD': '/builds/slave/test', 14:48:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:19 INFO - 'SHELL': '/bin/bash', 14:48:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRP1Ne6yfT/Listeners', 14:48:19 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:48:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:19 INFO - 'USER': 'cltbld', 14:48:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:19 INFO - 'XPC_FLAGS': '0x0', 14:48:19 INFO - 'XPC_SERVICE_NAME': '0', 14:48:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:19 INFO - Downloading/unpacking psutil>=0.7.1 14:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:48:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:22 INFO - Installing collected packages: psutil 14:48:22 INFO - Running setup.py install for psutil 14:48:22 INFO - building 'psutil._psutil_osx' extension 14:48:22 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 14:48:22 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 14:48:23 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 14:48:23 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 14:48:23 INFO - building 'psutil._psutil_posix' extension 14:48:23 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 14:48:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:48:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:48:23 INFO - ^ 14:48:23 INFO - 1 warning generated. 14:48:23 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 14:48:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:23 INFO - Successfully installed psutil 14:48:23 INFO - Cleaning up... 14:48:23 INFO - Return code: 0 14:48:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:23 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 0x10e1d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba0601af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e071e00>, '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 0x10dedadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e06cb20>, '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.27e91DaMC3/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.bRP1Ne6yfT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:48:23 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 14:48:23 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 14:48:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27e91DaMC3/Render', 14:48:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:23 INFO - 'HOME': '/Users/cltbld', 14:48:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:23 INFO - 'LOGNAME': 'cltbld', 14:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:23 INFO - 'MOZ_NO_REMOTE': '1', 14:48:23 INFO - 'NO_EM_RESTART': '1', 14:48:23 INFO - 'PAGER': '/bin/cat', 14:48:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:23 INFO - 'PWD': '/builds/slave/test', 14:48:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:23 INFO - 'SHELL': '/bin/bash', 14:48:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRP1Ne6yfT/Listeners', 14:48:23 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:48:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:23 INFO - 'USER': 'cltbld', 14:48:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:23 INFO - 'XPC_FLAGS': '0x0', 14:48:23 INFO - 'XPC_SERVICE_NAME': '0', 14:48:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:48:26 INFO - Installing collected packages: mozsystemmonitor 14:48:26 INFO - Running setup.py install for mozsystemmonitor 14:48:26 INFO - Successfully installed mozsystemmonitor 14:48:26 INFO - Cleaning up... 14:48:26 INFO - Return code: 0 14:48:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:26 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 0x10e1d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba0601af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e071e00>, '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 0x10dedadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e06cb20>, '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.27e91DaMC3/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.bRP1Ne6yfT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:48:26 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 14:48:26 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 14:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27e91DaMC3/Render', 14:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:26 INFO - 'HOME': '/Users/cltbld', 14:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:26 INFO - 'LOGNAME': 'cltbld', 14:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:26 INFO - 'MOZ_NO_REMOTE': '1', 14:48:26 INFO - 'NO_EM_RESTART': '1', 14:48:26 INFO - 'PAGER': '/bin/cat', 14:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:26 INFO - 'PWD': '/builds/slave/test', 14:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:26 INFO - 'SHELL': '/bin/bash', 14:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRP1Ne6yfT/Listeners', 14:48:26 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:26 INFO - 'USER': 'cltbld', 14:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:26 INFO - 'XPC_FLAGS': '0x0', 14:48:26 INFO - 'XPC_SERVICE_NAME': '0', 14:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:26 INFO - Downloading/unpacking blobuploader==1.2.4 14:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:29 INFO - Downloading blobuploader-1.2.4.tar.gz 14:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:48:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:48:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:48:30 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 14:48:30 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 14:48:30 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 14:48:30 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 14:48:30 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 14:48:30 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 14:48:30 INFO - Downloading docopt-0.6.1.tar.gz 14:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:48:30 INFO - Installing collected packages: blobuploader, requests, docopt 14:48:30 INFO - Running setup.py install for blobuploader 14:48:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:48:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:48:30 INFO - Running setup.py install for requests 14:48:31 INFO - Running setup.py install for docopt 14:48:31 INFO - Successfully installed blobuploader requests docopt 14:48:31 INFO - Cleaning up... 14:48:31 INFO - Return code: 0 14:48:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:31 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 0x10e1d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba0601af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e071e00>, '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 0x10dedadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e06cb20>, '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.27e91DaMC3/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.bRP1Ne6yfT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:48:31 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 14:48:31 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 14:48:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27e91DaMC3/Render', 14:48:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:31 INFO - 'HOME': '/Users/cltbld', 14:48:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:31 INFO - 'LOGNAME': 'cltbld', 14:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:31 INFO - 'MOZ_NO_REMOTE': '1', 14:48:31 INFO - 'NO_EM_RESTART': '1', 14:48:31 INFO - 'PAGER': '/bin/cat', 14:48:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:31 INFO - 'PWD': '/builds/slave/test', 14:48:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:31 INFO - 'SHELL': '/bin/bash', 14:48:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRP1Ne6yfT/Listeners', 14:48:31 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:48:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:31 INFO - 'USER': 'cltbld', 14:48:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:31 INFO - 'XPC_FLAGS': '0x0', 14:48:31 INFO - 'XPC_SERVICE_NAME': '0', 14:48:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:31 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-FuxgTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:31 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-xhLqYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:31 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-OxylUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-avHP9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-OM1Dtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-gxBVsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-oIGTwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-_kg3rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-oQ7Tpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-5bbPUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-YDngaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-LORkBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-4jUmR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-pgNAeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Y7gcWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-0h0y6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-2dReDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:48:33 INFO - Running setup.py install for manifestparser 14:48:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:48:33 INFO - Running setup.py install for mozcrash 14:48:33 INFO - Running setup.py install for mozdebug 14:48:33 INFO - Running setup.py install for mozdevice 14:48:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:48:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:48:34 INFO - Running setup.py install for mozfile 14:48:34 INFO - Running setup.py install for mozhttpd 14:48:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:48:34 INFO - Running setup.py install for mozinfo 14:48:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:48:34 INFO - Running setup.py install for mozInstall 14:48:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:48:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:48:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:48:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:48:34 INFO - Running setup.py install for mozleak 14:48:34 INFO - Running setup.py install for mozlog 14:48:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:48:34 INFO - Running setup.py install for moznetwork 14:48:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:48:35 INFO - Running setup.py install for mozprocess 14:48:35 INFO - Running setup.py install for mozprofile 14:48:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:48:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:48:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:48:35 INFO - Running setup.py install for mozrunner 14:48:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:48:35 INFO - Running setup.py install for mozscreenshot 14:48:35 INFO - Running setup.py install for moztest 14:48:35 INFO - Running setup.py install for mozversion 14:48:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:48:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:48:36 INFO - Cleaning up... 14:48:36 INFO - Return code: 0 14:48:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:36 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 0x10e1d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba0601af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e071e00>, '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 0x10dedadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e06cb20>, '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.27e91DaMC3/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.bRP1Ne6yfT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:48:36 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 14:48:36 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 14:48:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27e91DaMC3/Render', 14:48:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:36 INFO - 'HOME': '/Users/cltbld', 14:48:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:36 INFO - 'LOGNAME': 'cltbld', 14:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:36 INFO - 'MOZ_NO_REMOTE': '1', 14:48:36 INFO - 'NO_EM_RESTART': '1', 14:48:36 INFO - 'PAGER': '/bin/cat', 14:48:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:36 INFO - 'PWD': '/builds/slave/test', 14:48:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:36 INFO - 'SHELL': '/bin/bash', 14:48:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRP1Ne6yfT/Listeners', 14:48:36 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:48:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:36 INFO - 'USER': 'cltbld', 14:48:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:36 INFO - 'XPC_FLAGS': '0x0', 14:48:36 INFO - 'XPC_SERVICE_NAME': '0', 14:48:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:36 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-ST2lXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:36 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)) 14:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:36 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-a99CoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:36 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)) 14:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:36 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-QNfpuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:36 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)) 14:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:36 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-_V1PtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:36 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)) 14:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:36 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-KkFt8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:36 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)) 14:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:36 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-8yTho9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:36 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)) 14:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:36 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-C9FJQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:37 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)) 14:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-0Cvrf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:37 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)) 14:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-cvXME_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:37 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)) 14:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-_IKSqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:37 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)) 14:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-AE2L52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:37 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)) 14:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-qq50hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:37 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)) 14:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-LNvf8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:37 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)) 14:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-eusEDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:37 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)) 14:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Zxu16Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:37 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)) 14:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-atkdWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:38 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)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-9mBnU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:38 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)) 14:48:38 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)) 14:48:38 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)) 14:48:38 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)) 14:48:38 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)) 14:48:38 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)) 14:48:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:48: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 14:48: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 14:48: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 14:48: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 14:48: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 14:48: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 14:48:40 INFO - Downloading blessings-1.6.tar.gz 14:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:48:40 INFO - Installing collected packages: blessings 14:48:40 INFO - Running setup.py install for blessings 14:48:40 INFO - Successfully installed blessings 14:48:40 INFO - Cleaning up... 14:48:40 INFO - Return code: 0 14:48:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:48:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:41 INFO - Reading from file tmpfile_stdout 14:48:41 INFO - Current package versions: 14:48:41 INFO - blessings == 1.6 14:48:41 INFO - blobuploader == 1.2.4 14:48:41 INFO - docopt == 0.6.1 14:48:41 INFO - manifestparser == 1.1 14:48:41 INFO - mozInstall == 1.12 14:48:41 INFO - mozcrash == 0.17 14:48:41 INFO - mozdebug == 0.1 14:48:41 INFO - mozdevice == 0.48 14:48:41 INFO - mozfile == 1.2 14:48:41 INFO - mozhttpd == 0.7 14:48:41 INFO - mozinfo == 0.9 14:48:41 INFO - mozleak == 0.1 14:48:41 INFO - mozlog == 3.1 14:48:41 INFO - moznetwork == 0.27 14:48:41 INFO - mozprocess == 0.22 14:48:41 INFO - mozprofile == 0.28 14:48:41 INFO - mozrunner == 6.11 14:48:41 INFO - mozscreenshot == 0.1 14:48:41 INFO - mozsystemmonitor == 0.0 14:48:41 INFO - moztest == 0.7 14:48:41 INFO - mozversion == 1.4 14:48:41 INFO - psutil == 3.1.1 14:48:41 INFO - requests == 1.2.3 14:48:41 INFO - wsgiref == 0.1.2 14:48:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:41 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')]} 14:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:41 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')]} 14:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:41 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 0x10e1d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba0601af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e071e00>, '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 0x10dedadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e06cb20>, '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.27e91DaMC3/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.bRP1Ne6yfT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:48:41 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 14:48:41 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 14:48:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27e91DaMC3/Render', 14:48:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:41 INFO - 'HOME': '/Users/cltbld', 14:48:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:41 INFO - 'LOGNAME': 'cltbld', 14:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:41 INFO - 'MOZ_NO_REMOTE': '1', 14:48:41 INFO - 'NO_EM_RESTART': '1', 14:48:41 INFO - 'PAGER': '/bin/cat', 14:48:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:41 INFO - 'PWD': '/builds/slave/test', 14:48:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:41 INFO - 'SHELL': '/bin/bash', 14:48:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRP1Ne6yfT/Listeners', 14:48:41 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:48:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:41 INFO - 'USER': 'cltbld', 14:48:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:41 INFO - 'XPC_FLAGS': '0x0', 14:48:41 INFO - 'XPC_SERVICE_NAME': '0', 14:48:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 INFO - Cleaning up... 14:48:41 INFO - Return code: 0 14:48:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:48:41 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')]} 14:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:41 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')]} 14:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:41 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 0x10e1d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba0601af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e071e00>, '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 0x10dedadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e06cb20>, '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.27e91DaMC3/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.bRP1Ne6yfT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:48:41 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 14:48:41 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 14:48:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27e91DaMC3/Render', 14:48:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:41 INFO - 'HOME': '/Users/cltbld', 14:48:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:41 INFO - 'LOGNAME': 'cltbld', 14:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:41 INFO - 'MOZ_NO_REMOTE': '1', 14:48:41 INFO - 'NO_EM_RESTART': '1', 14:48:41 INFO - 'PAGER': '/bin/cat', 14:48:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:41 INFO - 'PWD': '/builds/slave/test', 14:48:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:41 INFO - 'SHELL': '/bin/bash', 14:48:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRP1Ne6yfT/Listeners', 14:48:41 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:48:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:41 INFO - 'USER': 'cltbld', 14:48:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:41 INFO - 'XPC_FLAGS': '0x0', 14:48:41 INFO - 'XPC_SERVICE_NAME': '0', 14:48:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:41 INFO - Downloading/unpacking jsonschema 14:48: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 14:48: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 14:48: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 14:48: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 14:48: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 14:48: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 14:48:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:48:44 INFO - Downloading/unpacking functools32 (from jsonschema) 14:48: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 14:48: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 14:48: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 14:48: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 14:48: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 14:48: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 14:48:44 INFO - Downloading functools32-3.2.3-2.tar.gz 14:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:48:44 INFO - warning: no files found matching '*.txt' 14:48:44 INFO - no previously-included directories found matching 'build' 14:48:44 INFO - no previously-included directories found matching 'dist' 14:48:44 INFO - no previously-included directories found matching '.git*' 14:48:44 INFO - Installing collected packages: jsonschema, functools32 14:48:44 INFO - Running setup.py install for functools32 14:48:44 INFO - warning: no files found matching '*.txt' 14:48:44 INFO - no previously-included directories found matching 'build' 14:48:44 INFO - no previously-included directories found matching 'dist' 14:48:44 INFO - no previously-included directories found matching '.git*' 14:48:44 INFO - Successfully installed jsonschema functools32 14:48:44 INFO - Cleaning up... 14:48:44 INFO - Return code: 0 14:48:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:44 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 0x10e1d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba0601af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e071e00>, '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 0x10dedadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e06cb20>, '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.27e91DaMC3/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.bRP1Ne6yfT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:48:44 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 14:48:44 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 14:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27e91DaMC3/Render', 14:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:44 INFO - 'HOME': '/Users/cltbld', 14:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:44 INFO - 'LOGNAME': 'cltbld', 14:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:44 INFO - 'MOZ_NO_REMOTE': '1', 14:48:44 INFO - 'NO_EM_RESTART': '1', 14:48:44 INFO - 'PAGER': '/bin/cat', 14:48:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:44 INFO - 'PWD': '/builds/slave/test', 14:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:44 INFO - 'SHELL': '/bin/bash', 14:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRP1Ne6yfT/Listeners', 14:48:44 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:44 INFO - 'USER': 'cltbld', 14:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:44 INFO - 'XPC_FLAGS': '0x0', 14:48:44 INFO - 'XPC_SERVICE_NAME': '0', 14:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:45 INFO - Downloading/unpacking flake8 14:48:45 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 14:48:45 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 14:48:45 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 14:48:45 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 14:48:45 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 14:48:45 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 14:48:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:48:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:48:47 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 14:48:47 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 14:48:47 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 14:48:47 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 14:48:47 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 14:48:47 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 14:48:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:48:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:48:47 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 14:48:47 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 14:48:47 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 14:48:47 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 14:48:47 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 14:48:47 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 14:48:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:48:48 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 14:48:48 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 14:48:48 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 14:48:48 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 14:48:48 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 14:48:48 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 14:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:48:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:48:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:48:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:48:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:48:48 INFO - no previously-included directories found matching 'docs/_build' 14:48:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:48:48 INFO - Running setup.py install for pep8 14:48:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:48:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:48:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:48:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:48:48 INFO - no previously-included directories found matching 'docs/_build' 14:48:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:48:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:48:49 INFO - Cleaning up... 14:48:49 INFO - Return code: 0 14:48:49 INFO - Running post-action listener: _resource_record_post_action 14:48:49 INFO - Running post-action listener: _start_resource_monitoring 14:48:49 INFO - Starting resource monitoring. 14:48:49 INFO - ##### 14:48:49 INFO - ##### Running install step. 14:48:49 INFO - ##### 14:48:49 INFO - Running pre-action listener: _resource_record_pre_action 14:48:49 INFO - Running main action method: install 14:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:49 INFO - Reading from file tmpfile_stdout 14:48:49 INFO - Detecting whether we're running mozinstall >=1.0... 14:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:48:49 INFO - Reading from file tmpfile_stdout 14:48:49 INFO - Output received: 14:48:49 INFO - Usage: mozinstall [options] installer 14:48:49 INFO - Options: 14:48:49 INFO - -h, --help show this help message and exit 14:48:49 INFO - -d DEST, --destination=DEST 14:48:49 INFO - Directory to install application into. [default: 14:48:49 INFO - "/builds/slave/test"] 14:48:49 INFO - --app=APP Application being installed. [default: firefox] 14:48:49 INFO - mkdir: /builds/slave/test/build/application 14:48:49 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'] 14:48:49 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 14:49:11 INFO - Reading from file tmpfile_stdout 14:49:11 INFO - Output received: 14:49:11 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:49:11 INFO - Running post-action listener: _resource_record_post_action 14:49:11 INFO - ##### 14:49:11 INFO - ##### Running run-tests step. 14:49:11 INFO - ##### 14:49:11 INFO - Running pre-action listener: _resource_record_pre_action 14:49:11 INFO - Running main action method: run_tests 14:49:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:49:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:49:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:49:11 INFO - 2016-06-30 14:49:11.314 screenresolution[1644:7342] starting screenresolution argv=screenresolution get 14:49:11 INFO - 2016-06-30 14:49:11.316 screenresolution[1644:7342] Display 0: 1600x1200x32@60 14:49:11 INFO - 2016-06-30 14:49:11.322 screenresolution[1645:7344] starting screenresolution argv=screenresolution list 14:49:11 INFO - Available Modes on Display 0 14:49:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:49:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:49:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:49:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:49:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:49:11 INFO - Intel Iris: 14:49:11 INFO - Chipset Model: Intel Iris 14:49:11 INFO - Type: GPU 14:49:11 INFO - Bus: Built-In 14:49:11 INFO - VRAM (Dynamic, Max): 1536 MB 14:49:11 INFO - Vendor: Intel (0x8086) 14:49:11 INFO - Device ID: 0x0a2e 14:49:11 INFO - Revision ID: 0x0009 14:49:11 INFO - Displays: 14:49:11 INFO - Display: 14:49:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:49:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:49:11 INFO - Display Serial Number: 1600x1200 60 14:49:11 INFO - Main Display: Yes 14:49:11 INFO - Mirror: Off 14:49:11 INFO - Online: Yes 14:49:11 INFO - Rotation: Supported 14:49:11 INFO - Return code: 0 14:49:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:49:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:49:11 INFO - Python 2.7.3 14:49:11 INFO - Return code: 0 14:49:11 INFO - grabbing minidump binary from tooltool 14:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:11 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 0x10e071e00>, '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 0x10dedadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e06cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:49:11 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 14:49:11 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 14:49:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:49:11 INFO - Return code: 0 14:49:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:49:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:49:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:49:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:49:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:49:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:49:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:49:12 INFO - Return code: 0 14:49:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:49:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27e91DaMC3/Render', 14:49:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:12 INFO - 'HOME': '/Users/cltbld', 14:49:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:12 INFO - 'LOGNAME': 'cltbld', 14:49:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:49:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:12 INFO - 'MOZ_NO_REMOTE': '1', 14:49:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:49:12 INFO - 'NO_EM_RESTART': '1', 14:49:12 INFO - 'PAGER': '/bin/cat', 14:49:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:12 INFO - 'PWD': '/builds/slave/test', 14:49:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:49:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:12 INFO - 'SHELL': '/bin/bash', 14:49:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRP1Ne6yfT/Listeners', 14:49:12 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:49:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:12 INFO - 'USER': 'cltbld', 14:49:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:12 INFO - 'XPC_FLAGS': '0x0', 14:49:12 INFO - 'XPC_SERVICE_NAME': '0', 14:49:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:49:12 INFO - mozversion application_buildid: 20160630123429 14:49:12 INFO - mozversion application_changeset: dd7af1fa4ece1cb3158d08c80dfcbf1c6ca830fb 14:49:12 INFO - mozversion application_display_name: Firefox 14:49:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:49:12 INFO - mozversion application_name: Firefox 14:49:12 INFO - mozversion application_remotingname: firefox 14:49:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:49:12 INFO - mozversion application_vendor: Mozilla 14:49:12 INFO - mozversion application_version: 48.0 14:49:12 INFO - mozversion platform_buildid: 20160630123429 14:49:12 INFO - mozversion platform_changeset: dd7af1fa4ece1cb3158d08c80dfcbf1c6ca830fb 14:49:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:49:12 INFO - mozversion platform_version: 48.0 14:49:12 INFO - using testdate: 1467323352 14:49:12 INFO - actual date: 1467323352 14:49:12 INFO - starting webserver on 'localhost:49272' 14:49:12 INFO - SUITE-START | Running 2 tests 14:49:12 INFO - TEST-START | dromaeo_css 14:49:12 INFO - operating with platform_type : mac_ 14:49:12 INFO - Initialising browser for dromaeo_css test... 14:49:13 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpFJ0vo7/profile http://localhost:49272/getInfo.html) 14:49:15 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 14:49:15 INFO - PROCESS | 1663 | colorDepth:24 14:49:15 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 14:49:15 INFO - PROCESS | 1663 | __metrics 14:49:15 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:49:16 INFO - TEST-INFO | 1663: exit 0 14:49:16 INFO - Browser initialized. 14:49:16 INFO - Running cycle 1/1 for dromaeo_css test... 14:49:16 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpFJ0vo7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:49:28 INFO - PROCESS | 1667 | RSS: Main: 171282432 14:49:28 INFO - PROCESS | 1667 | 14:50:18 INFO - PROCESS | 1667 | 1467323418076 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] 14:52:28 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 14:52:29 INFO - PROCESS | 1667 | RSS: Main: 182280192 14:52:29 INFO - PROCESS | 1667 | 14:55:32 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 14:55:32 INFO - PROCESS | 1667 | RSS: Main: 192983040 14:55:32 INFO - PROCESS | 1667 | 14:58:34 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 14:58:35 INFO - PROCESS | 1667 | RSS: Main: 195190784 14:58:35 INFO - PROCESS | 1667 | 15:01:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 15:01:37 INFO - PROCESS | 1667 | RSS: Main: 198758400 15:01:37 INFO - PROCESS | 1667 | 15:04:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 15:04:40 INFO - PROCESS | 1667 | RSS: Main: 198664192 15:04:40 INFO - PROCESS | 1667 | 15:07:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 15:07:42 INFO - PROCESS | 1667 | RSS: Main: 203517952 15:07:42 INFO - PROCESS | 1667 | 15:07:42 INFO - PROCESS | 1667 | __start_tp_report 15:07:42 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 15:07:42 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 15:07:42 INFO - PROCESS | 1667 | |i|pagename|runs| 15:07:42 INFO - PROCESS | 1667 | |0;dojo.html;3542.911427214321;3615.1323682316242;3701.4632878232674;3743.419769935661;3745.6441638044375;4910.558049775519;5914.142449344848;5988.221531200943;6001.5798894077325;6039.09413587962;5999.340072592011;6006.219191505098;6015.398460153982;6047.455728984391;6056.606320589159;5308.575313974882;5367.221752845835;5438.7280635968245;5467.890642187154;5556.111022236443;5257.631965762398;5348.973255133738;5352.57179425645;5363.141897296433;5366.329208848894;5401.891962160755;5407.432219616942;5414.07960646689;5418.972905135489;5421.972890135544;5337.2794672719265;5368.865778355534;5398.8920221595745;5419.3225846768955;5487.64330318528;5316.601254905898;5368.248445217672;5389.83830485086;5409.2967914171295;5411.783528658849;4718.858434246944;5692.943070569283;5799.956007918573;5914.615549989237;5944.64332140073;4884.4871288514905;5728.799492017801;6224.097505861625;6300.653464059475;6316.778912738032;5266.657667251617;6349.968250158766;6355.586886852339;6376.744930202786;6399.456046236076;5917.349091599921;6027.578069535178;6056.909146362808;6073.514118870524;6102.847428814315;6489.286178520359;6542.771003014872;6554;6558.278589355167;6593.901091483632;6297.4962003039645;6310.337414571496;6310.747570097236;6317.684115794192;6334.113224148623;6232.781852635136;6331.2085989251345;6389.520785941073;6396.392342727433;6399.64801935898;6286.811395658137;6295.527835412362;6309.589876658094;6311.652859092794;6316.652584107826;5165.845024649267;6241.625502469776;6324.841878953063;6327.683615819191;6330.39861213184;4985.227289770091;5015.3229314042865;5060.063888180698;5091.389033316026;5130.563902068291;4537.636989040869;4568.588827005586;4585.151746926829;4599.931001034987;4634.443866735945;6098.54260930432;6118.877622447526;6150.323464418911;6154.9384506154365;6194.194754681863;6211.3167551569295;6283.874322513524;6328.019157030668;6358.33237510064;6393.584417012972;6155.784547540815;6159.5072394208355;6161.44546990773;6169.475594574422;6189.938100619026;5499.532539734088;5606.635568688022;5630.127330263816;5638.774449022075;5677.261955945701;6494.415502604694;6498.155239818888;6526.771562995273;6621.933780662228;6657.966710166418;6384.489240860813;6416.037594360883;6416.45460135875;6423.807285781434;6435.613863168225;6490.513211509061;6593.571417858016;6658.167729033871;6659;6688.966555167193;6273;6335.429811317003;6340.239171299474;6346.2067241594805;6349.68251587428;6335.429811317003;6366.77716279928;6382.5532212744665;6408.423241908251;6413.16628838248;5109.616778741535;5351.170568561879;6117.510599151969;6251.968425209971;6269.090981807703;6126.517673797367;6264.843378915563;6273.52948528853;6286.74853005893;6287.874242515216;6106.961816491118;6164.229471316085;6169.50643948474;6254.249490061222;6266.154069200782;5830.737616807169;6158.353372895782;6169.907451388143;6201.255849298113;6276.560640755286;6173.475254603409;6174.289956655042;6205.689715514297;6244.46922011616;6260.280067792262 15:07:42 INFO - PROCESS | 1667 | |1;ext.html;513.6994858008065;529.1401472607014;570.8430181700035;583.0059748129438;603.957722959393;35230;39306.60693393065;39341;39416.408753868716;39418.81743547694;41047.38428923561;41763.58236417635;41772.16455670892;41786.58213417865;41869.743907682816;9612.951935240313;9822.852657210147;9844.507774611277;9857.507124643775;9879.802403951917;9654.13112819846;9862.45756483393;9878.654247101353;9917.603295868157;9939.453330066843;9882.505874706272;9884.901150988506;9897.851532226987;9913.851292230585;9924.106830385264;9771.413715177112;9839.655612053544;9844.655437059704;9870.45712485813;9884.752881177956;9786.1192492676;9817.312788104835;9915.65295214664;9932.404055756677;9949.253805964509;32855.83572082148;40081.19837603231;40168;40415.797921010504;40592.39111413331;3206.4709322961685;3351.8994430167136;3376.8480418380987;3387.728981681484;3907.7459965102175;20103.894285814273;28452.719627616807;28746.856265718747;28912.42175156506;30022.099337019707;2755.9448811023867;2807.101727447218;2842.033708539086;2881.683014868363;2907.0552070577146;322171;322834;324400;324695;325231;37373.813130934715;59934.70032649809;61301.08048379278;61465;61481.692591536754;36611.4508282376;36780;36814.631853681654;36861.447078293844;36867.446988295196;16441.588960276087;16441.588960276087;16556.83443165577;16613.41853035138;16625.83374166267;13641.86358136406;13948.651283717989;14031.158130512202;14140.858591413955;14166.362513686909;8300.958495207486;8304.584770761438;8349.499030058216;8356.080831108573;8526.190011948855;3007.684193159687;3441.4321636929626;3444.156181735491;3463.7748546344405;3488.2151515908718;1065.984010239847;1097.2648325621853;1098.774751176007;1121.495327102807;1152.5274637398793;30155.698443015728;30737.538936915964;30798.92203772902;31179.53230701541;31317.53023704601;911.7310393433953;1039.9584016639249;1132.932024078558;1154.722866512031;1201.6575276046285;11942;15858.841411585967;15861.920690396475;15896.682066358839;16073.437429690139;507703;509422;511714;512289;517473.65052698733;51804.48195517997;61594.76810463765;61863.6906815472;62392.68803655953;62421.37578624247;1519.270750039987;1562.898411603242;1571.449992502615;1581.7785510028605;1640.0651628571839;30268.84865575658;30574;30704.846475767477;30750.231244219074;31023.224419389695;50560.74719626379;53445.19832202598;53502;53766;53895.73052134714;551306;561107;562511;565808;568274;26190.86904565465;27438.17685469439;27487.17538473849;27540;27813.721862781924;39064;46388.840278993295;46796.532034679214;48151.277730834765;48770.78073048202;32700.69197232179;38701.80649096736;39148.217035658556;39201.6079839198;39307.410388843615;35917.28165436624;36607.81696091503;36932.44601330929;37141.81429092837;37327.626723732414;35730.28539429249;36307.45538816973;36490.45264320984;36522.45216321704;37039.44440833336;32848;33257.83371083129;33630;33745.49381759325;34096.97709068732;25120.62319065179;25272.36819079464;25398.492030158923;25715;25815.612765808153 15:07:42 INFO - PROCESS | 1667 | |2;jquery.html;370.6960292560101;414.9917001659967;415.1158033388881;418.6713429957484;425.2218440254335;15378.615534611612;15659.765103523441;17013.404530841424;20037.19851205952;20806;17297.962122272642;17602.471925842212;20782.89608551955;20791.584168316625;21179;5341.919871201925;6007.128966299884;6118.69406529674;6118.755249790003;6119.969400152993;5599.440055994409;5855.092460668582;5888.64668119912;5894.204282421861;5904.586678932455;5819.50534204591;5878.294604647448;5889.352171261158;5961.910571341434;6079.939200608003;6002.849928751794;6053.213082299317;6060.939390606081;6086.634801911855;6104.816855494342;5824.679642619654;5854.092615644539;5864.0031194697;5924.644521328734;5943.554233432466;13558.186508809504;13658.521951731742;13823.585292441243;13889.79165312521;13926.442942282296;2253.6056190166655;2314.9652755208685;2640.775534079586;2791.162651204651;2798.8740506677045;8293.543855087968;9705.90294097057;10288.69133925976;10341.844872326921;10651.786964260671;1700.5493544210794;1735.8871673341193;1750.2386461889118;1813.9116530081844;1816.6639171753268;98928.51607225898;105063.47468262687;105972.41041384386;112993;115681.26478102751;10653.414062226651;10875.91240875906;12049.277043377426;12141.878581214252;12168.695782605506;15164.317605707769;15354.923225384025;15467.226638668022;15533.378664853279;15613.219339033003;7641.006669132978;8095.5142691438705;9206.63173473067;9308;9387.812243755086;9057.275417966546;9617.56720947559;9630.711078667651;9634.71095867125;9659.71020869375;4764.6426518011285;4816.783244753994;4823.9517604824205;4827.372441582572;4847.297141914402;2016.8184863362367;2049.4671385439597;2057.567910738732;2062.113291284762;2070.637638413272;896.287451476065;1022.4172221833633;1036.3678156324636;1095.1512577752146;1110.6834552152598;16790.328386864632;20068.39794806158;20875.060622272034;21033.89483052575;21519.924003799748;882.2280504558511;991.2317953585884;995.8107959487675;1002.1682003936716;1040.1314902056715;11178.664640060812;11553.480093395818;11558.711032224093;11558.826617600742;11603.477843497063;578303;580266;586875;594996;622886;108633.91366086397;123601.14598281033;126801;132139.01791473135;135066;941.4257303045136;1010.0858722855827;1062.8299472084584;1068.086785798147;1070.6573896353248;19040.52398690044;19529.21883124659;19660.90169549143;19706.704399434308;20005.899970500053;48703.5129648699;52480.68798280074;52605.473945260055;54484.72757636187;56099.71950140223;60544.6972765151;78122.4375512498;79441.20558794338;79814;80009;8241.299489543217;8374.95812520958;8435.156484351515;8467.78830529217;8776.078511756428;11352.943235284101;13197.934010329887;13240.80138797938;13293.933530332286;13605.79591306151;10993.395363255098;11177.105831533621;11205.039118154127;11521.193516453768;11725.296482211095;10939.179561532757;11103.888961110286;11199.272047316897;11235.71910702239;11445.027172690414;11265.887341126483;11345.546178152781;11579.015783658484;11760.705982350168;11891.524339026342;8339.082700903016;8516.74449766508;8556.229939305493;8624.008239052338;8754.47473151613;10509.789804204025;10733.516991735547;11684.649460516199;11696.824547631622;11784.175107742376 15:07:42 INFO - PROCESS | 1667 | |3;mootools.html;1491.724031054255;1582.6280824006355;1596.8962017468866;1941.5340318323597;1989.7114918336833;7962.363010959124;8694.087120852315;8851.159139881709;8987.281017518599;9047.09529047095;8765.430247033939;8807.295416366691;8879.60041798119;8885.200331970122;8957.507337096456;2519.874006299682;2535.5055764126005;2538.0736031348515;2552.680914885639;2559.2706078767555;2474.505098980202;2484.291976786616;2488.8133389995733;2490.203134996802;2501.2371226775826;2100.2649072824543;2491.676082109323;2509.498100379922;2541.898324067035;2545.6690630218045;2475.591527397977;2507.2352932355625;2516.534441128388;2544.5547029269806;2556.744325567447;1855.35990083421;2515.9496810063697;2522.810789190818;2524.0408644715076;2560.782333501636;9001.594928228245;9026.142516460926;9029.819403611957;9047.276217902618;9072.909270907272;5536.280283563151;5705.087186050254;5734.197212390269;5760.855978600526;5792.131180322943;3632.2553876455263;3730.459083432914;3757.304898593769;3766.886993390203;3769.1142581493327;1047.9280283428243;1071.212658695858;1073.88187299397;1074.8656417947757;1076.9138468922467;11964.40177991097;11984.400779961054;12174;12270.202436841577;12323.815142772866;4945.703257804544;4971.304017437562;5039.44566097729;5049.873753156127;5101.897962040738;10346;10369.792604147875;10374.17006639467;10404.739881502872;10429.895701042893;5167.741612919339;5633.464820842096;5739.110437882135;5742;5752.913706294409;4500.257457519538;4970.030843985388;5066.189409694432;5084.694918304914;5193.402758682724;4213.094184750294;4216.51510076339;4249.192653395845;4250.171216612793;4271.295236285978;1388.340538244326;1421.9360128794021;1422.7439060969125;1426.7431862264891;1439.3450979804163;828;889.355217467331;948.4309414351472;970.3595626886221;986;6025.698715064229;6027.578069535178;6030.065339872327;6067.969660151671;6249.562530622813;469.10635239868105;478.22050058405273;484.6171524495679;485.3035893492849;490.78896074687515;3345.983270083634;4049.979750101231;4058.1680755445063;4069.8168582413864;4108.342665173558;10464.424456654957;10661.466926653637;10842.783144337069;10870.836937445945;10895.836562451412;9694.46680432583;10579.629712960163;10596.841047384296;10771.676849694522;10801.297915635458;7022.789316320519;7040.788776336718;7574.5833979130575;7726.188750181263;7965.084015338194;4849.878753031202;5971.820845374646;6119.44924956756;6142;6158.753649853956;9237.353385263235;9312.813743724952;9389.014153513783;9624.181944534794;9720.27097967641;9219.078092190728;9777.315587908779;9931.65239216624;9936.503174841084;10044.397336159855;7019.543729657556;7249.746258880914;7475.887861682188;7668.539887606761;7770.961145194464;7623.542587444771;8212.63043163071;8258.339332853477;8265.545395003333;8265.95867020661;6058.394160583906;6717.361850624183;7369.77890663281;7492.70029198826;7494.063242094739;7247.927520724726;7263.382612477787;7301.52540084914;7336.889946650911;7361.374283185989;6911.343422374866;7062.894056589258;7121.9643901780155;7127.287271272831;7149.249328820607;4931.852044438672;4997;5007.899842003067;5095.006473737586;5110.795568177231;4986.152354099884;5002.399712034579;5006.449290577961;5104.132297509358;5206.817761378334 15:07:42 INFO - PROCESS | 1667 | |4;prototype.html;336.0702318198742;336.5137376490971;337.6792047554822;344.7948470659957;346.8283199816091;6801.901585484231;6836.213835408929;6844.178698556168;6886.104806375164;6908.62002589858;6736.7978960631135;6769.661516924159;6775.491838112149;6826.863462730755;6841.076454678617;5007.874803129915;5026.522480364378;5028.296038554606;5032.471590483002;5044.243363495469;4752.881177970561;4853.805847766085;4971.254311853233;4973.477784832595;4976.900461990758;4882.316475693406;4883.9511604883855;4887.218045112782;4909.091818013679;4930.728809915453;4901.142300097486;4905.215165573509;4907.582855457291;4907.656464047518;4926.187179115442;3644.2893635741043;4065.390191471303;4231.640310573605;4233.23801715691;4271.273883439822;6496.675166241716;6508.056331831858;6508.772192973223;6521.93478065218;6528.706208220641;5100.209467532539;5728.369879313273;5880.6765627890445;5901.29184497863;5929.822105336803;7261.963690181516;7281.342310056844;7319.670614822346;7326.340629343332;7344.375728063121;4837.250226214942;4837.395325584302;4839.9032019359765;4840.903181936377;4854.563089321942;7796.532208067534;7805.126769575318;7808.414368922354;7812.179721129256;7822.139564647884;4744.430668319824;4906.681065730716;4908.288298196741;4927.162382395001;4928.901421971541;5014.272930425068;5018.874528136826;5025.899482010339;5044.672096313728;5045.646804723708;5076.695398276115;5896.204012458349;5966.671833049224;5969.582129250997;5980.43185897339;5894.351621321651;7033.683484243222;7035.261297563785;7429.888551671729;7448.175197076643;1728.775259216319;1747.3010795681828;1749.5713550180287;1750.903700296496;1757.1477833250863;1084.5932775209296;1122.7698321844002;1128.2779021426293;1128.8711288711288;1146.8394424780538;7012.298770123049;7075.92924070763;7081.433485321162;7084.0082388464625;7106.289371062956;7650.808729781688;7651.69393224276;7665.501742386727;7666.8083297918;7667.769966901002;6176.969115154396;6945.965270173718;7032.753853615099;7039.718411263594;7040.331168538981;3494.633063528344;3731.6193008586997;4040.7575545467366;4082.6733861291027;4083.3262511685834;8057.838843223103;8129.715459958873;8167.42828002046;8175.427720059539;8187.795305117301;8003.799905002422;8004.639791209293;8013.959930200312;8015.519068855887;8049.356051515864;7821.687132514636;8135.349172066339;8141.877871831927;8151.470154439942;8203.671853125808;6413.422791948747;6585.5719378240265;7574.522968021183;7688.730894418669;7749.225077492206;6106.480949119375;7611.2769286917655;7656.425768067305;7656.617169141632;7672.424568157299;8149.551774652451;8159.428839981382;8162.306203972729;8167.469114507538;8168.83662326762;4605.102005108972;4766.856994290177;4788.090262850047;4794.208955522439;4794.472608013186;6165.753369865155;7405.074365704287;7669.654865531176;7675.731349402744;7680.5391676499585;6289.96855015722;7413.110426748609;7417.369523590555;7434.405247580289;7458.813529661802;5914.58597898143;7168.247334029852;7388.335049845539;7389.889151662837;7421.851562968603;6411.807645770635;7205.171405288459;7233.63831808418;7250.20247772734;7261.273872612696;6831.69257383409;7394.2975417335265;7421.554706717614;7445.10658720957;7450.8823676448965;7274.781756547312;7274.854502910018;7276.272372762893;7288.526245794006;7307.488475806643 15:07:42 INFO - PROCESS | 1667 | |5;yui.html;687.4843867099678;693.8404167041581;728.4536597551836;729.18331468755;734.2804052029012;14385.712285754278;15259.237038148103;15346.079235245894;15477.07137571745;15504.302306396212;14220.217888016155;14251.857481425182;14366.353514091865;14374.70627643512;14658;779.3959681247022;963.2727290895382;963.9662611808589;971.4656938683696;985.1281615770059;935.046252822121;936.840737074699;954.7708549948032;981.3817295104075;981.9165370943442;999;1010.9241806864478;1011.2011510906375;1011.8886922438526;1016.5781200801658;959.2709540749012;960.7021823234819;960.7357976556433;960.7982323711959;961.3462845265217;631.4979591224987;740.1229542991518;744.4491076603275;758.8520238553484;761.6686741267511;14773.556793296219;14944.178070206135;14957.252137393087;15015;15115.697686046218;12834.67913302175;12963.351832408436;12989.636088210791;13017.609471715863;13020.609381718468;9461.52692365379;9461.952690236574;9471;9568.378055426376;9590.808183836354;3545.0960005198767;3590.174259920207;3600.6219346968455;3644.671979521856;3806.1436176859984;78030.21969780287;82577.58711206466;83147.75278370829;84083.15916840815;84120.57939710324;9614.18279446255;9697.272704547046;9774.022597740312;9858.704238872846;10096.394216347042;22161.33515994523;22206.555868882533;22215.88892055562;22252.666210006864;22296.10815567359;7533.359664428475;7539.585322807188;7588.27911348421;7630.961845190738;7649.31156195945;3756.398976163801;3802.904927376838;3864.304425203434;3987.7009224308295;4312.633426158749;3724.646158614927;3728.5339332583426;3729.589745128034;3769.8869033928477;3772.264408440383;664.1034603285526;667.2893368562466;671.7145213284334;691.3915754136428;696.585531608692;538.8329617818489;543.7195404821667;593.5459373579129;606.760329669778;608.856918624123;6370.777022804273;6672.1285268963;6843.3498817613245;8681.522516261666;8718.65125394977;539.5737367479726;545.7107732901569;570.0423288874647;597.3071237364636;608.613530408194;3768.2840260350445;3894.162755007687;4003.559608443069;4006.3990401439432;4101.97949010259;75745.86381204287;94940.52529737307;97720.51139744256;98895.50552247193;99460;78522.21477785263;78688.42623147505;81273;83156.16843831605;83852;73141;73483;74125;74443;75388;7204.9639751800905;7294.270572942663;8010.158933312151;8064.5967701615855;8198.442295963749;48788;50125.496235113;50733.22433714802;51830.74084629553;52149.696257592346;67932.6413471718;69587.65206173937;72285;72935;74335.62832185805;8914.86627700598;10239.641612543524;10280.742981425525;10692.091172250135;11164.330140191614;9675.661351852652;11962.282263064244;12114.454849531616;12124.75750485003;12438.00495960303;11050.723731906766;11731.706707332385;11755.471003804678;11783.057355411374;11992.460339284928;10542.472876356305;11294.04000659953;11467.139964502863;11621.76756464883;11635.767284654428;11404.828927565926;11473.770524589294;11481.942590286995;11651.708707282385;11685.357305348287;9837.754056148653;9980.500974951368;10041.04610062043;10109.090181883666;10133.290669653054;9744.610215591298;9892.98002926419;9964.950175249367;9993.781867926875;10079.445630490394 15:07:42 INFO - PROCESS | 1667 | __end_tp_report 15:07:42 INFO - PROCESS | 1667 | __start_cc_report 15:07:42 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,389 15:07:42 INFO - PROCESS | 1667 | __end_cc_report 15:07:42 INFO - PROCESS | 1667 | __startTimestamp1467324462765__endTimestamp 15:07:42 INFO - PROCESS | 1667 | 15:07:42 INFO - PROCESS | 1667 | ------- Summary: start ------- 15:07:42 INFO - PROCESS | 1667 | Number of tests: 6 15:07:42 INFO - PROCESS | 1667 | 15:07:42 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5893.63 Median:6161.45 stddev:646.21 (10.5%) stddev-sans-first:621.33 15:07:42 INFO - PROCESS | 1667 | Values: 3542.9 3615.1 3701.5 3743.4 3745.6 4910.6 5914.1 5988.2 6001.6 6039.1 5999.3 6006.2 6015.4 6047.5 6056.6 5308.6 5367.2 5438.7 5467.9 5556.1 5257.6 5349.0 5352.6 5363.1 5366.3 5401.9 5407.4 5414.1 5419.0 5422.0 5337.3 5368.9 5398.9 5419.3 5487.6 5316.6 5368.2 5389.8 5409.3 5411.8 4718.9 5692.9 5800.0 5914.6 5944.6 4884.5 5728.8 6224.1 6300.7 6316.8 5266.7 6350.0 6355.6 6376.7 6399.5 5917.3 6027.6 6056.9 6073.5 6102.8 6489.3 6542.8 6554.0 6558.3 6593.9 6297.5 6310.3 6310.7 6317.7 6334.1 6232.8 6331.2 6389.5 6396.4 6399.6 6286.8 6295.5 6309.6 6311.7 6316.7 5165.8 6241.6 6324.8 6327.7 6330.4 4985.2 5015.3 5060.1 5091.4 5130.6 4537.6 4568.6 4585.2 4599.9 4634.4 6098.5 6118.9 6150.3 6154.9 6194.2 6211.3 6283.9 6328.0 6358.3 6393.6 6155.8 6159.5 6161.4 6169.5 6189.9 5499.5 5606.6 5630.1 5638.8 5677.3 6494.4 6498.2 6526.8 6621.9 6658.0 6384.5 6416.0 6416.5 6423.8 6435.6 6490.5 6593.6 6658.2 6659.0 6689.0 6273.0 6335.4 6340.2 6346.2 6349.7 6335.4 6366.8 6382.6 6408.4 6413.2 5109.6 5351.2 6117.5 6252.0 6269.1 6126.5 6264.8 6273.5 6286.7 6287.9 6107.0 6164.2 6169.5 6254.2 6266.2 5830.7 6158.4 6169.9 6201.3 6276.6 6173.5 6174.3 6205.7 6244.5 6260.3 15:07:42 INFO - PROCESS | 1667 | 15:07:42 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:60324.97 Median:36864.45 stddev:127270.27 (345.2%) stddev-sans-first:127548.07 15:07:42 INFO - PROCESS | 1667 | Values: 513.7 529.1 570.8 583.0 604.0 35230.0 39306.6 39341.0 39416.4 39418.8 41047.4 41763.6 41772.2 41786.6 41869.7 9613.0 9822.9 9844.5 9857.5 9879.8 9654.1 9862.5 9878.7 9917.6 9939.5 9882.5 9884.9 9897.9 9913.9 9924.1 9771.4 9839.7 9844.7 9870.5 9884.8 9786.1 9817.3 9915.7 9932.4 9949.3 32855.8 40081.2 40168.0 40415.8 40592.4 3206.5 3351.9 3376.8 3387.7 3907.7 20103.9 28452.7 28746.9 28912.4 30022.1 2755.9 2807.1 2842.0 2881.7 2907.1 322171.0 322834.0 324400.0 324695.0 325231.0 37373.8 59934.7 61301.1 61465.0 61481.7 36611.5 36780.0 36814.6 36861.4 36867.4 16441.6 16441.6 16556.8 16613.4 16625.8 13641.9 13948.7 14031.2 14140.9 14166.4 8301.0 8304.6 8349.5 8356.1 8526.2 3007.7 3441.4 3444.2 3463.8 3488.2 1066.0 1097.3 1098.8 1121.5 1152.5 30155.7 30737.5 30798.9 31179.5 31317.5 911.7 1040.0 1132.9 1154.7 1201.7 11942.0 15858.8 15861.9 15896.7 16073.4 507703.0 509422.0 511714.0 512289.0 517473.7 51804.5 61594.8 61863.7 62392.7 62421.4 1519.3 1562.9 1571.4 1581.8 1640.1 30268.8 30574.0 30704.8 30750.2 31023.2 50560.7 53445.2 53502.0 53766.0 53895.7 551306.0 561107.0 562511.0 565808.0 568274.0 26190.9 27438.2 27487.2 27540.0 27813.7 39064.0 46388.8 46796.5 48151.3 48770.8 32700.7 38701.8 39148.2 39201.6 39307.4 35917.3 36607.8 36932.4 37141.8 37327.6 35730.3 36307.5 36490.5 36522.5 37039.4 32848.0 33257.8 33630.0 33745.5 34097.0 25120.6 25272.4 25398.5 25715.0 25815.6 15:07:42 INFO - PROCESS | 1667 | 15:07:42 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:34195.21 Median:20787.24 stddev:98721.22 (474.9%) stddev-sans-first:98965.49 15:07:42 INFO - PROCESS | 1667 | Values: 370.7 415.0 415.1 418.7 425.2 15378.6 15659.8 17013.4 20037.2 20806.0 17298.0 17602.5 20782.9 20791.6 21179.0 5341.9 6007.1 6118.7 6118.8 6120.0 5599.4 5855.1 5888.6 5894.2 5904.6 5819.5 5878.3 5889.4 5961.9 6079.9 6002.8 6053.2 6060.9 6086.6 6104.8 5824.7 5854.1 5864.0 5924.6 5943.6 13558.2 13658.5 13823.6 13889.8 13926.4 2253.6 2315.0 2640.8 2791.2 2798.9 8293.5 9705.9 10288.7 10341.8 10651.8 1700.5 1735.9 1750.2 1813.9 1816.7 98928.5 105063.5 105972.4 112993.0 115681.3 10653.4 10875.9 12049.3 12141.9 12168.7 15164.3 15354.9 15467.2 15533.4 15613.2 7641.0 8095.5 9206.6 9308.0 9387.8 9057.3 9617.6 9630.7 9634.7 9659.7 4764.6 4816.8 4824.0 4827.4 4847.3 2016.8 2049.5 2057.6 2062.1 2070.6 896.3 1022.4 1036.4 1095.2 1110.7 16790.3 20068.4 20875.1 21033.9 21519.9 882.2 991.2 995.8 1002.2 1040.1 11178.7 11553.5 11558.7 11558.8 11603.5 578303.0 580266.0 586875.0 594996.0 622886.0 108633.9 123601.1 126801.0 132139.0 135066.0 941.4 1010.1 1062.8 1068.1 1070.7 19040.5 19529.2 19660.9 19706.7 20005.9 48703.5 52480.7 52605.5 54484.7 56099.7 60544.7 78122.4 79441.2 79814.0 80009.0 8241.3 8375.0 8435.2 8467.8 8776.1 11352.9 13197.9 13240.8 13293.9 13605.8 10993.4 11177.1 11205.0 11521.2 11725.3 10939.2 11103.9 11199.3 11235.7 11445.0 11265.9 11345.5 11579.0 11760.7 11891.5 8339.1 8516.7 8556.2 8624.0 8754.5 10509.8 10733.5 11684.6 11696.8 11784.2 15:07:42 INFO - PROCESS | 1667 | 15:07:42 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5756.89 Median:5023.67 stddev:3177.46 (63.2%) stddev-sans-first:3170.20 15:07:42 INFO - PROCESS | 1667 | Values: 1491.7 1582.6 1596.9 1941.5 1989.7 7962.4 8694.1 8851.2 8987.3 9047.1 8765.4 8807.3 8879.6 8885.2 8957.5 2519.9 2535.5 2538.1 2552.7 2559.3 2474.5 2484.3 2488.8 2490.2 2501.2 2100.3 2491.7 2509.5 2541.9 2545.7 2475.6 2507.2 2516.5 2544.6 2556.7 1855.4 2515.9 2522.8 2524.0 2560.8 9001.6 9026.1 9029.8 9047.3 9072.9 5536.3 5705.1 5734.2 5760.9 5792.1 3632.3 3730.5 3757.3 3766.9 3769.1 1047.9 1071.2 1073.9 1074.9 1076.9 11964.4 11984.4 12174.0 12270.2 12323.8 4945.7 4971.3 5039.4 5049.9 5101.9 10346.0 10369.8 10374.2 10404.7 10429.9 5167.7 5633.5 5739.1 5742.0 5752.9 4500.3 4970.0 5066.2 5084.7 5193.4 4213.1 4216.5 4249.2 4250.2 4271.3 1388.3 1421.9 1422.7 1426.7 1439.3 828.0 889.4 948.4 970.4 986.0 6025.7 6027.6 6030.1 6068.0 6249.6 469.1 478.2 484.6 485.3 490.8 3346.0 4050.0 4058.2 4069.8 4108.3 10464.4 10661.5 10842.8 10870.8 10895.8 9694.5 10579.6 10596.8 10771.7 10801.3 7022.8 7040.8 7574.6 7726.2 7965.1 4849.9 5971.8 6119.4 6142.0 6158.8 9237.4 9312.8 9389.0 9624.2 9720.3 9219.1 9777.3 9931.7 9936.5 10044.4 7019.5 7249.7 7475.9 7668.5 7771.0 7623.5 8212.6 8258.3 8265.5 8266.0 6058.4 6717.4 7369.8 7492.7 7494.1 7247.9 7263.4 7301.5 7336.9 7361.4 6911.3 7062.9 7122.0 7127.3 7149.2 4931.9 4997.0 5007.9 5095.0 5110.8 4986.2 5002.4 5006.4 5104.1 5206.8 15:07:42 INFO - PROCESS | 1667 | 15:07:42 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5998.33 Median:6772.58 stddev:1951.31 (28.8%) stddev-sans-first:1909.95 15:07:42 INFO - PROCESS | 1667 | Values: 336.1 336.5 337.7 344.8 346.8 6801.9 6836.2 6844.2 6886.1 6908.6 6736.8 6769.7 6775.5 6826.9 6841.1 5007.9 5026.5 5028.3 5032.5 5044.2 4752.9 4853.8 4971.3 4973.5 4976.9 4882.3 4884.0 4887.2 4909.1 4930.7 4901.1 4905.2 4907.6 4907.7 4926.2 3644.3 4065.4 4231.6 4233.2 4271.3 6496.7 6508.1 6508.8 6521.9 6528.7 5100.2 5728.4 5880.7 5901.3 5929.8 7262.0 7281.3 7319.7 7326.3 7344.4 4837.3 4837.4 4839.9 4840.9 4854.6 7796.5 7805.1 7808.4 7812.2 7822.1 4744.4 4906.7 4908.3 4927.2 4928.9 5014.3 5018.9 5025.9 5044.7 5045.6 5076.7 5896.2 5966.7 5969.6 5980.4 5894.4 7033.7 7035.3 7429.9 7448.2 1728.8 1747.3 1749.6 1750.9 1757.1 1084.6 1122.8 1128.3 1128.9 1146.8 7012.3 7075.9 7081.4 7084.0 7106.3 7650.8 7651.7 7665.5 7666.8 7667.8 6177.0 6946.0 7032.8 7039.7 7040.3 3494.6 3731.6 4040.8 4082.7 4083.3 8057.8 8129.7 8167.4 8175.4 8187.8 8003.8 8004.6 8014.0 8015.5 8049.4 7821.7 8135.3 8141.9 8151.5 8203.7 6413.4 6585.6 7574.5 7688.7 7749.2 6106.5 7611.3 7656.4 7656.6 7672.4 8149.6 8159.4 8162.3 8167.5 8168.8 4605.1 4766.9 4788.1 4794.2 4794.5 6165.8 7405.1 7669.7 7675.7 7680.5 6290.0 7413.1 7417.4 7434.4 7458.8 5914.6 7168.2 7388.3 7389.9 7421.9 6411.8 7205.2 7233.6 7250.2 7261.3 6831.7 7394.3 7421.6 7445.1 7450.9 7274.8 7274.9 7276.3 7288.5 7307.5 15:07:42 INFO - PROCESS | 1667 | 15:07:42 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18715.14 Median:608.74 stddev:26596.14 (4369.1%) stddev-sans-first:26636.30 15:07:42 INFO - PROCESS | 1667 | Values: 687.5 693.8 728.5 729.2 734.3 14385.7 15259.2 15346.1 15477.1 15504.3 14220.2 14251.9 14366.4 14374.7 14658.0 779.4 963.3 964.0 971.5 985.1 935.0 936.8 954.8 981.4 981.9 999.0 1010.9 1011.2 1011.9 1016.6 959.3 960.7 960.7 960.8 961.3 631.5 740.1 744.4 758.9 761.7 14773.6 14944.2 14957.3 15015.0 15115.7 12834.7 12963.4 12989.6 13017.6 13020.6 9461.5 9462.0 9471.0 9568.4 9590.8 3545.1 3590.2 3600.6 3644.7 3806.1 78030.2 82577.6 83147.8 84083.2 84120.6 9614.2 9697.3 9774.0 9858.7 10096.4 22161.3 22206.6 22215.9 22252.7 22296.1 7533.4 7539.6 7588.3 7631.0 7649.3 3756.4 3802.9 3864.3 3987.7 4312.6 3724.6 3728.5 3729.6 3769.9 3772.3 664.1 667.3 671.7 691.4 696.6 538.8 543.7 593.5 606.8 608.9 6370.8 6672.1 6843.3 8681.5 8718.7 539.6 545.7 570.0 597.3 608.6 3768.3 3894.2 4003.6 4006.4 4102.0 75745.9 94940.5 97720.5 98895.5 99460.0 78522.2 78688.4 81273.0 83156.2 83852.0 73141.0 73483.0 74125.0 74443.0 75388.0 7205.0 7294.3 8010.2 8064.6 8198.4 48788.0 50125.5 50733.2 51830.7 52149.7 67932.6 69587.7 72285.0 72935.0 74335.6 8914.9 10239.6 10280.7 10692.1 11164.3 9675.7 11962.3 12114.5 12124.8 12438.0 11050.7 11731.7 11755.5 11783.1 11992.5 10542.5 11294.0 11467.1 11621.8 11635.8 11404.8 11473.8 11481.9 11651.7 11685.4 9837.8 9980.5 10041.0 10109.1 10133.3 9744.6 9893.0 9965.0 9993.8 10079.4 15:07:42 INFO - PROCESS | 1667 | -------- Summary: end -------- 15:07:42 INFO - PROCESS | 1667 | 15:07:43 INFO - TEST-INFO | 1667: exit 0 15:07:43 INFO - TEST-OK | dromaeo_css | took 1110339ms 15:07:43 INFO - TEST-START | kraken 15:07:43 INFO - operating with platform_type : mac_ 15:07:43 INFO - Initialising browser for kraken test... 15:07:43 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpbGNbLR/profile http://localhost:49272/getInfo.html) 15:07:45 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 15:07:45 INFO - PROCESS | 1679 | colorDepth:24 15:07:45 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 15:07:45 INFO - PROCESS | 1679 | __metrics 15:07:45 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 15:07:46 INFO - TEST-INFO | 1679: exit 0 15:07:46 INFO - Browser initialized. 15:07:46 INFO - Running cycle 1/1 for kraken test... 15:07:46 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpbGNbLR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:07:58 INFO - PROCESS | 1683 | RSS: Main: 171347968 15:07:58 INFO - PROCESS | 1683 | 15:08:01 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 15:08:01 INFO - PROCESS | 1683 | RSS: Main: 183844864 15:08:01 INFO - PROCESS | 1683 | 15:08:04 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 15:08:05 INFO - PROCESS | 1683 | RSS: Main: 192446464 15:08:05 INFO - PROCESS | 1683 | 15:08:08 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 15:08:09 INFO - PROCESS | 1683 | RSS: Main: 193933312 15:08:09 INFO - PROCESS | 1683 | 15:08:11 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 15:08:11 INFO - PROCESS | 1683 | RSS: Main: 195784704 15:08:11 INFO - PROCESS | 1683 | 15:08:13 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:08:14 INFO - PROCESS | 1683 | RSS: Main: 197681152 15:08:14 INFO - PROCESS | 1683 | 15:08:17 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 15:08:17 INFO - PROCESS | 1683 | RSS: Main: 198246400 15:08:17 INFO - PROCESS | 1683 | 15:08:20 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 15:08:21 INFO - PROCESS | 1683 | RSS: Main: 198152192 15:08:21 INFO - PROCESS | 1683 | 15:08:24 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 15:08:25 INFO - PROCESS | 1683 | RSS: Main: 198561792 15:08:25 INFO - PROCESS | 1683 | 15:08:26 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:08:27 INFO - PROCESS | 1683 | RSS: Main: 197763072 15:08:27 INFO - PROCESS | 1683 | 15:08:29 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:08:29 INFO - PROCESS | 1683 | RSS: Main: 197939200 15:08:29 INFO - PROCESS | 1683 | 15:08:31 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:08:32 INFO - PROCESS | 1683 | RSS: Main: 198127616 15:08:32 INFO - PROCESS | 1683 | 15:08:35 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:08:36 INFO - PROCESS | 1683 | RSS: Main: 198307840 15:08:36 INFO - PROCESS | 1683 | 15:08:39 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:08:39 INFO - PROCESS | 1683 | RSS: Main: 198299648 15:08:39 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 15:08:41 INFO - PROCESS | 1683 | RSS: Main: 199979008 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | __start_tp_report 15:08:41 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 15:08:41 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 15:08:41 INFO - PROCESS | 1683 | |i|pagename|runs| 15:08:41 INFO - PROCESS | 1683 | |0;ai-astar;115;114;116;114;117;130;115;124;121;117 15:08:41 INFO - PROCESS | 1683 | |1;audio-beat-detection;153;124;144;160;122;139;120;163;200;117 15:08:41 INFO - PROCESS | 1683 | |2;audio-dft;232;187;240;268;184;181;235;246;257;257 15:08:41 INFO - PROCESS | 1683 | |3;audio-fft;71;106;71;140;47;60;63;52;140;47 15:08:41 INFO - PROCESS | 1683 | |4;audio-oscillator;81;81;121;76;78;83;122;80;79;123 15:08:41 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;87;88;94;86;89;86;88;85;88;86 15:08:41 INFO - PROCESS | 1683 | |6;imaging-darkroom;99;106;141;114;103;143;149;94;93;107 15:08:41 INFO - PROCESS | 1683 | |7;imaging-desaturate;151;147;98;92;92;91;99;143;89;94 15:08:41 INFO - PROCESS | 1683 | |8;json-parse-financial;59;63;65;65;64;66;65;78;62;60 15:08:41 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;63;66;70;66;72;72;71;64;65;68 15:08:41 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;83;82;103;71;72;99;102;110;111;76 15:08:41 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;128;131;148;149;131;131;128;128;193;142 15:08:41 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;162;163;170;178;193;216;169;165;167;166 15:08:41 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;68;66;70;69;65;69;66;78;85;68 15:08:41 INFO - PROCESS | 1683 | __end_tp_report 15:08:41 INFO - PROCESS | 1683 | __start_cc_report 15:08:41 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1046 15:08:41 INFO - PROCESS | 1683 | __end_cc_report 15:08:41 INFO - PROCESS | 1683 | __startTimestamp1467324521585__endTimestamp 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | ------- Summary: start ------- 15:08:41 INFO - PROCESS | 1683 | Number of tests: 14 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:118.30 Median:117.00 stddev:5.21 (4.5%) stddev-sans-first:5.39 15:08:41 INFO - PROCESS | 1683 | Values: 115.0 114.0 116.0 114.0 117.0 130.0 115.0 124.0 121.0 117.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:148.50 stddev:25.92 (17.5%) stddev-sans-first:27.30 15:08:41 INFO - PROCESS | 1683 | Values: 153.0 124.0 144.0 160.0 122.0 139.0 120.0 163.0 200.0 117.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:228.70 Median:243.00 stddev:32.72 (13.5%) stddev-sans-first:34.68 15:08:41 INFO - PROCESS | 1683 | Values: 232.0 187.0 240.0 268.0 184.0 181.0 235.0 246.0 257.0 257.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:79.70 Median:56.00 stddev:36.04 (64.4%) stddev-sans-first:38.09 15:08:41 INFO - PROCESS | 1683 | Values: 71.0 106.0 71.0 140.0 47.0 60.0 63.0 52.0 140.0 47.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:79.50 stddev:20.52 (25.8%) stddev-sans-first:21.34 15:08:41 INFO - PROCESS | 1683 | Values: 81.0 81.0 121.0 76.0 78.0 83.0 122.0 80.0 79.0 123.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.00 stddev:2.54 (2.9%) stddev-sans-first:2.68 15:08:41 INFO - PROCESS | 1683 | Values: 87.0 88.0 94.0 86.0 89.0 86.0 88.0 85.0 88.0 86.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:114.90 Median:146.00 stddev:21.31 (14.6%) stddev-sans-first:21.81 15:08:41 INFO - PROCESS | 1683 | Values: 99.0 106.0 141.0 114.0 103.0 143.0 149.0 94.0 93.0 107.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:109.60 Median:92.00 stddev:26.05 (28.3%) stddev-sans-first:22.92 15:08:41 INFO - PROCESS | 1683 | Values: 151.0 147.0 98.0 92.0 92.0 91.0 99.0 143.0 89.0 94.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:5.21 (8.0%) stddev-sans-first:5.10 15:08:41 INFO - PROCESS | 1683 | Values: 59.0 63.0 65.0 65.0 64.0 66.0 65.0 78.0 62.0 60.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:69.00 stddev:3.37 (4.9%) stddev-sans-first:3.11 15:08:41 INFO - PROCESS | 1683 | Values: 63.0 66.0 70.0 66.0 72.0 72.0 71.0 64.0 65.0 68.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:74.00 stddev:15.71 (21.2%) stddev-sans-first:16.40 15:08:41 INFO - PROCESS | 1683 | Values: 83.0 82.0 103.0 71.0 72.0 99.0 102.0 110.0 111.0 76.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:136.50 stddev:20.07 (14.7%) stddev-sans-first:20.74 15:08:41 INFO - PROCESS | 1683 | Values: 128.0 131.0 148.0 149.0 131.0 131.0 128.0 128.0 193.0 142.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:169.50 stddev:17.10 (10.1%) stddev-sans-first:17.49 15:08:41 INFO - PROCESS | 1683 | Values: 162.0 163.0 170.0 178.0 193.0 216.0 169.0 165.0 167.0 166.0 15:08:41 INFO - PROCESS | 1683 | 15:08:41 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:69.00 stddev:6.28 (9.1%) stddev-sans-first:6.60 15:08:41 INFO - PROCESS | 1683 | Values: 68.0 66.0 70.0 69.0 65.0 69.0 66.0 78.0 85.0 68.0 15:08:41 INFO - PROCESS | 1683 | -------- Summary: end -------- 15:08:41 INFO - PROCESS | 1683 | 15:08:42 INFO - TEST-INFO | 1683: exit 0 15:08:42 INFO - TEST-OK | kraken | took 59030ms 15:08:42 INFO - SUITE-END | took 1169s 15:08:42 INFO - Completed test suite (00:19:29) 15:08:42 INFO - javascript benchmark 15:08:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3542.911427214321, 3615.1323682316242, 3701.4632878232674, 3743.419769935661, 3745.6441638044375, 4910.558049775519, 5914.142449344848, 5988.221531200943, 6001.5798894077325, 6039.09413587962, 5999.340072592011, 6006.219191505098, 6015.398460153982, 6047.455728984391, 6056.606320589159, 5308.575313974882, 5367.221752845835, 5438.7280635968245, 5467.890642187154, 5556.111022236443, 5257.631965762398, 5348.973255133738, 5352.57179425645, 5363.141897296433, 5366.329208848894, 5401.891962160755, 5407.432219616942, 5414.07960646689, 5418.972905135489, 5421.972890135544, 5337.2794672719265, 5368.865778355534, 5398.8920221595745, 5419.3225846768955, 5487.64330318528, 5316.601254905898, 5368.248445217672, 5389.83830485086, 5409.2967914171295, 5411.783528658849, 4718.858434246944, 5692.943070569283, 5799.956007918573, 5914.615549989237, 5944.64332140073, 4884.4871288514905, 5728.799492017801, 6224.097505861625, 6300.653464059475, 6316.778912738032, 5266.657667251617, 6349.968250158766, 6355.586886852339, 6376.744930202786, 6399.456046236076, 5917.349091599921, 6027.578069535178, 6056.909146362808, 6073.514118870524, 6102.847428814315, 6489.286178520359, 6542.771003014872, 6554.0, 6558.278589355167, 6593.901091483632, 6297.4962003039645, 6310.337414571496, 6310.747570097236, 6317.684115794192, 6334.113224148623, 6232.781852635136, 6331.2085989251345, 6389.520785941073, 6396.392342727433, 6399.64801935898, 6286.811395658137, 6295.527835412362, 6309.589876658094, 6311.652859092794, 6316.652584107826, 5165.845024649267, 6241.625502469776, 6324.841878953063, 6327.683615819191, 6330.39861213184, 4985.227289770091, 5015.3229314042865, 5060.063888180698, 5091.389033316026, 5130.563902068291, 4537.636989040869, 4568.588827005586, 4585.151746926829, 4599.931001034987, 4634.443866735945, 6098.54260930432, 6118.877622447526, 6150.323464418911, 6154.9384506154365, 6194.194754681863, 6211.3167551569295, 6283.874322513524, 6328.019157030668, 6358.33237510064, 6393.584417012972, 6155.784547540815, 6159.5072394208355, 6161.44546990773, 6169.475594574422, 6189.938100619026, 5499.532539734088, 5606.635568688022, 5630.127330263816, 5638.774449022075, 5677.261955945701, 6494.415502604694, 6498.155239818888, 6526.771562995273, 6621.933780662228, 6657.966710166418, 6384.489240860813, 6416.037594360883, 6416.45460135875, 6423.807285781434, 6435.613863168225, 6490.513211509061, 6593.571417858016, 6658.167729033871, 6659.0, 6688.966555167193, 6273.0, 6335.429811317003, 6340.239171299474, 6346.2067241594805, 6349.68251587428, 6335.429811317003, 6366.77716279928, 6382.5532212744665, 6408.423241908251, 6413.16628838248, 5109.616778741535, 5351.170568561879, 6117.510599151969, 6251.968425209971, 6269.090981807703, 6126.517673797367, 6264.843378915563, 6273.52948528853, 6286.74853005893, 6287.874242515216, 6106.961816491118, 6164.229471316085, 6169.50643948474, 6254.249490061222, 6266.154069200782, 5830.737616807169, 6158.353372895782, 6169.907451388143, 6201.255849298113, 6276.560640755286, 6173.475254603409, 6174.289956655042, 6205.689715514297, 6244.46922011616, 6260.280067792262], "value": 5856.992071051022, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.6994858008065, 529.1401472607014, 570.8430181700035, 583.0059748129438, 603.957722959393, 35230.0, 39306.60693393065, 39341.0, 39416.408753868716, 39418.81743547694, 41047.38428923561, 41763.58236417635, 41772.16455670892, 41786.58213417865, 41869.743907682816, 9612.951935240313, 9822.852657210147, 9844.507774611277, 9857.507124643775, 9879.802403951917, 9654.13112819846, 9862.45756483393, 9878.654247101353, 9917.603295868157, 9939.453330066843, 9882.505874706272, 9884.901150988506, 9897.851532226987, 9913.851292230585, 9924.106830385264, 9771.413715177112, 9839.655612053544, 9844.655437059704, 9870.45712485813, 9884.752881177956, 9786.1192492676, 9817.312788104835, 9915.65295214664, 9932.404055756677, 9949.253805964509, 32855.83572082148, 40081.19837603231, 40168.0, 40415.797921010504, 40592.39111413331, 3206.4709322961685, 3351.8994430167136, 3376.8480418380987, 3387.728981681484, 3907.7459965102175, 20103.894285814273, 28452.719627616807, 28746.856265718747, 28912.42175156506, 30022.099337019707, 2755.9448811023867, 2807.101727447218, 2842.033708539086, 2881.683014868363, 2907.0552070577146, 322171.0, 322834.0, 324400.0, 324695.0, 325231.0, 37373.813130934715, 59934.70032649809, 61301.08048379278, 61465.0, 61481.692591536754, 36611.4508282376, 36780.0, 36814.631853681654, 36861.447078293844, 36867.446988295196, 16441.588960276087, 16441.588960276087, 16556.83443165577, 16613.41853035138, 16625.83374166267, 13641.86358136406, 13948.651283717989, 14031.158130512202, 14140.858591413955, 14166.362513686909, 8300.958495207486, 8304.584770761438, 8349.499030058216, 8356.080831108573, 8526.190011948855, 3007.684193159687, 3441.4321636929626, 3444.156181735491, 3463.7748546344405, 3488.2151515908718, 1065.984010239847, 1097.2648325621853, 1098.774751176007, 1121.495327102807, 1152.5274637398793, 30155.698443015728, 30737.538936915964, 30798.92203772902, 31179.53230701541, 31317.53023704601, 911.7310393433953, 1039.9584016639249, 1132.932024078558, 1154.722866512031, 1201.6575276046285, 11942.0, 15858.841411585967, 15861.920690396475, 15896.682066358839, 16073.437429690139, 507703.0, 509422.0, 511714.0, 512289.0, 517473.65052698733, 51804.48195517997, 61594.76810463765, 61863.6906815472, 62392.68803655953, 62421.37578624247, 1519.270750039987, 1562.898411603242, 1571.449992502615, 1581.7785510028605, 1640.0651628571839, 30268.84865575658, 30574.0, 30704.846475767477, 30750.231244219074, 31023.224419389695, 50560.74719626379, 53445.19832202598, 53502.0, 53766.0, 53895.73052134714, 551306.0, 561107.0, 562511.0, 565808.0, 568274.0, 26190.86904565465, 27438.17685469439, 27487.17538473849, 27540.0, 27813.721862781924, 39064.0, 46388.840278993295, 46796.532034679214, 48151.277730834765, 48770.78073048202, 32700.69197232179, 38701.80649096736, 39148.217035658556, 39201.6079839198, 39307.410388843615, 35917.28165436624, 36607.81696091503, 36932.44601330929, 37141.81429092837, 37327.626723732414, 35730.28539429249, 36307.45538816973, 36490.45264320984, 36522.45216321704, 37039.44440833336, 32848.0, 33257.83371083129, 33630.0, 33745.49381759325, 34096.97709068732, 25120.62319065179, 25272.36819079464, 25398.492030158923, 25715.0, 25815.612765808153], "value": 18606.692297807364, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.6960292560101, 414.9917001659967, 415.1158033388881, 418.6713429957484, 425.2218440254335, 15378.615534611612, 15659.765103523441, 17013.404530841424, 20037.19851205952, 20806.0, 17297.962122272642, 17602.471925842212, 20782.89608551955, 20791.584168316625, 21179.0, 5341.919871201925, 6007.128966299884, 6118.69406529674, 6118.755249790003, 6119.969400152993, 5599.440055994409, 5855.092460668582, 5888.64668119912, 5894.204282421861, 5904.586678932455, 5819.50534204591, 5878.294604647448, 5889.352171261158, 5961.910571341434, 6079.939200608003, 6002.849928751794, 6053.213082299317, 6060.939390606081, 6086.634801911855, 6104.816855494342, 5824.679642619654, 5854.092615644539, 5864.0031194697, 5924.644521328734, 5943.554233432466, 13558.186508809504, 13658.521951731742, 13823.585292441243, 13889.79165312521, 13926.442942282296, 2253.6056190166655, 2314.9652755208685, 2640.775534079586, 2791.162651204651, 2798.8740506677045, 8293.543855087968, 9705.90294097057, 10288.69133925976, 10341.844872326921, 10651.786964260671, 1700.5493544210794, 1735.8871673341193, 1750.2386461889118, 1813.9116530081844, 1816.6639171753268, 98928.51607225898, 105063.47468262687, 105972.41041384386, 112993.0, 115681.26478102751, 10653.414062226651, 10875.91240875906, 12049.277043377426, 12141.878581214252, 12168.695782605506, 15164.317605707769, 15354.923225384025, 15467.226638668022, 15533.378664853279, 15613.219339033003, 7641.006669132978, 8095.5142691438705, 9206.63173473067, 9308.0, 9387.812243755086, 9057.275417966546, 9617.56720947559, 9630.711078667651, 9634.71095867125, 9659.71020869375, 4764.6426518011285, 4816.783244753994, 4823.9517604824205, 4827.372441582572, 4847.297141914402, 2016.8184863362367, 2049.4671385439597, 2057.567910738732, 2062.113291284762, 2070.637638413272, 896.287451476065, 1022.4172221833633, 1036.3678156324636, 1095.1512577752146, 1110.6834552152598, 16790.328386864632, 20068.39794806158, 20875.060622272034, 21033.89483052575, 21519.924003799748, 882.2280504558511, 991.2317953585884, 995.8107959487675, 1002.1682003936716, 1040.1314902056715, 11178.664640060812, 11553.480093395818, 11558.711032224093, 11558.826617600742, 11603.477843497063, 578303.0, 580266.0, 586875.0, 594996.0, 622886.0, 108633.91366086397, 123601.14598281033, 126801.0, 132139.01791473135, 135066.0, 941.4257303045136, 1010.0858722855827, 1062.8299472084584, 1068.086785798147, 1070.6573896353248, 19040.52398690044, 19529.21883124659, 19660.90169549143, 19706.704399434308, 20005.899970500053, 48703.5129648699, 52480.68798280074, 52605.473945260055, 54484.72757636187, 56099.71950140223, 60544.6972765151, 78122.4375512498, 79441.20558794338, 79814.0, 80009.0, 8241.299489543217, 8374.95812520958, 8435.156484351515, 8467.78830529217, 8776.078511756428, 11352.943235284101, 13197.934010329887, 13240.80138797938, 13293.933530332286, 13605.79591306151, 10993.395363255098, 11177.105831533621, 11205.039118154127, 11521.193516453768, 11725.296482211095, 10939.179561532757, 11103.888961110286, 11199.272047316897, 11235.71910702239, 11445.027172690414, 11265.887341126483, 11345.546178152781, 11579.015783658484, 11760.705982350168, 11891.524339026342, 8339.082700903016, 8516.74449766508, 8556.229939305493, 8624.008239052338, 8754.47473151613, 10509.789804204025, 10733.516991735547, 11684.649460516199, 11696.824547631622, 11784.175107742376], "value": 9587.076082047632, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.724031054255, 1582.6280824006355, 1596.8962017468866, 1941.5340318323597, 1989.7114918336833, 7962.363010959124, 8694.087120852315, 8851.159139881709, 8987.281017518599, 9047.09529047095, 8765.430247033939, 8807.295416366691, 8879.60041798119, 8885.200331970122, 8957.507337096456, 2519.874006299682, 2535.5055764126005, 2538.0736031348515, 2552.680914885639, 2559.2706078767555, 2474.505098980202, 2484.291976786616, 2488.8133389995733, 2490.203134996802, 2501.2371226775826, 2100.2649072824543, 2491.676082109323, 2509.498100379922, 2541.898324067035, 2545.6690630218045, 2475.591527397977, 2507.2352932355625, 2516.534441128388, 2544.5547029269806, 2556.744325567447, 1855.35990083421, 2515.9496810063697, 2522.810789190818, 2524.0408644715076, 2560.782333501636, 9001.594928228245, 9026.142516460926, 9029.819403611957, 9047.276217902618, 9072.909270907272, 5536.280283563151, 5705.087186050254, 5734.197212390269, 5760.855978600526, 5792.131180322943, 3632.2553876455263, 3730.459083432914, 3757.304898593769, 3766.886993390203, 3769.1142581493327, 1047.9280283428243, 1071.212658695858, 1073.88187299397, 1074.8656417947757, 1076.9138468922467, 11964.40177991097, 11984.400779961054, 12174.0, 12270.202436841577, 12323.815142772866, 4945.703257804544, 4971.304017437562, 5039.44566097729, 5049.873753156127, 5101.897962040738, 10346.0, 10369.792604147875, 10374.17006639467, 10404.739881502872, 10429.895701042893, 5167.741612919339, 5633.464820842096, 5739.110437882135, 5742.0, 5752.913706294409, 4500.257457519538, 4970.030843985388, 5066.189409694432, 5084.694918304914, 5193.402758682724, 4213.094184750294, 4216.51510076339, 4249.192653395845, 4250.171216612793, 4271.295236285978, 1388.340538244326, 1421.9360128794021, 1422.7439060969125, 1426.7431862264891, 1439.3450979804163, 828.0, 889.355217467331, 948.4309414351472, 970.3595626886221, 986.0, 6025.698715064229, 6027.578069535178, 6030.065339872327, 6067.969660151671, 6249.562530622813, 469.10635239868105, 478.22050058405273, 484.6171524495679, 485.3035893492849, 490.78896074687515, 3345.983270083634, 4049.979750101231, 4058.1680755445063, 4069.8168582413864, 4108.342665173558, 10464.424456654957, 10661.466926653637, 10842.783144337069, 10870.836937445945, 10895.836562451412, 9694.46680432583, 10579.629712960163, 10596.841047384296, 10771.676849694522, 10801.297915635458, 7022.789316320519, 7040.788776336718, 7574.5833979130575, 7726.188750181263, 7965.084015338194, 4849.878753031202, 5971.820845374646, 6119.44924956756, 6142.0, 6158.753649853956, 9237.353385263235, 9312.813743724952, 9389.014153513783, 9624.181944534794, 9720.27097967641, 9219.078092190728, 9777.315587908779, 9931.65239216624, 9936.503174841084, 10044.397336159855, 7019.543729657556, 7249.746258880914, 7475.887861682188, 7668.539887606761, 7770.961145194464, 7623.542587444771, 8212.63043163071, 8258.339332853477, 8265.545395003333, 8265.95867020661, 6058.394160583906, 6717.361850624183, 7369.77890663281, 7492.70029198826, 7494.063242094739, 7247.927520724726, 7263.382612477787, 7301.52540084914, 7336.889946650911, 7361.374283185989, 6911.343422374866, 7062.894056589258, 7121.9643901780155, 7127.287271272831, 7149.249328820607, 4931.852044438672, 4997.0, 5007.899842003067, 5095.006473737586, 5110.795568177231, 4986.152354099884, 5002.399712034579, 5006.449290577961, 5104.132297509358, 5206.817761378334], "value": 4601.254843206429, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.0702318198742, 336.5137376490971, 337.6792047554822, 344.7948470659957, 346.8283199816091, 6801.901585484231, 6836.213835408929, 6844.178698556168, 6886.104806375164, 6908.62002589858, 6736.7978960631135, 6769.661516924159, 6775.491838112149, 6826.863462730755, 6841.076454678617, 5007.874803129915, 5026.522480364378, 5028.296038554606, 5032.471590483002, 5044.243363495469, 4752.881177970561, 4853.805847766085, 4971.254311853233, 4973.477784832595, 4976.900461990758, 4882.316475693406, 4883.9511604883855, 4887.218045112782, 4909.091818013679, 4930.728809915453, 4901.142300097486, 4905.215165573509, 4907.582855457291, 4907.656464047518, 4926.187179115442, 3644.2893635741043, 4065.390191471303, 4231.640310573605, 4233.23801715691, 4271.273883439822, 6496.675166241716, 6508.056331831858, 6508.772192973223, 6521.93478065218, 6528.706208220641, 5100.209467532539, 5728.369879313273, 5880.6765627890445, 5901.29184497863, 5929.822105336803, 7261.963690181516, 7281.342310056844, 7319.670614822346, 7326.340629343332, 7344.375728063121, 4837.250226214942, 4837.395325584302, 4839.9032019359765, 4840.903181936377, 4854.563089321942, 7796.532208067534, 7805.126769575318, 7808.414368922354, 7812.179721129256, 7822.139564647884, 4744.430668319824, 4906.681065730716, 4908.288298196741, 4927.162382395001, 4928.901421971541, 5014.272930425068, 5018.874528136826, 5025.899482010339, 5044.672096313728, 5045.646804723708, 5076.695398276115, 5896.204012458349, 5966.671833049224, 5969.582129250997, 5980.43185897339, 5894.351621321651, 7033.683484243222, 7035.261297563785, 7429.888551671729, 7448.175197076643, 1728.775259216319, 1747.3010795681828, 1749.5713550180287, 1750.903700296496, 1757.1477833250863, 1084.5932775209296, 1122.7698321844002, 1128.2779021426293, 1128.8711288711288, 1146.8394424780538, 7012.298770123049, 7075.92924070763, 7081.433485321162, 7084.0082388464625, 7106.289371062956, 7650.808729781688, 7651.69393224276, 7665.501742386727, 7666.8083297918, 7667.769966901002, 6176.969115154396, 6945.965270173718, 7032.753853615099, 7039.718411263594, 7040.331168538981, 3494.633063528344, 3731.6193008586997, 4040.7575545467366, 4082.6733861291027, 4083.3262511685834, 8057.838843223103, 8129.715459958873, 8167.42828002046, 8175.427720059539, 8187.795305117301, 8003.799905002422, 8004.639791209293, 8013.959930200312, 8015.519068855887, 8049.356051515864, 7821.687132514636, 8135.349172066339, 8141.877871831927, 8151.470154439942, 8203.671853125808, 6413.422791948747, 6585.5719378240265, 7574.522968021183, 7688.730894418669, 7749.225077492206, 6106.480949119375, 7611.2769286917655, 7656.425768067305, 7656.617169141632, 7672.424568157299, 8149.551774652451, 8159.428839981382, 8162.306203972729, 8167.469114507538, 8168.83662326762, 4605.102005108972, 4766.856994290177, 4788.090262850047, 4794.208955522439, 4794.472608013186, 6165.753369865155, 7405.074365704287, 7669.654865531176, 7675.731349402744, 7680.5391676499585, 6289.96855015722, 7413.110426748609, 7417.369523590555, 7434.405247580289, 7458.813529661802, 5914.58597898143, 7168.247334029852, 7388.335049845539, 7389.889151662837, 7421.851562968603, 6411.807645770635, 7205.171405288459, 7233.63831808418, 7250.20247772734, 7261.273872612696, 6831.69257383409, 7394.2975417335265, 7421.554706717614, 7445.10658720957, 7450.8823676448965, 7274.781756547312, 7274.854502910018, 7276.272372762893, 7288.526245794006, 7307.488475806643], "value": 5351.398580717202, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.4843867099678, 693.8404167041581, 728.4536597551836, 729.18331468755, 734.2804052029012, 14385.712285754278, 15259.237038148103, 15346.079235245894, 15477.07137571745, 15504.302306396212, 14220.217888016155, 14251.857481425182, 14366.353514091865, 14374.70627643512, 14658.0, 779.3959681247022, 963.2727290895382, 963.9662611808589, 971.4656938683696, 985.1281615770059, 935.046252822121, 936.840737074699, 954.7708549948032, 981.3817295104075, 981.9165370943442, 999.0, 1010.9241806864478, 1011.2011510906375, 1011.8886922438526, 1016.5781200801658, 959.2709540749012, 960.7021823234819, 960.7357976556433, 960.7982323711959, 961.3462845265217, 631.4979591224987, 740.1229542991518, 744.4491076603275, 758.8520238553484, 761.6686741267511, 14773.556793296219, 14944.178070206135, 14957.252137393087, 15015.0, 15115.697686046218, 12834.67913302175, 12963.351832408436, 12989.636088210791, 13017.609471715863, 13020.609381718468, 9461.52692365379, 9461.952690236574, 9471.0, 9568.378055426376, 9590.808183836354, 3545.0960005198767, 3590.174259920207, 3600.6219346968455, 3644.671979521856, 3806.1436176859984, 78030.21969780287, 82577.58711206466, 83147.75278370829, 84083.15916840815, 84120.57939710324, 9614.18279446255, 9697.272704547046, 9774.022597740312, 9858.704238872846, 10096.394216347042, 22161.33515994523, 22206.555868882533, 22215.88892055562, 22252.666210006864, 22296.10815567359, 7533.359664428475, 7539.585322807188, 7588.27911348421, 7630.961845190738, 7649.31156195945, 3756.398976163801, 3802.904927376838, 3864.304425203434, 3987.7009224308295, 4312.633426158749, 3724.646158614927, 3728.5339332583426, 3729.589745128034, 3769.8869033928477, 3772.264408440383, 664.1034603285526, 667.2893368562466, 671.7145213284334, 691.3915754136428, 696.585531608692, 538.8329617818489, 543.7195404821667, 593.5459373579129, 606.760329669778, 608.856918624123, 6370.777022804273, 6672.1285268963, 6843.3498817613245, 8681.522516261666, 8718.65125394977, 539.5737367479726, 545.7107732901569, 570.0423288874647, 597.3071237364636, 608.613530408194, 3768.2840260350445, 3894.162755007687, 4003.559608443069, 4006.3990401439432, 4101.97949010259, 75745.86381204287, 94940.52529737307, 97720.51139744256, 98895.50552247193, 99460.0, 78522.21477785263, 78688.42623147505, 81273.0, 83156.16843831605, 83852.0, 73141.0, 73483.0, 74125.0, 74443.0, 75388.0, 7204.9639751800905, 7294.270572942663, 8010.158933312151, 8064.5967701615855, 8198.442295963749, 48788.0, 50125.496235113, 50733.22433714802, 51830.74084629553, 52149.696257592346, 67932.6413471718, 69587.65206173937, 72285.0, 72935.0, 74335.62832185805, 8914.86627700598, 10239.641612543524, 10280.742981425525, 10692.091172250135, 11164.330140191614, 9675.661351852652, 11962.282263064244, 12114.454849531616, 12124.75750485003, 12438.00495960303, 11050.723731906766, 11731.706707332385, 11755.471003804678, 11783.057355411374, 11992.460339284928, 10542.472876356305, 11294.04000659953, 11467.139964502863, 11621.76756464883, 11635.767284654428, 11404.828927565926, 11473.770524589294, 11481.942590286995, 11651.708707282385, 11685.357305348287, 9837.754056148653, 9980.500974951368, 10041.04610062043, 10109.090181883666, 10133.290669653054, 9744.610215591298, 9892.98002926419, 9964.950175249367, 9993.781867926875, 10079.445630490394], "value": 6991.585388921868, "unit": "score"}], "name": "dromaeo_css", "value": 7513.295607535141, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 116.0, 114.0, 117.0, 130.0, 115.0, 124.0, 121.0, 117.0], "value": 118.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 144.0, 160.0, 122.0, 139.0, 120.0, 163.0, 200.0, 117.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [232.0, 187.0, 240.0, 268.0, 184.0, 181.0, 235.0, 246.0, 257.0, 257.0], "value": 228.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 106.0, 71.0, 140.0, 47.0, 60.0, 63.0, 52.0, 140.0, 47.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 121.0, 76.0, 78.0, 83.0, 122.0, 80.0, 79.0, 123.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 94.0, 86.0, 89.0, 86.0, 88.0, 85.0, 88.0, 86.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 106.0, 141.0, 114.0, 103.0, 143.0, 149.0, 94.0, 93.0, 107.0], "value": 114.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 147.0, 98.0, 92.0, 92.0, 91.0, 99.0, 143.0, 89.0, 94.0], "value": 109.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 65.0, 65.0, 64.0, 66.0, 65.0, 78.0, 62.0, 60.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 70.0, 66.0, 72.0, 72.0, 71.0, 64.0, 65.0, 68.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 103.0, 71.0, 72.0, 99.0, 102.0, 110.0, 111.0, 76.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 131.0, 148.0, 149.0, 131.0, 131.0, 128.0, 128.0, 193.0, 142.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 170.0, 178.0, 193.0, 216.0, 169.0, 165.0, 167.0, 166.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 70.0, 69.0, 65.0, 69.0, 66.0, 78.0, 85.0, 68.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1585.0000000000005, "alertThreshold": 2.0}]} 15:08:42 INFO - Return code: 0 15:08:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:08:42 ERROR - # TBPL SUCCESS # 15:08:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:08:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:08:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:08:42 INFO - 2016-06-30 15:08:42.904 screenresolution[1688:10284] starting screenresolution argv=screenresolution get 15:08:42 INFO - 2016-06-30 15:08:42.907 screenresolution[1688:10284] Display 0: 1600x1200x32@60 15:08:42 INFO - 2016-06-30 15:08:42.912 screenresolution[1689:10287] starting screenresolution argv=screenresolution list 15:08:42 INFO - Available Modes on Display 0 15:08:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:08:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:08:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:08:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:08:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:08:43 INFO - Intel Iris: 15:08:43 INFO - Chipset Model: Intel Iris 15:08:43 INFO - Type: GPU 15:08:43 INFO - Bus: Built-In 15:08:43 INFO - VRAM (Dynamic, Max): 1536 MB 15:08:43 INFO - Vendor: Intel (0x8086) 15:08:43 INFO - Device ID: 0x0a2e 15:08:43 INFO - Revision ID: 0x0009 15:08:43 INFO - Displays: 15:08:43 INFO - Display: 15:08:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:08:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:08:43 INFO - Display Serial Number: 1600x1200 60 15:08:43 INFO - Main Display: Yes 15:08:43 INFO - Mirror: Off 15:08:43 INFO - Online: Yes 15:08:43 INFO - Rotation: Supported 15:08:43 INFO - Return code: 0 15:08:43 INFO - Running post-action listener: _resource_record_post_action 15:08:43 INFO - Running post-run listener: _resource_record_post_run 15:08:44 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 38114816; Write bytes: 496302592; Read time: 468; Write time: 1840 15:08:44 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194808320; Write bytes: 196589056; Read time: 17582; Write time: 423 15:08:44 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 36333056; Write bytes: 298705920; Read time: 443; Write time: 1409 15:08:44 INFO - Running post-run listener: _upload_blobber_files 15:08:44 INFO - Blob upload gear active. 15:08:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:08:44 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 15:08:44 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'] 15:08:44 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 15:08:44 INFO - (blobuploader) - INFO - Open directory for files ... 15:08:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:08:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:08:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:45 INFO - (blobuploader) - INFO - Done attempting. 15:08:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:08:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:08:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:46 INFO - (blobuploader) - INFO - Done attempting. 15:08:46 INFO - (blobuploader) - INFO - Iteration through files over. 15:08:46 INFO - Return code: 0 15:08:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:08:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:08:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95174314c50d8d8a7095d8109b32856c26a663b154be965ce4d07b7bcd888689b76f464d032cfbb5414987815e203499a855b8218433827a63f60e7215d5e25c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df3ebe392794af59af268db21f5f7d9842032d0775f7018d4aecfe4415a92ca6b78b065dc416ad4bedc4902f45faf0b02fff07a862c0f11326837618f6893272"} 15:08:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:08:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:08:46 INFO - Contents: 15:08:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95174314c50d8d8a7095d8109b32856c26a663b154be965ce4d07b7bcd888689b76f464d032cfbb5414987815e203499a855b8218433827a63f60e7215d5e25c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df3ebe392794af59af268db21f5f7d9842032d0775f7018d4aecfe4415a92ca6b78b065dc416ad4bedc4902f45faf0b02fff07a862c0f11326837618f6893272"} 15:08:46 INFO - Running post-run listener: copy_logs_to_upload_dir 15:08:46 INFO - Copying logs to upload dir... 15:08:46 INFO - mkdir: /builds/slave/test/build/upload/logs 15:08:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.079358 ========= master_lag: 1.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-30 15:08:47.859191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 15:08:47.866501) ========= 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.27e91DaMC3/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.bRP1Ne6yfT/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95174314c50d8d8a7095d8109b32856c26a663b154be965ce4d07b7bcd888689b76f464d032cfbb5414987815e203499a855b8218433827a63f60e7215d5e25c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df3ebe392794af59af268db21f5f7d9842032d0775f7018d4aecfe4415a92ca6b78b065dc416ad4bedc4902f45faf0b02fff07a862c0f11326837618f6893272"} build_url:https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010256 build_url: 'https://queue.taskcluster.net/v1/task/EfhWK4UQT_2OPjyItseFPA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95174314c50d8d8a7095d8109b32856c26a663b154be965ce4d07b7bcd888689b76f464d032cfbb5414987815e203499a855b8218433827a63f60e7215d5e25c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df3ebe392794af59af268db21f5f7d9842032d0775f7018d4aecfe4415a92ca6b78b065dc416ad4bedc4902f45faf0b02fff07a862c0f11326837618f6893272"}' ========= master_lag: 0.70 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 15:08:48.581001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:08:48.581333) ========= 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.27e91DaMC3/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.bRP1Ne6yfT/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.004612 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:08:48.610769) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 15:08:48.611054) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 15:08:48.611338) ========= ========= Total master_lag: 1.85 =========