builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0116 starttime: 1463431736.89 results: success (0) buildid: 20160516124143 builduid: 3a25a15ff16c4b0cb6e450f554c3ebd7 revision: 17724486e1591858eea09dc327475a25883854a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 13:48:56.891042) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 13:48:56.891408) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-05-16 13:48:56.891670) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-05-16 13:48:59.770901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 13:48:59.771321) ========= 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.61EbGqIk7y/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.WolwrQkj9C/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-16 13:48:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 203M=0s 2016-05-16 13:48:59 (203 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120141 ========= master_lag: 1.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 13:49:00.933619) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 13:49:00.937992) ========= 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.61EbGqIk7y/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.WolwrQkj9C/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.028788 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 13:49:00.992236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 13:49:00.992574) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 17724486e1591858eea09dc327475a25883854a4 --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-aurora --rev 17724486e1591858eea09dc327475a25883854a4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.61EbGqIk7y/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.WolwrQkj9C/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-16 13:49:01,074 truncating revision to first 12 chars 2016-05-16 13:49:01,074 Setting DEBUG logging. 2016-05-16 13:49:01,074 attempt 1/10 2016-05-16 13:49:01,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/17724486e159?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 13:49:02,163 unpacking tar archive at: mozilla-aurora-17724486e159/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331806 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 13:49:02.347641) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 13:49:02.349581) ========= script_repo_revision: 17724486e1591858eea09dc327475a25883854a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 13:49:02.350033) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 13:49:02.350301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 13:49:02.368943) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-16 13:49:02.369331) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.61EbGqIk7y/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.WolwrQkj9C/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 13:49:02 INFO - MultiFileLogger online at 20160516 13:49:02 in /builds/slave/test 13:49:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:49:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:49:02 INFO - {'append_to_log': False, 13:49:02 INFO - 'base_work_dir': '/builds/slave/test', 13:49:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:49:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:49:02 INFO - 'branch': 'Mozilla-Aurora', 13:49:02 INFO - 'buildbot_json_path': 'buildprops.json', 13:49:02 INFO - 'config_files': ('talos/mac_config.py',), 13:49:02 INFO - 'default_actions': ('clobber', 13:49:02 INFO - 'read-buildbot-config', 13:49:02 INFO - 'download-and-extract', 13:49:02 INFO - 'populate-webroot', 13:49:02 INFO - 'create-virtualenv', 13:49:02 INFO - 'install', 13:49:02 INFO - 'run-tests'), 13:49:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:49:02 INFO - 'download_minidump_stackwalk': True, 13:49:02 INFO - 'download_symbols': 'ondemand', 13:49:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:49:02 INFO - 'tooltool.py': '/tools/tooltool.py', 13:49:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:49:02 INFO - '/tools/misc-python/virtualenv.py')}, 13:49:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:49:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:49:02 INFO - 'installer_path': 'installer.exe', 13:49:02 INFO - 'log_level': 'info', 13:49:02 INFO - 'log_name': 'talos', 13:49:02 INFO - 'log_to_console': True, 13:49:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:49:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:49:02 INFO - 'opt_config_files': (), 13:49:02 INFO - 'pip_index': False, 13:49:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:49:02 INFO - 'cmd': ('bash', 13:49:02 INFO - '-c', 13:49:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:49:02 INFO - 'enabled': True, 13:49:02 INFO - 'halt_on_failure': False, 13:49:02 INFO - 'name': 'check_screen_resolution'},), 13:49:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:49:02 INFO - 'cmd': ('bash', 13:49:02 INFO - '-c', 13:49:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:49:02 INFO - 'enabled': True, 13:49:02 INFO - 'halt_on_failure': False, 13:49:02 INFO - 'name': 'check_screen_resolution'},), 13:49:02 INFO - 'run_cmd_checks_enabled': True, 13:49:02 INFO - 'sps_profile': False, 13:49:02 INFO - 'sps_profile_interval': 0, 13:49:02 INFO - 'suite': 'dromaeojs', 13:49:02 INFO - 'system_bits': '32', 13:49:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:49:02 INFO - 'title': 't-yosemite-r7-0116', 13:49:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:49:02 INFO - 'use_talos_json': True, 13:49:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:49:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:49:02 INFO - 'work_dir': 'build'} 13:49:02 INFO - ##### 13:49:02 INFO - ##### Running clobber step. 13:49:02 INFO - ##### 13:49:02 INFO - Running pre-action listener: _resource_record_pre_action 13:49:02 INFO - Running main action method: clobber 13:49:02 INFO - rmtree: /builds/slave/test/build 13:49:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:49:04 INFO - Running post-action listener: _resource_record_post_action 13:49:04 INFO - ##### 13:49:04 INFO - ##### Running read-buildbot-config step. 13:49:04 INFO - ##### 13:49:04 INFO - Running pre-action listener: _resource_record_pre_action 13:49:04 INFO - Running main action method: read_buildbot_config 13:49:04 INFO - Using buildbot properties: 13:49:04 INFO - { 13:49:04 INFO - "project": "", 13:49:04 INFO - "product": "firefox", 13:49:04 INFO - "script_repo_revision": "production", 13:49:04 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:49:04 INFO - "repository": "", 13:49:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:49:04 INFO - "buildid": "20160516124143", 13:49:04 INFO - "pgo_build": "False", 13:49:04 INFO - "basedir": "/builds/slave/test", 13:49:04 INFO - "buildnumber": 343, 13:49:04 INFO - "slavename": "t-yosemite-r7-0116", 13:49:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:49:04 INFO - "platform": "yosemite_r7", 13:49:04 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:49:04 INFO - "branch": "mozilla-aurora", 13:49:04 INFO - "repo_path": "releases/mozilla-aurora", 13:49:04 INFO - "revision": "17724486e1591858eea09dc327475a25883854a4", 13:49:04 INFO - "stage_platform": "macosx64", 13:49:04 INFO - "builduid": "3a25a15ff16c4b0cb6e450f554c3ebd7", 13:49:04 INFO - "slavebuilddir": "test" 13:49:04 INFO - } 13:49:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 13:49:04 INFO - Running post-action listener: _resource_record_post_action 13:49:04 INFO - ##### 13:49:04 INFO - ##### Running download-and-extract step. 13:49:04 INFO - ##### 13:49:04 INFO - Running pre-action listener: _resource_record_pre_action 13:49:04 INFO - Running main action method: download_and_extract 13:49:04 INFO - mkdir: /builds/slave/test/build/tests 13:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:04 INFO - https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:49:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 13:49:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 13:49:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 13:49:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 13:49:06 INFO - Downloaded 1199 bytes. 13:49:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 13:49:06 INFO - Using the following test package requirements: 13:49:06 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 13:49:06 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:49:06 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 13:49:06 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:49:06 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 13:49:06 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:49:06 INFO - u'jsshell-mac.zip'], 13:49:06 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:49:06 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 13:49:06 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 13:49:06 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:49:06 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 13:49:06 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:49:06 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 13:49:06 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:49:06 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 13:49:06 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:49:06 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 13:49:06 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:06 INFO - https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:49:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 13:49:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 13:49:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 13:49:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:49:08 INFO - Downloaded 18102374 bytes. 13:49:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:49:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:49:11 INFO - Return code: 0 13:49:11 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:11 INFO - https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:49:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 13:49:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 13:49:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 13:49:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:49:12 INFO - Downloaded 18102374 bytes. 13:49:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:49:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:49:16 INFO - Return code: 0 13:49: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')]} 13:49:16 INFO - https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:49:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 13:49:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 13:49:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 13:49:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:49:17 INFO - Downloaded 10840145 bytes. 13:49:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:49:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:49:17 INFO - Return code: 0 13:49:17 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')]} 13:49:17 INFO - https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 13:49:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 13:49:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 13:49:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 13:49:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 13:49:20 INFO - Downloaded 114126469 bytes. 13:49:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 13:49:20 INFO - mkdir: /builds/slave/test/properties 13:49:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:49:20 INFO - Writing to file /builds/slave/test/properties/build_url 13:49:20 INFO - Contents: 13:49:20 INFO - build_url:https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 13:49:22 INFO - Running post-action listener: _resource_record_post_action 13:49:22 INFO - Running post-action listener: set_extra_try_arguments 13:49:22 INFO - ##### 13:49:22 INFO - ##### Running populate-webroot step. 13:49:22 INFO - ##### 13:49:22 INFO - Running pre-action listener: _resource_record_pre_action 13:49:22 INFO - Running main action method: populate_webroot 13:49:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:49:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:49:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:49:22 INFO - '--tppagecycles', 13:49:22 INFO - '7'], 13:49:22 INFO - 'tests': ['tsvgm']}}, 13:49:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:49:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:49:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:49:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:49:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:49:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:49:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:22 INFO - 'talos_options': ['--disable-e10s'], 13:49:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:22 INFO - 'talos_options': ['--disable-e10s'], 13:49:22 INFO - 'tests': ['damp', 'tps']}, 13:49:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:22 INFO - 'tests': ['damp', 'tps']}, 13:49:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:49:22 INFO - 'tests': ['dromaeo_dom']}, 13:49:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:49:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:49:22 INFO - 'tests': ['a11yr', 13:49:22 INFO - 'ts_paint', 13:49:22 INFO - 'tpaint', 13:49:22 INFO - 'sessionrestore', 13:49:22 INFO - 'sessionrestore_no_auto_restore', 13:49:22 INFO - 'tabpaint']}, 13:49:22 INFO - 'other-e10s': {'tests': ['a11yr', 13:49:22 INFO - 'ts_paint', 13:49:22 INFO - 'tpaint', 13:49:22 INFO - 'sessionrestore', 13:49:22 INFO - 'sessionrestore_no_auto_restore', 13:49:22 INFO - 'tabpaint']}, 13:49:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:49:22 INFO - 'ts_paint', 13:49:22 INFO - 'tpaint', 13:49:22 INFO - 'sessionrestore', 13:49:22 INFO - 'sessionrestore_no_auto_restore', 13:49:22 INFO - 'tabpaint']}, 13:49:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:49:22 INFO - 'ts_paint', 13:49:22 INFO - 'tpaint', 13:49:22 INFO - 'sessionrestore', 13:49:22 INFO - 'sessionrestore_no_auto_restore', 13:49:22 INFO - 'tabpaint']}, 13:49:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:49:22 INFO - 'tests': ['a11yr', 13:49:22 INFO - 'ts_paint', 13:49:22 INFO - 'tpaint', 13:49:22 INFO - 'sessionrestore', 13:49:22 INFO - 'sessionrestore_no_auto_restore', 13:49:22 INFO - 'tabpaint']}, 13:49:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:49:22 INFO - 'tests': ['a11yr', 13:49:22 INFO - 'ts_paint', 13:49:22 INFO - 'tpaint', 13:49:22 INFO - 'sessionrestore', 13:49:22 INFO - 'sessionrestore_no_auto_restore', 13:49:22 INFO - 'tabpaint']}, 13:49:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:49:22 INFO - 'tests': ['tsvgx', 13:49:22 INFO - 'tsvgr_opacity', 13:49:22 INFO - 'tart', 13:49:22 INFO - 'tscrollx', 13:49:22 INFO - 'cart']}, 13:49:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:49:22 INFO - 'tsvgr_opacity', 13:49:22 INFO - 'tart', 13:49:22 INFO - 'tscrollx', 13:49:22 INFO - 'cart']}, 13:49:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:22 INFO - 'talos_options': ['--disable-e10s'], 13:49:22 INFO - 'tests': ['tp5o']}, 13:49:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:22 INFO - 'tests': ['tp5o']}, 13:49:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:22 INFO - 'talos_options': ['--disable-e10s', 13:49:22 INFO - '--xperf_path', 13:49:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:22 INFO - 'tests': ['tp5n']}, 13:49:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:22 INFO - 'talos_options': ['--xperf_path', 13:49:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:22 INFO - 'tests': ['tp5n']}}, 13:49:22 INFO - 'talos.zip': {'path': '', 13:49:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:49:22 INFO - Running post-action listener: _resource_record_post_action 13:49:22 INFO - ##### 13:49:22 INFO - ##### Running create-virtualenv step. 13:49:22 INFO - ##### 13:49:22 INFO - Running pre-action listener: _resource_record_pre_action 13:49:22 INFO - Running main action method: create_virtualenv 13:49:22 INFO - Creating virtualenv /builds/slave/test/build/venv 13:49:22 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 13:49:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:49:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:49:22 INFO - Using real prefix '/tools/python27' 13:49:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:49:23 INFO - Installing distribute.............................................................................................................................................................................................done. 13:49:26 INFO - Installing pip.................done. 13:49:26 INFO - Return code: 0 13:49:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710d99820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107341e00>, '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 0x1071aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10733cb20>, '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.61EbGqIk7y/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.WolwrQkj9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 13:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:49:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EbGqIk7y/Render', 13:49:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:26 INFO - 'HOME': '/Users/cltbld', 13:49:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:26 INFO - 'LOGNAME': 'cltbld', 13:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:26 INFO - 'MOZ_NO_REMOTE': '1', 13:49:26 INFO - 'NO_EM_RESTART': '1', 13:49:26 INFO - 'PAGER': '/bin/cat', 13:49:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:26 INFO - 'PWD': '/builds/slave/test', 13:49:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:26 INFO - 'SHELL': '/bin/bash', 13:49:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WolwrQkj9C/Listeners', 13:49:26 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:49:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:26 INFO - 'USER': 'cltbld', 13:49:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:26 INFO - 'XPC_FLAGS': '0x0', 13:49:26 INFO - 'XPC_SERVICE_NAME': '0', 13:49:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:26 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 13:49:26 INFO - Cleaning up... 13:49:26 INFO - Return code: 0 13:49:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710d99820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107341e00>, '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 0x1071aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10733cb20>, '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.61EbGqIk7y/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.WolwrQkj9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 13:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:49:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EbGqIk7y/Render', 13:49:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:26 INFO - 'HOME': '/Users/cltbld', 13:49:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:26 INFO - 'LOGNAME': 'cltbld', 13:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:26 INFO - 'MOZ_NO_REMOTE': '1', 13:49:26 INFO - 'NO_EM_RESTART': '1', 13:49:26 INFO - 'PAGER': '/bin/cat', 13:49:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:26 INFO - 'PWD': '/builds/slave/test', 13:49:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:26 INFO - 'SHELL': '/bin/bash', 13:49:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WolwrQkj9C/Listeners', 13:49:26 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:49:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:26 INFO - 'USER': 'cltbld', 13:49:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:26 INFO - 'XPC_FLAGS': '0x0', 13:49:26 INFO - 'XPC_SERVICE_NAME': '0', 13:49:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:26 INFO - Downloading/unpacking psutil>=0.7.1 13:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:49:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:29 INFO - Installing collected packages: psutil 13:49:29 INFO - Running setup.py install for psutil 13:49:29 INFO - building 'psutil._psutil_osx' extension 13:49:29 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 13:49:30 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 13:49:30 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 13:49:30 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 13:49:30 INFO - building 'psutil._psutil_posix' extension 13:49:30 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 13:49:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:49:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:49:30 INFO - ^ 13:49:30 INFO - 1 warning generated. 13:49:30 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 13:49:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:30 INFO - Successfully installed psutil 13:49:30 INFO - Cleaning up... 13:49:30 INFO - Return code: 0 13:49:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:49:30 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')]} 13:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:30 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')]} 13:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:30 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 0x1074a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710d99820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107341e00>, '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 0x1071aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10733cb20>, '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.61EbGqIk7y/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.WolwrQkj9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 13:49:30 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 13:49:30 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 13:49:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EbGqIk7y/Render', 13:49:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:30 INFO - 'HOME': '/Users/cltbld', 13:49:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:30 INFO - 'LOGNAME': 'cltbld', 13:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:30 INFO - 'MOZ_NO_REMOTE': '1', 13:49:30 INFO - 'NO_EM_RESTART': '1', 13:49:30 INFO - 'PAGER': '/bin/cat', 13:49:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:30 INFO - 'PWD': '/builds/slave/test', 13:49:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:30 INFO - 'SHELL': '/bin/bash', 13:49:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WolwrQkj9C/Listeners', 13:49:30 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:49:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:30 INFO - 'USER': 'cltbld', 13:49:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:30 INFO - 'XPC_FLAGS': '0x0', 13:49:30 INFO - 'XPC_SERVICE_NAME': '0', 13:49:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:49:31 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 13:49:31 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 13:49:31 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 13:49:31 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 13:49:31 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 13:49:31 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 13:49:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:49:33 INFO - Installing collected packages: mozsystemmonitor 13:49:33 INFO - Running setup.py install for mozsystemmonitor 13:49:33 INFO - Successfully installed mozsystemmonitor 13:49:33 INFO - Cleaning up... 13:49:33 INFO - Return code: 0 13:49:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710d99820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107341e00>, '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 0x1071aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10733cb20>, '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.61EbGqIk7y/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.WolwrQkj9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 13:49:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:49:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:49:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EbGqIk7y/Render', 13:49:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:33 INFO - 'HOME': '/Users/cltbld', 13:49:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:33 INFO - 'LOGNAME': 'cltbld', 13:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:33 INFO - 'MOZ_NO_REMOTE': '1', 13:49:33 INFO - 'NO_EM_RESTART': '1', 13:49:33 INFO - 'PAGER': '/bin/cat', 13:49:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:33 INFO - 'PWD': '/builds/slave/test', 13:49:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:33 INFO - 'SHELL': '/bin/bash', 13:49:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WolwrQkj9C/Listeners', 13:49:33 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:49:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:33 INFO - 'USER': 'cltbld', 13:49:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:33 INFO - 'XPC_FLAGS': '0x0', 13:49:33 INFO - 'XPC_SERVICE_NAME': '0', 13:49:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:34 INFO - Downloading/unpacking blobuploader==1.2.4 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49:36 INFO - Downloading blobuploader-1.2.4.tar.gz 13:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:49:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:49:36 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 13:49:36 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 13:49:36 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 13:49:36 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 13:49:36 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 13:49:36 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 13:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:49:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49:37 INFO - Downloading docopt-0.6.1.tar.gz 13:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:49:37 INFO - Installing collected packages: blobuploader, requests, docopt 13:49:37 INFO - Running setup.py install for blobuploader 13:49:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:49:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:49:38 INFO - Running setup.py install for requests 13:49:38 INFO - Running setup.py install for docopt 13:49:38 INFO - Successfully installed blobuploader requests docopt 13:49:38 INFO - Cleaning up... 13:49:38 INFO - Return code: 0 13:49:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:38 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')]} 13:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:38 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')]} 13:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:38 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 0x1074a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710d99820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107341e00>, '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 0x1071aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10733cb20>, '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.61EbGqIk7y/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.WolwrQkj9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 13:49:38 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 13:49:38 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 13:49:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EbGqIk7y/Render', 13:49:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:38 INFO - 'HOME': '/Users/cltbld', 13:49:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:38 INFO - 'LOGNAME': 'cltbld', 13:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:38 INFO - 'MOZ_NO_REMOTE': '1', 13:49:38 INFO - 'NO_EM_RESTART': '1', 13:49:38 INFO - 'PAGER': '/bin/cat', 13:49:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:38 INFO - 'PWD': '/builds/slave/test', 13:49:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:38 INFO - 'SHELL': '/bin/bash', 13:49:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WolwrQkj9C/Listeners', 13:49:38 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:49:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:38 INFO - 'USER': 'cltbld', 13:49:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:38 INFO - 'XPC_FLAGS': '0x0', 13:49:38 INFO - 'XPC_SERVICE_NAME': '0', 13:49:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-d5x8ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-nwOxM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-1W7JjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-D8VvoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Oe7nNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-zbcLL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-CCGpvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-zPoK0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-_Miksf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-ZVb4cC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-xwbKAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Cch3DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Vn4UyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-EfRXS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-wju9bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-2ZHd_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-M6Vc7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:49:40 INFO - Running setup.py install for manifestparser 13:49:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:49:40 INFO - Running setup.py install for mozcrash 13:49:41 INFO - Running setup.py install for mozdebug 13:49:41 INFO - Running setup.py install for mozdevice 13:49:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:49:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:49:41 INFO - Running setup.py install for mozfile 13:49:41 INFO - Running setup.py install for mozhttpd 13:49:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:49:41 INFO - Running setup.py install for mozinfo 13:49:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:49:41 INFO - Running setup.py install for mozInstall 13:49:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:49:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:49:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:49:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:49:41 INFO - Running setup.py install for mozleak 13:49:42 INFO - Running setup.py install for mozlog 13:49:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:49:42 INFO - Running setup.py install for moznetwork 13:49:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:49:42 INFO - Running setup.py install for mozprocess 13:49:42 INFO - Running setup.py install for mozprofile 13:49:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:49:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:49:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:49:42 INFO - Running setup.py install for mozrunner 13:49:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:49:42 INFO - Running setup.py install for mozscreenshot 13:49:43 INFO - Running setup.py install for moztest 13:49:43 INFO - Running setup.py install for mozversion 13:49:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:49:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:49:43 INFO - Cleaning up... 13:49:43 INFO - Return code: 0 13:49:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:43 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')]} 13:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:43 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')]} 13:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:43 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 0x1074a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710d99820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107341e00>, '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 0x1071aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10733cb20>, '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.61EbGqIk7y/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.WolwrQkj9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 13:49:43 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 13:49:43 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 13:49:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EbGqIk7y/Render', 13:49:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:43 INFO - 'HOME': '/Users/cltbld', 13:49:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:43 INFO - 'LOGNAME': 'cltbld', 13:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:43 INFO - 'MOZ_NO_REMOTE': '1', 13:49:43 INFO - 'NO_EM_RESTART': '1', 13:49:43 INFO - 'PAGER': '/bin/cat', 13:49:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:43 INFO - 'PWD': '/builds/slave/test', 13:49:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:43 INFO - 'SHELL': '/bin/bash', 13:49:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WolwrQkj9C/Listeners', 13:49:43 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:49:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:43 INFO - 'USER': 'cltbld', 13:49:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:43 INFO - 'XPC_FLAGS': '0x0', 13:49:43 INFO - 'XPC_SERVICE_NAME': '0', 13:49:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:43 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-cw777x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:43 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)) 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:43 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-md_9ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:43 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)) 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:43 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-XbQFmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:43 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)) 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-_TXgKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:44 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)) 13:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-J_TyQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:44 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)) 13:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-dhuzjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:44 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)) 13:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-9u5IJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:44 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)) 13:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-d1JxEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:44 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)) 13:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-RlznU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:44 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)) 13:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-bm73Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:44 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)) 13:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Gysn18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:44 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)) 13:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-mUDoxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:44 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)) 13:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-AANFTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:45 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)) 13:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-IVwTVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:45 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)) 13:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-nWKgTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:45 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)) 13:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-pzLvjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:45 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)) 13:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-BE3cIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:45 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)) 13:49:45 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)) 13:49:45 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)) 13:49:45 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)) 13:49:45 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)) 13:49:45 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)) 13:49:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:47 INFO - Downloading blessings-1.6.tar.gz 13:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:49:47 INFO - Installing collected packages: blessings 13:49:47 INFO - Running setup.py install for blessings 13:49:48 INFO - Successfully installed blessings 13:49:48 INFO - Cleaning up... 13:49:48 INFO - Return code: 0 13:49:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:48 INFO - Reading from file tmpfile_stdout 13:49:48 INFO - Current package versions: 13:49:48 INFO - blessings == 1.6 13:49:48 INFO - blobuploader == 1.2.4 13:49:48 INFO - docopt == 0.6.1 13:49:48 INFO - manifestparser == 1.1 13:49:48 INFO - mozInstall == 1.12 13:49:48 INFO - mozcrash == 0.17 13:49:48 INFO - mozdebug == 0.1 13:49:48 INFO - mozdevice == 0.48 13:49:48 INFO - mozfile == 1.2 13:49:48 INFO - mozhttpd == 0.7 13:49:48 INFO - mozinfo == 0.9 13:49:48 INFO - mozleak == 0.1 13:49:48 INFO - mozlog == 3.1 13:49:48 INFO - moznetwork == 0.27 13:49:48 INFO - mozprocess == 0.22 13:49:48 INFO - mozprofile == 0.28 13:49:48 INFO - mozrunner == 6.11 13:49:48 INFO - mozscreenshot == 0.1 13:49:48 INFO - mozsystemmonitor == 0.0 13:49:48 INFO - moztest == 0.7 13:49:48 INFO - mozversion == 1.4 13:49:48 INFO - psutil == 3.1.1 13:49:48 INFO - requests == 1.2.3 13:49:48 INFO - wsgiref == 0.1.2 13:49:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:48 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 0x1074a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710d99820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107341e00>, '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 0x1071aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10733cb20>, '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.61EbGqIk7y/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.WolwrQkj9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 13:49:48 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 13:49:48 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 13:49:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EbGqIk7y/Render', 13:49:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:48 INFO - 'HOME': '/Users/cltbld', 13:49:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:48 INFO - 'LOGNAME': 'cltbld', 13:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:48 INFO - 'MOZ_NO_REMOTE': '1', 13:49:48 INFO - 'NO_EM_RESTART': '1', 13:49:48 INFO - 'PAGER': '/bin/cat', 13:49:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:48 INFO - 'PWD': '/builds/slave/test', 13:49:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:48 INFO - 'SHELL': '/bin/bash', 13:49:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WolwrQkj9C/Listeners', 13:49:48 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:49:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:48 INFO - 'USER': 'cltbld', 13:49:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:48 INFO - 'XPC_FLAGS': '0x0', 13:49:48 INFO - 'XPC_SERVICE_NAME': '0', 13:49:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:48 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)) 13:49:48 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)) 13:49:48 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)) 13:49:48 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)) 13:49:48 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)) 13:49:48 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)) 13:49:48 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)) 13:49:48 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)) 13:49:48 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)) 13:49:48 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)) 13:49:48 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)) 13:49:48 INFO - Cleaning up... 13:49:48 INFO - Return code: 0 13:49:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:48 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 0x1074a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710d99820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107341e00>, '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 0x1071aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10733cb20>, '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.61EbGqIk7y/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.WolwrQkj9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 13:49:48 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 13:49:48 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 13:49:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EbGqIk7y/Render', 13:49:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:48 INFO - 'HOME': '/Users/cltbld', 13:49:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:48 INFO - 'LOGNAME': 'cltbld', 13:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:48 INFO - 'MOZ_NO_REMOTE': '1', 13:49:48 INFO - 'NO_EM_RESTART': '1', 13:49:48 INFO - 'PAGER': '/bin/cat', 13:49:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:48 INFO - 'PWD': '/builds/slave/test', 13:49:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:48 INFO - 'SHELL': '/bin/bash', 13:49:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WolwrQkj9C/Listeners', 13:49:48 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:49:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:48 INFO - 'USER': 'cltbld', 13:49:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:48 INFO - 'XPC_FLAGS': '0x0', 13:49:48 INFO - 'XPC_SERVICE_NAME': '0', 13:49:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:49 INFO - Downloading/unpacking jsonschema 13:49:49 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 13:49:49 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 13:49:49 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 13:49:49 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 13:49:49 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 13:49:49 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 13:49:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:49:51 INFO - Downloading/unpacking functools32 (from jsonschema) 13:49:51 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 13:49:51 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 13:49:51 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 13:49:51 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 13:49:51 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 13:49:51 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 13:49:51 INFO - Downloading functools32-3.2.3-2.tar.gz 13:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:49:52 INFO - warning: no files found matching '*.txt' 13:49:52 INFO - no previously-included directories found matching 'build' 13:49:52 INFO - no previously-included directories found matching 'dist' 13:49:52 INFO - no previously-included directories found matching '.git*' 13:49:52 INFO - Installing collected packages: jsonschema, functools32 13:49:52 INFO - Running setup.py install for functools32 13:49:52 INFO - warning: no files found matching '*.txt' 13:49:52 INFO - no previously-included directories found matching 'build' 13:49:52 INFO - no previously-included directories found matching 'dist' 13:49:52 INFO - no previously-included directories found matching '.git*' 13:49:52 INFO - Successfully installed jsonschema functools32 13:49:52 INFO - Cleaning up... 13:49:52 INFO - Return code: 0 13:49:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:52 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 0x1074a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710d99820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107341e00>, '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 0x1071aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10733cb20>, '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.61EbGqIk7y/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.WolwrQkj9C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 13:49:52 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 13:49:52 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 13:49:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EbGqIk7y/Render', 13:49:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:52 INFO - 'HOME': '/Users/cltbld', 13:49:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:52 INFO - 'LOGNAME': 'cltbld', 13:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:52 INFO - 'MOZ_NO_REMOTE': '1', 13:49:52 INFO - 'NO_EM_RESTART': '1', 13:49:52 INFO - 'PAGER': '/bin/cat', 13:49:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:52 INFO - 'PWD': '/builds/slave/test', 13:49:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:52 INFO - 'SHELL': '/bin/bash', 13:49:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WolwrQkj9C/Listeners', 13:49:52 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:49:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:52 INFO - 'USER': 'cltbld', 13:49:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:52 INFO - 'XPC_FLAGS': '0x0', 13:49:52 INFO - 'XPC_SERVICE_NAME': '0', 13:49:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:52 INFO - Downloading/unpacking flake8 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:49:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:49:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:49:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:49:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:49:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:49:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:49:56 INFO - no previously-included directories found matching 'docs/_build' 13:49:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:49:56 INFO - Running setup.py install for pep8 13:49:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:49:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:49:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:49:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:49:56 INFO - no previously-included directories found matching 'docs/_build' 13:49:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:49:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:49:56 INFO - Cleaning up... 13:49:56 INFO - Return code: 0 13:49:56 INFO - Running post-action listener: _resource_record_post_action 13:49:56 INFO - Running post-action listener: _start_resource_monitoring 13:49:56 INFO - Starting resource monitoring. 13:49:56 INFO - ##### 13:49:56 INFO - ##### Running install step. 13:49:56 INFO - ##### 13:49:56 INFO - Running pre-action listener: _resource_record_pre_action 13:49:56 INFO - Running main action method: install 13:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:56 INFO - Reading from file tmpfile_stdout 13:49:56 INFO - Detecting whether we're running mozinstall >=1.0... 13:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:49:56 INFO - Reading from file tmpfile_stdout 13:49:56 INFO - Output received: 13:49:56 INFO - Usage: mozinstall [options] installer 13:49:56 INFO - Options: 13:49:56 INFO - -h, --help show this help message and exit 13:49:56 INFO - -d DEST, --destination=DEST 13:49:56 INFO - Directory to install application into. [default: 13:49:56 INFO - "/builds/slave/test"] 13:49:56 INFO - --app=APP Application being installed. [default: firefox] 13:49:56 INFO - mkdir: /builds/slave/test/build/application 13:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:50:28 INFO - Reading from file tmpfile_stdout 13:50:28 INFO - Output received: 13:50:28 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:50:28 INFO - Running post-action listener: _resource_record_post_action 13:50:28 INFO - ##### 13:50:28 INFO - ##### Running run-tests step. 13:50:28 INFO - ##### 13:50:28 INFO - Running pre-action listener: _resource_record_pre_action 13:50:28 INFO - Running main action method: run_tests 13:50:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:50:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:50:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:50:28 INFO - 2016-05-16 13:50:28.513 screenresolution[1637:7550] starting screenresolution argv=screenresolution get 13:50:28 INFO - 2016-05-16 13:50:28.516 screenresolution[1637:7550] Display 0: 1600x1200x32@60 13:50:28 INFO - 2016-05-16 13:50:28.522 screenresolution[1638:7553] starting screenresolution argv=screenresolution list 13:50:28 INFO - Available Modes on Display 0 13:50:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:50:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:50:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:50:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:50:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:50:28 INFO - Intel Iris: 13:50:28 INFO - Chipset Model: Intel Iris 13:50:28 INFO - Type: GPU 13:50:28 INFO - Bus: Built-In 13:50:28 INFO - VRAM (Dynamic, Max): 1536 MB 13:50:28 INFO - Vendor: Intel (0x8086) 13:50:28 INFO - Device ID: 0x0a2e 13:50:28 INFO - Revision ID: 0x0009 13:50:28 INFO - Displays: 13:50:28 INFO - Display: 13:50:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:50:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:50:28 INFO - Display Serial Number: 1600x1200 60 13:50:28 INFO - Main Display: Yes 13:50:28 INFO - Mirror: Off 13:50:28 INFO - Online: Yes 13:50:28 INFO - Rotation: Supported 13:50:28 INFO - Return code: 0 13:50:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:50:28 INFO - Python 2.7.3 13:50:28 INFO - Return code: 0 13:50:28 INFO - grabbing minidump binary from tooltool 13:50:28 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')]} 13:50:28 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 0x107341e00>, '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 0x1071aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10733cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:50:28 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 13:50:28 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 13:50:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:50:28 INFO - Return code: 0 13:50:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:50:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:50:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:50:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:50:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:50:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:50:29 INFO - Return code: 0 13:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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 13:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0116 --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 13:50:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61EbGqIk7y/Render', 13:50:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:29 INFO - 'HOME': '/Users/cltbld', 13:50:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:29 INFO - 'LOGNAME': 'cltbld', 13:50:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:50:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:29 INFO - 'MOZ_NO_REMOTE': '1', 13:50:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:50:29 INFO - 'NO_EM_RESTART': '1', 13:50:29 INFO - 'PAGER': '/bin/cat', 13:50:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:29 INFO - 'PWD': '/builds/slave/test', 13:50:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:50:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:29 INFO - 'SHELL': '/bin/bash', 13:50:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WolwrQkj9C/Listeners', 13:50:29 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:50:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:29 INFO - 'USER': 'cltbld', 13:50:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:29 INFO - 'XPC_FLAGS': '0x0', 13:50:29 INFO - 'XPC_SERVICE_NAME': '0', 13:50:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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 13:50:30 INFO - mozversion application_buildid: 20160516124143 13:50:30 INFO - mozversion application_changeset: 17724486e1591858eea09dc327475a25883854a4 13:50:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:50:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:50:30 INFO - mozversion application_name: Firefox 13:50:30 INFO - mozversion application_remotingname: firefox-dev 13:50:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:50:30 INFO - mozversion application_vendor: Mozilla 13:50:30 INFO - mozversion application_version: 48.0a2 13:50:30 INFO - mozversion platform_buildid: 20160516124143 13:50:30 INFO - mozversion platform_changeset: 17724486e1591858eea09dc327475a25883854a4 13:50:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:50:30 INFO - mozversion platform_version: 48.0a2 13:50:30 INFO - using testdate: 1463431830 13:50:30 INFO - actual date: 1463431830 13:50:30 INFO - starting webserver on 'localhost:49278' 13:50:30 INFO - SUITE-START | Running 2 tests 13:50:30 INFO - TEST-START | dromaeo_css 13:50:30 INFO - operating with platform_type : mac_ 13:50:30 INFO - Initialising browser for dromaeo_css test... 13:50:30 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmppcBDnp/profile http://localhost:49278/getInfo.html) 13:50:32 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 13:50:32 INFO - PROCESS | 1656 | colorDepth:24 13:50:32 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 13:50:32 INFO - PROCESS | 1656 | __metrics 13:50:32 INFO - PROCESS | 1656 | 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" 13:50:32 ERROR - PROCESS | 1656 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:50:33 INFO - TEST-INFO | 1656: exit 0 13:50:33 INFO - Browser initialized. 13:50:33 INFO - Running cycle 1/1 for dromaeo_css test... 13:50:33 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmppcBDnp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:50:45 INFO - PROCESS | 1658 | RSS: Main: 211062784 13:50:45 INFO - PROCESS | 1658 | 13:51:35 INFO - PROCESS | 1658 | 1463431895920 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] 13:53:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 13:53:49 INFO - PROCESS | 1658 | RSS: Main: 347598848 13:53:49 INFO - PROCESS | 1658 | 13:56:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 13:56:52 INFO - PROCESS | 1658 | RSS: Main: 354086912 13:56:52 INFO - PROCESS | 1658 | 13:59:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 13:59:55 INFO - PROCESS | 1658 | RSS: Main: 353087488 13:59:55 INFO - PROCESS | 1658 | 14:02:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 14:02:58 INFO - PROCESS | 1658 | RSS: Main: 357462016 14:02:58 INFO - PROCESS | 1658 | 14:06:01 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 14:06:01 INFO - PROCESS | 1658 | RSS: Main: 318758912 14:06:01 INFO - PROCESS | 1658 | 14:09:04 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 14:09:04 INFO - PROCESS | 1658 | RSS: Main: 364605440 14:09:04 INFO - PROCESS | 1658 | 14:09:04 INFO - PROCESS | 1658 | __start_tp_report 14:09:04 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 14:09:04 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 14:09:04 INFO - PROCESS | 1658 | |i|pagename|runs| 14:09:04 INFO - PROCESS | 1658 | |0;dojo.html;3167.461531539638;3475.8088305143215;3479.8608055677773;3484.442489201728;3544.308859772344;5143.639945203838;5684.232628595133;5709.1436284557285;5725.227094342263;5730.656160630355;5756.712164391784;5826.126081087828;5828.562857785672;5832.329282132556;5841.7955371562;5135.383753949532;5164.767585458663;5197.506236907488;5277.525022747952;5316.627836051478;5291.841244762663;5300.734963251822;5303.151495760679;5303.23103150043;5304.416514183436;5222.112240919053;5246.5278124968745;5286.947130528684;5287.339082614673;5291.153415453528;5283.682979021271;5315.946840531584;5317.707526086064;5336.599755018389;5341.599380046512;5132.461091585367;5158.767855446514;5183.611229157828;5259.211118332242;5259.316288882421;5653.604247702662;5689.431056894319;5698.401667824902;5702.942970570282;5758.971205143989;6230.813075607739;6259.37406259375;6259.499240060784;6269.7178626961895;6282.340354262782;6141.877162456771;6182.598131121463;6254.906176407358;6278.717457714368;6280.654563998978;4937.432195297587;5906.822795316148;5936.465718085393;5954.5534084943365;5988.550858685572;6354.936450635527;6364.077208804697;6367.458766004849;6369;6375.075614035939;6090.878182436327;6139.171211886427;6161.72272247741;6219.626822390671;6228.564000520011;6252.5935814171935;6267.717952692049;6277.183966084471;6299.527535434769;6305.306416294204;6197.845053873599;6258.624482530971;6276.717547710364;6278.466330361879;6289.842753931189;6142.815715528542;6169.784057557964;6198.473129784019;6204.782832600928;6240.65676387794;4921.261810728348;4941.530554597308;4955.603551715854;4969.577585905238;5010.323606313174;3673.7979411132646;4425.982024134402;4426.136903303889;4428.557144285545;4456.68803183774;5649.265595472644;5792.913106303409;5795.710214489259;5796.681182535001;5805.983952808242;6192.59748116371;6244.313125556185;6322.525810564226;6329.651869147149;6336.239651241881;5707.6575405475805;5775.815957728655;5784.681842498703;5809.24479817621;5848.093545500455;5351.86620334487;5432.972835135878;5442.863928401822;5460.590455715837;5465.863353416196;6298.433141017239;6324.083007963727;6399.55203135776;6407.967960160169;6418.454431373386;5304.708241046779;6277.435030847246;6299.023651334051;6307.085472606538;6315.96842015787;6261.24865016201;6333.081703153109;6386.90419643715;6410.1987251593555;6416.422521973045;5087.389513258285;6153.384661533811;6249.875002500015;6262.405071518198;6274.592151510137;6264.874702506016;6321.652309123042;6323.525735569759;6324.462420694109;6331.683415829282;6130.816075517741;6167.969160154171;6194.5973511721595;6208.348123446973;6214.223222097238;5960.374160713062;6130.356312587114;6137.560853825989;6138.541671868701;6199.690015499297;6012.128241404885;6013.548983826143;6015.4586087252355;6036.63780173191;6044.304904935812;6003.579749417673;6183.227096612924;6191.380861913773;6202.56582039271;6206.534509911684;5900.232969713909;5941.613795103304;5963.105534169736;5984.461398473984;5986.07215881539 14:09:04 INFO - PROCESS | 1658 | |1;ext.html;507.53306957599006;523.6962561714206;580.4978693430185;593.9703014849258;619.0775744141229;30681;38014;38814.611853881455;38907;39096.80451597745;40781.7960910195;41224;41245.38131928023;41342;41451;8502.14978502148;9372.156505914483;9712.70861874145;9712.902870971271;9715.27135464843;8571.871421928676;8694.913050869474;8699.99950005751;8707;9650.5174741263;11507.194496385257;11579.305241685526;11597.130215233849;11597.24617899838;11673.941630291836;11703.414829258503;11832.290062596272;11835.408229588485;11842.7631447371;11849.763004739943;8648.35137364694;11482.942585287105;11622.07023438123;11696.064314854877;11726.589569365031;38103.61896381029;38464.615353846384;38480;38587.8070609648;38691;3087.536869469575;3277.8197199154038;3290.654481279455;3435.7251419886597;3705.0366904605;22968.196113136128;27248.04631837896;28482;29014.12957611275;30412.239694007607;2373.988130059356;2673.3717576369536;2688.7042425333198;2770.127409865906;2791.0649932272713;431329;434220.8288958567;435354;436114;436166;62391.37608623946;62647.68676156681;62867;63113.684431577545;63125.36874631195;64974.67512662406;65357;65370.673146634916;65459.345406545326;65505;17105.91447042782;17728.29086836538;17733.202005909767;17748.112594370228;17786.199621017084;11496.42517874103;13513.459461621425;13546.051776375756;13548.983826213074;13579.185248885098;16650.916745416438;17036.403725869783;18851.24595016184;19356.32252871143;19383.4184974451;7589.43079269057;7834.373250140089;8030.799230019296;8062.879056814152;8068.8386232275025;857.2884505860121;922.2115091596588;922.276013329533;999.2954966748425;1087.494315143462;27899.721002790116;28376.574351384745;29094.563581546292;29143.417131657247;29219.56170657442;1024.8565200871883;1040.6461802987021;1091.6888686724246;1143.868455127671;1235.721962558417;13985.440582376794;14269.571912842424;14271;14598;14689.485867994568;531505;544151;570789;575193;580671;59265.407345926855;59557;59628.10557841636;59804.40195598076;59944;1372.5950844500896;1433.376481230668;1511.3803340630288;1524.4359586952899;1531.4410240262223;24346.75653243445;29473.85263073671;29803.85098074496;29882;30571.54142687906;48828.0234395303;48865.755671221414;49575.50424495709;49596.25605615846;49740;569730;596345;596647;597356;598276;35749.64250357463;42527.362089568065;43101.78449107734;43614;43872;44803;44843.55156448394;45803.77098114488;45979.31031034604;46099.30851037304;37853.242935140595;38935.22129557336;38998.61001390063;39117.60882391254;39681.80159099186;37556.624433756406;38486.6151338483;38510.80744596259;39323.803380982914;39532.80233598813;37929.4310585347;38390.040248993995;38626;39010;39191;30778.076657700305;33940.83029584836;34160.82919585386;34254;34410.82794586011;21927.38887039969;25283.620745689197;25377;25854.61218081768;25861.870690646425 14:09:04 INFO - PROCESS | 1658 | |2;jquery.html;367.54791606324204;405.1916426728676;407.1064014488198;408.8957315884449;418.9832406703732;15144.924275378607;15477.845221547781;16972;19919.900400497994;20581;19752;20154.19383224673;20184.293549725764;20364.796352036476;20775.065122069504;5822.243108395903;6156.6613836238985;6159.076138579204;6164.630122192661;6166.167567378414;3266.6243382011135;4111.198316328318;5588.245586845785;5796.30444346679;5874.265716785402;6032.034874420094;6052.909206361908;6072.119542666311;6072.119542666333;6077.908831367533;5991.970040149793;6038.939610603904;6234.688265586702;6630.436412904909;6651.86696266072;5413.781899072716;5582.302212223472;5848.7075646217945;5872.5889187756875;5891.8527036824;13641.522546710918;25311.734413279446;25938.962441502317;26123.477530449476;26323.605145922826;1864.7089878574843;2095.863768855035;2165.436986383536;2408.8193385496156;2657.5747880339245;10027.247956403298;10038.899611003942;10089.697309080666;10251;14425.855741442556;1681.411505972912;1726.1369315342329;1771.8051014388407;1802.7115661494097;1880.7774946284887;112022.43988780004;115674;116735;118423;119622;11692.649220523397;11807.763844723057;11827.231229970024;11828.757980412105;11858.525658973716;15267;15272.389104435699;15276.618084547976;15280.083195008336;15299.847001530065;8880.1563851434;8914.910850891538;8915;9021.774455638662;9038.593263303168;8911.197992180734;8929.285657147413;8940.195382415613;9051.27589792815;9055.094490551024;3965.20695860829;4567.2464043432465;4638.582527572535;4643.930341044887;4712.363830882856;1742.8513274922689;1799.813226929287;1940.6118776244807;1948.5713143108494;1969.1631056801089;897.5915958238986;922.5341202692597;946.1201082992745;968.5931908598405;994.4778991029767;19265;20242.291519796738;20441.182352706022;20493.07781149852;20530.897345513178;979.1187930862138;991.9702408927744;996.9351992120489;1002.8194924913586;1051.9053285204368;10675.306105103144;10874.891251087387;10881.346121218876;10938.289011214245;10978.835317470244;589262;589539;590006;633657.1585710394;639823;126328.36835815762;132950.33524832313;134458;139176;140270;909.5361365703538;943.6461327002374;1066.051214419152;1095.769888323461;1114.8662160540787;14589.562313130624;14909;18276.90861545737;18629.72055419197;18671.6265674683;39674.206515868944;41763.7911810439;49569.752151239016;51700.70748231174;52124.739376302874;80194.39611207627;80195.59902200452;83337;83979;85739;8297.211764882326;8314.833703326021;8359.66561337564;8432.620532075949;8686.261667758312;7710.807229819075;9709.417434953926;10350.223733219887;12153.453094610586;13063.804042939173;11111.444427778417;11232.943835280772;11303.095752339628;11403.258788178742;11448;10580.947095264475;10859.2398532102;10920.836187457036;11182.440877955907;11275.943620281847;11027.889721102687;11403.486843091914;11633.941830290794;11651.941740291244;11729.47217375203;8320.209580089882;8371.37214708887;8450.577471126542;8477.660893564189;8597;8403.831923361377;11466.827997579876;11678.532858685558;11779.52881884715;11836.467358968695 14:09:04 INFO - PROCESS | 1658 | |3;mootools.html;1400.6988497473042;1531.5405378386486;1552.9223538823055;1754.350890170637;1892.5741708115684;7816.882746758796;8027.197280271985;8037.236462536064;8041.87937180942;8058.033036035684;8264.462809917351;8518.87221691675;8524.190201930822;8533.573321333939;8544.316454683625;2403.1709060374187;2473.727889932106;2481.081999660128;2483.888225029869;2484.7391023942496;2407.265783935899;2458.9508209835794;2460.2619214235747;2462.224399314219;2465.642481840132;2406.109739396426;2431.185552839801;2454.128784281581;2455.435249892526;2457.348802567321;2418.3071849705275;2427.6237183236626;2452.3746444656585;2459.9139030133947;2460.950780984388;2059.4851287178208;2383.0348708772976;2389.7012873390827;2437.293184976355;2437.9146729864547;7185;8726.738197854074;8728.432651877607;8731.126887311282;8770;4480.283154695266;5323.893522129536;5435.42927992559;5447.809326673587;5496.203050557687;3478.3565040467342;3529.7882127072457;3551.8401671924826;3591.3535563598543;3620.7827530348;1023.2888142740799;1030.3920686794827;1047.738065483629;1052.9473526323652;1054.8839627640953;11392.487338069725;11460;11460.312381257068;11495;11509.539618415254;4464.062546865194;4521.864344069683;4590.242609969385;4601.907961840744;4696.459907110658;8987.51705968521;9287.303452241109;9349.90650093504;9352;9353.579088941015;4076.9796151019054;5225.268462415265;5277.656952298088;5319.441458646864;5326.280952071498;4369.191699535596;4443.822247110079;4486.887827804331;4488.663350248679;4947.925781113287;3576.9821150894077;3605.521736088191;3635.1457407509215;3839.788811615332;3911.6675082617726;1181.8345431639577;1224.8897599215936;1228.4778968938165;1235.8764123587569;1235.932023738685;831.995840020796;893.066745251214;894.1952242981239;904.9185573298303;933.9953300233456;5484.506394424441;5643.322801263875;5749.137629355547;5793.15999180125;5814.76740930358;947.8104379124203;951.8239125761756;952.7903861150675;975.024975024975;1004.2568499310457;3647.76289541179;3785.886423407302;3803.964078645097;3814.0846196913094;3844.961550384516;10451.738706532245;10688.572457101784;10738.838917416246;10861.185411094042;10867.130629549618;10733.195010374253;10738.409387483607;10742;10749.83875241872;10759.784804304027;7167.247439018932;8359.749207523662;8416.705415310435;8445.366597505212;8502.277306429023;4648.2562789953445;5531.197976293334;5604.355499117653;5632.802851900164;5780.248567686174;9012.909870901207;9203.953980230055;9443.291753118407;9564.139227469283;9595.808083838145;9504.667336643184;9859.063388978035;9876.85184722244;9880.20958323318;9917.950410247902;7430.591317477374;7609.467337286558;7649.082110146818;7651.464397492122;7679.884801728091;7436.330730234305;7611.467197296136;8115.878261826196;8277.130901255281;8307.252347288773;7528.284812942762;7573.242675732603;7595.354394876497;7727.11138219112;7758.92241077582;7398.2231865655485;7398.408127349907;7448.92551074504;7481.588512631857;7592.81017974555;6594.340565943367;6653.403183235891;6657.234418041793;6659.234188068434;6662.100616416722;4856.514348565115;4969.652124351405;4978.6763860348965;4991.975040124777;5014.147594908947;4977.402711674622;5005.149124648891;5005.7997680092385;5101.617378696538;5212.9739351303 14:09:04 INFO - PROCESS | 1658 | |4;prototype.html;283.83963060870605;316.7212852689634;326.6537470281501;330.7701147702345;333.1288680101534;6406.551541392105;6493.188351456068;6504.544681872271;6520.445762110215;6521.673916304189;6224.470919971808;6397.616143031421;6425.48596112311;6441.516886233528;6457.935420645792;3866.574676785551;4737.170995075848;4751.192297309449;4760.8333708320215;4772.732951847879;4764.952350476503;4773.427188737339;4776.689515181502;4780.211265141265;4788.90422191556;4716.97641511792;4724.3858298421155;4729.62163026957;4731.57415832575;4738.431388233417;4730.361401210827;4733.171694953404;4747.074320507502;4749.691270067469;4764.047190561884;3917.275304068728;4044.9685330240895;4052.2908491013955;4065.3292206785845;4075.49056367954;5031.597472202215;6126.356732543063;6189.783357582463;6243.125962365272;6247.468965137923;5482.725863706799;5515;5528.281323427928;5531.3915469298345;5533.667979921218;6132.540059495555;6290.836195303884;6873.450123990069;6877.862442751117;6891.862162756767;3870.632289932452;4193.224253513079;4488.7531185784765;4505.932411013838;4523.5024147343765;5935.198748168985;6407.359264073602;6928.064711263965;7178.4616153788675;7313.378362839165;4504.887377815581;4521.208788462006;4533.38799262102;4548.044910568751;4573.49691533931;4043.636072753466;4657;4662.766861656972;4662.997455547006;4668.486466488684;5206.323177986837;5334.359876814729;5440.884618653166;5513.3108361454815;5513.62159460135;6795.490338224554;6811.795646130624;6811.897821532681;6822.692978815965;6868.9313106869295;1577.629257124575;1599.9120048397217;1605.4621701729818;1605.9116748578706;1606.4939544043589;1002.318423472046;1011.4083261292079;1025.9794804103876;1028.619410818002;1036.5231993283023;6447.2263328400895;6458.741650333934;6477.870442591122;6478.190226221723;6496.317886621931;7209.630170267632;7211.134663840267;7222.674979625929;7234.674439650228;7239.420846332281;5301.257823904656;6464.062710906892;6473.449756770633;6474.12599299098;6477.352264773485;3755.6432138946757;3801.125741079567;3812.1613245086037;3817.541894972621;3822.0827001519433;7149;7502.474826762074;7511.248875112555;7516.812079697942;7547.811304717426;7386.446016548781;7415.3326200642205;7420.962895185489;7447.031885854804;7447.5531468112085;7245.275472452818;7365.410767138616;7398.334149926425;7509.549427034395;7518.248175182438;7264.89102663471;7264.963675181802;7275.1997280298065;7294.890576641248;7295.562266264041;7129.144502659714;7132.607706576188;7152.356287934111;7161.856762864818;7169.856602867809;6078.095065190624;7515.661795219337;7578.962105189439;7594.050743657043;7599.240075992357;4532.546745325573;4564.680472367036;4575.222212223864;4576.222042252892;4584.426946631671;7172.246914073947;7178.353948144692;7191.316824901626;7194.460415468756;7216.314450127229;6953.304669533006;6957.652117394211;6964.616946067812;6967.407770339375;6979.162500499972;6627.900581491185;6924.619145947021;6929.5842249465195;6938.5143039986715;6944.722211111499;6736.7873782717625;6750.86498270022;6754.358335958076;6771.661416929035;6803.489738269748;6271.341509141657;6707.960266158753;6969.512134150764;6970.372666460043;6970.930290697028;6775.62734049632;6783.253842077269;6797.66011699423;6810.829729256809;6814.829629259309 14:09:04 INFO - PROCESS | 1658 | |5;yui.html;675.1257122026975;681.7511608262986;686.3342557719011;732.3152852083306;748.985020299594;15016.249187540634;15051.774223386645;15273.465428709997;15288.770668439982;15304.540863774091;14335.641608959755;14365.640858978531;14374.20941848198;14381.065230759994;14403.567892963201;728.4318231779221;736.469741785916;737.5795796396056;739.8113481062348;896.1576118448654;727.5525551785666;897.6274845938927;932.1051790281338;932.5849996751448;933.5099072986668;957.6887511558737;975.6438899801592;977.359829311802;978.149010360987;981.205223768746;762.3786613909646;952.9523523823816;966.2946049383954;966.5264020629841;968.3705591365633;713.6574444266781;726.9018682477904;729.5950747335227;731.3783284208433;732.8094695379186;12217.877821221762;14480.637984050378;14531;14552.781708274384;14558.563243102619;12627.873721262762;12640.810387844189;12732.936335318263;12938.48246070156;13208.273544955024;10009.999000099931;10078.798424031478;10247.487625618689;10343.32768370061;10679.34715308217;2929.985350073236;3434.9656503434894;3508.7193024557973;3537.4163263061564;3556.2354093869685;85556.14443855544;85983.71024434638;86285;87543;88549;9714.611415543299;9731.172850307661;9754.024597540189;9912.801743965081;10476.580936762597;21816.563668726536;22015.779842201693;22266.777332226793;22290.888545557493;22345.888270558542;7472.775816725507;7475.813104672318;7627.199144089902;7738.806529836799;7750.302472777477;3860.2279544091293;3924.50943632046;3977.085270387827;4106.589341065929;4149.647279981235;3547.7693949893173;3638.6179451157777;3648.1791596891017;3649.59854416014;3656.323580137683;547.9397266300704;631.9178506794179;652.8204743695521;663.8240866170469;678.9049533065374;540.9756560954767;545.2693390856192;586.5835256967515;598.87423641035;618.4990157972057;7659.770206893802;8161.836763264701;8511.787205319917;8625.964884213934;8727.694530691395;521.272824409946;577.2005772005718;618.2426527503771;620.1318154583529;633.965131917749;3140.309131990958;3479.460683594047;3765.1528406108955;3831.1379939513386;3859.5947425520476;94489.5275523618;94676.52661736647;96251;96296;96417.51791241;73306;73857;77954;78925;80636.79044814332;54382;70969;71334.64332678303;71978;72368;7982.840343192987;8325.333973282002;8550.74347769568;8656.740297791077;8671.34964877624;48789;48933;49085.77285567889;49807.75096124641;50046.499535004186;67385.66307168432;71596.28403715896;72059.51464368022;72107.63946180236;73922.26077739369;10732.570697172026;10740.624078157227;11126.165537584875;11140.10879129684;11178.329300242012;11599.942000289944;12025.158238923192;12058.276503409823;12462.43919023628;12572.994160466958;11109.888901110886;11412.885871141183;11424.257423267461;11605.30368177912;11657.708557285796;11265.436728163722;11298.983091521473;11505.539778408769;11729.648110556696;11736.823947640622;10827.296225745302;10941.37407022293;11189.944050279697;11237.662870113909;11906.821397679216;8177.4684645497855;9214.44713317203;9266.768330791785;9570.425774453555;9726.70819875405;8441.535715535705;9015.323850711355;9412.529373531434;9664.275179361435;9722.611095556098 14:09:04 INFO - PROCESS | 1658 | __end_tp_report 14:09:04 INFO - PROCESS | 1658 | __start_cc_report 14:09:04 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1409 14:09:04 INFO - PROCESS | 1658 | __end_cc_report 14:09:04 INFO - PROCESS | 1658 | __startTimestamp1463432944866__endTimestamp 14:09:04 INFO - PROCESS | 1658 | 14:09:04 INFO - PROCESS | 1658 | ------- Summary: start ------- 14:09:04 INFO - PROCESS | 1658 | Number of tests: 6 14:09:04 INFO - PROCESS | 1658 | 14:09:04 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5771.05 Median:5988.55 stddev:657.22 (11.0%) stddev-sans-first:626.70 14:09:04 INFO - PROCESS | 1658 | Values: 3167.5 3475.8 3479.9 3484.4 3544.3 5143.6 5684.2 5709.1 5725.2 5730.7 5756.7 5826.1 5828.6 5832.3 5841.8 5135.4 5164.8 5197.5 5277.5 5316.6 5291.8 5300.7 5303.2 5303.2 5304.4 5222.1 5246.5 5286.9 5287.3 5291.2 5283.7 5315.9 5317.7 5336.6 5341.6 5132.5 5158.8 5183.6 5259.2 5259.3 5653.6 5689.4 5698.4 5702.9 5759.0 6230.8 6259.4 6259.5 6269.7 6282.3 6141.9 6182.6 6254.9 6278.7 6280.7 4937.4 5906.8 5936.5 5954.6 5988.6 6354.9 6364.1 6367.5 6369.0 6375.1 6090.9 6139.2 6161.7 6219.6 6228.6 6252.6 6267.7 6277.2 6299.5 6305.3 6197.8 6258.6 6276.7 6278.5 6289.8 6142.8 6169.8 6198.5 6204.8 6240.7 4921.3 4941.5 4955.6 4969.6 5010.3 3673.8 4426.0 4426.1 4428.6 4456.7 5649.3 5792.9 5795.7 5796.7 5806.0 6192.6 6244.3 6322.5 6329.7 6336.2 5707.7 5775.8 5784.7 5809.2 5848.1 5351.9 5433.0 5442.9 5460.6 5465.9 6298.4 6324.1 6399.6 6408.0 6418.5 5304.7 6277.4 6299.0 6307.1 6316.0 6261.2 6333.1 6386.9 6410.2 6416.4 5087.4 6153.4 6249.9 6262.4 6274.6 6264.9 6321.7 6323.5 6324.5 6331.7 6130.8 6168.0 6194.6 6208.3 6214.2 5960.4 6130.4 6137.6 6138.5 6199.7 6012.1 6013.5 6015.5 6036.6 6044.3 6003.6 6183.2 6191.4 6202.6 6206.5 5900.2 5941.6 5963.1 5984.5 5986.1 14:09:04 INFO - PROCESS | 1658 | 14:09:04 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:67273.81 Median:38498.71 stddev:142171.56 (369.3%) stddev-sans-first:142482.01 14:09:04 INFO - PROCESS | 1658 | Values: 507.5 523.7 580.5 594.0 619.1 30681.0 38014.0 38814.6 38907.0 39096.8 40781.8 41224.0 41245.4 41342.0 41451.0 8502.1 9372.2 9712.7 9712.9 9715.3 8571.9 8694.9 8700.0 8707.0 9650.5 11507.2 11579.3 11597.1 11597.2 11673.9 11703.4 11832.3 11835.4 11842.8 11849.8 8648.4 11482.9 11622.1 11696.1 11726.6 38103.6 38464.6 38480.0 38587.8 38691.0 3087.5 3277.8 3290.7 3435.7 3705.0 22968.2 27248.0 28482.0 29014.1 30412.2 2374.0 2673.4 2688.7 2770.1 2791.1 431329.0 434220.8 435354.0 436114.0 436166.0 62391.4 62647.7 62867.0 63113.7 63125.4 64974.7 65357.0 65370.7 65459.3 65505.0 17105.9 17728.3 17733.2 17748.1 17786.2 11496.4 13513.5 13546.1 13549.0 13579.2 16650.9 17036.4 18851.2 19356.3 19383.4 7589.4 7834.4 8030.8 8062.9 8068.8 857.3 922.2 922.3 999.3 1087.5 27899.7 28376.6 29094.6 29143.4 29219.6 1024.9 1040.6 1091.7 1143.9 1235.7 13985.4 14269.6 14271.0 14598.0 14689.5 531505.0 544151.0 570789.0 575193.0 580671.0 59265.4 59557.0 59628.1 59804.4 59944.0 1372.6 1433.4 1511.4 1524.4 1531.4 24346.8 29473.9 29803.9 29882.0 30571.5 48828.0 48865.8 49575.5 49596.3 49740.0 569730.0 596345.0 596647.0 597356.0 598276.0 35749.6 42527.4 43101.8 43614.0 43872.0 44803.0 44843.6 45803.8 45979.3 46099.3 37853.2 38935.2 38998.6 39117.6 39681.8 37556.6 38486.6 38510.8 39323.8 39532.8 37929.4 38390.0 38626.0 39010.0 39191.0 30778.1 33940.8 34160.8 34254.0 34410.8 21927.4 25283.6 25377.0 25854.6 25861.9 14:09:04 INFO - PROCESS | 1658 | 14:09:04 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35271.43 Median:2287.13 stddev:101733.76 (4448.1%) stddev-sans-first:101985.39 14:09:04 INFO - PROCESS | 1658 | Values: 367.5 405.2 407.1 408.9 419.0 15144.9 15477.8 16972.0 19919.9 20581.0 19752.0 20154.2 20184.3 20364.8 20775.1 5822.2 6156.7 6159.1 6164.6 6166.2 3266.6 4111.2 5588.2 5796.3 5874.3 6032.0 6052.9 6072.1 6072.1 6077.9 5992.0 6038.9 6234.7 6630.4 6651.9 5413.8 5582.3 5848.7 5872.6 5891.9 13641.5 25311.7 25939.0 26123.5 26323.6 1864.7 2095.9 2165.4 2408.8 2657.6 10027.2 10038.9 10089.7 10251.0 14425.9 1681.4 1726.1 1771.8 1802.7 1880.8 112022.4 115674.0 116735.0 118423.0 119622.0 11692.6 11807.8 11827.2 11828.8 11858.5 15267.0 15272.4 15276.6 15280.1 15299.8 8880.2 8914.9 8915.0 9021.8 9038.6 8911.2 8929.3 8940.2 9051.3 9055.1 3965.2 4567.2 4638.6 4643.9 4712.4 1742.9 1799.8 1940.6 1948.6 1969.2 897.6 922.5 946.1 968.6 994.5 19265.0 20242.3 20441.2 20493.1 20530.9 979.1 992.0 996.9 1002.8 1051.9 10675.3 10874.9 10881.3 10938.3 10978.8 589262.0 589539.0 590006.0 633657.2 639823.0 126328.4 132950.3 134458.0 139176.0 140270.0 909.5 943.6 1066.1 1095.8 1114.9 14589.6 14909.0 18276.9 18629.7 18671.6 39674.2 41763.8 49569.8 51700.7 52124.7 80194.4 80195.6 83337.0 83979.0 85739.0 8297.2 8314.8 8359.7 8432.6 8686.3 7710.8 9709.4 10350.2 12153.5 13063.8 11111.4 11232.9 11303.1 11403.3 11448.0 10580.9 10859.2 10920.8 11182.4 11275.9 11027.9 11403.5 11633.9 11651.9 11729.5 8320.2 8371.4 8450.6 8477.7 8597.0 8403.8 11466.8 11678.5 11779.5 11836.5 14:09:04 INFO - PROCESS | 1658 | 14:09:04 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5590.21 Median:5009.97 stddev:3104.35 (62.0%) stddev-sans-first:3097.09 14:09:04 INFO - PROCESS | 1658 | Values: 1400.7 1531.5 1552.9 1754.4 1892.6 7816.9 8027.2 8037.2 8041.9 8058.0 8264.5 8518.9 8524.2 8533.6 8544.3 2403.2 2473.7 2481.1 2483.9 2484.7 2407.3 2459.0 2460.3 2462.2 2465.6 2406.1 2431.2 2454.1 2455.4 2457.3 2418.3 2427.6 2452.4 2459.9 2461.0 2059.5 2383.0 2389.7 2437.3 2437.9 7185.0 8726.7 8728.4 8731.1 8770.0 4480.3 5323.9 5435.4 5447.8 5496.2 3478.4 3529.8 3551.8 3591.4 3620.8 1023.3 1030.4 1047.7 1052.9 1054.9 11392.5 11460.0 11460.3 11495.0 11509.5 4464.1 4521.9 4590.2 4601.9 4696.5 8987.5 9287.3 9349.9 9352.0 9353.6 4077.0 5225.3 5277.7 5319.4 5326.3 4369.2 4443.8 4486.9 4488.7 4947.9 3577.0 3605.5 3635.1 3839.8 3911.7 1181.8 1224.9 1228.5 1235.9 1235.9 832.0 893.1 894.2 904.9 934.0 5484.5 5643.3 5749.1 5793.2 5814.8 947.8 951.8 952.8 975.0 1004.3 3647.8 3785.9 3804.0 3814.1 3845.0 10451.7 10688.6 10738.8 10861.2 10867.1 10733.2 10738.4 10742.0 10749.8 10759.8 7167.2 8359.7 8416.7 8445.4 8502.3 4648.3 5531.2 5604.4 5632.8 5780.2 9012.9 9204.0 9443.3 9564.1 9595.8 9504.7 9859.1 9876.9 9880.2 9918.0 7430.6 7609.5 7649.1 7651.5 7679.9 7436.3 7611.5 8115.9 8277.1 8307.3 7528.3 7573.2 7595.4 7727.1 7758.9 7398.2 7398.4 7448.9 7481.6 7592.8 6594.3 6653.4 6657.2 6659.2 6662.1 4856.5 4969.7 4978.7 4992.0 5014.1 4977.4 5005.1 5005.8 5101.6 5213.0 14:09:04 INFO - PROCESS | 1658 | 14:09:04 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:5633.00 Median:6433.50 stddev:1813.52 (28.2%) stddev-sans-first:1773.60 14:09:04 INFO - PROCESS | 1658 | Values: 283.8 316.7 326.7 330.8 333.1 6406.6 6493.2 6504.5 6520.4 6521.7 6224.5 6397.6 6425.5 6441.5 6457.9 3866.6 4737.2 4751.2 4760.8 4772.7 4765.0 4773.4 4776.7 4780.2 4788.9 4717.0 4724.4 4729.6 4731.6 4738.4 4730.4 4733.2 4747.1 4749.7 4764.0 3917.3 4045.0 4052.3 4065.3 4075.5 5031.6 6126.4 6189.8 6243.1 6247.5 5482.7 5515.0 5528.3 5531.4 5533.7 6132.5 6290.8 6873.5 6877.9 6891.9 3870.6 4193.2 4488.8 4505.9 4523.5 5935.2 6407.4 6928.1 7178.5 7313.4 4504.9 4521.2 4533.4 4548.0 4573.5 4043.6 4657.0 4662.8 4663.0 4668.5 5206.3 5334.4 5440.9 5513.3 5513.6 6795.5 6811.8 6811.9 6822.7 6868.9 1577.6 1599.9 1605.5 1605.9 1606.5 1002.3 1011.4 1026.0 1028.6 1036.5 6447.2 6458.7 6477.9 6478.2 6496.3 7209.6 7211.1 7222.7 7234.7 7239.4 5301.3 6464.1 6473.4 6474.1 6477.4 3755.6 3801.1 3812.2 3817.5 3822.1 7149.0 7502.5 7511.2 7516.8 7547.8 7386.4 7415.3 7421.0 7447.0 7447.6 7245.3 7365.4 7398.3 7509.5 7518.2 7264.9 7265.0 7275.2 7294.9 7295.6 7129.1 7132.6 7152.4 7161.9 7169.9 6078.1 7515.7 7579.0 7594.1 7599.2 4532.5 4564.7 4575.2 4576.2 4584.4 7172.2 7178.4 7191.3 7194.5 7216.3 6953.3 6957.7 6964.6 6967.4 6979.2 6627.9 6924.6 6929.6 6938.5 6944.7 6736.8 6750.9 6754.4 6771.7 6803.5 6271.3 6708.0 6969.5 6970.4 6970.9 6775.6 6783.3 6797.7 6810.8 6814.8 14:09:04 INFO - PROCESS | 1658 | 14:09:04 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:18573.57 Median:619.32 stddev:26429.11 (4267.5%) stddev-sans-first:26469.08 14:09:04 INFO - PROCESS | 1658 | Values: 675.1 681.8 686.3 732.3 749.0 15016.2 15051.8 15273.5 15288.8 15304.5 14335.6 14365.6 14374.2 14381.1 14403.6 728.4 736.5 737.6 739.8 896.2 727.6 897.6 932.1 932.6 933.5 957.7 975.6 977.4 978.1 981.2 762.4 953.0 966.3 966.5 968.4 713.7 726.9 729.6 731.4 732.8 12217.9 14480.6 14531.0 14552.8 14558.6 12627.9 12640.8 12732.9 12938.5 13208.3 10010.0 10078.8 10247.5 10343.3 10679.3 2930.0 3435.0 3508.7 3537.4 3556.2 85556.1 85983.7 86285.0 87543.0 88549.0 9714.6 9731.2 9754.0 9912.8 10476.6 21816.6 22015.8 22266.8 22290.9 22345.9 7472.8 7475.8 7627.2 7738.8 7750.3 3860.2 3924.5 3977.1 4106.6 4149.6 3547.8 3638.6 3648.2 3649.6 3656.3 547.9 631.9 652.8 663.8 678.9 541.0 545.3 586.6 598.9 618.5 7659.8 8161.8 8511.8 8626.0 8727.7 521.3 577.2 618.2 620.1 634.0 3140.3 3479.5 3765.2 3831.1 3859.6 94489.5 94676.5 96251.0 96296.0 96417.5 73306.0 73857.0 77954.0 78925.0 80636.8 54382.0 70969.0 71334.6 71978.0 72368.0 7982.8 8325.3 8550.7 8656.7 8671.3 48789.0 48933.0 49085.8 49807.8 50046.5 67385.7 71596.3 72059.5 72107.6 73922.3 10732.6 10740.6 11126.2 11140.1 11178.3 11599.9 12025.2 12058.3 12462.4 12573.0 11109.9 11412.9 11424.3 11605.3 11657.7 11265.4 11299.0 11505.5 11729.6 11736.8 10827.3 10941.4 11189.9 11237.7 11906.8 8177.5 9214.4 9266.8 9570.4 9726.7 8441.5 9015.3 9412.5 9664.3 9722.6 14:09:04 INFO - PROCESS | 1658 | -------- Summary: end -------- 14:09:04 INFO - PROCESS | 1658 | 14:09:05 INFO - TEST-INFO | 1658: exit 0 14:09:05 INFO - TEST-OK | dromaeo_css | took 1115217ms 14:09:05 INFO - TEST-START | kraken 14:09:05 INFO - operating with platform_type : mac_ 14:09:05 INFO - Initialising browser for kraken test... 14:09:05 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpYOd05i/profile http://localhost:49278/getInfo.html) 14:09:07 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 14:09:07 INFO - PROCESS | 1667 | colorDepth:24 14:09:07 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 14:09:07 INFO - PROCESS | 1667 | __metrics 14:09:07 INFO - PROCESS | 1667 | 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" 14:09:07 ERROR - PROCESS | 1667 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:09:08 INFO - TEST-INFO | 1667: exit 0 14:09:08 INFO - Browser initialized. 14:09:08 INFO - Running cycle 1/1 for kraken test... 14:09:08 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpYOd05i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:20 INFO - PROCESS | 1669 | RSS: Main: 211365888 14:09:20 INFO - PROCESS | 1669 | 14:09:23 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 14:09:24 INFO - PROCESS | 1669 | RSS: Main: 272203776 14:09:24 INFO - PROCESS | 1669 | 14:09:27 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 14:09:27 INFO - PROCESS | 1669 | RSS: Main: 286572544 14:09:27 INFO - PROCESS | 1669 | 14:09:30 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 14:09:31 INFO - PROCESS | 1669 | RSS: Main: 374562816 14:09:31 INFO - PROCESS | 1669 | 14:09:33 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 14:09:34 INFO - PROCESS | 1669 | RSS: Main: 280305664 14:09:34 INFO - PROCESS | 1669 | 14:09:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:09:36 INFO - PROCESS | 1669 | RSS: Main: 280666112 14:09:36 INFO - PROCESS | 1669 | 14:09:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 14:09:40 INFO - PROCESS | 1669 | RSS: Main: 319213568 14:09:40 INFO - PROCESS | 1669 | 14:09:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 14:09:43 INFO - PROCESS | 1669 | RSS: Main: 320417792 14:09:43 INFO - PROCESS | 1669 | 14:09:46 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 14:09:47 INFO - PROCESS | 1669 | RSS: Main: 317935616 14:09:47 INFO - PROCESS | 1669 | 14:09:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:09:49 INFO - PROCESS | 1669 | RSS: Main: 310067200 14:09:49 INFO - PROCESS | 1669 | 14:09:51 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:09:52 INFO - PROCESS | 1669 | RSS: Main: 317612032 14:09:52 INFO - PROCESS | 1669 | 14:09:54 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:09:54 INFO - PROCESS | 1669 | RSS: Main: 319627264 14:09:54 INFO - PROCESS | 1669 | 14:09:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:09:58 INFO - PROCESS | 1669 | RSS: Main: 325169152 14:09:58 INFO - PROCESS | 1669 | 14:10:01 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:10:01 INFO - PROCESS | 1669 | RSS: Main: 322830336 14:10:01 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 14:10:03 INFO - PROCESS | 1669 | RSS: Main: 386912256 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | __start_tp_report 14:10:03 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 14:10:03 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 14:10:03 INFO - PROCESS | 1669 | |i|pagename|runs| 14:10:03 INFO - PROCESS | 1669 | |0;ai-astar;114;122;172;150;112;112;114;115;113;134 14:10:03 INFO - PROCESS | 1669 | |1;audio-beat-detection;158;123;159;182;150;141;167;110;196;151 14:10:03 INFO - PROCESS | 1669 | |2;audio-dft;186;185;187;186;187;184;186;186;182;186 14:10:03 INFO - PROCESS | 1669 | |3;audio-fft;67;77;71;148;74;87;83;97;168;58 14:10:03 INFO - PROCESS | 1669 | |4;audio-oscillator;96;94;136;64;80;86;126;79;77;124 14:10:03 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;87;85;87;83;88;84;89;84;87;85 14:10:03 INFO - PROCESS | 1669 | |6;imaging-darkroom;93;94;94;94;94;93;93;104;142;93 14:10:03 INFO - PROCESS | 1669 | |7;imaging-desaturate;84;84;85;86;86;84;84;86;82;140 14:10:03 INFO - PROCESS | 1669 | |8;json-parse-financial;61;65;64;62;64;65;64;84;58;58 14:10:03 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;63;64;68;71;77;73;69;68;69;69 14:10:03 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;83;83;80;80;78;82;81;79;81;85 14:10:03 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;136;145;145;126;128;129;132;157;136;156 14:10:03 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;187;167;152;160;176;169;167;162;171;199 14:10:03 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;67;66;66;67;67;69;66;66;67;76 14:10:03 INFO - PROCESS | 1669 | __end_tp_report 14:10:03 INFO - PROCESS | 1669 | __start_cc_report 14:10:03 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,2058 14:10:03 INFO - PROCESS | 1669 | __end_cc_report 14:10:03 INFO - PROCESS | 1669 | __startTimestamp1463433003722__endTimestamp 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | ------- Summary: start ------- 14:10:03 INFO - PROCESS | 1669 | Number of tests: 14 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:125.80 Median:118.50 stddev:20.39 (17.2%) stddev-sans-first:21.17 14:10:03 INFO - PROCESS | 1669 | Values: 114.0 122.0 172.0 150.0 112.0 112.0 114.0 115.0 113.0 134.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:158.50 stddev:25.49 (16.1%) stddev-sans-first:26.99 14:10:03 INFO - PROCESS | 1669 | Values: 158.0 123.0 159.0 182.0 150.0 141.0 167.0 110.0 196.0 151.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:185.50 Median:186.00 stddev:1.51 (0.8%) stddev-sans-first:1.59 14:10:03 INFO - PROCESS | 1669 | Values: 186.0 185.0 187.0 186.0 187.0 184.0 186.0 186.0 182.0 186.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.50 stddev:36.22 (48.0%) stddev-sans-first:37.17 14:10:03 INFO - PROCESS | 1669 | Values: 67.0 77.0 71.0 148.0 74.0 87.0 83.0 97.0 168.0 58.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:79.50 stddev:24.31 (30.6%) stddev-sans-first:25.78 14:10:03 INFO - PROCESS | 1669 | Values: 96.0 94.0 136.0 64.0 80.0 86.0 126.0 79.0 77.0 124.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:1.97 (2.3%) stddev-sans-first:2.05 14:10:03 INFO - PROCESS | 1669 | Values: 87.0 85.0 87.0 83.0 88.0 84.0 89.0 84.0 87.0 85.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:99.40 Median:93.50 stddev:15.33 (16.4%) stddev-sans-first:16.09 14:10:03 INFO - PROCESS | 1669 | Values: 93.0 94.0 94.0 94.0 94.0 93.0 93.0 104.0 142.0 93.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:90.10 Median:84.50 stddev:17.58 (20.8%) stddev-sans-first:18.51 14:10:03 INFO - PROCESS | 1669 | Values: 84.0 84.0 85.0 86.0 86.0 84.0 84.0 86.0 82.0 140.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.00 stddev:7.34 (11.5%) stddev-sans-first:7.67 14:10:03 INFO - PROCESS | 1669 | Values: 61.0 65.0 64.0 62.0 64.0 65.0 64.0 84.0 58.0 58.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:4.04 (5.9%) stddev-sans-first:3.63 14:10:03 INFO - PROCESS | 1669 | Values: 63.0 64.0 68.0 71.0 77.0 73.0 69.0 68.0 69.0 69.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.50 stddev:2.10 (2.6%) stddev-sans-first:2.12 14:10:03 INFO - PROCESS | 1669 | Values: 83.0 83.0 80.0 80.0 78.0 82.0 81.0 79.0 81.0 85.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:140.50 stddev:11.26 (8.0%) stddev-sans-first:11.90 14:10:03 INFO - PROCESS | 1669 | Values: 136.0 145.0 145.0 126.0 128.0 129.0 132.0 157.0 136.0 156.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:170.00 stddev:13.60 (8.0%) stddev-sans-first:13.13 14:10:03 INFO - PROCESS | 1669 | Values: 187.0 167.0 152.0 160.0 176.0 169.0 167.0 162.0 171.0 199.0 14:10:03 INFO - PROCESS | 1669 | 14:10:03 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:3.06 (4.6%) stddev-sans-first:3.23 14:10:03 INFO - PROCESS | 1669 | Values: 67.0 66.0 66.0 67.0 67.0 69.0 66.0 66.0 67.0 76.0 14:10:03 INFO - PROCESS | 1669 | -------- Summary: end -------- 14:10:03 INFO - PROCESS | 1669 | 14:10:04 INFO - TEST-INFO | 1669: exit 0 14:10:04 INFO - TEST-OK | kraken | took 59179ms 14:10:04 INFO - SUITE-END | took 1174s 14:10:04 INFO - Completed test suite (00:19:34) 14:10:04 INFO - javascript benchmark 14:10:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3167.461531539638, 3475.8088305143215, 3479.8608055677773, 3484.442489201728, 3544.308859772344, 5143.639945203838, 5684.232628595133, 5709.1436284557285, 5725.227094342263, 5730.656160630355, 5756.712164391784, 5826.126081087828, 5828.562857785672, 5832.329282132556, 5841.7955371562, 5135.383753949532, 5164.767585458663, 5197.506236907488, 5277.525022747952, 5316.627836051478, 5291.841244762663, 5300.734963251822, 5303.151495760679, 5303.23103150043, 5304.416514183436, 5222.112240919053, 5246.5278124968745, 5286.947130528684, 5287.339082614673, 5291.153415453528, 5283.682979021271, 5315.946840531584, 5317.707526086064, 5336.599755018389, 5341.599380046512, 5132.461091585367, 5158.767855446514, 5183.611229157828, 5259.211118332242, 5259.316288882421, 5653.604247702662, 5689.431056894319, 5698.401667824902, 5702.942970570282, 5758.971205143989, 6230.813075607739, 6259.37406259375, 6259.499240060784, 6269.7178626961895, 6282.340354262782, 6141.877162456771, 6182.598131121463, 6254.906176407358, 6278.717457714368, 6280.654563998978, 4937.432195297587, 5906.822795316148, 5936.465718085393, 5954.5534084943365, 5988.550858685572, 6354.936450635527, 6364.077208804697, 6367.458766004849, 6369.0, 6375.075614035939, 6090.878182436327, 6139.171211886427, 6161.72272247741, 6219.626822390671, 6228.564000520011, 6252.5935814171935, 6267.717952692049, 6277.183966084471, 6299.527535434769, 6305.306416294204, 6197.845053873599, 6258.624482530971, 6276.717547710364, 6278.466330361879, 6289.842753931189, 6142.815715528542, 6169.784057557964, 6198.473129784019, 6204.782832600928, 6240.65676387794, 4921.261810728348, 4941.530554597308, 4955.603551715854, 4969.577585905238, 5010.323606313174, 3673.7979411132646, 4425.982024134402, 4426.136903303889, 4428.557144285545, 4456.68803183774, 5649.265595472644, 5792.913106303409, 5795.710214489259, 5796.681182535001, 5805.983952808242, 6192.59748116371, 6244.313125556185, 6322.525810564226, 6329.651869147149, 6336.239651241881, 5707.6575405475805, 5775.815957728655, 5784.681842498703, 5809.24479817621, 5848.093545500455, 5351.86620334487, 5432.972835135878, 5442.863928401822, 5460.590455715837, 5465.863353416196, 6298.433141017239, 6324.083007963727, 6399.55203135776, 6407.967960160169, 6418.454431373386, 5304.708241046779, 6277.435030847246, 6299.023651334051, 6307.085472606538, 6315.96842015787, 6261.24865016201, 6333.081703153109, 6386.90419643715, 6410.1987251593555, 6416.422521973045, 5087.389513258285, 6153.384661533811, 6249.875002500015, 6262.405071518198, 6274.592151510137, 6264.874702506016, 6321.652309123042, 6323.525735569759, 6324.462420694109, 6331.683415829282, 6130.816075517741, 6167.969160154171, 6194.5973511721595, 6208.348123446973, 6214.223222097238, 5960.374160713062, 6130.356312587114, 6137.560853825989, 6138.541671868701, 6199.690015499297, 6012.128241404885, 6013.548983826143, 6015.4586087252355, 6036.63780173191, 6044.304904935812, 6003.579749417673, 6183.227096612924, 6191.380861913773, 6202.56582039271, 6206.534509911684, 5900.232969713909, 5941.613795103304, 5963.105534169736, 5984.461398473984, 5986.07215881539], "value": 5729.168153239163, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.53306957599006, 523.6962561714206, 580.4978693430185, 593.9703014849258, 619.0775744141229, 30681.0, 38014.0, 38814.611853881455, 38907.0, 39096.80451597745, 40781.7960910195, 41224.0, 41245.38131928023, 41342.0, 41451.0, 8502.14978502148, 9372.156505914483, 9712.70861874145, 9712.902870971271, 9715.27135464843, 8571.871421928676, 8694.913050869474, 8699.99950005751, 8707.0, 9650.5174741263, 11507.194496385257, 11579.305241685526, 11597.130215233849, 11597.24617899838, 11673.941630291836, 11703.414829258503, 11832.290062596272, 11835.408229588485, 11842.7631447371, 11849.763004739943, 8648.35137364694, 11482.942585287105, 11622.07023438123, 11696.064314854877, 11726.589569365031, 38103.61896381029, 38464.615353846384, 38480.0, 38587.8070609648, 38691.0, 3087.536869469575, 3277.8197199154038, 3290.654481279455, 3435.7251419886597, 3705.0366904605, 22968.196113136128, 27248.04631837896, 28482.0, 29014.12957611275, 30412.239694007607, 2373.988130059356, 2673.3717576369536, 2688.7042425333198, 2770.127409865906, 2791.0649932272713, 431329.0, 434220.8288958567, 435354.0, 436114.0, 436166.0, 62391.37608623946, 62647.68676156681, 62867.0, 63113.684431577545, 63125.36874631195, 64974.67512662406, 65357.0, 65370.673146634916, 65459.345406545326, 65505.0, 17105.91447042782, 17728.29086836538, 17733.202005909767, 17748.112594370228, 17786.199621017084, 11496.42517874103, 13513.459461621425, 13546.051776375756, 13548.983826213074, 13579.185248885098, 16650.916745416438, 17036.403725869783, 18851.24595016184, 19356.32252871143, 19383.4184974451, 7589.43079269057, 7834.373250140089, 8030.799230019296, 8062.879056814152, 8068.8386232275025, 857.2884505860121, 922.2115091596588, 922.276013329533, 999.2954966748425, 1087.494315143462, 27899.721002790116, 28376.574351384745, 29094.563581546292, 29143.417131657247, 29219.56170657442, 1024.8565200871883, 1040.6461802987021, 1091.6888686724246, 1143.868455127671, 1235.721962558417, 13985.440582376794, 14269.571912842424, 14271.0, 14598.0, 14689.485867994568, 531505.0, 544151.0, 570789.0, 575193.0, 580671.0, 59265.407345926855, 59557.0, 59628.10557841636, 59804.40195598076, 59944.0, 1372.5950844500896, 1433.376481230668, 1511.3803340630288, 1524.4359586952899, 1531.4410240262223, 24346.75653243445, 29473.85263073671, 29803.85098074496, 29882.0, 30571.54142687906, 48828.0234395303, 48865.755671221414, 49575.50424495709, 49596.25605615846, 49740.0, 569730.0, 596345.0, 596647.0, 597356.0, 598276.0, 35749.64250357463, 42527.362089568065, 43101.78449107734, 43614.0, 43872.0, 44803.0, 44843.55156448394, 45803.77098114488, 45979.31031034604, 46099.30851037304, 37853.242935140595, 38935.22129557336, 38998.61001390063, 39117.60882391254, 39681.80159099186, 37556.624433756406, 38486.6151338483, 38510.80744596259, 39323.803380982914, 39532.80233598813, 37929.4310585347, 38390.040248993995, 38626.0, 39010.0, 39191.0, 30778.076657700305, 33940.83029584836, 34160.82919585386, 34254.0, 34410.82794586011, 21927.38887039969, 25283.620745689197, 25377.0, 25854.61218081768, 25861.870690646425], "value": 20228.87657328274, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.54791606324204, 405.1916426728676, 407.1064014488198, 408.8957315884449, 418.9832406703732, 15144.924275378607, 15477.845221547781, 16972.0, 19919.900400497994, 20581.0, 19752.0, 20154.19383224673, 20184.293549725764, 20364.796352036476, 20775.065122069504, 5822.243108395903, 6156.6613836238985, 6159.076138579204, 6164.630122192661, 6166.167567378414, 3266.6243382011135, 4111.198316328318, 5588.245586845785, 5796.30444346679, 5874.265716785402, 6032.034874420094, 6052.909206361908, 6072.119542666311, 6072.119542666333, 6077.908831367533, 5991.970040149793, 6038.939610603904, 6234.688265586702, 6630.436412904909, 6651.86696266072, 5413.781899072716, 5582.302212223472, 5848.7075646217945, 5872.5889187756875, 5891.8527036824, 13641.522546710918, 25311.734413279446, 25938.962441502317, 26123.477530449476, 26323.605145922826, 1864.7089878574843, 2095.863768855035, 2165.436986383536, 2408.8193385496156, 2657.5747880339245, 10027.247956403298, 10038.899611003942, 10089.697309080666, 10251.0, 14425.855741442556, 1681.411505972912, 1726.1369315342329, 1771.8051014388407, 1802.7115661494097, 1880.7774946284887, 112022.43988780004, 115674.0, 116735.0, 118423.0, 119622.0, 11692.649220523397, 11807.763844723057, 11827.231229970024, 11828.757980412105, 11858.525658973716, 15267.0, 15272.389104435699, 15276.618084547976, 15280.083195008336, 15299.847001530065, 8880.1563851434, 8914.910850891538, 8915.0, 9021.774455638662, 9038.593263303168, 8911.197992180734, 8929.285657147413, 8940.195382415613, 9051.27589792815, 9055.094490551024, 3965.20695860829, 4567.2464043432465, 4638.582527572535, 4643.930341044887, 4712.363830882856, 1742.8513274922689, 1799.813226929287, 1940.6118776244807, 1948.5713143108494, 1969.1631056801089, 897.5915958238986, 922.5341202692597, 946.1201082992745, 968.5931908598405, 994.4778991029767, 19265.0, 20242.291519796738, 20441.182352706022, 20493.07781149852, 20530.897345513178, 979.1187930862138, 991.9702408927744, 996.9351992120489, 1002.8194924913586, 1051.9053285204368, 10675.306105103144, 10874.891251087387, 10881.346121218876, 10938.289011214245, 10978.835317470244, 589262.0, 589539.0, 590006.0, 633657.1585710394, 639823.0, 126328.36835815762, 132950.33524832313, 134458.0, 139176.0, 140270.0, 909.5361365703538, 943.6461327002374, 1066.051214419152, 1095.769888323461, 1114.8662160540787, 14589.562313130624, 14909.0, 18276.90861545737, 18629.72055419197, 18671.6265674683, 39674.206515868944, 41763.7911810439, 49569.752151239016, 51700.70748231174, 52124.739376302874, 80194.39611207627, 80195.59902200452, 83337.0, 83979.0, 85739.0, 8297.211764882326, 8314.833703326021, 8359.66561337564, 8432.620532075949, 8686.261667758312, 7710.807229819075, 9709.417434953926, 10350.223733219887, 12153.453094610586, 13063.804042939173, 11111.444427778417, 11232.943835280772, 11303.095752339628, 11403.258788178742, 11448.0, 10580.947095264475, 10859.2398532102, 10920.836187457036, 11182.440877955907, 11275.943620281847, 11027.889721102687, 11403.486843091914, 11633.941830290794, 11651.941740291244, 11729.47217375203, 8320.209580089882, 8371.37214708887, 8450.577471126542, 8477.660893564189, 8597.0, 8403.831923361377, 11466.827997579876, 11678.532858685558, 11779.52881884715, 11836.467358968695], "value": 9548.506434603398, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.6988497473042, 1531.5405378386486, 1552.9223538823055, 1754.350890170637, 1892.5741708115684, 7816.882746758796, 8027.197280271985, 8037.236462536064, 8041.87937180942, 8058.033036035684, 8264.462809917351, 8518.87221691675, 8524.190201930822, 8533.573321333939, 8544.316454683625, 2403.1709060374187, 2473.727889932106, 2481.081999660128, 2483.888225029869, 2484.7391023942496, 2407.265783935899, 2458.9508209835794, 2460.2619214235747, 2462.224399314219, 2465.642481840132, 2406.109739396426, 2431.185552839801, 2454.128784281581, 2455.435249892526, 2457.348802567321, 2418.3071849705275, 2427.6237183236626, 2452.3746444656585, 2459.9139030133947, 2460.950780984388, 2059.4851287178208, 2383.0348708772976, 2389.7012873390827, 2437.293184976355, 2437.9146729864547, 7185.0, 8726.738197854074, 8728.432651877607, 8731.126887311282, 8770.0, 4480.283154695266, 5323.893522129536, 5435.42927992559, 5447.809326673587, 5496.203050557687, 3478.3565040467342, 3529.7882127072457, 3551.8401671924826, 3591.3535563598543, 3620.7827530348, 1023.2888142740799, 1030.3920686794827, 1047.738065483629, 1052.9473526323652, 1054.8839627640953, 11392.487338069725, 11460.0, 11460.312381257068, 11495.0, 11509.539618415254, 4464.062546865194, 4521.864344069683, 4590.242609969385, 4601.907961840744, 4696.459907110658, 8987.51705968521, 9287.303452241109, 9349.90650093504, 9352.0, 9353.579088941015, 4076.9796151019054, 5225.268462415265, 5277.656952298088, 5319.441458646864, 5326.280952071498, 4369.191699535596, 4443.822247110079, 4486.887827804331, 4488.663350248679, 4947.925781113287, 3576.9821150894077, 3605.521736088191, 3635.1457407509215, 3839.788811615332, 3911.6675082617726, 1181.8345431639577, 1224.8897599215936, 1228.4778968938165, 1235.8764123587569, 1235.932023738685, 831.995840020796, 893.066745251214, 894.1952242981239, 904.9185573298303, 933.9953300233456, 5484.506394424441, 5643.322801263875, 5749.137629355547, 5793.15999180125, 5814.76740930358, 947.8104379124203, 951.8239125761756, 952.7903861150675, 975.024975024975, 1004.2568499310457, 3647.76289541179, 3785.886423407302, 3803.964078645097, 3814.0846196913094, 3844.961550384516, 10451.738706532245, 10688.572457101784, 10738.838917416246, 10861.185411094042, 10867.130629549618, 10733.195010374253, 10738.409387483607, 10742.0, 10749.83875241872, 10759.784804304027, 7167.247439018932, 8359.749207523662, 8416.705415310435, 8445.366597505212, 8502.277306429023, 4648.2562789953445, 5531.197976293334, 5604.355499117653, 5632.802851900164, 5780.248567686174, 9012.909870901207, 9203.953980230055, 9443.291753118407, 9564.139227469283, 9595.808083838145, 9504.667336643184, 9859.063388978035, 9876.85184722244, 9880.20958323318, 9917.950410247902, 7430.591317477374, 7609.467337286558, 7649.082110146818, 7651.464397492122, 7679.884801728091, 7436.330730234305, 7611.467197296136, 8115.878261826196, 8277.130901255281, 8307.252347288773, 7528.284812942762, 7573.242675732603, 7595.354394876497, 7727.11138219112, 7758.92241077582, 7398.2231865655485, 7398.408127349907, 7448.92551074504, 7481.588512631857, 7592.81017974555, 6594.340565943367, 6653.403183235891, 6657.234418041793, 6659.234188068434, 6662.100616416722, 4856.514348565115, 4969.652124351405, 4978.6763860348965, 4991.975040124777, 5014.147594908947, 4977.402711674622, 5005.149124648891, 5005.7997680092385, 5101.617378696538, 5212.9739351303], "value": 4520.832024126077, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.83963060870605, 316.7212852689634, 326.6537470281501, 330.7701147702345, 333.1288680101534, 6406.551541392105, 6493.188351456068, 6504.544681872271, 6520.445762110215, 6521.673916304189, 6224.470919971808, 6397.616143031421, 6425.48596112311, 6441.516886233528, 6457.935420645792, 3866.574676785551, 4737.170995075848, 4751.192297309449, 4760.8333708320215, 4772.732951847879, 4764.952350476503, 4773.427188737339, 4776.689515181502, 4780.211265141265, 4788.90422191556, 4716.97641511792, 4724.3858298421155, 4729.62163026957, 4731.57415832575, 4738.431388233417, 4730.361401210827, 4733.171694953404, 4747.074320507502, 4749.691270067469, 4764.047190561884, 3917.275304068728, 4044.9685330240895, 4052.2908491013955, 4065.3292206785845, 4075.49056367954, 5031.597472202215, 6126.356732543063, 6189.783357582463, 6243.125962365272, 6247.468965137923, 5482.725863706799, 5515.0, 5528.281323427928, 5531.3915469298345, 5533.667979921218, 6132.540059495555, 6290.836195303884, 6873.450123990069, 6877.862442751117, 6891.862162756767, 3870.632289932452, 4193.224253513079, 4488.7531185784765, 4505.932411013838, 4523.5024147343765, 5935.198748168985, 6407.359264073602, 6928.064711263965, 7178.4616153788675, 7313.378362839165, 4504.887377815581, 4521.208788462006, 4533.38799262102, 4548.044910568751, 4573.49691533931, 4043.636072753466, 4657.0, 4662.766861656972, 4662.997455547006, 4668.486466488684, 5206.323177986837, 5334.359876814729, 5440.884618653166, 5513.3108361454815, 5513.62159460135, 6795.490338224554, 6811.795646130624, 6811.897821532681, 6822.692978815965, 6868.9313106869295, 1577.629257124575, 1599.9120048397217, 1605.4621701729818, 1605.9116748578706, 1606.4939544043589, 1002.318423472046, 1011.4083261292079, 1025.9794804103876, 1028.619410818002, 1036.5231993283023, 6447.2263328400895, 6458.741650333934, 6477.870442591122, 6478.190226221723, 6496.317886621931, 7209.630170267632, 7211.134663840267, 7222.674979625929, 7234.674439650228, 7239.420846332281, 5301.257823904656, 6464.062710906892, 6473.449756770633, 6474.12599299098, 6477.352264773485, 3755.6432138946757, 3801.125741079567, 3812.1613245086037, 3817.541894972621, 3822.0827001519433, 7149.0, 7502.474826762074, 7511.248875112555, 7516.812079697942, 7547.811304717426, 7386.446016548781, 7415.3326200642205, 7420.962895185489, 7447.031885854804, 7447.5531468112085, 7245.275472452818, 7365.410767138616, 7398.334149926425, 7509.549427034395, 7518.248175182438, 7264.89102663471, 7264.963675181802, 7275.1997280298065, 7294.890576641248, 7295.562266264041, 7129.144502659714, 7132.607706576188, 7152.356287934111, 7161.856762864818, 7169.856602867809, 6078.095065190624, 7515.661795219337, 7578.962105189439, 7594.050743657043, 7599.240075992357, 4532.546745325573, 4564.680472367036, 4575.222212223864, 4576.222042252892, 4584.426946631671, 7172.246914073947, 7178.353948144692, 7191.316824901626, 7194.460415468756, 7216.314450127229, 6953.304669533006, 6957.652117394211, 6964.616946067812, 6967.407770339375, 6979.162500499972, 6627.900581491185, 6924.619145947021, 6929.5842249465195, 6938.5143039986715, 6944.722211111499, 6736.7873782717625, 6750.86498270022, 6754.358335958076, 6771.661416929035, 6803.489738269748, 6271.341509141657, 6707.960266158753, 6969.512134150764, 6970.372666460043, 6970.930290697028, 6775.62734049632, 6783.253842077269, 6797.66011699423, 6810.829729256809, 6814.829629259309], "value": 5024.224740478071, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.1257122026975, 681.7511608262986, 686.3342557719011, 732.3152852083306, 748.985020299594, 15016.249187540634, 15051.774223386645, 15273.465428709997, 15288.770668439982, 15304.540863774091, 14335.641608959755, 14365.640858978531, 14374.20941848198, 14381.065230759994, 14403.567892963201, 728.4318231779221, 736.469741785916, 737.5795796396056, 739.8113481062348, 896.1576118448654, 727.5525551785666, 897.6274845938927, 932.1051790281338, 932.5849996751448, 933.5099072986668, 957.6887511558737, 975.6438899801592, 977.359829311802, 978.149010360987, 981.205223768746, 762.3786613909646, 952.9523523823816, 966.2946049383954, 966.5264020629841, 968.3705591365633, 713.6574444266781, 726.9018682477904, 729.5950747335227, 731.3783284208433, 732.8094695379186, 12217.877821221762, 14480.637984050378, 14531.0, 14552.781708274384, 14558.563243102619, 12627.873721262762, 12640.810387844189, 12732.936335318263, 12938.48246070156, 13208.273544955024, 10009.999000099931, 10078.798424031478, 10247.487625618689, 10343.32768370061, 10679.34715308217, 2929.985350073236, 3434.9656503434894, 3508.7193024557973, 3537.4163263061564, 3556.2354093869685, 85556.14443855544, 85983.71024434638, 86285.0, 87543.0, 88549.0, 9714.611415543299, 9731.172850307661, 9754.024597540189, 9912.801743965081, 10476.580936762597, 21816.563668726536, 22015.779842201693, 22266.777332226793, 22290.888545557493, 22345.888270558542, 7472.775816725507, 7475.813104672318, 7627.199144089902, 7738.806529836799, 7750.302472777477, 3860.2279544091293, 3924.50943632046, 3977.085270387827, 4106.589341065929, 4149.647279981235, 3547.7693949893173, 3638.6179451157777, 3648.1791596891017, 3649.59854416014, 3656.323580137683, 547.9397266300704, 631.9178506794179, 652.8204743695521, 663.8240866170469, 678.9049533065374, 540.9756560954767, 545.2693390856192, 586.5835256967515, 598.87423641035, 618.4990157972057, 7659.770206893802, 8161.836763264701, 8511.787205319917, 8625.964884213934, 8727.694530691395, 521.272824409946, 577.2005772005718, 618.2426527503771, 620.1318154583529, 633.965131917749, 3140.309131990958, 3479.460683594047, 3765.1528406108955, 3831.1379939513386, 3859.5947425520476, 94489.5275523618, 94676.52661736647, 96251.0, 96296.0, 96417.51791241, 73306.0, 73857.0, 77954.0, 78925.0, 80636.79044814332, 54382.0, 70969.0, 71334.64332678303, 71978.0, 72368.0, 7982.840343192987, 8325.333973282002, 8550.74347769568, 8656.740297791077, 8671.34964877624, 48789.0, 48933.0, 49085.77285567889, 49807.75096124641, 50046.499535004186, 67385.66307168432, 71596.28403715896, 72059.51464368022, 72107.63946180236, 73922.26077739369, 10732.570697172026, 10740.624078157227, 11126.165537584875, 11140.10879129684, 11178.329300242012, 11599.942000289944, 12025.158238923192, 12058.276503409823, 12462.43919023628, 12572.994160466958, 11109.888901110886, 11412.885871141183, 11424.257423267461, 11605.30368177912, 11657.708557285796, 11265.436728163722, 11298.983091521473, 11505.539778408769, 11729.648110556696, 11736.823947640622, 10827.296225745302, 10941.37407022293, 11189.944050279697, 11237.662870113909, 11906.821397679216, 8177.4684645497855, 9214.44713317203, 9266.768330791785, 9570.425774453555, 9726.70819875405, 8441.535715535705, 9015.323850711355, 9412.529373531434, 9664.275179361435, 9722.611095556098], "value": 6890.480203497004, "unit": "score"}], "name": "dromaeo_css", "value": 7466.134811384074, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 122.0, 172.0, 150.0, 112.0, 112.0, 114.0, 115.0, 113.0, 134.0], "value": 125.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 123.0, 159.0, 182.0, 150.0, 141.0, 167.0, 110.0, 196.0, 151.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 187.0, 186.0, 187.0, 184.0, 186.0, 186.0, 182.0, 186.0], "value": 185.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 77.0, 71.0, 148.0, 74.0, 87.0, 83.0, 97.0, 168.0, 58.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 136.0, 64.0, 80.0, 86.0, 126.0, 79.0, 77.0, 124.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 83.0, 88.0, 84.0, 89.0, 84.0, 87.0, 85.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 104.0, 142.0, 93.0], "value": 99.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 86.0, 86.0, 84.0, 84.0, 86.0, 82.0, 140.0], "value": 90.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 64.0, 62.0, 64.0, 65.0, 64.0, 84.0, 58.0, 58.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 68.0, 71.0, 77.0, 73.0, 69.0, 68.0, 69.0, 69.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 80.0, 80.0, 78.0, 82.0, 81.0, 79.0, 81.0, 85.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 145.0, 145.0, 126.0, 128.0, 129.0, 132.0, 157.0, 136.0, 156.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 167.0, 152.0, 160.0, 176.0, 169.0, 167.0, 162.0, 171.0, 199.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 69.0, 66.0, 66.0, 67.0, 76.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1522.1000000000001, "alertThreshold": 2.0}]} 14:10:04 INFO - Return code: 0 14:10:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:10:05 ERROR - # TBPL SUCCESS # 14:10:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:10:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:10:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:10:05 INFO - 2016-05-16 14:10:05.020 screenresolution[1673:10058] starting screenresolution argv=screenresolution get 14:10:05 INFO - 2016-05-16 14:10:05.022 screenresolution[1673:10058] Display 0: 1600x1200x32@60 14:10:05 INFO - 2016-05-16 14:10:05.028 screenresolution[1674:10061] starting screenresolution argv=screenresolution list 14:10:05 INFO - Available Modes on Display 0 14:10:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:10:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:10:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:10:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:10:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:10:05 INFO - Intel Iris: 14:10:05 INFO - Chipset Model: Intel Iris 14:10:05 INFO - Type: GPU 14:10:05 INFO - Bus: Built-In 14:10:05 INFO - VRAM (Dynamic, Max): 1536 MB 14:10:05 INFO - Vendor: Intel (0x8086) 14:10:05 INFO - Device ID: 0x0a2e 14:10:05 INFO - Revision ID: 0x0009 14:10:05 INFO - Displays: 14:10:05 INFO - Display: 14:10:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:10:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:10:05 INFO - Display Serial Number: 1600x1200 60 14:10:05 INFO - Main Display: Yes 14:10:05 INFO - Mirror: Off 14:10:05 INFO - Online: Yes 14:10:05 INFO - Rotation: Supported 14:10:05 INFO - Return code: 0 14:10:05 INFO - Running post-action listener: _resource_record_post_action 14:10:05 INFO - Running post-run listener: _resource_record_post_run 14:10:06 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37967360; Write bytes: 653979136; Read time: 425; Write time: 1993 14:10:06 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 342602240; Write bytes: 337016320; Read time: 26474; Write time: 646 14:10:06 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 37012992; Write bytes: 297625600; Read time: 403; Write time: 1297 14:10:06 INFO - Running post-run listener: _upload_blobber_files 14:10:06 INFO - Blob upload gear active. 14:10:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:10:06 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 14:10:06 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:10:06 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:10:06 INFO - (blobuploader) - INFO - Open directory for files ... 14:10:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:10:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:10:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:08 INFO - (blobuploader) - INFO - Done attempting. 14:10:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:10:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:10:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:09 INFO - (blobuploader) - INFO - Done attempting. 14:10:09 INFO - (blobuploader) - INFO - Iteration through files over. 14:10:09 INFO - Return code: 0 14:10:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:10:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:10:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ae4d94f9a36a039bfd0e12f4ba71234f5de953a19d700c73d7aa90a26c03213140cb69c2ed5e75b8f736c3e5459ba74f075cb619eadc2f6712bc62e7d9d7614", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/591baa990d7a8e81b9709a44cbb15fce9a118844ee98e41832bcbf56f32539fc2d2df4fc2ce0acf3374626d6487ced9732e41a5a6ffd229b72758332c0865a74"} 14:10:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:10:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:10:09 INFO - Contents: 14:10:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ae4d94f9a36a039bfd0e12f4ba71234f5de953a19d700c73d7aa90a26c03213140cb69c2ed5e75b8f736c3e5459ba74f075cb619eadc2f6712bc62e7d9d7614", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/591baa990d7a8e81b9709a44cbb15fce9a118844ee98e41832bcbf56f32539fc2d2df4fc2ce0acf3374626d6487ced9732e41a5a6ffd229b72758332c0865a74"} 14:10:09 INFO - Running post-run listener: copy_logs_to_upload_dir 14:10:09 INFO - Copying logs to upload dir... 14:10:09 INFO - mkdir: /builds/slave/test/build/upload/logs 14:10:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.728882 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-16 14:10:09.132301) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 14:10:09.136342) ========= 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.61EbGqIk7y/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.WolwrQkj9C/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-Aurora/sha512/0ae4d94f9a36a039bfd0e12f4ba71234f5de953a19d700c73d7aa90a26c03213140cb69c2ed5e75b8f736c3e5459ba74f075cb619eadc2f6712bc62e7d9d7614", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/591baa990d7a8e81b9709a44cbb15fce9a118844ee98e41832bcbf56f32539fc2d2df4fc2ce0acf3374626d6487ced9732e41a5a6ffd229b72758332c0865a74"} build_url:https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011151 build_url: 'https://queue.taskcluster.net/v1/task/BHfYKtMzTuy974xb02XETA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ae4d94f9a36a039bfd0e12f4ba71234f5de953a19d700c73d7aa90a26c03213140cb69c2ed5e75b8f736c3e5459ba74f075cb619eadc2f6712bc62e7d9d7614", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/591baa990d7a8e81b9709a44cbb15fce9a118844ee98e41832bcbf56f32539fc2d2df4fc2ce0acf3374626d6487ced9732e41a5a6ffd229b72758332c0865a74"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 14:10:09.164854) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:10:09.165263) ========= 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.61EbGqIk7y/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.WolwrQkj9C/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005084 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:10:09.214514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 14:10:09.214863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 14:10:09.215229) ========= ========= Total master_lag: 1.19 =========