builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0346 starttime: 1464300902.05 results: success (0) buildid: 20160526140250 builduid: 01574422c30242cc92a6c0b32dab29da revision: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 15:15:02.047122) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 15:15:02.047548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 15:15:02.047825) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 15:15:02.070182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 15:15:02.070558) ========= 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.lTBwERZvZd/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.b0FNSDEFrA/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-26 15:15:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 68.5M=0s 2016-05-26 15:15:02 (68.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139841 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 15:15:02.230441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-05-26 15:15:02.230750) ========= 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.lTBwERZvZd/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.b0FNSDEFrA/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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.026016 ========= master_lag: 2.38 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-05-26 15:15:04.638559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 15:15:04.638925) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2ee4473c729acb2ba7dc723e7affe79ce14bff85 --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 2ee4473c729acb2ba7dc723e7affe79ce14bff85 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lTBwERZvZd/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.b0FNSDEFrA/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-26 15:15:04,721 truncating revision to first 12 chars 2016-05-26 15:15:04,721 Setting DEBUG logging. 2016-05-26 15:15:04,721 attempt 1/10 2016-05-26 15:15:04,721 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2ee4473c729a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 15:15:05,805 unpacking tar archive at: mozilla-beta-2ee4473c729a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.355211 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 15:15:06.014848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 15:15:06.015182) ========= script_repo_revision: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 15:15:06.015561) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 15:15:06.015822) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 15:15:06.031782) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-26 15:15:06.032078) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lTBwERZvZd/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.b0FNSDEFrA/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 15:15:06 INFO - MultiFileLogger online at 20160526 15:15:06 in /builds/slave/test 15:15:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:15:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:15:06 INFO - {'append_to_log': False, 15:15:06 INFO - 'base_work_dir': '/builds/slave/test', 15:15:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:15:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:15:06 INFO - 'branch': 'Mozilla-Beta', 15:15:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:15:06 INFO - 'config_files': ('talos/mac_config.py',), 15:15:06 INFO - 'default_actions': ('clobber', 15:15:06 INFO - 'read-buildbot-config', 15:15:06 INFO - 'download-and-extract', 15:15:06 INFO - 'populate-webroot', 15:15:06 INFO - 'create-virtualenv', 15:15:06 INFO - 'install', 15:15:06 INFO - 'run-tests'), 15:15:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:15:06 INFO - 'download_minidump_stackwalk': True, 15:15:06 INFO - 'download_symbols': 'ondemand', 15:15:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:15:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:15:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:15:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:15:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:15:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:15:06 INFO - 'installer_path': 'installer.exe', 15:15:06 INFO - 'log_level': 'info', 15:15:06 INFO - 'log_name': 'talos', 15:15:06 INFO - 'log_to_console': True, 15:15:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:15:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:15:06 INFO - 'opt_config_files': (), 15:15:06 INFO - 'pip_index': False, 15:15:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:15:06 INFO - 'cmd': ('bash', 15:15:06 INFO - '-c', 15:15:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:15:06 INFO - 'enabled': True, 15:15:06 INFO - 'halt_on_failure': False, 15:15:06 INFO - 'name': 'check_screen_resolution'},), 15:15:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:15:06 INFO - 'cmd': ('bash', 15:15:06 INFO - '-c', 15:15:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:15:06 INFO - 'enabled': True, 15:15:06 INFO - 'halt_on_failure': False, 15:15:06 INFO - 'name': 'check_screen_resolution'},), 15:15:06 INFO - 'run_cmd_checks_enabled': True, 15:15:06 INFO - 'sps_profile': False, 15:15:06 INFO - 'sps_profile_interval': 0, 15:15:06 INFO - 'suite': 'dromaeojs', 15:15:06 INFO - 'system_bits': '32', 15:15:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:15:06 INFO - 'title': 't-yosemite-r7-0346', 15:15:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:15:06 INFO - 'use_talos_json': True, 15:15:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:15:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:15:06 INFO - 'work_dir': 'build'} 15:15:06 INFO - ##### 15:15:06 INFO - ##### Running clobber step. 15:15:06 INFO - ##### 15:15:06 INFO - Running pre-action listener: _resource_record_pre_action 15:15:06 INFO - Running main action method: clobber 15:15:06 INFO - rmtree: /builds/slave/test/build 15:15:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:15:08 INFO - Running post-action listener: _resource_record_post_action 15:15:08 INFO - ##### 15:15:08 INFO - ##### Running read-buildbot-config step. 15:15:08 INFO - ##### 15:15:08 INFO - Running pre-action listener: _resource_record_pre_action 15:15:08 INFO - Running main action method: read_buildbot_config 15:15:08 INFO - Using buildbot properties: 15:15:08 INFO - { 15:15:08 INFO - "project": "", 15:15:08 INFO - "product": "firefox", 15:15:08 INFO - "script_repo_revision": "production", 15:15:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:15:08 INFO - "repository": "", 15:15:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:15:08 INFO - "buildid": "20160526140250", 15:15:08 INFO - "pgo_build": "False", 15:15:08 INFO - "basedir": "/builds/slave/test", 15:15:08 INFO - "buildnumber": 14, 15:15:08 INFO - "slavename": "t-yosemite-r7-0346", 15:15:08 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:15:08 INFO - "platform": "yosemite_r7", 15:15:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:15:08 INFO - "branch": "mozilla-beta", 15:15:08 INFO - "repo_path": "releases/mozilla-beta", 15:15:08 INFO - "revision": "2ee4473c729acb2ba7dc723e7affe79ce14bff85", 15:15:08 INFO - "stage_platform": "macosx64", 15:15:08 INFO - "builduid": "01574422c30242cc92a6c0b32dab29da", 15:15:08 INFO - "slavebuilddir": "test" 15:15:08 INFO - } 15:15:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 15:15:08 INFO - Running post-action listener: _resource_record_post_action 15:15:08 INFO - ##### 15:15:08 INFO - ##### Running download-and-extract step. 15:15:08 INFO - ##### 15:15:08 INFO - Running pre-action listener: _resource_record_pre_action 15:15:08 INFO - Running main action method: download_and_extract 15:15:08 INFO - mkdir: /builds/slave/test/build/tests 15:15:08 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')]} 15:15:08 INFO - https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:15:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 15:15:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 15:15:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 15:15:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 15:15:09 INFO - Downloaded 1241 bytes. 15:15:09 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 15:15:09 INFO - Using the following test package requirements: 15:15:09 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 15:15:09 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:09 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 15:15:09 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:09 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 15:15:09 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:15:09 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:09 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 15:15:09 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 15:15:09 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:09 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 15:15:09 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:09 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 15:15:09 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:09 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 15:15:09 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 15:15:09 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:09 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 15:15:09 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 15:15:09 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')]} 15:15:09 INFO - https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:15:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 15:15:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 15:15:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 15:15:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 15:15:13 INFO - Downloaded 17816878 bytes. 15:15:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:15:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:15:16 INFO - Return code: 0 15:15:16 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:16 INFO - https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:15:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 15:15:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 15:15:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 15:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 15:15:17 INFO - Downloaded 17816878 bytes. 15:15:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:15:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:15:20 INFO - Return code: 0 15:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:20 INFO - https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:15:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 15:15:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 15:15:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 15:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 15:15:22 INFO - Downloaded 10845194 bytes. 15:15:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:15:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:15:22 INFO - Return code: 0 15:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:22 INFO - https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 15:15:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 15:15:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 15:15:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 15:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 15:15:25 INFO - Downloaded 88466316 bytes. 15:15:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 15:15:25 INFO - mkdir: /builds/slave/test/properties 15:15:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:15:25 INFO - Writing to file /builds/slave/test/properties/build_url 15:15:25 INFO - Contents: 15:15:25 INFO - build_url:https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 15:15:25 INFO - Running post-action listener: _resource_record_post_action 15:15:25 INFO - Running post-action listener: set_extra_try_arguments 15:15:25 INFO - ##### 15:15:25 INFO - ##### Running populate-webroot step. 15:15:25 INFO - ##### 15:15:25 INFO - Running pre-action listener: _resource_record_pre_action 15:15:25 INFO - Running main action method: populate_webroot 15:15:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:15:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:15:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:15:25 INFO - '--tppagecycles', 15:15:25 INFO - '7'], 15:15:25 INFO - 'tests': ['tsvgm']}}, 15:15:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:15:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:15:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:15:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:15:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:15:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:15:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:25 INFO - 'talos_options': ['--e10s'], 15:15:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:25 INFO - 'tests': ['damp', 'tps']}, 15:15:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:25 INFO - 'talos_options': ['--e10s'], 15:15:25 INFO - 'tests': ['damp', 'tps']}, 15:15:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:15:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:15:25 INFO - 'other': {'tests': ['a11yr', 15:15:25 INFO - 'ts_paint', 15:15:25 INFO - 'tpaint', 15:15:25 INFO - 'sessionrestore', 15:15:25 INFO - 'sessionrestore_no_auto_restore', 15:15:25 INFO - 'tabpaint']}, 15:15:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:15:25 INFO - 'tests': ['a11yr', 15:15:25 INFO - 'ts_paint', 15:15:25 INFO - 'tpaint', 15:15:25 INFO - 'sessionrestore', 15:15:25 INFO - 'sessionrestore_no_auto_restore', 15:15:25 INFO - 'tabpaint']}, 15:15:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:15:25 INFO - 'tests': ['a11yr', 15:15:25 INFO - 'ts_paint', 15:15:25 INFO - 'tpaint', 15:15:25 INFO - 'sessionrestore', 15:15:25 INFO - 'sessionrestore_no_auto_restore', 15:15:25 INFO - 'tabpaint']}, 15:15:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:15:25 INFO - 'tests': ['a11yr', 15:15:25 INFO - 'ts_paint', 15:15:25 INFO - 'tpaint', 15:15:25 INFO - 'sessionrestore', 15:15:25 INFO - 'sessionrestore_no_auto_restore', 15:15:25 INFO - 'tabpaint']}, 15:15:25 INFO - 'other_l64': {'tests': ['a11yr', 15:15:25 INFO - 'ts_paint', 15:15:25 INFO - 'tpaint', 15:15:25 INFO - 'sessionrestore', 15:15:25 INFO - 'sessionrestore_no_auto_restore', 15:15:25 INFO - 'tabpaint']}, 15:15:25 INFO - 'other_nol64': {'tests': ['a11yr', 15:15:25 INFO - 'ts_paint', 15:15:25 INFO - 'tpaint', 15:15:25 INFO - 'sessionrestore', 15:15:25 INFO - 'sessionrestore_no_auto_restore', 15:15:25 INFO - 'tabpaint']}, 15:15:25 INFO - 'svgr': {'tests': ['tsvgx', 15:15:25 INFO - 'tsvgr_opacity', 15:15:25 INFO - 'tart', 15:15:25 INFO - 'tscrollx', 15:15:25 INFO - 'cart']}, 15:15:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:15:25 INFO - 'tests': ['tsvgx', 15:15:25 INFO - 'tsvgr_opacity', 15:15:25 INFO - 'tart', 15:15:25 INFO - 'tscrollx', 15:15:25 INFO - 'cart']}, 15:15:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:25 INFO - 'tests': ['tp5o']}, 15:15:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:25 INFO - 'talos_options': ['--e10s'], 15:15:25 INFO - 'tests': ['tp5o']}, 15:15:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:25 INFO - 'talos_options': ['--xperf_path', 15:15:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:25 INFO - 'tests': ['tp5n']}, 15:15:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:25 INFO - 'talos_options': ['--e10s', 15:15:25 INFO - '--xperf_path', 15:15:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:25 INFO - 'tests': ['tp5n']}}, 15:15:25 INFO - 'talos.zip': {'path': '', 15:15:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:15:25 INFO - Running post-action listener: _resource_record_post_action 15:15:25 INFO - ##### 15:15:25 INFO - ##### Running create-virtualenv step. 15:15:25 INFO - ##### 15:15:25 INFO - Running pre-action listener: _resource_record_pre_action 15:15:25 INFO - Running main action method: create_virtualenv 15:15:25 INFO - Creating virtualenv /builds/slave/test/build/venv 15:15:25 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 15:15:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:15:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:15:26 INFO - Using real prefix '/tools/python27' 15:15:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:15:26 INFO - Installing distribute.............................................................................................................................................................................................done. 15:15:29 INFO - Installing pip.................done. 15:15:29 INFO - Return code: 0 15:15:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:15:29 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')]} 15:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:29 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')]} 15:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:29 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 0x105414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f349f730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052b8d30>, '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 0x10511cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052afb20>, '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.lTBwERZvZd/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.b0FNSDEFrA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 15:15:29 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 15:15:29 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 15:15:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lTBwERZvZd/Render', 15:15:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:29 INFO - 'HOME': '/Users/cltbld', 15:15:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:29 INFO - 'LOGNAME': 'cltbld', 15:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:29 INFO - 'MOZ_NO_REMOTE': '1', 15:15:29 INFO - 'NO_EM_RESTART': '1', 15:15:29 INFO - 'PAGER': '/bin/cat', 15:15:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:29 INFO - 'PWD': '/builds/slave/test', 15:15:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:29 INFO - 'SHELL': '/bin/bash', 15:15:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b0FNSDEFrA/Listeners', 15:15:29 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 15:15:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:29 INFO - 'USER': 'cltbld', 15:15:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:29 INFO - 'XPC_FLAGS': '0x0', 15:15:29 INFO - 'XPC_SERVICE_NAME': '0', 15:15:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:29 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 15:15:29 INFO - Cleaning up... 15:15:29 INFO - Return code: 0 15:15:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:15:29 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')]} 15:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:29 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')]} 15:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:29 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 0x105414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f349f730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052b8d30>, '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 0x10511cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052afb20>, '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.lTBwERZvZd/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.b0FNSDEFrA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 15:15:29 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 15:15:29 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 15:15:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lTBwERZvZd/Render', 15:15:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:29 INFO - 'HOME': '/Users/cltbld', 15:15:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:29 INFO - 'LOGNAME': 'cltbld', 15:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:29 INFO - 'MOZ_NO_REMOTE': '1', 15:15:29 INFO - 'NO_EM_RESTART': '1', 15:15:29 INFO - 'PAGER': '/bin/cat', 15:15:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:29 INFO - 'PWD': '/builds/slave/test', 15:15:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:29 INFO - 'SHELL': '/bin/bash', 15:15:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b0FNSDEFrA/Listeners', 15:15:29 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 15:15:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:29 INFO - 'USER': 'cltbld', 15:15:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:29 INFO - 'XPC_FLAGS': '0x0', 15:15:29 INFO - 'XPC_SERVICE_NAME': '0', 15:15:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:30 INFO - Downloading/unpacking psutil>=0.7.1 15:15: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 15:15: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 15:15: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 15:15: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 15:15: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 15:15: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 15:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:15:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:32 INFO - Installing collected packages: psutil 15:15:32 INFO - Running setup.py install for psutil 15:15:33 INFO - building 'psutil._psutil_osx' extension 15:15:33 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 15:15:33 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 15:15:33 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 15:15:33 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 15:15:33 INFO - building 'psutil._psutil_posix' extension 15:15:33 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 15:15:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:15:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:15:33 INFO - ^ 15:15:33 INFO - 1 warning generated. 15:15:33 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 15:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:34 INFO - Successfully installed psutil 15:15:34 INFO - Cleaning up... 15:15:34 INFO - Return code: 0 15:15:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f349f730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052b8d30>, '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 0x10511cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052afb20>, '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.lTBwERZvZd/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.b0FNSDEFrA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 15:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lTBwERZvZd/Render', 15:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:34 INFO - 'HOME': '/Users/cltbld', 15:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:34 INFO - 'LOGNAME': 'cltbld', 15:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:34 INFO - 'MOZ_NO_REMOTE': '1', 15:15:34 INFO - 'NO_EM_RESTART': '1', 15:15:34 INFO - 'PAGER': '/bin/cat', 15:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:34 INFO - 'PWD': '/builds/slave/test', 15:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:34 INFO - 'SHELL': '/bin/bash', 15:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b0FNSDEFrA/Listeners', 15:15:34 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 15:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:34 INFO - 'USER': 'cltbld', 15:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:34 INFO - 'XPC_FLAGS': '0x0', 15:15:34 INFO - 'XPC_SERVICE_NAME': '0', 15:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:15:36 INFO - Installing collected packages: mozsystemmonitor 15:15:36 INFO - Running setup.py install for mozsystemmonitor 15:15:37 INFO - Successfully installed mozsystemmonitor 15:15:37 INFO - Cleaning up... 15:15:37 INFO - Return code: 0 15:15:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f349f730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052b8d30>, '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 0x10511cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052afb20>, '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.lTBwERZvZd/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.b0FNSDEFrA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 15:15:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:15:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lTBwERZvZd/Render', 15:15:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:37 INFO - 'HOME': '/Users/cltbld', 15:15:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:37 INFO - 'LOGNAME': 'cltbld', 15:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:37 INFO - 'MOZ_NO_REMOTE': '1', 15:15:37 INFO - 'NO_EM_RESTART': '1', 15:15:37 INFO - 'PAGER': '/bin/cat', 15:15:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:37 INFO - 'PWD': '/builds/slave/test', 15:15:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:37 INFO - 'SHELL': '/bin/bash', 15:15:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b0FNSDEFrA/Listeners', 15:15:37 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 15:15:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:37 INFO - 'USER': 'cltbld', 15:15:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:37 INFO - 'XPC_FLAGS': '0x0', 15:15:37 INFO - 'XPC_SERVICE_NAME': '0', 15:15:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:15:37 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 15:15:37 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 15:15:37 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 15:15:37 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 15:15:37 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 15:15:37 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 15:15:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:15:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:15:39 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 15:15:39 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 15:15:39 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 15:15:39 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 15:15:39 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 15:15:39 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 15:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:15:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 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 15:15:40 INFO - Downloading docopt-0.6.1.tar.gz 15:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:15:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:15:41 INFO - Running setup.py install for blobuploader 15:15:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:15:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:15:41 INFO - Running setup.py install for requests 15:15:41 INFO - Running setup.py install for docopt 15:15:41 INFO - Successfully installed blobuploader requests docopt 15:15:41 INFO - Cleaning up... 15:15:41 INFO - Return code: 0 15:15:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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')]} 15:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:41 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 0x105414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f349f730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052b8d30>, '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 0x10511cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052afb20>, '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.lTBwERZvZd/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.b0FNSDEFrA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 15:15:41 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 15:15:41 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 15:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lTBwERZvZd/Render', 15:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:41 INFO - 'HOME': '/Users/cltbld', 15:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:41 INFO - 'LOGNAME': 'cltbld', 15:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:41 INFO - 'MOZ_NO_REMOTE': '1', 15:15:41 INFO - 'NO_EM_RESTART': '1', 15:15:41 INFO - 'PAGER': '/bin/cat', 15:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:41 INFO - 'PWD': '/builds/slave/test', 15:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:41 INFO - 'SHELL': '/bin/bash', 15:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b0FNSDEFrA/Listeners', 15:15:41 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 15:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:41 INFO - 'USER': 'cltbld', 15:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:41 INFO - 'XPC_FLAGS': '0x0', 15:15:41 INFO - 'XPC_SERVICE_NAME': '0', 15:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:42 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-9BHI2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:42 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-T9W_cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:42 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-nojY7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:42 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-M_zxJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:42 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-xIHI_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:42 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-IPY0h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:42 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-OB7ydD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:42 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-t5l8k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-56Vem7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-QqlH6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-0h3D3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-9jnfNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-OPjPEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-OQNOvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-DJCTuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-TkqSjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Lm2IXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:15:43 INFO - Running setup.py install for manifestparser 15:15:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:15:44 INFO - Running setup.py install for mozcrash 15:15:44 INFO - Running setup.py install for mozdebug 15:15:44 INFO - Running setup.py install for mozdevice 15:15:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:15:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:15:44 INFO - Running setup.py install for mozfile 15:15:44 INFO - Running setup.py install for mozhttpd 15:15:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:15:44 INFO - Running setup.py install for mozinfo 15:15:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:15:44 INFO - Running setup.py install for mozInstall 15:15:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:15:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:15:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:15:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:15:45 INFO - Running setup.py install for mozleak 15:15:45 INFO - Running setup.py install for mozlog 15:15:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:15:45 INFO - Running setup.py install for moznetwork 15:15:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:15:45 INFO - Running setup.py install for mozprocess 15:15:45 INFO - Running setup.py install for mozprofile 15:15:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:15:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:15:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:15:45 INFO - Running setup.py install for mozrunner 15:15:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Running setup.py install for mozscreenshot 15:15:46 INFO - Running setup.py install for moztest 15:15:46 INFO - Running setup.py install for mozversion 15:15:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:15:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:15:46 INFO - Cleaning up... 15:15:46 INFO - Return code: 0 15:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:46 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')]} 15:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:46 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')]} 15:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:46 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 0x105414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f349f730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052b8d30>, '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 0x10511cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052afb20>, '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.lTBwERZvZd/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.b0FNSDEFrA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 15:15:46 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 15:15:46 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 15:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lTBwERZvZd/Render', 15:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:46 INFO - 'HOME': '/Users/cltbld', 15:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:46 INFO - 'LOGNAME': 'cltbld', 15:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:46 INFO - 'MOZ_NO_REMOTE': '1', 15:15:46 INFO - 'NO_EM_RESTART': '1', 15:15:46 INFO - 'PAGER': '/bin/cat', 15:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:46 INFO - 'PWD': '/builds/slave/test', 15:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:46 INFO - 'SHELL': '/bin/bash', 15:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b0FNSDEFrA/Listeners', 15:15:46 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 15:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:46 INFO - 'USER': 'cltbld', 15:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:46 INFO - 'XPC_FLAGS': '0x0', 15:15:46 INFO - 'XPC_SERVICE_NAME': '0', 15:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:46 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-FYZ3Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:46 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)) 15:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:46 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-zeuwn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:47 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-G76JMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:47 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Wo2nGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:47 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-PO_cw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:47 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-iYKgUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:47 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-sQ9Fs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:47 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-mrrzON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:47 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-5hdSIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:47 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-vFCH9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:47 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-wUd9E5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:47 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)) 15:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:47 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-WATHsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:48 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-xeunwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:48 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-oMfOjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:48 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-YtoPsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:48 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Zdalyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:48 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)) 15:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:48 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-dzF2LN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:48 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)) 15:15:48 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)) 15:15:48 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)) 15:15:48 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)) 15:15:48 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)) 15:15:48 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)) 15:15:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:15: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 15:15: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 15:15: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 15:15: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 15:15: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 15:15: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 15:15:50 INFO - Downloading blessings-1.6.tar.gz 15:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:15:51 INFO - Installing collected packages: blessings 15:15:51 INFO - Running setup.py install for blessings 15:15:51 INFO - Successfully installed blessings 15:15:51 INFO - Cleaning up... 15:15:51 INFO - Return code: 0 15:15:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:51 INFO - Reading from file tmpfile_stdout 15:15:51 INFO - Current package versions: 15:15:51 INFO - blessings == 1.6 15:15:51 INFO - blobuploader == 1.2.4 15:15:51 INFO - docopt == 0.6.1 15:15:51 INFO - manifestparser == 1.1 15:15:51 INFO - mozInstall == 1.12 15:15:51 INFO - mozcrash == 0.17 15:15:51 INFO - mozdebug == 0.1 15:15:51 INFO - mozdevice == 0.48 15:15:51 INFO - mozfile == 1.2 15:15:51 INFO - mozhttpd == 0.7 15:15:51 INFO - mozinfo == 0.9 15:15:51 INFO - mozleak == 0.1 15:15:51 INFO - mozlog == 3.1 15:15:51 INFO - moznetwork == 0.27 15:15:51 INFO - mozprocess == 0.22 15:15:51 INFO - mozprofile == 0.28 15:15:51 INFO - mozrunner == 6.11 15:15:51 INFO - mozscreenshot == 0.1 15:15:51 INFO - mozsystemmonitor == 0.0 15:15:51 INFO - moztest == 0.7 15:15:51 INFO - mozversion == 1.4 15:15:51 INFO - psutil == 3.1.1 15:15:51 INFO - requests == 1.2.3 15:15:51 INFO - wsgiref == 0.1.2 15:15:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:51 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')]} 15:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:51 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')]} 15:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:51 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 0x105414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f349f730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052b8d30>, '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 0x10511cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052afb20>, '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.lTBwERZvZd/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.b0FNSDEFrA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 15:15:51 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 15:15:51 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 15:15:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lTBwERZvZd/Render', 15:15:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:51 INFO - 'HOME': '/Users/cltbld', 15:15:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:51 INFO - 'LOGNAME': 'cltbld', 15:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:51 INFO - 'MOZ_NO_REMOTE': '1', 15:15:51 INFO - 'NO_EM_RESTART': '1', 15:15:51 INFO - 'PAGER': '/bin/cat', 15:15:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:51 INFO - 'PWD': '/builds/slave/test', 15:15:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:51 INFO - 'SHELL': '/bin/bash', 15:15:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b0FNSDEFrA/Listeners', 15:15:51 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 15:15:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:51 INFO - 'USER': 'cltbld', 15:15:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:51 INFO - 'XPC_FLAGS': '0x0', 15:15:51 INFO - 'XPC_SERVICE_NAME': '0', 15:15:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 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)) 15:15:51 INFO - Cleaning up... 15:15:51 INFO - Return code: 0 15:15:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:15:51 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')]} 15:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:51 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')]} 15:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:51 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 0x105414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f349f730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052b8d30>, '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 0x10511cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052afb20>, '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.lTBwERZvZd/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.b0FNSDEFrA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 15:15:51 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 15:15:51 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 15:15:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lTBwERZvZd/Render', 15:15:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:51 INFO - 'HOME': '/Users/cltbld', 15:15:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:51 INFO - 'LOGNAME': 'cltbld', 15:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:51 INFO - 'MOZ_NO_REMOTE': '1', 15:15:51 INFO - 'NO_EM_RESTART': '1', 15:15:51 INFO - 'PAGER': '/bin/cat', 15:15:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:51 INFO - 'PWD': '/builds/slave/test', 15:15:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:51 INFO - 'SHELL': '/bin/bash', 15:15:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b0FNSDEFrA/Listeners', 15:15:51 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 15:15:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:51 INFO - 'USER': 'cltbld', 15:15:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:51 INFO - 'XPC_FLAGS': '0x0', 15:15:51 INFO - 'XPC_SERVICE_NAME': '0', 15:15:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:52 INFO - Downloading/unpacking jsonschema 15:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:15:54 INFO - Downloading/unpacking functools32 (from jsonschema) 15:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:54 INFO - Downloading functools32-3.2.3-2.tar.gz 15:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:15:55 INFO - warning: no files found matching '*.txt' 15:15:55 INFO - no previously-included directories found matching 'build' 15:15:55 INFO - no previously-included directories found matching 'dist' 15:15:55 INFO - no previously-included directories found matching '.git*' 15:15:55 INFO - Installing collected packages: jsonschema, functools32 15:15:55 INFO - Running setup.py install for functools32 15:15:55 INFO - warning: no files found matching '*.txt' 15:15:55 INFO - no previously-included directories found matching 'build' 15:15:55 INFO - no previously-included directories found matching 'dist' 15:15:55 INFO - no previously-included directories found matching '.git*' 15:15:55 INFO - Successfully installed jsonschema functools32 15:15:55 INFO - Cleaning up... 15:15:55 INFO - Return code: 0 15:15:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105414a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f349f730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052b8d30>, '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 0x10511cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052afb20>, '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.lTBwERZvZd/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.b0FNSDEFrA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 15:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:15:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lTBwERZvZd/Render', 15:15:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:55 INFO - 'HOME': '/Users/cltbld', 15:15:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:55 INFO - 'LOGNAME': 'cltbld', 15:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:55 INFO - 'MOZ_NO_REMOTE': '1', 15:15:55 INFO - 'NO_EM_RESTART': '1', 15:15:55 INFO - 'PAGER': '/bin/cat', 15:15:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:55 INFO - 'PWD': '/builds/slave/test', 15:15:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:55 INFO - 'SHELL': '/bin/bash', 15:15:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b0FNSDEFrA/Listeners', 15:15:55 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 15:15:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:55 INFO - 'USER': 'cltbld', 15:15:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:55 INFO - 'XPC_FLAGS': '0x0', 15:15:55 INFO - 'XPC_SERVICE_NAME': '0', 15:15:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:55 INFO - Downloading/unpacking flake8 15:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:15:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:15:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:15:59 INFO - no previously-included directories found matching 'docs/_build' 15:15:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:15:59 INFO - Running setup.py install for pep8 15:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:15:59 INFO - no previously-included directories found matching 'docs/_build' 15:15:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:15:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:15:59 INFO - Cleaning up... 15:15:59 INFO - Return code: 0 15:15:59 INFO - Running post-action listener: _resource_record_post_action 15:15:59 INFO - Running post-action listener: _start_resource_monitoring 15:15:59 INFO - Starting resource monitoring. 15:15:59 INFO - ##### 15:15:59 INFO - ##### Running install step. 15:15:59 INFO - ##### 15:15:59 INFO - Running pre-action listener: _resource_record_pre_action 15:15:59 INFO - Running main action method: install 15:15:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:59 INFO - Reading from file tmpfile_stdout 15:15:59 INFO - Detecting whether we're running mozinstall >=1.0... 15:15:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:16:00 INFO - Reading from file tmpfile_stdout 15:16:00 INFO - Output received: 15:16:00 INFO - Usage: mozinstall [options] installer 15:16:00 INFO - Options: 15:16:00 INFO - -h, --help show this help message and exit 15:16:00 INFO - -d DEST, --destination=DEST 15:16:00 INFO - Directory to install application into. [default: 15:16:00 INFO - "/builds/slave/test"] 15:16:00 INFO - --app=APP Application being installed. [default: firefox] 15:16:00 INFO - mkdir: /builds/slave/test/build/application 15:16:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:16:22 INFO - Reading from file tmpfile_stdout 15:16:22 INFO - Output received: 15:16:22 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:16:22 INFO - Running post-action listener: _resource_record_post_action 15:16:22 INFO - ##### 15:16:22 INFO - ##### Running run-tests step. 15:16:22 INFO - ##### 15:16:22 INFO - Running pre-action listener: _resource_record_pre_action 15:16:22 INFO - Running main action method: run_tests 15:16:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:16:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:16:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:16:22 INFO - 2016-05-26 15:16:22.557 screenresolution[1641:7560] starting screenresolution argv=screenresolution get 15:16:22 INFO - 2016-05-26 15:16:22.560 screenresolution[1641:7560] Display 0: 1600x1200x32@60 15:16:22 INFO - 2016-05-26 15:16:22.566 screenresolution[1642:7562] starting screenresolution argv=screenresolution list 15:16:22 INFO - Available Modes on Display 0 15:16:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:16:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:16:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:16:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:16:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:16:22 INFO - Intel Iris: 15:16:22 INFO - Chipset Model: Intel Iris 15:16:22 INFO - Type: GPU 15:16:22 INFO - Bus: Built-In 15:16:22 INFO - VRAM (Dynamic, Max): 1536 MB 15:16:22 INFO - Vendor: Intel (0x8086) 15:16:22 INFO - Device ID: 0x0a2e 15:16:22 INFO - Revision ID: 0x0009 15:16:22 INFO - Displays: 15:16:22 INFO - Display: 15:16:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:16:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:16:22 INFO - Display Serial Number: 1600x1200 60 15:16:22 INFO - Main Display: Yes 15:16:22 INFO - Mirror: Off 15:16:22 INFO - Online: Yes 15:16:22 INFO - Rotation: Supported 15:16:22 INFO - Return code: 0 15:16:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:16:22 INFO - Python 2.7.3 15:16:22 INFO - Return code: 0 15:16:22 INFO - grabbing minidump binary from tooltool 15:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:22 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 0x1052b8d30>, '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 0x10511cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052afb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:16:22 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 15:16:22 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 15:16:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:16:22 INFO - Return code: 0 15:16:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:16:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:16:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:16:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:16:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:16:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:16:24 INFO - Return code: 0 15:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0346', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0346 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:16:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lTBwERZvZd/Render', 15:16:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:24 INFO - 'HOME': '/Users/cltbld', 15:16:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:24 INFO - 'LOGNAME': 'cltbld', 15:16:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:16:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:24 INFO - 'MOZ_NO_REMOTE': '1', 15:16:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:16:24 INFO - 'NO_EM_RESTART': '1', 15:16:24 INFO - 'PAGER': '/bin/cat', 15:16:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:24 INFO - 'PWD': '/builds/slave/test', 15:16:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:16:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:24 INFO - 'SHELL': '/bin/bash', 15:16:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b0FNSDEFrA/Listeners', 15:16:24 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 15:16:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:24 INFO - 'USER': 'cltbld', 15:16:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:24 INFO - 'XPC_FLAGS': '0x0', 15:16:24 INFO - 'XPC_SERVICE_NAME': '0', 15:16:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0346', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:16:24 INFO - mozversion application_buildid: 20160526140250 15:16:24 INFO - mozversion application_changeset: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 15:16:24 INFO - mozversion application_display_name: Firefox 15:16:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:16:24 INFO - mozversion application_name: Firefox 15:16:24 INFO - mozversion application_remotingname: firefox 15:16:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:16:24 INFO - mozversion application_vendor: Mozilla 15:16:24 INFO - mozversion application_version: 47.0 15:16:24 INFO - mozversion platform_buildid: 20160526140250 15:16:24 INFO - mozversion platform_changeset: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 15:16:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:16:24 INFO - mozversion platform_version: 47.0 15:16:24 INFO - using testdate: 1464300984 15:16:24 INFO - actual date: 1464300984 15:16:24 INFO - starting webserver on 'localhost:49275' 15:16:24 INFO - SUITE-START | Running 2 tests 15:16:24 INFO - TEST-START | dromaeo_css 15:16:24 INFO - operating with platform_type : mac_ 15:16:24 INFO - Initialising browser for dromaeo_css test... 15:16:24 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpMoWdzc/profile http://localhost:49275/getInfo.html) 15:16:26 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 15:16:26 INFO - PROCESS | 1660 | colorDepth:24 15:16:26 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 15:16:26 INFO - PROCESS | 1660 | __metrics 15:16:26 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:16:26 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:16:27 INFO - TEST-INFO | 1660: exit 0 15:16:27 INFO - Browser initialized. 15:16:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:16:27 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpMoWdzc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:16:39 INFO - PROCESS | 1663 | RSS: Main: 157319168 15:16:39 INFO - PROCESS | 1663 | 15:17:30 INFO - PROCESS | 1663 | 1464301050223 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] 15:19:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 15:19:41 INFO - PROCESS | 1663 | RSS: Main: 297857024 15:19:41 INFO - PROCESS | 1663 | 15:22:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 15:22:44 INFO - PROCESS | 1663 | RSS: Main: 295796736 15:22:44 INFO - PROCESS | 1663 | 15:25:46 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 15:25:46 INFO - PROCESS | 1663 | RSS: Main: 299970560 15:25:46 INFO - PROCESS | 1663 | 15:28:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 15:28:49 INFO - PROCESS | 1663 | RSS: Main: 257572864 15:28:49 INFO - PROCESS | 1663 | 15:31:52 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 15:31:52 INFO - PROCESS | 1663 | RSS: Main: 259391488 15:31:52 INFO - PROCESS | 1663 | 15:34:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 15:34:55 INFO - PROCESS | 1663 | RSS: Main: 305319936 15:34:55 INFO - PROCESS | 1663 | 15:34:55 INFO - PROCESS | 1663 | __start_tp_report 15:34:55 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 15:34:55 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 15:34:55 INFO - PROCESS | 1663 | |i|pagename|runs| 15:34:55 INFO - PROCESS | 1663 | |0;dojo.html;3093.9071827845164;3661.4873917651516;3667.633236676331;3678.448232765086;3742.0083677825364;5934.080217566273;5943.197668314776;5951.691785607342;5966.731497082631;6007.639541627505;5936;5988.401159884021;6008.729607167677;6011.639301641904;6013.368596297391;5236.607254455912;5334.973325133378;5377.704226267554;5426.782928682848;5442.156465747796;5429.728513574325;5448.046591846431;5451.727413629303;5458.645188062763;5461.5357694596005;5389.649672771257;5400.29796126503;5426.8914621707545;5432.75552600134;5435.565154787627;5431.022415965124;5443.618946673695;5463.672179669193;5473.808416705436;5521.089020311644;5208.140656791625;5368.785248590052;5389.461053894618;5390.865228369283;5413.242146099549;5822.737976791054;5856.853578660525;5860.443257890493;5882.617629854046;5895.410458954113;6272.404121608485;6336.081268216083;6338.778142764981;6355.332690067568;6358.046293056079;5601.3558440779425;6281.87436251277;6301.8109456716375;6320.399562041599;6330.366963303679;6015.669138197398;6056.606320589148;6059.818205453844;6069.666168360783;6071.423214794588;5458.918116228259;6383.808485745435;6398.968005160037;6401.487880969511;6402.231732192074;6261.123442718023;6309.905351419732;6318.147050148171;6332.873342533216;6333.240011198685;5417.322834645669;6336.52476064297;6367.808965731036;6385.074164246251;6389.584676995981;6290.308066112724;6333.240011198685;6340.334264902119;6346.365363463617;6358.682065896686;5431.619786614899;5614.101743720985;6351.872962540723;6362.204724409449;6366.554341196164;4688.718676879398;5055.494450554915;5085.95737873735;5125.103106956268;5137.0753264412015;4556.567126123079;4564.178447879413;4566.8173273068705;4570.794314255866;4591.4260717410325;6061.454469097803;6064.211652485149;6070.969645151746;6083.969580152071;6096.146539484475;6239.625622462667;6268.592541484789;6269.8746025079245;6270.686465676789;6302.558820882494;6137;6165.445109940127;6185.938140618626;6186.381361863868;6195.473384762256;5512.6692398456225;5608.186812912105;5623.550115990793;5623.606347555632;5638.04153293941;6413.486921046305;6468.579542329733;6552.410283074546;6572.605643661395;6575.835604109936;6215.223097112861;6255.999040153553;6285.937140628718;6289.371062893674;6294.653794041372;6556.803295901131;6583.63789991555;6598.769043083469;6607.80176594703;6618.271990080991;6167.814965551041;6185.8144255672405;6239.78160764371;6256.687165641791;6275.246970363585;6289.339619340087;6289.748410063729;6290.528210384148;6294.590851594632;6296.937030629635;6159.29168145669;6197.163382943425;6214.130021797043;6215.720292586754;6221.3156552778255;5839.29944382875;6188.071789231652;6246.125542424155;6288.811335659938;6300.338464461349;5247.081760691787;5627.577931655224;6144.341027922525;6194.721237544411;6223.097650840693;6188.535859810442;6209.441150296495;6264.906026409516;6321.051842223703;6335.746570137143;6228.657423841732;6257.405546473078;6266.028765541349;6266.185395898504;6273.686315684289 15:34:55 INFO - PROCESS | 1663 | |1;ext.html;479.9952000479994;580.4311774461028;590.7282649981008;650.6649075726001;660.0330515794362;39728.60271397289;40206;40221.3966790498;40319;40320.79839600798;43701.562984370146;44140.55859441405;44215.55784442154;44222.77888610552;44400.77799611005;9632.759181020478;9848;9861.60553577856;9876.950615246913;9891;9681.225501959862;9833.754156146082;9857.556409961533;9860.753481162992;9946.15457686094;9924.305298629099;9989.150922171624;10002.649907253248;10002.699919002442;10018.699439016804;9886.604535818595;9978.700638980843;9983.251256155818;9992.600295988152;9996.950015249913;9758.756031099208;9893.950530247375;9910.653127140515;9911.851322230172;9922.553485093189;42161.57838421638;42414.78792606017;42443.151136977394;42494.78752606248;42499.150016999796;3246.2371342734436;3407.148212946763;3450.189205536697;3694.0026192927758;3891.7859517726515;28596.285092872637;29429.411411771645;29612.407751845058;29655.25861853449;30274.697253027407;2732.5491293936475;2784.8886044558194;2820;2840.4887120318335;2882.7261410166;499646;500783;501167.9883201158;501982.99999999633;503230;46078.53921460809;46968.5303146971;63712.04431933525;64345;64372.678136609014;46584.767076164404;46856.29715554269;46999;47006.76496617495;47034.76482617565;16378.918105409635;16707.49877503677;16716.99698018123;16719.91640041792;16727.749083763752;13337.599872003855;13398.397072131778;13427.597172084657;13438.924886009096;13440.663983400298;14882.553523394316;15249.23753812327;15280;15368.077915325117;15383.538493845203;6458.644774537445;6549.9520076787485;6593.901091483632;6606.306337834554;6613.5370524062855;1001.7746007148334;1054.7363159210197;1055.7044027672264;1146.9197156199152;1164.301419148504;26396.47207055848;29903.850480747456;30407.543886841715;30415.78336866545;31115.68884311128;1160.5473865192582;1190.1787766441128;1192.469351138735;1205.1443475132578;1280.11032332528;15383;15452.381904723685;15537.533873983799;15749.291281892343;15785.131817749905;511411;514745;522547;523948;524680;61825.690871546256;62594;62627;62703.37296627067;62714.372856271766;1346.9663258418618;1390.6662401023884;1548.651553400476;1580.5574439156824;1592.6416556274978;29455.11634650964;29568;29611.555826663047;30305;30377.544336835406;46562;46600.067998640516;46815;46843.29735053909;46856;374424;382574;383279;384541;385148;34758.65241347655;34988;35669.286614267054;35674.46488302729;35738;46035.30947035864;46198;46455.535444645124;47575.28637070516;48055.03889922252;38100.61899380971;38515.61484385232;38780.224395511366;38860.41709374418;39458.80270598629;38069.66756163521;38141.809290953366;38291.425628615034;38350.23299534049;38897;37377.813110935356;37730;37831.43252851265;39121.6087839118;39621.60378396294;33198.360327934024;33355.666443336224;34180.48729269113;34335.82832085923;34446;25432;25752.484950301263;25775;26239.73760262373;26338 15:34:55 INFO - PROCESS | 1663 | |2;jquery.html;381.110107898058;385.5623866911056;387.42274011722526;393.1233349630326;393.66341777779996;20625.17499300028;21610.243641472553;21935;22190.445238869037;22291.996860141313;20781.896090519527;20803.895980520116;21543.24598639048;22607.208747693832;22612.75629840358;6168.629882207082;6169.2596888373455;6230.750769969196;6237.064440333964;6248.937510624881;6011.789587364443;6151.169592105076;6193.907091393633;6210.658413787262;6216.720247588847;5827.883442331172;6064.363241859607;6160.722767475452;6165.599236049642;6167.352427995041;6009.4591486766185;6036.124761909498;6053.485453736438;6056.0613104969025;6063.393660633946;5229.581633469352;5768.42315768424;5784.595078344518;5786.392428794958;5897.616654917417;14234.501792437319;14265.857341426661;14319.570412887526;14451.71096578073;14514.709705805824;2174.521605246843;2184.7815218478186;2228.9108435662556;2271.818254539633;2335.229374306492;10282.177425805918;10716.892831071667;10828.945855270753;11343.489542970587;15299.923500382538;1716.9484915452556;1756.9560760981078;1790.7403426503083;1817.5092724964186;1850.6021205440761;109190.45404772925;113122;115640;116377.41811290974;117748;11173.217874748689;11425.31448113116;11493;11495.310281383145;11537.88462115385;13246.536371226961;14638.975271730877;14657.413703451955;14707.92646036763;14714;8277.54473503951;8410.77114564641;8815.779605509786;9027.819443611092;9084.40951338161;7048.541844780073;9187.954060229657;9197.126273004054;9253.814923701622;9561.517964715342;4486.461624605068;4576.222042252825;4603.723776573416;4611.792469338888;4640.883977900579;1853.1012458957396;1905.4759941016332;1910.1595298068805;1911.694128939363;1913.87559808612;934.490702567089;972.5720682899502;976.9902300977042;1005.8390657494766;1044.5665049004579;20214.898925505277;20778.688319675217;20786.856722880388;20954.580908382053;21049.84252362158;1000.5347513406156;1022.197574903697;1044.3211912257093;1050.8423736439443;1082.6697857153486;8980.730578082668;10025.548850301608;11364.977152056355;11371.374574398322;11408.429578521042;662835;686296;702115;725627;726340;117599;118087;122458;122795.77204228022;123272.38363808124;1082.875469321038;1092.939888306135;1131.9207655464038;1152.5389844062443;1152.8904754048351;18004.708093222267;18759.15583798705;18811.529711757317;18939.90530047341;19165.808341916403;53421.46578534321;54721.1791823115;54763;55975;56094;77941.61029195045;78989.60505197437;80877;80935;81813.77279340696;8272.710455134042;8378.748637540639;8396.202360775716;8563.229309362187;8685.91314086851;11338.433078346216;13599.932000339935;13653.590392288248;13905.37425815861;13991.58025259244;11663.475143618387;11752.911543928709;11900.523979040741;12132.029437645144;12185.817212741993;11542.653720388402;11779.998700110244;11957.282563046245;11967.820482692592;12091.75816483683;11535.76928461443;11865.347405892759;12061;12175.025997919967;12175.634730958085;8171.509709417454;8367.707130250412;8525.10486398944;8668.696595619123;8766.386352955233;11013.229073965065;11599.594014209462;11787;11962.222455540363;12018.699532511757 15:34:55 INFO - PROCESS | 1663 | |3;mootools.html;1451.9564413067599;1626.6584017356354;1656.1470842516103;2013.6375452418567;2085.0929845517194;8398.3281337493;9140.177384035436;9276.165145136936;9293.674721384745;9306.488143152124;8763.956180219106;9009.549522523865;9024.097590240988;9024.458532488055;9027;2580.251726999168;2597.2727636261784;2597.4155814941582;2599.2332261982665;2607.0223666125203;2474.604063349864;2554.859482728449;2557.258395065429;2559.2322303309024;2565.576679847823;2577.6262441946;2587.3531617095728;2616.6467526883816;2622.5672763993916;2625.7636812686856;2569.11365578875;2590.779783718386;2593.455374371384;2598.558245098338;2603.869806509667;2555.310066282112;2578.1363243313513;2585.31489155374;2596.9870150649313;2607.8565678887653;9218.677346292847;9270.258379329638;9272.490013049279;9277.860832087525;9278.814423711556;5643.520300774439;5793.449622285876;5803.912941305884;5839.562032847511;5863.706814659293;3582.623824498416;3713.3130370881204;3717.646823551758;3740.4950331705145;3817.1983883384523;1074.0923919288189;1089.983650245247;1096.1614365010773;1107.9612213572486;1128.531659361364;12166.635000949986;12349.629511114592;12372.381380931007;12389;12393.318367489785;4185.727927684691;5030.3963524377305;5077.720725360141;5131.384233891957;5136.974315128476;10542.42016689074;10593.470326483799;10600.628977985734;10600.946995264974;10624.575016999388;5836.941630583725;5843.5325173985975;5846.766129354864;5847;5856.502197313191;4719.339292499053;4796.904061918742;4822.95177048225;4833.613310935117;5316.255724198615;4051.2910240707756;4057.634812866856;4134.235166494208;4139.441175441337;4155.667546596265;1337.6923307639104;1362.3801170467414;1368.8973327000515;1376.6351916742071;1378.4830688491816;1164.3828770751516;1173.7711146326385;1180.6871179137536;1421.3390773290469;1470.3089547912464;8428.32573394127;8502.532360720095;8598.5700714964;8606.182412670787;8608.91391086081;540.8269353806822;546.9015577196063;548.8216329692866;549.2365611799602;551.0439387662402;6338.936610633927;6341.841453963688;6393.456556192776;6393.744250230032;6398.232212134573;10889.618863339745;11410.714732131597;11426.371549564687;11432.428378581038;11452;10502.579896804195;10832.295900766425;11217.439128043565;11268.774624507463;11270.267432616854;7416.666250018762;8546.914530854736;8674.132586741276;8686.95656521726;8687.261582765535;8366.832663346577;8377.078521362524;8437.95781021091;8509.829803404022;8531.360147988802;8672.219500245008;9764.707058788248;9956;10068.647597334058;10129.544170512198;9827.950860245654;10125.038121378457;10338.0695737384;10345.120664743581;10451.529681164518;7064.576125432491;7250.057492525938;7485.438592105723;7719.459637825298;7724.729634462767;7993.520388776459;8053.758387248392;8341.624626891684;8526.445781024213;8555.914440855511;7521.435892308208;7624.161342252459;7629.618519074135;7744.225577442436;7746.883796742941;7433.851322973402;7463.2163622818825;7510.098788145458;7540.886886696813;7591.127020392505;7965.203479651988;8023.4784738991775;8036.87944680842;8040.517568945882;8043.235892590194;7319.048523691886;7366.7053317866685;7402.1117465904435;7420.480566360519;7448.813779655552;7421.2949769771785;7444.813879653052;7488.176300607038;7500.699972001277;7501.362384197186 15:34:55 INFO - PROCESS | 1663 | |4;prototype.html;337.1671970233523;344.18256640478864;345.26803177264196;345.78561291998966;351.44998078007916;5468.9726551367185;6578.835529111775;6590.769323073693;6618.30507796681;6643.734250629969;6556.573822701521;6601.273859875422;6602.867942641156;6613.867722645544;6624.668766561665;4705.294205869112;4797.448293446246;4801.8079276828885;4915.3855768029;4962.131626965275;4376.606105450509;4595.75914503084;4849.466558678542;4892.510748925097;4911.778969946361;4802.615790736751;4804.90390192196;4818;4820.493848145947;4833.564979151875;4658.976705116453;4725.574698277172;4808.134535783557;4861.343718597979;4873;4170.457840480748;4191.790410479494;4199.4330765346895;4200.096979149467;4205.663546916239;6200.379962003809;6224.159738435299;6241.500679945593;6267.4045965633195;6267.529935254828;4981.427135879384;5128.589712823003;5755.539556835443;5756.510696590794;5770.480656740871;6954.756583519553;6965.79102626922;6968.163820341591;6999.580025198505;7007.544509606911;4580.725156490588;4622.884427889329;4673.6027437667835;4738.194506933795;4767.61859051275;6376.234851817811;7293.380062694678;7382.667779949915;7385.9261407385775;7393.334599885982;4280.743155410685;4835.95164048362;4840.080384726891;4846.878828029327;4859.246816743411;4492.797824097924;4612.976935115303;4904.4605093439695;4918.606511479073;4928.324369714314;5732.77068917247;5745.68398738065;5748.798792042258;5750.166225897222;5772.163036359704;6760.7295708172105;7006.719731210796;7020.087388639547;7094.751683691046;7106.324899134574;1676.79040119985;1695.8643308535534;1709.6153365492664;1712.4605749188966;1715.622563036155;897.8742975983367;1101.1851230089676;1112.9777404452027;1117.3686866920164;1127.5095333529941;6452.354764523604;6626.304238054935;6806.0865002622695;6906.965465172642;6915.965420172867;6199.039148931923;7171.677274522659;7267.672954716944;7280.41756659466;7297.197308296083;5647.858803529863;6694.364035416627;6720.092787473726;6721.22705888829;6737.831554211086;3784.394496880486;3824.0822202671156;3827.2919509890758;3829.4255861620422;3842.9231415372096;7311.195768465464;7646.617669116522;7651.579163145969;7670.117936437269;7692.192319806451;7489.063867016623;7523.172451030382;7531.736389226351;7534.472586918972;7543.245675432413;6619.007148927795;7377.631118443949;7624.42816788743;7643.388528917673;7655.540667559852;7103.360697537247;7241.456890733321;7246.89129663066;7254.16577093641;7257.854842903218;7214.531055481377;7216.278372162742;7217.06178196831;7242.420606351374;7264.382527485223;7691.730789422343;7710.190430004769;7712.460127791001;7729.111152217567;7734.5359278443475;4631.884202894955;4667.253239481666;4674.018456124252;4675.555822196886;4694.812207511662;6934.479914006369;7230.42156627479;7232.42140628759;7244.239354867663;7259.818504537428;5737.311522617312;6994.755183568551;7008.22909479967;7026.718931242897;7045;6947.583145011114;6964.303569642995;6978.127734033246;7029.929700702927;7037.225905150327;6849.48628852848;6854.520183587101;6886.414654754402;6902.309769023058;6924.549904256207;6767.458603311625;6969.860602788017;6976.930230697831;6992.3357281058215;7028.50800443964;6604.471642268511;6716.3955244028275;6757.425618822259;6878.7248510059035;6889.414399775875 15:34:55 INFO - PROCESS | 1663 | |5;yui.html;782.2529484342457;797.2027972027972;802.6307898366751;806.6168569929281;810.0846043970313;14934.701305973875;14964.925175374121;15225.467108651199;15250.542483725492;15324.54026379209;14612.342444589993;14690.971631985765;14696.338664760086;14720;14726.63183420415;815.9510429374257;828.1511450762986;967.830629639812;998.9700308990742;999.8400255959048;981.2591493422456;981.4994352880046;982.135720565901;982.8722266105397;989.1295659819385;1033.0805583031108;1033.101201954301;1033.9638112666057;1034.1261633919326;1059.6767985764338;850.2900078434484;858.9141085891423;1023.5701005577638;1031.9226058045676;1053.531178625512;780.3834970373398;785.1363500149847;786.7679034684782;786.7757689058648;789.4631650477672;15600.531984040497;15695.764563531442;15696.921515392463;15713.05721656693;15780;13276.46894124234;13310.733785324335;13339.733205335937;13480.191188528719;13515.391807368693;10283.280170388076;10356.948215258875;10505.52725127371;10597.576096956112;10765.784684306349;3633.8364773585254;3681.5582130144553;3754.6433088856515;3781.2059467511854;3912.0219945013746;87440;87846;88474.5576272121;89374.5531272346;89877.20245595051;9712.854307185398;9728.75678108053;9779.119879210763;10215.94892025535;10660.840087398696;21964.341069767932;22039;22041.89790510468;22070;22130.557388852132;7718.773373223635;7743.9612801936755;7769.3784497240085;7783.532988020737;7900.881486777703;4188.204241194224;4216.978915105405;4288.292431748727;4294.055307832272;4336.6530677545725;3723.8510459581853;3776.773393596393;3778.6977041837135;3785.091578021255;3809.504764380613;609.4819403506983;663.1279866974912;671.375620672779;672.4721093941331;673.5520878615665;587.2395248153651;626.0921663587816;635.259922190652;638.9808255832033;665.112075379374;8113.432059755878;8355.164483551718;8459.619317130744;8468.364872634455;8557.957210214034;567.2172402085096;597.8654802669365;603.2188316130621;612.0421540289433;640.3724350136799;3884.7280690351404;3887.261420330128;3890.9416358754643;3993.9600603994168;3999.24014437256;93010.0698993015;94256.52871735598;96168.03831961591;101746;101827;78327.216727832;81309;83733;85650.57174714087;85792.71310930341;74728.62635686896;75463;75578;76649.616751917;76680.61659691777;7041.401480874183;7695.2304769524835;8412.915870841458;8687.913120868963;8883.333749968908;52124.957500849014;52184.47815521796;53499.46500534945;53920;54217.45782542124;70195.64902175457;72376.63811680907;72520.27479725135;73256.90114648391;73545.6322718383;11064.668059958214;11139.72150696239;11277.436128193722;11300.604478843201;11655.125865559947;11963.940180299043;12033.819492707791;12176.878231217928;12206.206596571194;12456.43946022413;11611.593594224161;11645.995791558362;11808.291502509877;11850.348230847387;12069.39653017328;11515.481803319039;11522.366269855238;11593.5362585499;11618.419079046183;11660.766784664429;11431;11448.484818183368;11552.59565915189;11829.822552661544;12021.579244726392;9658.3722058066;9811.215102791903;9838.557264923238;9889.950550247202;10148.340357876714;9665.613375464902;9865.358751681119;9873.605055797687;9879.160271377013;9979.950100249453 15:34:55 INFO - PROCESS | 1663 | __end_tp_report 15:34:55 INFO - PROCESS | 1663 | __start_cc_report 15:34:55 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1178 15:34:55 INFO - PROCESS | 1663 | __end_cc_report 15:34:55 INFO - PROCESS | 1663 | __startTimestamp1464302095545__endTimestamp 15:34:55 INFO - PROCESS | 1663 | 15:34:55 INFO - PROCESS | 1663 | ------- Summary: start ------- 15:34:55 INFO - PROCESS | 1663 | Number of tests: 6 15:34:55 INFO - PROCESS | 1663 | 15:34:55 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5892.02 Median:6167.81 stddev:626.61 (10.2%) stddev-sans-first:588.84 15:34:55 INFO - PROCESS | 1663 | Values: 3093.9 3661.5 3667.6 3678.4 3742.0 5934.1 5943.2 5951.7 5966.7 6007.6 5936.0 5988.4 6008.7 6011.6 6013.4 5236.6 5335.0 5377.7 5426.8 5442.2 5429.7 5448.0 5451.7 5458.6 5461.5 5389.6 5400.3 5426.9 5432.8 5435.6 5431.0 5443.6 5463.7 5473.8 5521.1 5208.1 5368.8 5389.5 5390.9 5413.2 5822.7 5856.9 5860.4 5882.6 5895.4 6272.4 6336.1 6338.8 6355.3 6358.0 5601.4 6281.9 6301.8 6320.4 6330.4 6015.7 6056.6 6059.8 6069.7 6071.4 5458.9 6383.8 6399.0 6401.5 6402.2 6261.1 6309.9 6318.1 6332.9 6333.2 5417.3 6336.5 6367.8 6385.1 6389.6 6290.3 6333.2 6340.3 6346.4 6358.7 5431.6 5614.1 6351.9 6362.2 6366.6 4688.7 5055.5 5086.0 5125.1 5137.1 4556.6 4564.2 4566.8 4570.8 4591.4 6061.5 6064.2 6071.0 6084.0 6096.1 6239.6 6268.6 6269.9 6270.7 6302.6 6137.0 6165.4 6185.9 6186.4 6195.5 5512.7 5608.2 5623.6 5623.6 5638.0 6413.5 6468.6 6552.4 6572.6 6575.8 6215.2 6256.0 6285.9 6289.4 6294.7 6556.8 6583.6 6598.8 6607.8 6618.3 6167.8 6185.8 6239.8 6256.7 6275.2 6289.3 6289.7 6290.5 6294.6 6296.9 6159.3 6197.2 6214.1 6215.7 6221.3 5839.3 6188.1 6246.1 6288.8 6300.3 5247.1 5627.6 6144.3 6194.7 6223.1 6188.5 6209.4 6264.9 6321.1 6335.7 6228.7 6257.4 6266.0 6266.2 6273.7 15:34:55 INFO - PROCESS | 1663 | 15:34:55 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:61580.25 Median:38647.92 stddev:125235.64 (324.0%) stddev-sans-first:125502.94 15:34:55 INFO - PROCESS | 1663 | Values: 480.0 580.4 590.7 650.7 660.0 39728.6 40206.0 40221.4 40319.0 40320.8 43701.6 44140.6 44215.6 44222.8 44400.8 9632.8 9848.0 9861.6 9877.0 9891.0 9681.2 9833.8 9857.6 9860.8 9946.2 9924.3 9989.2 10002.6 10002.7 10018.7 9886.6 9978.7 9983.3 9992.6 9997.0 9758.8 9894.0 9910.7 9911.9 9922.6 42161.6 42414.8 42443.2 42494.8 42499.2 3246.2 3407.1 3450.2 3694.0 3891.8 28596.3 29429.4 29612.4 29655.3 30274.7 2732.5 2784.9 2820.0 2840.5 2882.7 499646.0 500783.0 501168.0 501983.0 503230.0 46078.5 46968.5 63712.0 64345.0 64372.7 46584.8 46856.3 46999.0 47006.8 47034.8 16378.9 16707.5 16717.0 16719.9 16727.7 13337.6 13398.4 13427.6 13438.9 13440.7 14882.6 15249.2 15280.0 15368.1 15383.5 6458.6 6550.0 6593.9 6606.3 6613.5 1001.8 1054.7 1055.7 1146.9 1164.3 26396.5 29903.9 30407.5 30415.8 31115.7 1160.5 1190.2 1192.5 1205.1 1280.1 15383.0 15452.4 15537.5 15749.3 15785.1 511411.0 514745.0 522547.0 523948.0 524680.0 61825.7 62594.0 62627.0 62703.4 62714.4 1347.0 1390.7 1548.7 1580.6 1592.6 29455.1 29568.0 29611.6 30305.0 30377.5 46562.0 46600.1 46815.0 46843.3 46856.0 374424.0 382574.0 383279.0 384541.0 385148.0 34758.7 34988.0 35669.3 35674.5 35738.0 46035.3 46198.0 46455.5 47575.3 48055.0 38100.6 38515.6 38780.2 38860.4 39458.8 38069.7 38141.8 38291.4 38350.2 38897.0 37377.8 37730.0 37831.4 39121.6 39621.6 33198.4 33355.7 34180.5 34335.8 34446.0 25432.0 25752.5 25775.0 26239.7 26338.0 15:34:55 INFO - PROCESS | 1663 | 15:34:55 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:37663.66 Median:20795.38 stddev:115955.18 (557.6%) stddev-sans-first:116246.67 15:34:55 INFO - PROCESS | 1663 | Values: 381.1 385.6 387.4 393.1 393.7 20625.2 21610.2 21935.0 22190.4 22292.0 20781.9 20803.9 21543.2 22607.2 22612.8 6168.6 6169.3 6230.8 6237.1 6248.9 6011.8 6151.2 6193.9 6210.7 6216.7 5827.9 6064.4 6160.7 6165.6 6167.4 6009.5 6036.1 6053.5 6056.1 6063.4 5229.6 5768.4 5784.6 5786.4 5897.6 14234.5 14265.9 14319.6 14451.7 14514.7 2174.5 2184.8 2228.9 2271.8 2335.2 10282.2 10716.9 10828.9 11343.5 15299.9 1716.9 1757.0 1790.7 1817.5 1850.6 109190.5 113122.0 115640.0 116377.4 117748.0 11173.2 11425.3 11493.0 11495.3 11537.9 13246.5 14639.0 14657.4 14707.9 14714.0 8277.5 8410.8 8815.8 9027.8 9084.4 7048.5 9188.0 9197.1 9253.8 9561.5 4486.5 4576.2 4603.7 4611.8 4640.9 1853.1 1905.5 1910.2 1911.7 1913.9 934.5 972.6 977.0 1005.8 1044.6 20214.9 20778.7 20786.9 20954.6 21049.8 1000.5 1022.2 1044.3 1050.8 1082.7 8980.7 10025.5 11365.0 11371.4 11408.4 662835.0 686296.0 702115.0 725627.0 726340.0 117599.0 118087.0 122458.0 122795.8 123272.4 1082.9 1092.9 1131.9 1152.5 1152.9 18004.7 18759.2 18811.5 18939.9 19165.8 53421.5 54721.2 54763.0 55975.0 56094.0 77941.6 78989.6 80877.0 80935.0 81813.8 8272.7 8378.7 8396.2 8563.2 8685.9 11338.4 13599.9 13653.6 13905.4 13991.6 11663.5 11752.9 11900.5 12132.0 12185.8 11542.7 11780.0 11957.3 11967.8 12091.8 11535.8 11865.3 12061.0 12175.0 12175.6 8171.5 8367.7 8525.1 8668.7 8766.4 11013.2 11599.6 11787.0 11962.2 12018.7 15:34:55 INFO - PROCESS | 1663 | 15:34:55 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6286.81 Median:2928.54 stddev:3332.60 (113.8%) stddev-sans-first:3322.13 15:34:55 INFO - PROCESS | 1663 | Values: 1452.0 1626.7 1656.1 2013.6 2085.1 8398.3 9140.2 9276.2 9293.7 9306.5 8764.0 9009.5 9024.1 9024.5 9027.0 2580.3 2597.3 2597.4 2599.2 2607.0 2474.6 2554.9 2557.3 2559.2 2565.6 2577.6 2587.4 2616.6 2622.6 2625.8 2569.1 2590.8 2593.5 2598.6 2603.9 2555.3 2578.1 2585.3 2597.0 2607.9 9218.7 9270.3 9272.5 9277.9 9278.8 5643.5 5793.4 5803.9 5839.6 5863.7 3582.6 3713.3 3717.6 3740.5 3817.2 1074.1 1090.0 1096.2 1108.0 1128.5 12166.6 12349.6 12372.4 12389.0 12393.3 4185.7 5030.4 5077.7 5131.4 5137.0 10542.4 10593.5 10600.6 10600.9 10624.6 5836.9 5843.5 5846.8 5847.0 5856.5 4719.3 4796.9 4823.0 4833.6 5316.3 4051.3 4057.6 4134.2 4139.4 4155.7 1337.7 1362.4 1368.9 1376.6 1378.5 1164.4 1173.8 1180.7 1421.3 1470.3 8428.3 8502.5 8598.6 8606.2 8608.9 540.8 546.9 548.8 549.2 551.0 6338.9 6341.8 6393.5 6393.7 6398.2 10889.6 11410.7 11426.4 11432.4 11452.0 10502.6 10832.3 11217.4 11268.8 11270.3 7416.7 8546.9 8674.1 8687.0 8687.3 8366.8 8377.1 8438.0 8509.8 8531.4 8672.2 9764.7 9956.0 10068.6 10129.5 9828.0 10125.0 10338.1 10345.1 10451.5 7064.6 7250.1 7485.4 7719.5 7724.7 7993.5 8053.8 8341.6 8526.4 8555.9 7521.4 7624.2 7629.6 7744.2 7746.9 7433.9 7463.2 7510.1 7540.9 7591.1 7965.2 8023.5 8036.9 8040.5 8043.2 7319.0 7366.7 7402.1 7420.5 7448.8 7421.3 7444.8 7488.2 7500.7 7501.4 15:34:55 INFO - PROCESS | 1663 | 15:34:55 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5756.40 Median:6609.17 stddev:1820.97 (27.6%) stddev-sans-first:1780.08 15:34:55 INFO - PROCESS | 1663 | Values: 337.2 344.2 345.3 345.8 351.4 5469.0 6578.8 6590.8 6618.3 6643.7 6556.6 6601.3 6602.9 6613.9 6624.7 4705.3 4797.4 4801.8 4915.4 4962.1 4376.6 4595.8 4849.5 4892.5 4911.8 4802.6 4804.9 4818.0 4820.5 4833.6 4659.0 4725.6 4808.1 4861.3 4873.0 4170.5 4191.8 4199.4 4200.1 4205.7 6200.4 6224.2 6241.5 6267.4 6267.5 4981.4 5128.6 5755.5 5756.5 5770.5 6954.8 6965.8 6968.2 6999.6 7007.5 4580.7 4622.9 4673.6 4738.2 4767.6 6376.2 7293.4 7382.7 7385.9 7393.3 4280.7 4836.0 4840.1 4846.9 4859.2 4492.8 4613.0 4904.5 4918.6 4928.3 5732.8 5745.7 5748.8 5750.2 5772.2 6760.7 7006.7 7020.1 7094.8 7106.3 1676.8 1695.9 1709.6 1712.5 1715.6 897.9 1101.2 1113.0 1117.4 1127.5 6452.4 6626.3 6806.1 6907.0 6916.0 6199.0 7171.7 7267.7 7280.4 7297.2 5647.9 6694.4 6720.1 6721.2 6737.8 3784.4 3824.1 3827.3 3829.4 3842.9 7311.2 7646.6 7651.6 7670.1 7692.2 7489.1 7523.2 7531.7 7534.5 7543.2 6619.0 7377.6 7624.4 7643.4 7655.5 7103.4 7241.5 7246.9 7254.2 7257.9 7214.5 7216.3 7217.1 7242.4 7264.4 7691.7 7710.2 7712.5 7729.1 7734.5 4631.9 4667.3 4674.0 4675.6 4694.8 6934.5 7230.4 7232.4 7244.2 7259.8 5737.3 6994.8 7008.2 7026.7 7045.0 6947.6 6964.3 6978.1 7029.9 7037.2 6849.5 6854.5 6886.4 6902.3 6924.5 6767.5 6969.9 6976.9 6992.3 7028.5 6604.5 6716.4 6757.4 6878.7 6889.4 15:34:55 INFO - PROCESS | 1663 | 15:34:55 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:19374.37 Median:53709.73 stddev:27595.41 (51.4%) stddev-sans-first:27637.51 15:34:55 INFO - PROCESS | 1663 | Values: 782.3 797.2 802.6 806.6 810.1 14934.7 14964.9 15225.5 15250.5 15324.5 14612.3 14691.0 14696.3 14720.0 14726.6 816.0 828.2 967.8 999.0 999.8 981.3 981.5 982.1 982.9 989.1 1033.1 1033.1 1034.0 1034.1 1059.7 850.3 858.9 1023.6 1031.9 1053.5 780.4 785.1 786.8 786.8 789.5 15600.5 15695.8 15696.9 15713.1 15780.0 13276.5 13310.7 13339.7 13480.2 13515.4 10283.3 10356.9 10505.5 10597.6 10765.8 3633.8 3681.6 3754.6 3781.2 3912.0 87440.0 87846.0 88474.6 89374.6 89877.2 9712.9 9728.8 9779.1 10215.9 10660.8 21964.3 22039.0 22041.9 22070.0 22130.6 7718.8 7744.0 7769.4 7783.5 7900.9 4188.2 4217.0 4288.3 4294.1 4336.7 3723.9 3776.8 3778.7 3785.1 3809.5 609.5 663.1 671.4 672.5 673.6 587.2 626.1 635.3 639.0 665.1 8113.4 8355.2 8459.6 8468.4 8558.0 567.2 597.9 603.2 612.0 640.4 3884.7 3887.3 3890.9 3994.0 3999.2 93010.1 94256.5 96168.0 101746.0 101827.0 78327.2 81309.0 83733.0 85650.6 85792.7 74728.6 75463.0 75578.0 76649.6 76680.6 7041.4 7695.2 8412.9 8687.9 8883.3 52125.0 52184.5 53499.5 53920.0 54217.5 70195.6 72376.6 72520.3 73256.9 73545.6 11064.7 11139.7 11277.4 11300.6 11655.1 11963.9 12033.8 12176.9 12206.2 12456.4 11611.6 11646.0 11808.3 11850.3 12069.4 11515.5 11522.4 11593.5 11618.4 11660.8 11431.0 11448.5 11552.6 11829.8 12021.6 9658.4 9811.2 9838.6 9890.0 10148.3 9665.6 9865.4 9873.6 9879.2 9980.0 15:34:55 INFO - PROCESS | 1663 | -------- Summary: end -------- 15:34:55 INFO - PROCESS | 1663 | 15:34:56 INFO - TEST-INFO | 1663: exit 0 15:34:56 INFO - TEST-OK | dromaeo_css | took 1111775ms 15:34:56 INFO - TEST-START | kraken 15:34:56 INFO - operating with platform_type : mac_ 15:34:56 INFO - Initialising browser for kraken test... 15:34:56 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpH2L4k5/profile http://localhost:49275/getInfo.html) 15:34:57 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 15:34:57 INFO - PROCESS | 1675 | colorDepth:24 15:34:57 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 15:34:57 INFO - PROCESS | 1675 | __metrics 15:34:58 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:34:58 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:34:58 INFO - TEST-INFO | 1675: exit 0 15:34:58 INFO - Browser initialized. 15:34:58 INFO - Running cycle 1/1 for kraken test... 15:34:58 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpH2L4k5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:10 INFO - PROCESS | 1678 | RSS: Main: 157462528 15:35:10 INFO - PROCESS | 1678 | 15:35:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 15:35:13 INFO - PROCESS | 1678 | RSS: Main: 217952256 15:35:13 INFO - PROCESS | 1678 | 15:35:16 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 15:35:16 INFO - PROCESS | 1678 | RSS: Main: 228741120 15:35:16 INFO - PROCESS | 1678 | 15:35:19 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 15:35:20 INFO - PROCESS | 1678 | RSS: Main: 218419200 15:35:20 INFO - PROCESS | 1678 | 15:35:22 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 15:35:22 INFO - PROCESS | 1678 | RSS: Main: 219037696 15:35:22 INFO - PROCESS | 1678 | 15:35:24 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:35:25 INFO - PROCESS | 1678 | RSS: Main: 220192768 15:35:25 INFO - PROCESS | 1678 | 15:35:28 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 15:35:28 INFO - PROCESS | 1678 | RSS: Main: 220241920 15:35:28 INFO - PROCESS | 1678 | 15:35:31 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 15:35:32 INFO - PROCESS | 1678 | RSS: Main: 220520448 15:35:32 INFO - PROCESS | 1678 | 15:35:34 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 15:35:35 INFO - PROCESS | 1678 | RSS: Main: 220618752 15:35:35 INFO - PROCESS | 1678 | 15:35:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:35:37 INFO - PROCESS | 1678 | RSS: Main: 255418368 15:35:37 INFO - PROCESS | 1678 | 15:35:39 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:35:40 INFO - PROCESS | 1678 | RSS: Main: 256401408 15:35:40 INFO - PROCESS | 1678 | 15:35:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:35:42 INFO - PROCESS | 1678 | RSS: Main: 261406720 15:35:42 INFO - PROCESS | 1678 | 15:35:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:35:45 INFO - PROCESS | 1678 | RSS: Main: 262615040 15:35:45 INFO - PROCESS | 1678 | 15:35:48 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:35:48 INFO - PROCESS | 1678 | RSS: Main: 262651904 15:35:48 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 15:35:50 INFO - PROCESS | 1678 | RSS: Main: 325324800 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | __start_tp_report 15:35:50 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 15:35:50 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 15:35:50 INFO - PROCESS | 1678 | |i|pagename|runs| 15:35:50 INFO - PROCESS | 1678 | |0;ai-astar;112;111;111;112;111;111;129;111;110;111 15:35:50 INFO - PROCESS | 1678 | |1;audio-beat-detection;152;120;142;180;140;142;117;152;145;119 15:35:50 INFO - PROCESS | 1678 | |2;audio-dft;182;182;184;183;184;184;184;185;184;182 15:35:50 INFO - PROCESS | 1678 | |3;audio-fft;72;73;72;115;56;57;57;57;116;54 15:35:50 INFO - PROCESS | 1678 | |4;audio-oscillator;87;91;128;78;81;81;118;75;78;115 15:35:50 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;87;86;106;115;114;84;87;85;87;83 15:35:50 INFO - PROCESS | 1678 | |6;imaging-darkroom;93;94;94;94;93;94;93;93;93;92 15:35:50 INFO - PROCESS | 1678 | |7;imaging-desaturate;86;86;84;86;86;87;84;85;85;86 15:35:50 INFO - PROCESS | 1678 | |8;json-parse-financial;56;58;53;55;75;79;79;77;68;53 15:35:50 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;61;76;94;99;68;66;65;65;66;67 15:35:50 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;80;80;80;79;80;79;80;79;79;85 15:35:50 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;127;128;124;122;118;124;129;124;113;118 15:35:50 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;133;118;141;129;133;121;133;133;133;131 15:35:50 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;64;67;64;65;65;65;67;65;66;65 15:35:50 INFO - PROCESS | 1678 | __end_tp_report 15:35:50 INFO - PROCESS | 1678 | __start_cc_report 15:35:50 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1144 15:35:50 INFO - PROCESS | 1678 | __end_cc_report 15:35:50 INFO - PROCESS | 1678 | __startTimestamp1464302150836__endTimestamp 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | ------- Summary: start ------- 15:35:50 INFO - PROCESS | 1678 | Number of tests: 14 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:112.90 Median:111.00 stddev:5.69 (5.1%) stddev-sans-first:6.02 15:35:50 INFO - PROCESS | 1678 | Values: 112.0 111.0 111.0 112.0 111.0 111.0 129.0 111.0 110.0 111.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:143.50 stddev:19.10 (13.3%) stddev-sans-first:19.83 15:35:50 INFO - PROCESS | 1678 | Values: 152.0 120.0 142.0 180.0 140.0 142.0 117.0 152.0 145.0 119.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.07 (0.6%) stddev-sans-first:1.01 15:35:50 INFO - PROCESS | 1678 | Values: 182.0 182.0 184.0 183.0 184.0 184.0 184.0 185.0 184.0 182.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:72.90 Median:57.00 stddev:23.65 (41.5%) stddev-sans-first:25.08 15:35:50 INFO - PROCESS | 1678 | Values: 72.0 73.0 72.0 115.0 56.0 57.0 57.0 57.0 116.0 54.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:79.50 stddev:19.54 (24.6%) stddev-sans-first:20.59 15:35:50 INFO - PROCESS | 1678 | Values: 87.0 91.0 128.0 78.0 81.0 81.0 118.0 75.0 78.0 115.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:85.50 stddev:12.89 (15.1%) stddev-sans-first:13.46 15:35:50 INFO - PROCESS | 1678 | Values: 87.0 86.0 106.0 115.0 114.0 84.0 87.0 85.0 87.0 83.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:35:50 INFO - PROCESS | 1678 | Values: 93.0 94.0 94.0 94.0 93.0 94.0 93.0 93.0 93.0 92.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:0.97 (1.1%) stddev-sans-first:1.01 15:35:50 INFO - PROCESS | 1678 | Values: 86.0 86.0 84.0 86.0 86.0 87.0 84.0 85.0 85.0 86.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:71.50 stddev:11.36 (15.9%) stddev-sans-first:11.54 15:35:50 INFO - PROCESS | 1678 | Values: 56.0 58.0 53.0 55.0 75.0 79.0 79.0 77.0 68.0 53.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:67.50 stddev:13.15 (19.5%) stddev-sans-first:13.25 15:35:50 INFO - PROCESS | 1678 | Values: 61.0 76.0 94.0 99.0 68.0 66.0 65.0 65.0 66.0 67.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:1.79 (2.2%) stddev-sans-first:1.90 15:35:50 INFO - PROCESS | 1678 | Values: 80.0 80.0 80.0 79.0 80.0 79.0 80.0 79.0 79.0 85.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:124.00 stddev:5.06 (4.1%) stddev-sans-first:5.12 15:35:50 INFO - PROCESS | 1678 | Values: 127.0 128.0 124.0 122.0 118.0 124.0 129.0 124.0 113.0 118.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:130.50 Median:133.00 stddev:6.59 (5.0%) stddev-sans-first:6.92 15:35:50 INFO - PROCESS | 1678 | Values: 133.0 118.0 141.0 129.0 133.0 121.0 133.0 133.0 133.0 131.0 15:35:50 INFO - PROCESS | 1678 | 15:35:50 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.01 15:35:50 INFO - PROCESS | 1678 | Values: 64.0 67.0 64.0 65.0 65.0 65.0 67.0 65.0 66.0 65.0 15:35:50 INFO - PROCESS | 1678 | -------- Summary: end -------- 15:35:50 INFO - PROCESS | 1678 | 15:35:51 INFO - TEST-INFO | 1678: exit 0 15:35:51 INFO - TEST-OK | kraken | took 55506ms 15:35:51 INFO - SUITE-END | took 1167s 15:35:52 INFO - Completed test suite (00:19:27) 15:35:52 INFO - javascript benchmark 15:35:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3093.9071827845164, 3661.4873917651516, 3667.633236676331, 3678.448232765086, 3742.0083677825364, 5934.080217566273, 5943.197668314776, 5951.691785607342, 5966.731497082631, 6007.639541627505, 5936.0, 5988.401159884021, 6008.729607167677, 6011.639301641904, 6013.368596297391, 5236.607254455912, 5334.973325133378, 5377.704226267554, 5426.782928682848, 5442.156465747796, 5429.728513574325, 5448.046591846431, 5451.727413629303, 5458.645188062763, 5461.5357694596005, 5389.649672771257, 5400.29796126503, 5426.8914621707545, 5432.75552600134, 5435.565154787627, 5431.022415965124, 5443.618946673695, 5463.672179669193, 5473.808416705436, 5521.089020311644, 5208.140656791625, 5368.785248590052, 5389.461053894618, 5390.865228369283, 5413.242146099549, 5822.737976791054, 5856.853578660525, 5860.443257890493, 5882.617629854046, 5895.410458954113, 6272.404121608485, 6336.081268216083, 6338.778142764981, 6355.332690067568, 6358.046293056079, 5601.3558440779425, 6281.87436251277, 6301.8109456716375, 6320.399562041599, 6330.366963303679, 6015.669138197398, 6056.606320589148, 6059.818205453844, 6069.666168360783, 6071.423214794588, 5458.918116228259, 6383.808485745435, 6398.968005160037, 6401.487880969511, 6402.231732192074, 6261.123442718023, 6309.905351419732, 6318.147050148171, 6332.873342533216, 6333.240011198685, 5417.322834645669, 6336.52476064297, 6367.808965731036, 6385.074164246251, 6389.584676995981, 6290.308066112724, 6333.240011198685, 6340.334264902119, 6346.365363463617, 6358.682065896686, 5431.619786614899, 5614.101743720985, 6351.872962540723, 6362.204724409449, 6366.554341196164, 4688.718676879398, 5055.494450554915, 5085.95737873735, 5125.103106956268, 5137.0753264412015, 4556.567126123079, 4564.178447879413, 4566.8173273068705, 4570.794314255866, 4591.4260717410325, 6061.454469097803, 6064.211652485149, 6070.969645151746, 6083.969580152071, 6096.146539484475, 6239.625622462667, 6268.592541484789, 6269.8746025079245, 6270.686465676789, 6302.558820882494, 6137.0, 6165.445109940127, 6185.938140618626, 6186.381361863868, 6195.473384762256, 5512.6692398456225, 5608.186812912105, 5623.550115990793, 5623.606347555632, 5638.04153293941, 6413.486921046305, 6468.579542329733, 6552.410283074546, 6572.605643661395, 6575.835604109936, 6215.223097112861, 6255.999040153553, 6285.937140628718, 6289.371062893674, 6294.653794041372, 6556.803295901131, 6583.63789991555, 6598.769043083469, 6607.80176594703, 6618.271990080991, 6167.814965551041, 6185.8144255672405, 6239.78160764371, 6256.687165641791, 6275.246970363585, 6289.339619340087, 6289.748410063729, 6290.528210384148, 6294.590851594632, 6296.937030629635, 6159.29168145669, 6197.163382943425, 6214.130021797043, 6215.720292586754, 6221.3156552778255, 5839.29944382875, 6188.071789231652, 6246.125542424155, 6288.811335659938, 6300.338464461349, 5247.081760691787, 5627.577931655224, 6144.341027922525, 6194.721237544411, 6223.097650840693, 6188.535859810442, 6209.441150296495, 6264.906026409516, 6321.051842223703, 6335.746570137143, 6228.657423841732, 6257.405546473078, 6266.028765541349, 6266.185395898504, 6273.686315684289], "unit": "score", "name": "dojo.html", "value": 5855.074073016912}, {"lowerIsBetter": false, "replicates": [479.9952000479994, 580.4311774461028, 590.7282649981008, 650.6649075726001, 660.0330515794362, 39728.60271397289, 40206.0, 40221.3966790498, 40319.0, 40320.79839600798, 43701.562984370146, 44140.55859441405, 44215.55784442154, 44222.77888610552, 44400.77799611005, 9632.759181020478, 9848.0, 9861.60553577856, 9876.950615246913, 9891.0, 9681.225501959862, 9833.754156146082, 9857.556409961533, 9860.753481162992, 9946.15457686094, 9924.305298629099, 9989.150922171624, 10002.649907253248, 10002.699919002442, 10018.699439016804, 9886.604535818595, 9978.700638980843, 9983.251256155818, 9992.600295988152, 9996.950015249913, 9758.756031099208, 9893.950530247375, 9910.653127140515, 9911.851322230172, 9922.553485093189, 42161.57838421638, 42414.78792606017, 42443.151136977394, 42494.78752606248, 42499.150016999796, 3246.2371342734436, 3407.148212946763, 3450.189205536697, 3694.0026192927758, 3891.7859517726515, 28596.285092872637, 29429.411411771645, 29612.407751845058, 29655.25861853449, 30274.697253027407, 2732.5491293936475, 2784.8886044558194, 2820.0, 2840.4887120318335, 2882.7261410166, 499646.0, 500783.0, 501167.9883201158, 501982.99999999633, 503230.0, 46078.53921460809, 46968.5303146971, 63712.04431933525, 64345.0, 64372.678136609014, 46584.767076164404, 46856.29715554269, 46999.0, 47006.76496617495, 47034.76482617565, 16378.918105409635, 16707.49877503677, 16716.99698018123, 16719.91640041792, 16727.749083763752, 13337.599872003855, 13398.397072131778, 13427.597172084657, 13438.924886009096, 13440.663983400298, 14882.553523394316, 15249.23753812327, 15280.0, 15368.077915325117, 15383.538493845203, 6458.644774537445, 6549.9520076787485, 6593.901091483632, 6606.306337834554, 6613.5370524062855, 1001.7746007148334, 1054.7363159210197, 1055.7044027672264, 1146.9197156199152, 1164.301419148504, 26396.47207055848, 29903.850480747456, 30407.543886841715, 30415.78336866545, 31115.68884311128, 1160.5473865192582, 1190.1787766441128, 1192.469351138735, 1205.1443475132578, 1280.11032332528, 15383.0, 15452.381904723685, 15537.533873983799, 15749.291281892343, 15785.131817749905, 511411.0, 514745.0, 522547.0, 523948.0, 524680.0, 61825.690871546256, 62594.0, 62627.0, 62703.37296627067, 62714.372856271766, 1346.9663258418618, 1390.6662401023884, 1548.651553400476, 1580.5574439156824, 1592.6416556274978, 29455.11634650964, 29568.0, 29611.555826663047, 30305.0, 30377.544336835406, 46562.0, 46600.067998640516, 46815.0, 46843.29735053909, 46856.0, 374424.0, 382574.0, 383279.0, 384541.0, 385148.0, 34758.65241347655, 34988.0, 35669.286614267054, 35674.46488302729, 35738.0, 46035.30947035864, 46198.0, 46455.535444645124, 47575.28637070516, 48055.03889922252, 38100.61899380971, 38515.61484385232, 38780.224395511366, 38860.41709374418, 39458.80270598629, 38069.66756163521, 38141.809290953366, 38291.425628615034, 38350.23299534049, 38897.0, 37377.813110935356, 37730.0, 37831.43252851265, 39121.6087839118, 39621.60378396294, 33198.360327934024, 33355.666443336224, 34180.48729269113, 34335.82832085923, 34446.0, 25432.0, 25752.484950301263, 25775.0, 26239.73760262373, 26338.0], "unit": "score", "name": "ext.html", "value": 19805.73627241569}, {"lowerIsBetter": false, "replicates": [381.110107898058, 385.5623866911056, 387.42274011722526, 393.1233349630326, 393.66341777779996, 20625.17499300028, 21610.243641472553, 21935.0, 22190.445238869037, 22291.996860141313, 20781.896090519527, 20803.895980520116, 21543.24598639048, 22607.208747693832, 22612.75629840358, 6168.629882207082, 6169.2596888373455, 6230.750769969196, 6237.064440333964, 6248.937510624881, 6011.789587364443, 6151.169592105076, 6193.907091393633, 6210.658413787262, 6216.720247588847, 5827.883442331172, 6064.363241859607, 6160.722767475452, 6165.599236049642, 6167.352427995041, 6009.4591486766185, 6036.124761909498, 6053.485453736438, 6056.0613104969025, 6063.393660633946, 5229.581633469352, 5768.42315768424, 5784.595078344518, 5786.392428794958, 5897.616654917417, 14234.501792437319, 14265.857341426661, 14319.570412887526, 14451.71096578073, 14514.709705805824, 2174.521605246843, 2184.7815218478186, 2228.9108435662556, 2271.818254539633, 2335.229374306492, 10282.177425805918, 10716.892831071667, 10828.945855270753, 11343.489542970587, 15299.923500382538, 1716.9484915452556, 1756.9560760981078, 1790.7403426503083, 1817.5092724964186, 1850.6021205440761, 109190.45404772925, 113122.0, 115640.0, 116377.41811290974, 117748.0, 11173.217874748689, 11425.31448113116, 11493.0, 11495.310281383145, 11537.88462115385, 13246.536371226961, 14638.975271730877, 14657.413703451955, 14707.92646036763, 14714.0, 8277.54473503951, 8410.77114564641, 8815.779605509786, 9027.819443611092, 9084.40951338161, 7048.541844780073, 9187.954060229657, 9197.126273004054, 9253.814923701622, 9561.517964715342, 4486.461624605068, 4576.222042252825, 4603.723776573416, 4611.792469338888, 4640.883977900579, 1853.1012458957396, 1905.4759941016332, 1910.1595298068805, 1911.694128939363, 1913.87559808612, 934.490702567089, 972.5720682899502, 976.9902300977042, 1005.8390657494766, 1044.5665049004579, 20214.898925505277, 20778.688319675217, 20786.856722880388, 20954.580908382053, 21049.84252362158, 1000.5347513406156, 1022.197574903697, 1044.3211912257093, 1050.8423736439443, 1082.6697857153486, 8980.730578082668, 10025.548850301608, 11364.977152056355, 11371.374574398322, 11408.429578521042, 662835.0, 686296.0, 702115.0, 725627.0, 726340.0, 117599.0, 118087.0, 122458.0, 122795.77204228022, 123272.38363808124, 1082.875469321038, 1092.939888306135, 1131.9207655464038, 1152.5389844062443, 1152.8904754048351, 18004.708093222267, 18759.15583798705, 18811.529711757317, 18939.90530047341, 19165.808341916403, 53421.46578534321, 54721.1791823115, 54763.0, 55975.0, 56094.0, 77941.61029195045, 78989.60505197437, 80877.0, 80935.0, 81813.77279340696, 8272.710455134042, 8378.748637540639, 8396.202360775716, 8563.229309362187, 8685.91314086851, 11338.433078346216, 13599.932000339935, 13653.590392288248, 13905.37425815861, 13991.58025259244, 11663.475143618387, 11752.911543928709, 11900.523979040741, 12132.029437645144, 12185.817212741993, 11542.653720388402, 11779.998700110244, 11957.282563046245, 11967.820482692592, 12091.75816483683, 11535.76928461443, 11865.347405892759, 12061.0, 12175.025997919967, 12175.634730958085, 8171.509709417454, 8367.707130250412, 8525.10486398944, 8668.696595619123, 8766.386352955233, 11013.229073965065, 11599.594014209462, 11787.0, 11962.222455540363, 12018.699532511757], "unit": "score", "name": "jquery.html", "value": 9761.50055784169}, {"lowerIsBetter": false, "replicates": [1451.9564413067599, 1626.6584017356354, 1656.1470842516103, 2013.6375452418567, 2085.0929845517194, 8398.3281337493, 9140.177384035436, 9276.165145136936, 9293.674721384745, 9306.488143152124, 8763.956180219106, 9009.549522523865, 9024.097590240988, 9024.458532488055, 9027.0, 2580.251726999168, 2597.2727636261784, 2597.4155814941582, 2599.2332261982665, 2607.0223666125203, 2474.604063349864, 2554.859482728449, 2557.258395065429, 2559.2322303309024, 2565.576679847823, 2577.6262441946, 2587.3531617095728, 2616.6467526883816, 2622.5672763993916, 2625.7636812686856, 2569.11365578875, 2590.779783718386, 2593.455374371384, 2598.558245098338, 2603.869806509667, 2555.310066282112, 2578.1363243313513, 2585.31489155374, 2596.9870150649313, 2607.8565678887653, 9218.677346292847, 9270.258379329638, 9272.490013049279, 9277.860832087525, 9278.814423711556, 5643.520300774439, 5793.449622285876, 5803.912941305884, 5839.562032847511, 5863.706814659293, 3582.623824498416, 3713.3130370881204, 3717.646823551758, 3740.4950331705145, 3817.1983883384523, 1074.0923919288189, 1089.983650245247, 1096.1614365010773, 1107.9612213572486, 1128.531659361364, 12166.635000949986, 12349.629511114592, 12372.381380931007, 12389.0, 12393.318367489785, 4185.727927684691, 5030.3963524377305, 5077.720725360141, 5131.384233891957, 5136.974315128476, 10542.42016689074, 10593.470326483799, 10600.628977985734, 10600.946995264974, 10624.575016999388, 5836.941630583725, 5843.5325173985975, 5846.766129354864, 5847.0, 5856.502197313191, 4719.339292499053, 4796.904061918742, 4822.95177048225, 4833.613310935117, 5316.255724198615, 4051.2910240707756, 4057.634812866856, 4134.235166494208, 4139.441175441337, 4155.667546596265, 1337.6923307639104, 1362.3801170467414, 1368.8973327000515, 1376.6351916742071, 1378.4830688491816, 1164.3828770751516, 1173.7711146326385, 1180.6871179137536, 1421.3390773290469, 1470.3089547912464, 8428.32573394127, 8502.532360720095, 8598.5700714964, 8606.182412670787, 8608.91391086081, 540.8269353806822, 546.9015577196063, 548.8216329692866, 549.2365611799602, 551.0439387662402, 6338.936610633927, 6341.841453963688, 6393.456556192776, 6393.744250230032, 6398.232212134573, 10889.618863339745, 11410.714732131597, 11426.371549564687, 11432.428378581038, 11452.0, 10502.579896804195, 10832.295900766425, 11217.439128043565, 11268.774624507463, 11270.267432616854, 7416.666250018762, 8546.914530854736, 8674.132586741276, 8686.95656521726, 8687.261582765535, 8366.832663346577, 8377.078521362524, 8437.95781021091, 8509.829803404022, 8531.360147988802, 8672.219500245008, 9764.707058788248, 9956.0, 10068.647597334058, 10129.544170512198, 9827.950860245654, 10125.038121378457, 10338.0695737384, 10345.120664743581, 10451.529681164518, 7064.576125432491, 7250.057492525938, 7485.438592105723, 7719.459637825298, 7724.729634462767, 7993.520388776459, 8053.758387248392, 8341.624626891684, 8526.445781024213, 8555.914440855511, 7521.435892308208, 7624.161342252459, 7629.618519074135, 7744.225577442436, 7746.883796742941, 7433.851322973402, 7463.2163622818825, 7510.098788145458, 7540.886886696813, 7591.127020392505, 7965.203479651988, 8023.4784738991775, 8036.87944680842, 8040.517568945882, 8043.235892590194, 7319.048523691886, 7366.7053317866685, 7402.1117465904435, 7420.480566360519, 7448.813779655552, 7421.2949769771785, 7444.813879653052, 7488.176300607038, 7500.699972001277, 7501.362384197186], "unit": "score", "name": "mootools.html", "value": 5043.188257271837}, {"lowerIsBetter": false, "replicates": [337.1671970233523, 344.18256640478864, 345.26803177264196, 345.78561291998966, 351.44998078007916, 5468.9726551367185, 6578.835529111775, 6590.769323073693, 6618.30507796681, 6643.734250629969, 6556.573822701521, 6601.273859875422, 6602.867942641156, 6613.867722645544, 6624.668766561665, 4705.294205869112, 4797.448293446246, 4801.8079276828885, 4915.3855768029, 4962.131626965275, 4376.606105450509, 4595.75914503084, 4849.466558678542, 4892.510748925097, 4911.778969946361, 4802.615790736751, 4804.90390192196, 4818.0, 4820.493848145947, 4833.564979151875, 4658.976705116453, 4725.574698277172, 4808.134535783557, 4861.343718597979, 4873.0, 4170.457840480748, 4191.790410479494, 4199.4330765346895, 4200.096979149467, 4205.663546916239, 6200.379962003809, 6224.159738435299, 6241.500679945593, 6267.4045965633195, 6267.529935254828, 4981.427135879384, 5128.589712823003, 5755.539556835443, 5756.510696590794, 5770.480656740871, 6954.756583519553, 6965.79102626922, 6968.163820341591, 6999.580025198505, 7007.544509606911, 4580.725156490588, 4622.884427889329, 4673.6027437667835, 4738.194506933795, 4767.61859051275, 6376.234851817811, 7293.380062694678, 7382.667779949915, 7385.9261407385775, 7393.334599885982, 4280.743155410685, 4835.95164048362, 4840.080384726891, 4846.878828029327, 4859.246816743411, 4492.797824097924, 4612.976935115303, 4904.4605093439695, 4918.606511479073, 4928.324369714314, 5732.77068917247, 5745.68398738065, 5748.798792042258, 5750.166225897222, 5772.163036359704, 6760.7295708172105, 7006.719731210796, 7020.087388639547, 7094.751683691046, 7106.324899134574, 1676.79040119985, 1695.8643308535534, 1709.6153365492664, 1712.4605749188966, 1715.622563036155, 897.8742975983367, 1101.1851230089676, 1112.9777404452027, 1117.3686866920164, 1127.5095333529941, 6452.354764523604, 6626.304238054935, 6806.0865002622695, 6906.965465172642, 6915.965420172867, 6199.039148931923, 7171.677274522659, 7267.672954716944, 7280.41756659466, 7297.197308296083, 5647.858803529863, 6694.364035416627, 6720.092787473726, 6721.22705888829, 6737.831554211086, 3784.394496880486, 3824.0822202671156, 3827.2919509890758, 3829.4255861620422, 3842.9231415372096, 7311.195768465464, 7646.617669116522, 7651.579163145969, 7670.117936437269, 7692.192319806451, 7489.063867016623, 7523.172451030382, 7531.736389226351, 7534.472586918972, 7543.245675432413, 6619.007148927795, 7377.631118443949, 7624.42816788743, 7643.388528917673, 7655.540667559852, 7103.360697537247, 7241.456890733321, 7246.89129663066, 7254.16577093641, 7257.854842903218, 7214.531055481377, 7216.278372162742, 7217.06178196831, 7242.420606351374, 7264.382527485223, 7691.730789422343, 7710.190430004769, 7712.460127791001, 7729.111152217567, 7734.5359278443475, 4631.884202894955, 4667.253239481666, 4674.018456124252, 4675.555822196886, 4694.812207511662, 6934.479914006369, 7230.42156627479, 7232.42140628759, 7244.239354867663, 7259.818504537428, 5737.311522617312, 6994.755183568551, 7008.22909479967, 7026.718931242897, 7045.0, 6947.583145011114, 6964.303569642995, 6978.127734033246, 7029.929700702927, 7037.225905150327, 6849.48628852848, 6854.520183587101, 6886.414654754402, 6902.309769023058, 6924.549904256207, 6767.458603311625, 6969.860602788017, 6976.930230697831, 6992.3357281058215, 7028.50800443964, 6604.471642268511, 6716.3955244028275, 6757.425618822259, 6878.7248510059035, 6889.414399775875], "unit": "score", "name": "prototype.html", "value": 5155.586978191699}, {"lowerIsBetter": false, "replicates": [782.2529484342457, 797.2027972027972, 802.6307898366751, 806.6168569929281, 810.0846043970313, 14934.701305973875, 14964.925175374121, 15225.467108651199, 15250.542483725492, 15324.54026379209, 14612.342444589993, 14690.971631985765, 14696.338664760086, 14720.0, 14726.63183420415, 815.9510429374257, 828.1511450762986, 967.830629639812, 998.9700308990742, 999.8400255959048, 981.2591493422456, 981.4994352880046, 982.135720565901, 982.8722266105397, 989.1295659819385, 1033.0805583031108, 1033.101201954301, 1033.9638112666057, 1034.1261633919326, 1059.6767985764338, 850.2900078434484, 858.9141085891423, 1023.5701005577638, 1031.9226058045676, 1053.531178625512, 780.3834970373398, 785.1363500149847, 786.7679034684782, 786.7757689058648, 789.4631650477672, 15600.531984040497, 15695.764563531442, 15696.921515392463, 15713.05721656693, 15780.0, 13276.46894124234, 13310.733785324335, 13339.733205335937, 13480.191188528719, 13515.391807368693, 10283.280170388076, 10356.948215258875, 10505.52725127371, 10597.576096956112, 10765.784684306349, 3633.8364773585254, 3681.5582130144553, 3754.6433088856515, 3781.2059467511854, 3912.0219945013746, 87440.0, 87846.0, 88474.5576272121, 89374.5531272346, 89877.20245595051, 9712.854307185398, 9728.75678108053, 9779.119879210763, 10215.94892025535, 10660.840087398696, 21964.341069767932, 22039.0, 22041.89790510468, 22070.0, 22130.557388852132, 7718.773373223635, 7743.9612801936755, 7769.3784497240085, 7783.532988020737, 7900.881486777703, 4188.204241194224, 4216.978915105405, 4288.292431748727, 4294.055307832272, 4336.6530677545725, 3723.8510459581853, 3776.773393596393, 3778.6977041837135, 3785.091578021255, 3809.504764380613, 609.4819403506983, 663.1279866974912, 671.375620672779, 672.4721093941331, 673.5520878615665, 587.2395248153651, 626.0921663587816, 635.259922190652, 638.9808255832033, 665.112075379374, 8113.432059755878, 8355.164483551718, 8459.619317130744, 8468.364872634455, 8557.957210214034, 567.2172402085096, 597.8654802669365, 603.2188316130621, 612.0421540289433, 640.3724350136799, 3884.7280690351404, 3887.261420330128, 3890.9416358754643, 3993.9600603994168, 3999.24014437256, 93010.0698993015, 94256.52871735598, 96168.03831961591, 101746.0, 101827.0, 78327.216727832, 81309.0, 83733.0, 85650.57174714087, 85792.71310930341, 74728.62635686896, 75463.0, 75578.0, 76649.616751917, 76680.61659691777, 7041.401480874183, 7695.2304769524835, 8412.915870841458, 8687.913120868963, 8883.333749968908, 52124.957500849014, 52184.47815521796, 53499.46500534945, 53920.0, 54217.45782542124, 70195.64902175457, 72376.63811680907, 72520.27479725135, 73256.90114648391, 73545.6322718383, 11064.668059958214, 11139.72150696239, 11277.436128193722, 11300.604478843201, 11655.125865559947, 11963.940180299043, 12033.819492707791, 12176.878231217928, 12206.206596571194, 12456.43946022413, 11611.593594224161, 11645.995791558362, 11808.291502509877, 11850.348230847387, 12069.39653017328, 11515.481803319039, 11522.366269855238, 11593.5362585499, 11618.419079046183, 11660.766784664429, 11431.0, 11448.484818183368, 11552.59565915189, 11829.822552661544, 12021.579244726392, 9658.3722058066, 9811.215102791903, 9838.557264923238, 9889.950550247202, 10148.340357876714, 9665.613375464902, 9865.358751681119, 9873.605055797687, 9879.160271377013, 9979.950100249453], "unit": "score", "name": "yui.html", "value": 7236.768563729416}], "name": "dromaeo_css", "value": 7727.997136442979}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 111.0, 112.0, 111.0, 111.0, 129.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [152.0, 120.0, 142.0, 180.0, 140.0, 142.0, 117.0, 152.0, 145.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 140.9}, {"lowerIsBetter": true, "replicates": [182.0, 182.0, 184.0, 183.0, 184.0, 184.0, 184.0, 185.0, 184.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 115.0, 56.0, 57.0, 57.0, 57.0, 116.0, 54.0], "unit": "score", "name": "audio-fft", "value": 72.9}, {"lowerIsBetter": true, "replicates": [87.0, 91.0, 128.0, 78.0, 81.0, 81.0, 118.0, 75.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 93.2}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 106.0, 115.0, 114.0, 84.0, 87.0, 85.0, 87.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 93.3}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 84.0, 86.0, 86.0, 87.0, 84.0, 85.0, 85.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.5}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 53.0, 55.0, 75.0, 79.0, 79.0, 77.0, 68.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 65.3}, {"lowerIsBetter": true, "replicates": [61.0, 76.0, 94.0, 99.0, 68.0, 66.0, 65.0, 65.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.7}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 80.0, 79.0, 80.0, 79.0, 80.0, 79.0, 79.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.1}, {"lowerIsBetter": true, "replicates": [127.0, 128.0, 124.0, 122.0, 118.0, 124.0, 129.0, 124.0, 113.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [133.0, 118.0, 141.0, 129.0, 133.0, 121.0, 133.0, 133.0, 133.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 130.5}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 64.0, 65.0, 65.0, 65.0, 67.0, 65.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.3}], "name": "kraken", "value": 1412.1}]} 15:35:52 INFO - Return code: 0 15:35:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:35:52 INFO - # TBPL SUCCESS # 15:35:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:35:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:35:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:35:52 INFO - 2016-05-26 15:35:52.166 screenresolution[1682:9974] starting screenresolution argv=screenresolution get 15:35:52 INFO - 2016-05-26 15:35:52.169 screenresolution[1682:9974] Display 0: 1600x1200x32@60 15:35:52 INFO - 2016-05-26 15:35:52.175 screenresolution[1683:9977] starting screenresolution argv=screenresolution list 15:35:52 INFO - Available Modes on Display 0 15:35:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:35:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:35:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:35:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:35:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:35:52 INFO - Intel Iris: 15:35:52 INFO - Chipset Model: Intel Iris 15:35:52 INFO - Type: GPU 15:35:52 INFO - Bus: Built-In 15:35:52 INFO - VRAM (Dynamic, Max): 1536 MB 15:35:52 INFO - Vendor: Intel (0x8086) 15:35:52 INFO - Device ID: 0x0a2e 15:35:52 INFO - Revision ID: 0x0009 15:35:52 INFO - Displays: 15:35:52 INFO - Display: 15:35:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:35:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:35:52 INFO - Display Serial Number: 1600x1200 60 15:35:52 INFO - Main Display: Yes 15:35:52 INFO - Mirror: Off 15:35:52 INFO - Online: Yes 15:35:52 INFO - Rotation: Supported 15:35:52 INFO - Return code: 0 15:35:52 INFO - Running post-action listener: _resource_record_post_action 15:35:52 INFO - Running post-run listener: _resource_record_post_run 15:35:53 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 36906496; Write bytes: 508102144; Read time: 242; Write time: 1540 15:35:53 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 196852224; Write bytes: 198182400; Read time: 18036; Write time: 413 15:35:53 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 35976704; Write bytes: 299958272; Read time: 229; Write time: 1093 15:35:53 INFO - Running post-run listener: _upload_blobber_files 15:35:53 INFO - Blob upload gear active. 15:35:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:35:53 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:35:53 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:35:53 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:35:53 INFO - (blobuploader) - INFO - Open directory for files ... 15:35:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:35:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:35:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:55 INFO - (blobuploader) - INFO - Done attempting. 15:35:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:35:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:35:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:56 INFO - (blobuploader) - INFO - Done attempting. 15:35:56 INFO - (blobuploader) - INFO - Iteration through files over. 15:35:56 INFO - Return code: 0 15:35:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:35:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:35:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4a776e4211aab64df79b9a9b79da8832536735f548b100a2280f74660ba3d9f7b49eb7b7ab563437e5b4ee14bbaad190e1ddac93b134e2b0e16638cf339df383", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3803cce1d6333c2b2418be1da4c491fe4a5f04729677621099ea3307d36e83127b9cc47e1cc07fb88aebde3ab233d773a9706f79b7cbd6ab07557c1d51218fb"} 15:35:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:35:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:35:56 INFO - Contents: 15:35:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4a776e4211aab64df79b9a9b79da8832536735f548b100a2280f74660ba3d9f7b49eb7b7ab563437e5b4ee14bbaad190e1ddac93b134e2b0e16638cf339df383", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3803cce1d6333c2b2418be1da4c491fe4a5f04729677621099ea3307d36e83127b9cc47e1cc07fb88aebde3ab233d773a9706f79b7cbd6ab07557c1d51218fb"} 15:35:56 INFO - Running post-run listener: copy_logs_to_upload_dir 15:35:56 INFO - Copying logs to upload dir... 15:35:56 INFO - mkdir: /builds/slave/test/build/upload/logs 15:35:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.333981 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-26 15:35:56.407475) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 15:35:56.412356) ========= 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.lTBwERZvZd/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.b0FNSDEFrA/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4a776e4211aab64df79b9a9b79da8832536735f548b100a2280f74660ba3d9f7b49eb7b7ab563437e5b4ee14bbaad190e1ddac93b134e2b0e16638cf339df383", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3803cce1d6333c2b2418be1da4c491fe4a5f04729677621099ea3307d36e83127b9cc47e1cc07fb88aebde3ab233d773a9706f79b7cbd6ab07557c1d51218fb"} build_url:https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010859 build_url: 'https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4a776e4211aab64df79b9a9b79da8832536735f548b100a2280f74660ba3d9f7b49eb7b7ab563437e5b4ee14bbaad190e1ddac93b134e2b0e16638cf339df383", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3803cce1d6333c2b2418be1da4c491fe4a5f04729677621099ea3307d36e83127b9cc47e1cc07fb88aebde3ab233d773a9706f79b7cbd6ab07557c1d51218fb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 15:35:56.443777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 15:35:56.444115) ========= 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.lTBwERZvZd/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.b0FNSDEFrA/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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.005004 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 15:35:56.492750) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 15:35:56.493072) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 15:35:56.493396) ========= ========= Total master_lag: 2.53 =========