builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0015 starttime: 1460646864.46 results: success (0) buildid: 20160414071051 builduid: 84c751fb1d734afa955c68997472d991 revision: 7bb53c007a2ecde84e470b86ee3ec39fccea9518 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 08:14:24.463754) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 08:14:24.464212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 08:14:24.464494) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 08:14:24.550551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:14:24.550927) ========= 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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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-04-14 08:14:25-- 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% 148M=0s 2016-04-14 08:14:25 (148 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144219 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:14:24.711433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:14:24.711744) ========= 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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.020748 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:14:24.760199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 08:14:24.760543) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7bb53c007a2ecde84e470b86ee3ec39fccea9518 --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 7bb53c007a2ecde84e470b86ee3ec39fccea9518 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tVBMwnIzmK/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.nRUSVZMn2f/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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-04-14 08:14:25,343 truncating revision to first 12 chars 2016-04-14 08:14:25,343 Setting DEBUG logging. 2016-04-14 08:14:25,343 attempt 1/10 2016-04-14 08:14:25,343 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7bb53c007a2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 08:14:26,395 unpacking tar archive at: mozilla-aurora-7bb53c007a2e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.301931 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 08:14:26.079607) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 08:14:26.079956) ========= script_repo_revision: 7bb53c007a2ecde84e470b86ee3ec39fccea9518 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 08:14:26.080390) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 08:14:26.080657) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 08:14:26.095297) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-14 08:14:26.095685) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:14:26 INFO - MultiFileLogger online at 20160414 08:14:26 in /builds/slave/test 08:14:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:14:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:26 INFO - {'append_to_log': False, 08:14:26 INFO - 'base_work_dir': '/builds/slave/test', 08:14:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:14:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:26 INFO - 'branch': 'Mozilla-Aurora', 08:14:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:26 INFO - 'config_files': ('talos/mac_config.py',), 08:14:26 INFO - 'default_actions': ('clobber', 08:14:26 INFO - 'read-buildbot-config', 08:14:26 INFO - 'download-and-extract', 08:14:26 INFO - 'populate-webroot', 08:14:26 INFO - 'create-virtualenv', 08:14:26 INFO - 'install', 08:14:26 INFO - 'run-tests'), 08:14:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:26 INFO - 'download_minidump_stackwalk': True, 08:14:26 INFO - 'download_symbols': 'ondemand', 08:14:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:26 INFO - 'installer_path': 'installer.exe', 08:14:26 INFO - 'log_level': 'info', 08:14:26 INFO - 'log_name': 'talos', 08:14:26 INFO - 'log_to_console': True, 08:14:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:14:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:14:26 INFO - 'opt_config_files': (), 08:14:26 INFO - 'pip_index': False, 08:14:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:14:26 INFO - 'cmd': ('bash', 08:14:26 INFO - '-c', 08:14:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:14:26 INFO - 'enabled': True, 08:14:26 INFO - 'halt_on_failure': False, 08:14:26 INFO - 'name': 'check_screen_resolution'},), 08:14:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:14:26 INFO - 'cmd': ('bash', 08:14:26 INFO - '-c', 08:14:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:14:26 INFO - 'enabled': True, 08:14:26 INFO - 'halt_on_failure': False, 08:14:26 INFO - 'name': 'check_screen_resolution'},), 08:14:26 INFO - 'run_cmd_checks_enabled': True, 08:14:26 INFO - 'sps_profile': False, 08:14:26 INFO - 'sps_profile_interval': 0, 08:14:26 INFO - 'suite': 'dromaeojs-e10s', 08:14:26 INFO - 'system_bits': '32', 08:14:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:26 INFO - 'title': 't-yosemite-r7-0015', 08:14:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:26 INFO - 'use_talos_json': True, 08:14:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:26 INFO - 'work_dir': 'build'} 08:14:26 INFO - ##### 08:14:26 INFO - ##### Running clobber step. 08:14:26 INFO - ##### 08:14:26 INFO - Running pre-action listener: _resource_record_pre_action 08:14:26 INFO - Running main action method: clobber 08:14:26 INFO - rmtree: /builds/slave/test/build 08:14:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:28 INFO - Running post-action listener: _resource_record_post_action 08:14:28 INFO - ##### 08:14:28 INFO - ##### Running read-buildbot-config step. 08:14:28 INFO - ##### 08:14:28 INFO - Running pre-action listener: _resource_record_pre_action 08:14:28 INFO - Running main action method: read_buildbot_config 08:14:28 INFO - Using buildbot properties: 08:14:28 INFO - { 08:14:28 INFO - "project": "", 08:14:28 INFO - "product": "firefox", 08:14:28 INFO - "script_repo_revision": "production", 08:14:28 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:14:28 INFO - "repository": "", 08:14:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:14:28 INFO - "buildid": "20160414071051", 08:14:28 INFO - "pgo_build": "False", 08:14:28 INFO - "basedir": "/builds/slave/test", 08:14:28 INFO - "buildnumber": 268, 08:14:28 INFO - "slavename": "t-yosemite-r7-0015", 08:14:28 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:14:28 INFO - "platform": "yosemite_r7", 08:14:28 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:14:28 INFO - "branch": "mozilla-aurora", 08:14:28 INFO - "repo_path": "releases/mozilla-aurora", 08:14:28 INFO - "revision": "7bb53c007a2ecde84e470b86ee3ec39fccea9518", 08:14:28 INFO - "stage_platform": "macosx64", 08:14:28 INFO - "builduid": "84c751fb1d734afa955c68997472d991", 08:14:28 INFO - "slavebuilddir": "test" 08:14:28 INFO - } 08:14:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 08:14:28 INFO - Running post-action listener: _resource_record_post_action 08:14:28 INFO - ##### 08:14:28 INFO - ##### Running download-and-extract step. 08:14:28 INFO - ##### 08:14:28 INFO - Running pre-action listener: _resource_record_pre_action 08:14:28 INFO - Running main action method: download_and_extract 08:14:28 INFO - mkdir: /builds/slave/test/build/tests 08:14: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')]} 08:14:28 INFO - https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:14:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 08:14:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 08:14:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 08:14:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 08:14:30 INFO - Downloaded 1277 bytes. 08:14:30 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 08:14:30 INFO - Using the following test package requirements: 08:14:30 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:14:30 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:14:30 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 08:14:30 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:14:30 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 08:14:30 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:14:30 INFO - u'jsshell-mac.zip'], 08:14:30 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:14:30 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 08:14:30 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:14:30 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:14:30 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 08:14:30 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:14:30 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 08:14:30 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:14:30 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 08:14:30 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:14:30 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:14:30 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 08:14:30 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:14: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')]} 08:14:30 INFO - https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:14:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:14:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:14:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:14:32 INFO - Downloaded 17910943 bytes. 08:14:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:14:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:14:35 INFO - Return code: 0 08:14:35 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:35 INFO - https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:14:36 INFO - Downloaded 17910943 bytes. 08:14:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:14:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:14:39 INFO - Return code: 0 08:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:39 INFO - https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:14:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:14:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:14:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:14:40 INFO - Downloaded 10845168 bytes. 08:14:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:14:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:14:41 INFO - Return code: 0 08:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:41 INFO - https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:14:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:14:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:14:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 08:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 08:14:44 INFO - Downloaded 115198029 bytes. 08:14:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:14:44 INFO - mkdir: /builds/slave/test/properties 08:14:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:44 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:44 INFO - Contents: 08:14:44 INFO - build_url:https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:14:45 INFO - Running post-action listener: _resource_record_post_action 08:14:45 INFO - Running post-action listener: set_extra_try_arguments 08:14:45 INFO - ##### 08:14:45 INFO - ##### Running populate-webroot step. 08:14:45 INFO - ##### 08:14:45 INFO - Running pre-action listener: _resource_record_pre_action 08:14:45 INFO - Running main action method: populate_webroot 08:14:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:45 INFO - '--tppagecycles', 08:14:45 INFO - '7'], 08:14:45 INFO - 'tests': ['tsvgm']}}, 08:14:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:14:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:14:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:14:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:14:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:45 INFO - 'talos_options': ['--e10s'], 08:14:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:45 INFO - 'tests': ['damp', 'tps']}, 08:14:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:45 INFO - 'talos_options': ['--e10s'], 08:14:45 INFO - 'tests': ['damp', 'tps']}, 08:14:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:14:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:45 INFO - 'other': {'tests': ['a11yr', 08:14:45 INFO - 'ts_paint', 08:14:45 INFO - 'tpaint', 08:14:45 INFO - 'sessionrestore', 08:14:45 INFO - 'sessionrestore_no_auto_restore', 08:14:45 INFO - 'tabpaint']}, 08:14:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:14:45 INFO - 'tests': ['a11yr', 08:14:45 INFO - 'ts_paint', 08:14:45 INFO - 'tpaint', 08:14:45 INFO - 'sessionrestore', 08:14:45 INFO - 'sessionrestore_no_auto_restore', 08:14:45 INFO - 'tabpaint']}, 08:14:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:14:45 INFO - 'tests': ['a11yr', 08:14:45 INFO - 'ts_paint', 08:14:45 INFO - 'tpaint', 08:14:45 INFO - 'sessionrestore', 08:14:45 INFO - 'sessionrestore_no_auto_restore', 08:14:45 INFO - 'tabpaint']}, 08:14:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:14:45 INFO - 'tests': ['a11yr', 08:14:45 INFO - 'ts_paint', 08:14:45 INFO - 'tpaint', 08:14:45 INFO - 'sessionrestore', 08:14:45 INFO - 'sessionrestore_no_auto_restore', 08:14:45 INFO - 'tabpaint']}, 08:14:45 INFO - 'other_l64': {'tests': ['a11yr', 08:14:45 INFO - 'ts_paint', 08:14:45 INFO - 'tpaint', 08:14:45 INFO - 'sessionrestore', 08:14:45 INFO - 'sessionrestore_no_auto_restore', 08:14:45 INFO - 'tabpaint']}, 08:14:45 INFO - 'other_nol64': {'tests': ['a11yr', 08:14:45 INFO - 'ts_paint', 08:14:45 INFO - 'tpaint', 08:14:45 INFO - 'sessionrestore', 08:14:45 INFO - 'sessionrestore_no_auto_restore', 08:14:45 INFO - 'tabpaint']}, 08:14:45 INFO - 'svgr': {'tests': ['tsvgx', 08:14:45 INFO - 'tsvgr_opacity', 08:14:45 INFO - 'tart', 08:14:45 INFO - 'tscrollx', 08:14:45 INFO - 'cart']}, 08:14:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:14:45 INFO - 'tests': ['tsvgx', 08:14:45 INFO - 'tsvgr_opacity', 08:14:45 INFO - 'tart', 08:14:45 INFO - 'tscrollx', 08:14:45 INFO - 'cart']}, 08:14:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:45 INFO - 'tests': ['tp5o']}, 08:14:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:45 INFO - 'talos_options': ['--e10s'], 08:14:45 INFO - 'tests': ['tp5o']}, 08:14:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:45 INFO - 'talos_options': ['--xperf_path', 08:14:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:45 INFO - 'tests': ['tp5n']}, 08:14:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:45 INFO - 'talos_options': ['--e10s', 08:14:45 INFO - '--xperf_path', 08:14:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:45 INFO - 'tests': ['tp5n']}}, 08:14:45 INFO - 'talos.zip': {'path': '', 08:14:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:45 INFO - Running post-action listener: _resource_record_post_action 08:14:45 INFO - ##### 08:14:45 INFO - ##### Running create-virtualenv step. 08:14:45 INFO - ##### 08:14:45 INFO - Running pre-action listener: _resource_record_pre_action 08:14:45 INFO - Running main action method: create_virtualenv 08:14:45 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:14:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:45 INFO - Using real prefix '/tools/python27' 08:14:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:46 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:49 INFO - Installing pip.................done. 08:14:49 INFO - Return code: 0 08:14:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:49 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 0x10f9fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2184beea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a1d30>, '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 0x10f705db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f898b20>, '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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:14:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVBMwnIzmK/Render', 08:14:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:49 INFO - 'HOME': '/Users/cltbld', 08:14:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:49 INFO - 'LOGNAME': 'cltbld', 08:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:49 INFO - 'MOZ_NO_REMOTE': '1', 08:14:49 INFO - 'NO_EM_RESTART': '1', 08:14:49 INFO - 'PAGER': '/bin/cat', 08:14:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:49 INFO - 'PWD': '/builds/slave/test', 08:14:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:49 INFO - 'SHELL': '/bin/bash', 08:14:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRUSVZMn2f/Listeners', 08:14:49 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 08:14:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:49 INFO - 'USER': 'cltbld', 08:14:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:49 INFO - 'XPC_FLAGS': '0x0', 08:14:49 INFO - 'XPC_SERVICE_NAME': '0', 08:14:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:14:49 INFO - Cleaning up... 08:14:49 INFO - Return code: 0 08:14:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:49 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 0x10f9fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2184beea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a1d30>, '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 0x10f705db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f898b20>, '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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:14:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVBMwnIzmK/Render', 08:14:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:49 INFO - 'HOME': '/Users/cltbld', 08:14:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:49 INFO - 'LOGNAME': 'cltbld', 08:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:49 INFO - 'MOZ_NO_REMOTE': '1', 08:14:49 INFO - 'NO_EM_RESTART': '1', 08:14:49 INFO - 'PAGER': '/bin/cat', 08:14:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:49 INFO - 'PWD': '/builds/slave/test', 08:14:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:49 INFO - 'SHELL': '/bin/bash', 08:14:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRUSVZMn2f/Listeners', 08:14:49 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 08:14:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:49 INFO - 'USER': 'cltbld', 08:14:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:49 INFO - 'XPC_FLAGS': '0x0', 08:14:49 INFO - 'XPC_SERVICE_NAME': '0', 08:14:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:49 INFO - Downloading/unpacking psutil>=0.7.1 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:52 INFO - Installing collected packages: psutil 08:14:52 INFO - Running setup.py install for psutil 08:14:52 INFO - building 'psutil._psutil_osx' extension 08:14:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:14:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:14:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:14:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:14:53 INFO - building 'psutil._psutil_posix' extension 08:14:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:14:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:14:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:14:53 INFO - ^ 08:14:53 INFO - 1 warning generated. 08:14:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:14:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:53 INFO - Successfully installed psutil 08:14:53 INFO - Cleaning up... 08:14:53 INFO - Return code: 0 08:14:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:53 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 0x10f9fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2184beea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a1d30>, '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 0x10f705db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f898b20>, '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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:14:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVBMwnIzmK/Render', 08:14:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:53 INFO - 'HOME': '/Users/cltbld', 08:14:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:53 INFO - 'LOGNAME': 'cltbld', 08:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:53 INFO - 'MOZ_NO_REMOTE': '1', 08:14:53 INFO - 'NO_EM_RESTART': '1', 08:14:53 INFO - 'PAGER': '/bin/cat', 08:14:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:53 INFO - 'PWD': '/builds/slave/test', 08:14:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:53 INFO - 'SHELL': '/bin/bash', 08:14:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRUSVZMn2f/Listeners', 08:14:53 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 08:14:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:53 INFO - 'USER': 'cltbld', 08:14:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:53 INFO - 'XPC_FLAGS': '0x0', 08:14:53 INFO - 'XPC_SERVICE_NAME': '0', 08:14:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:14:56 INFO - Installing collected packages: mozsystemmonitor 08:14:56 INFO - Running setup.py install for mozsystemmonitor 08:14:56 INFO - Successfully installed mozsystemmonitor 08:14:56 INFO - Cleaning up... 08:14:56 INFO - Return code: 0 08:14:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:56 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 0x10f9fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2184beea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a1d30>, '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 0x10f705db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f898b20>, '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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVBMwnIzmK/Render', 08:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:56 INFO - 'HOME': '/Users/cltbld', 08:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:56 INFO - 'LOGNAME': 'cltbld', 08:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:56 INFO - 'MOZ_NO_REMOTE': '1', 08:14:56 INFO - 'NO_EM_RESTART': '1', 08:14:56 INFO - 'PAGER': '/bin/cat', 08:14:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:56 INFO - 'PWD': '/builds/slave/test', 08:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:56 INFO - 'SHELL': '/bin/bash', 08:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRUSVZMn2f/Listeners', 08:14:56 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 08:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:56 INFO - 'USER': 'cltbld', 08:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:56 INFO - 'XPC_FLAGS': '0x0', 08:14:56 INFO - 'XPC_SERVICE_NAME': '0', 08:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:57 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:15:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:00 INFO - Downloading docopt-0.6.1.tar.gz 08:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:15:00 INFO - Installing collected packages: blobuploader, requests, docopt 08:15:00 INFO - Running setup.py install for blobuploader 08:15:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:15:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:15:00 INFO - Running setup.py install for requests 08:15:01 INFO - Running setup.py install for docopt 08:15:01 INFO - Successfully installed blobuploader requests docopt 08:15:01 INFO - Cleaning up... 08:15:01 INFO - Return code: 0 08:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:01 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 0x10f9fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2184beea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a1d30>, '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 0x10f705db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f898b20>, '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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:15:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVBMwnIzmK/Render', 08:15:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:01 INFO - 'HOME': '/Users/cltbld', 08:15:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:01 INFO - 'LOGNAME': 'cltbld', 08:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:01 INFO - 'MOZ_NO_REMOTE': '1', 08:15:01 INFO - 'NO_EM_RESTART': '1', 08:15:01 INFO - 'PAGER': '/bin/cat', 08:15:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:01 INFO - 'PWD': '/builds/slave/test', 08:15:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:01 INFO - 'SHELL': '/bin/bash', 08:15:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRUSVZMn2f/Listeners', 08:15:01 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 08:15:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:01 INFO - 'USER': 'cltbld', 08:15:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:01 INFO - 'XPC_FLAGS': '0x0', 08:15:01 INFO - 'XPC_SERVICE_NAME': '0', 08:15:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:01 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Fx89fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:01 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-_I4PWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-iTlAe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-7VC_EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-mpvxcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-MmPrDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-XJXjEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-g2LWj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-eCc7Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-5WYu06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-hwR4kX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-39wTSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-rRX_n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-fTTKOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-sS1eIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-laoiba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-9HsH6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:15:03 INFO - Running setup.py install for manifestparser 08:15:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:15:03 INFO - Running setup.py install for mozcrash 08:15:03 INFO - Running setup.py install for mozdebug 08:15:03 INFO - Running setup.py install for mozdevice 08:15:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Running setup.py install for mozfile 08:15:04 INFO - Running setup.py install for mozhttpd 08:15:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Running setup.py install for mozinfo 08:15:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Running setup.py install for mozInstall 08:15:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Running setup.py install for mozleak 08:15:04 INFO - Running setup.py install for mozlog 08:15:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:15:05 INFO - Running setup.py install for moznetwork 08:15:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:15:05 INFO - Running setup.py install for mozprocess 08:15:05 INFO - Running setup.py install for mozprofile 08:15:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:15:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:15:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:15:05 INFO - Running setup.py install for mozrunner 08:15:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:15:05 INFO - Running setup.py install for mozscreenshot 08:15:05 INFO - Running setup.py install for moztest 08:15:05 INFO - Running setup.py install for mozversion 08:15:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:15:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:15:06 INFO - Cleaning up... 08:15:06 INFO - Return code: 0 08:15:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:06 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 0x10f9fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2184beea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a1d30>, '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 0x10f705db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f898b20>, '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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:15:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVBMwnIzmK/Render', 08:15:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:06 INFO - 'HOME': '/Users/cltbld', 08:15:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:06 INFO - 'LOGNAME': 'cltbld', 08:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:06 INFO - 'MOZ_NO_REMOTE': '1', 08:15:06 INFO - 'NO_EM_RESTART': '1', 08:15:06 INFO - 'PAGER': '/bin/cat', 08:15:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:06 INFO - 'PWD': '/builds/slave/test', 08:15:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:06 INFO - 'SHELL': '/bin/bash', 08:15:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRUSVZMn2f/Listeners', 08:15:06 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 08:15:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:06 INFO - 'USER': 'cltbld', 08:15:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:06 INFO - 'XPC_FLAGS': '0x0', 08:15:06 INFO - 'XPC_SERVICE_NAME': '0', 08:15:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:06 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-oPqE4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:06 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-XWlrEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:06 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Pt_QSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:06 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Ucjb71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:06 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-1LQ7Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:06 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-cyka7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-vCVt6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-4IEBP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-n7mZXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-T7gX0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-AdMqxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Wl31sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Gn1E1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-foLOUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-48T3nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-SlZdsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:08 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-OvC5BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:15:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:10 INFO - Downloading blessings-1.6.tar.gz 08:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:15:10 INFO - Installing collected packages: blessings 08:15:10 INFO - Running setup.py install for blessings 08:15:10 INFO - Successfully installed blessings 08:15:10 INFO - Cleaning up... 08:15:10 INFO - Return code: 0 08:15:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:11 INFO - Reading from file tmpfile_stdout 08:15:11 INFO - Current package versions: 08:15:11 INFO - blessings == 1.6 08:15:11 INFO - blobuploader == 1.2.4 08:15:11 INFO - docopt == 0.6.1 08:15:11 INFO - manifestparser == 1.1 08:15:11 INFO - mozInstall == 1.12 08:15:11 INFO - mozcrash == 0.17 08:15:11 INFO - mozdebug == 0.1 08:15:11 INFO - mozdevice == 0.48 08:15:11 INFO - mozfile == 1.2 08:15:11 INFO - mozhttpd == 0.7 08:15:11 INFO - mozinfo == 0.9 08:15:11 INFO - mozleak == 0.1 08:15:11 INFO - mozlog == 3.1 08:15:11 INFO - moznetwork == 0.27 08:15:11 INFO - mozprocess == 0.22 08:15:11 INFO - mozprofile == 0.28 08:15:11 INFO - mozrunner == 6.11 08:15:11 INFO - mozscreenshot == 0.1 08:15:11 INFO - mozsystemmonitor == 0.0 08:15:11 INFO - moztest == 0.7 08:15:11 INFO - mozversion == 1.4 08:15:11 INFO - psutil == 3.1.1 08:15:11 INFO - requests == 1.2.3 08:15:11 INFO - wsgiref == 0.1.2 08:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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')]} 08:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:11 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 0x10f9fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2184beea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a1d30>, '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 0x10f705db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f898b20>, '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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:15:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:15:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVBMwnIzmK/Render', 08:15:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:11 INFO - 'HOME': '/Users/cltbld', 08:15:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:11 INFO - 'LOGNAME': 'cltbld', 08:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:11 INFO - 'MOZ_NO_REMOTE': '1', 08:15:11 INFO - 'NO_EM_RESTART': '1', 08:15:11 INFO - 'PAGER': '/bin/cat', 08:15:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:11 INFO - 'PWD': '/builds/slave/test', 08:15:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:11 INFO - 'SHELL': '/bin/bash', 08:15:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRUSVZMn2f/Listeners', 08:15:11 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 08:15:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:11 INFO - 'USER': 'cltbld', 08:15:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:11 INFO - 'XPC_FLAGS': '0x0', 08:15:11 INFO - 'XPC_SERVICE_NAME': '0', 08:15:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:15:11 INFO - Cleaning up... 08:15:11 INFO - Return code: 0 08:15:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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')]} 08:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:11 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 0x10f9fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2184beea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a1d30>, '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 0x10f705db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f898b20>, '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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:15:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:15:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVBMwnIzmK/Render', 08:15:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:11 INFO - 'HOME': '/Users/cltbld', 08:15:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:11 INFO - 'LOGNAME': 'cltbld', 08:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:11 INFO - 'MOZ_NO_REMOTE': '1', 08:15:11 INFO - 'NO_EM_RESTART': '1', 08:15:11 INFO - 'PAGER': '/bin/cat', 08:15:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:11 INFO - 'PWD': '/builds/slave/test', 08:15:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:11 INFO - 'SHELL': '/bin/bash', 08:15:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRUSVZMn2f/Listeners', 08:15:11 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 08:15:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:11 INFO - 'USER': 'cltbld', 08:15:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:11 INFO - 'XPC_FLAGS': '0x0', 08:15:11 INFO - 'XPC_SERVICE_NAME': '0', 08:15:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:11 INFO - Downloading/unpacking jsonschema 08:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:15:14 INFO - Downloading/unpacking functools32 (from jsonschema) 08:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:14 INFO - Downloading functools32-3.2.3-2.tar.gz 08:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:15:14 INFO - warning: no files found matching '*.txt' 08:15:14 INFO - no previously-included directories found matching 'build' 08:15:14 INFO - no previously-included directories found matching 'dist' 08:15:14 INFO - no previously-included directories found matching '.git*' 08:15:14 INFO - Installing collected packages: jsonschema, functools32 08:15:14 INFO - Running setup.py install for functools32 08:15:14 INFO - warning: no files found matching '*.txt' 08:15:14 INFO - no previously-included directories found matching 'build' 08:15:14 INFO - no previously-included directories found matching 'dist' 08:15:14 INFO - no previously-included directories found matching '.git*' 08:15:14 INFO - Successfully installed jsonschema functools32 08:15:14 INFO - Cleaning up... 08:15:15 INFO - Return code: 0 08:15:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:15 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 0x10f9fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2184beea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a1d30>, '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 0x10f705db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f898b20>, '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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:15:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVBMwnIzmK/Render', 08:15:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:15 INFO - 'HOME': '/Users/cltbld', 08:15:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:15 INFO - 'LOGNAME': 'cltbld', 08:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:15 INFO - 'MOZ_NO_REMOTE': '1', 08:15:15 INFO - 'NO_EM_RESTART': '1', 08:15:15 INFO - 'PAGER': '/bin/cat', 08:15:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:15 INFO - 'PWD': '/builds/slave/test', 08:15:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:15 INFO - 'SHELL': '/bin/bash', 08:15:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRUSVZMn2f/Listeners', 08:15:15 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 08:15:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:15 INFO - 'USER': 'cltbld', 08:15:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:15 INFO - 'XPC_FLAGS': '0x0', 08:15:15 INFO - 'XPC_SERVICE_NAME': '0', 08:15:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:15 INFO - Downloading/unpacking flake8 08:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:15:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:15:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:15:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:15:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:15:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:15:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:15:18 INFO - no previously-included directories found matching 'docs/_build' 08:15:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:15:19 INFO - Running setup.py install for pep8 08:15:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:15:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:15:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:15:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:15:19 INFO - no previously-included directories found matching 'docs/_build' 08:15:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:15:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:15:19 INFO - Cleaning up... 08:15:19 INFO - Return code: 0 08:15:19 INFO - Running post-action listener: _resource_record_post_action 08:15:19 INFO - Running post-action listener: _start_resource_monitoring 08:15:19 INFO - Starting resource monitoring. 08:15:19 INFO - ##### 08:15:19 INFO - ##### Running install step. 08:15:19 INFO - ##### 08:15:19 INFO - Running pre-action listener: _resource_record_pre_action 08:15:19 INFO - Running main action method: install 08:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:19 INFO - Reading from file tmpfile_stdout 08:15:19 INFO - Detecting whether we're running mozinstall >=1.0... 08:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:15:19 INFO - Reading from file tmpfile_stdout 08:15:19 INFO - Output received: 08:15:19 INFO - Usage: mozinstall [options] installer 08:15:19 INFO - Options: 08:15:19 INFO - -h, --help show this help message and exit 08:15:19 INFO - -d DEST, --destination=DEST 08:15:19 INFO - Directory to install application into. [default: 08:15:19 INFO - "/builds/slave/test"] 08:15:19 INFO - --app=APP Application being installed. [default: firefox] 08:15:19 INFO - mkdir: /builds/slave/test/build/application 08:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:15:52 INFO - Reading from file tmpfile_stdout 08:15:52 INFO - Output received: 08:15:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:15:52 INFO - Running post-action listener: _resource_record_post_action 08:15:52 INFO - ##### 08:15:52 INFO - ##### Running run-tests step. 08:15:52 INFO - ##### 08:15:52 INFO - Running pre-action listener: _resource_record_pre_action 08:15:52 INFO - Running main action method: run_tests 08:15:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:15:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:15:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:15:52 INFO - 2016-04-14 08:15:52.212 screenresolution[1969:65044] starting screenresolution argv=screenresolution get 08:15:52 INFO - 2016-04-14 08:15:52.214 screenresolution[1969:65044] Display 0: 1600x1200x32@60 08:15:52 INFO - 2016-04-14 08:15:52.220 screenresolution[1970:65048] starting screenresolution argv=screenresolution list 08:15:52 INFO - Available Modes on Display 0 08:15:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:15:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:15:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:15:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:15:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:15:52 INFO - Intel Iris: 08:15:52 INFO - Chipset Model: Intel Iris 08:15:52 INFO - Type: GPU 08:15:52 INFO - Bus: Built-In 08:15:52 INFO - VRAM (Dynamic, Max): 1536 MB 08:15:52 INFO - Vendor: Intel (0x8086) 08:15:52 INFO - Device ID: 0x0a2e 08:15:52 INFO - Revision ID: 0x0009 08:15:52 INFO - Displays: 08:15:52 INFO - Display: 08:15:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:15:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:15:52 INFO - Display Serial Number: 1600x1200 60 08:15:52 INFO - Main Display: Yes 08:15:52 INFO - Mirror: Off 08:15:52 INFO - Online: Yes 08:15:52 INFO - Rotation: Supported 08:15:52 INFO - Return code: 0 08:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:52 INFO - Python 2.7.3 08:15:52 INFO - Return code: 0 08:15:52 INFO - grabbing minidump binary from tooltool 08:15: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')]} 08:15:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a1d30>, '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 0x10f705db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f898b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:15:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:15:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:52 INFO - Return code: 0 08:15:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:15:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:15:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:15:53 INFO - Return code: 0 08:15:53 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:15:53 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:15:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVBMwnIzmK/Render', 08:15:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:53 INFO - 'HOME': '/Users/cltbld', 08:15:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:53 INFO - 'LOGNAME': 'cltbld', 08:15:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:53 INFO - 'MOZ_NO_REMOTE': '1', 08:15:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:53 INFO - 'NO_EM_RESTART': '1', 08:15:53 INFO - 'PAGER': '/bin/cat', 08:15:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:53 INFO - 'PWD': '/builds/slave/test', 08:15:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:53 INFO - 'SHELL': '/bin/bash', 08:15:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nRUSVZMn2f/Listeners', 08:15:53 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 08:15:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:53 INFO - 'USER': 'cltbld', 08:15:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:53 INFO - 'XPC_FLAGS': '0x0', 08:15:53 INFO - 'XPC_SERVICE_NAME': '0', 08:15:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:15:53 INFO - mozversion application_buildid: 20160414071051 08:15:53 INFO - mozversion application_changeset: 7bb53c007a2ecde84e470b86ee3ec39fccea9518 08:15:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:15:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:53 INFO - mozversion application_name: Firefox 08:15:53 INFO - mozversion application_remotingname: firefox-dev 08:15:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:53 INFO - mozversion application_vendor: Mozilla 08:15:53 INFO - mozversion application_version: 47.0a2 08:15:53 INFO - mozversion platform_buildid: 20160414071051 08:15:53 INFO - mozversion platform_changeset: 7bb53c007a2ecde84e470b86ee3ec39fccea9518 08:15:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:53 INFO - mozversion platform_version: 47.0a2 08:15:53 INFO - using testdate: 1460646953 08:15:53 INFO - actual date: 1460646953 08:15:53 INFO - starting webserver on 'localhost:51244' 08:15:53 INFO - SUITE-START | Running 2 tests 08:15:53 INFO - TEST-START | dromaeo_css 08:15:53 INFO - operating with platform_type : mac_ 08:15:53 INFO - Initialising browser for dromaeo_css test... 08:15:53 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpV2vS4I/profile http://localhost:51244/getInfo.html) 08:15:56 INFO - PROCESS | 1988 | __metrics Screen width/height:1600/1200 08:15:56 INFO - PROCESS | 1988 | colorDepth:24 08:15:56 INFO - PROCESS | 1988 | Browser inner width/height: 1024/689 08:15:56 INFO - PROCESS | 1988 | __metrics 08:15:56 ERROR - PROCESS | 1988 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:15:57 INFO - TEST-INFO | 1988: exit 0 08:15:57 INFO - Browser initialized. 08:15:57 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:57 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpV2vS4I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:09 INFO - PROCESS | 1991 | RSS: Main: 218103808 08:16:09 INFO - PROCESS | 1991 | 08:16:59 INFO - PROCESS | 1991 | 1460647019155 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:19:10 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51244/tests/dromaeo/cssquery-ext.html) 08:19:11 INFO - PROCESS | 1991 | RSS: Main: 228749312 08:19:11 INFO - PROCESS | 1991 | 08:22:13 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51244/tests/dromaeo/cssquery-ext.html (next: http://localhost:51244/tests/dromaeo/cssquery-jquery.html) 08:22:13 INFO - PROCESS | 1991 | RSS: Main: 240386048 08:22:13 INFO - PROCESS | 1991 | 08:25:15 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51244/tests/dromaeo/cssquery-mootools.html) 08:25:16 INFO - PROCESS | 1991 | RSS: Main: 242499584 08:25:16 INFO - PROCESS | 1991 | 08:28:17 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51244/tests/dromaeo/cssquery-prototype.html) 08:28:18 INFO - PROCESS | 1991 | RSS: Main: 243916800 08:28:18 INFO - PROCESS | 1991 | 08:31:20 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51244/tests/dromaeo/cssquery-yui.html) 08:31:21 INFO - PROCESS | 1991 | RSS: Main: 246743040 08:31:21 INFO - PROCESS | 1991 | 08:34:23 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:51244/tests/dromaeo/cssquery-yui.html (next: http://localhost:51244/tests/dromaeo/cssquery-dojo.html) 08:34:24 INFO - PROCESS | 1991 | RSS: Main: 248201216 08:34:24 INFO - PROCESS | 1991 | 08:34:24 INFO - PROCESS | 1991 | __start_tp_report 08:34:24 INFO - PROCESS | 1991 | _x_x_mozilla_page_load 08:34:24 INFO - PROCESS | 1991 | _x_x_mozilla_page_load_details 08:34:24 INFO - PROCESS | 1991 | |i|pagename|runs| 08:34:24 INFO - PROCESS | 1991 | |0;dojo.html;2996.535536991767;3214.4214041472533;3570.0717813368533;3626.4379021251716;3634.200475895302;6013.278406591216;6018.759249630009;6018.849528761783;6043.486303664188;6065.181200537926;6056.818295451132;6061.66660833654;6067.757289708417;6085.056816193497;6090.208272924514;5416.945830541684;5437.13005919052;5439.456054394568;5498.697571633558;5546.944530554703;5028.195488721805;5388.137897936331;5443.618946673734;5533.363663178726;5568.972155139219;5466.371367292752;5489.807856725015;5496.917546236809;5531.778728850841;5531.834044978657;4445.84439544616;5486.0125177468235;5486.094794358926;5536.256407704168;5575.107982722745;5259.684418934838;5325.254464374991;5357.651752636105;5467.917981230285;5469.917951230735;4684.36761037259;5946.643201407929;5981.401859814027;5984.551158663117;5991.700414979277;6322.36776322364;6326.462250708695;6354.904676429811;6360.204974378203;6362.363763623647;6267.592606480564;6389.233292004943;6429.807105786834;6493.350664933469;6506.349365063503;6175.5985860919345;6200.976838821634;6210.4100110489435;6217.3471785462325;6256.374362563753;6311.747530098836;6573.375529324707;6586.8353291168105;6607.933920660732;6630;6070.150178974947;6113.962834745988;6130.769115614378;6144.477719393902;6146.446819786241;5418.133098704188;6407.423331900058;6435.903461448082;6444.742210311629;6444.8388790280615;6199.721012554446;6226.62640241587;6356.046593011085;6359.046143078575;6365.840853978688;6246.500279977591;6344.651044192614;6360.077788720702;6377.840553986095;6427.132337134521;5053.31780209667;5058.140116180258;5064.898702026013;5090.77091530882;5110.6678065926335;4447.62195213404;4498.617617502484;4540.954590454119;4578.130155270488;4643.396358473445;6024.518038556905;6048.818535443944;6100.542459315569;6101.877962440726;6115.737177244448;6319.0837328587095;6332.778352757631;6382.904256436157;6399.136116624196;6427.2929977702415;5967.433093856163;6052.394760524;6100.23747031621;6105.267367915879;6127.724252408652;5438.293021907127;5478.233047373371;5481.177823326533;5561.972190139023;5614.29821272341;6608.140941677647;6624.403803657694;6635.469162467088;6636.933630663728;6638.402543770987;6416.390442907917;6416.615003099829;6427.260865000398;6436.195475565554;6448.258970077959;6381.106645069601;6534.673266336569;6616.702248398929;6622.63575503352;6664.366885145903;6295.370462953668;6330.556861019684;6340.144080549251;6344.651044192614;6352.555321127662;6312.747490100528;6373.075903993988;6374.840628984312;6414.711337989895;6420;6085.087236914498;6203.286622038523;6219.751209951552;6282.3089460158435;6286.497080233662;6209.192804935329;6239.844003899939;6247.312795592572;6280.434760871543;6281.59169653971;6077.787277445268;6119.167450728499;6285.088662143872;6295.685215739286;6315.147455093687;6201.348858369986;6219.222597175353;6242.28213755424;6247.625142491283;6254.6247225166635;6187.783427580013;6236.064590311489;6254.4996400286955;6257.311695713377;6285.5600107992 08:34:24 INFO - PROCESS | 1991 | |1;ext.html;490.842930262316;560.9398237331442;587.7325816753378;668.953088416628;675.4393853101924;38899.41650875232;39651.603483965155;40367.59632403675;40379.79810100949;40500.797496012514;41675.37486937691;42089.57910420895;42204.788976055075;42546.36180457295;42608.786956065254;9472.715818525437;9639.180669643054;9675.612975481008;9686.612535498607;9719.319647624669;8373.330133589297;9600.567974441166;9732.026797320246;9757.853632195523;9837.213022958182;9768.316217864753;9773.07155820196;9778.902210977905;9849.556769945333;9868.753281167956;9746.31775775696;9771.022897710243;9826.1156495915;9856.014398560159;9869.901300987007;9683.564239609235;9734.951325243328;9788.657396991142;9802.117809397118;9814.558344874498;40807.387889181686;41010.38484422736;41121.58878411208;41171.38242926358;41450;3329.583802024747;3426.7429942754393;3486.6339034401276;3523.524324216249;3864.574896761354;28679.426411471653;29002.70997290021;29603;29823.25441863949;29832.8508357459;2734.1387462949106;2796.6923638399758;2816.155153453956;2869.426114777032;2885.2209903326193;458225;469202;491362.54318728537;505527;506304;49008;49063.01873962501;49576.008479830205;71565.92651110237;73370.63314683392;46987.530124698314;48082;48115;48244;48305.51694483081;16688.998660080433;16784.496465106065;17081.316747330216;17122.91438542824;17323.307067717404;13317.200967941955;13448.193108413527;13494.865051349558;13524.053316267768;13536.052476326562;15406.845931540765;15618.984765990173;15801.577857992836;15809.841901581067;15811.920940395225;6541.495456045136;6588.24235212947;6612.801615951529;6619.073329733841;6642.269350371455;950.1970834644715;1011.549860312154;1077.6928575355985;1120.2214460949563;1151.6238095475826;30981.380372392425;31046.689533104833;31160.812977365546;31448.52827207594;31715.207119821727;1064.3986147826454;1120.8206686930052;1131.2194585735815;1213.9453724582415;1230.6923269182705;13753.635798632691;14230.359633816295;15777.368905243891;15928.147879378275;16037;496048;543122;544182;549189;554906;62207.68896155581;63624;63792;63830.6808465964;64509.67745161338;1319.8416190057255;1511.3350125944548;1517.590250632323;1531.3568301313476;1553.673728517024;25199.87400062988;30378.39243215079;30554.95971865466;30558;30975.69024309728;54875.17687234774;54876.72561637166;55335.72332138474;55434.72282638561;55661.1650825246;507535;514897;516826;517363;521682;34736.478952815225;35452.822735886155;35482.467762984095;35909.820450897576;45460.09079818319;45466.31800523061;46969.59091227269;47642.808929777035;48330;49089.50910490992;38876.80561597174;39414.01464963399;39840.402393964694;39893;40574.59425405826;30740.231494212825;30890.382192355577;38534.6146538531;39311.820645380685;39501.80249098851;39638;40190.397144042276;40763.79618101891;41625.1674966505;41765;31705.524417134224;34560.30879382348;34860.47709284312;34878;35083.824580876935;21861.67207491857;26195.73804261933;26228.819703113026;26290.211293660457;26400.86799566067 08:34:24 INFO - PROCESS | 1991 | |2;jquery.html;334.47487444711805;347.15640992388484;374.40843467321633;383.64896120050156;383.98436136419156;20306.796932030677;20825.895870520646;21276.36170914875;22002.339929802092;22049.669254961147;21144.788552114474;21886.45283867904;21957.67063494049;22146.667799982974;22274.774887381187;5864.23764910561;5947.851303717398;6108.450239478446;6122.234720659918;6131.110988906606;4901.534354236342;5908.67502287374;6009.038553831388;6018.458338749511;6040.365761595035;5626.352969408509;5943.554233432488;5979.641221526722;5986.221791167142;5993.580449368546;5917.733701983399;5931.406859314077;5955.761769529214;5956.195913551658;6022.879542409128;5119.462456442095;5180.067587834188;5183.222516622499;5221.06020916235;5227.268182454422;26494.86752566244;26713.664316784278;26817.195484135507;26969.460610787675;27075.86462067677;2214.446388402899;2267.127156044918;2308.5729140108965;2359.079958816063;2490.3774056485877;14809.703805923822;15069.698606027818;15160.696786064216;15315.004524705859;15351.462698805488;1706.3260012295198;1727.8790484666079;1734.2889415339775;1746.2840235503509;1753.8070812210774;108883.91116088816;113323;115122;115611;115801.42099289618;9839.262055345878;10493.737656558495;10678.786424271471;10909.781804364027;10964.890351096547;13586.32068396596;13707.109037912503;13714.51999180024;13753.174809511462;13762;8838.07200243978;8918.063603321687;9039.638414463348;9084.772880678036;9106.408083474553;9398;9440.24478041755;9476.099770521789;9487.905120948702;9508.477033763209;6183.752649894044;6264.68676566179;6333.556651034383;6356.745730170742;6366.108744775735;1844.087176847469;1861.9627607447776;1867.6918308478948;1898.8670793044355;1902.1820617134765;926.3191554207652;1005.8038682456997;1045.2160879340495;1073.9850840955223;1169.053067015703;21282.89358553228;21566.353009409744;21663.241786537397;21684.02421891019;21709.240176593743;865.8354912566592;913.6025828764509;914.7255823252998;994.6518718448485;1008.6721815410021;10491.94754026225;11216.9904708575;11669.883301167049;11692.47383867728;11815.704607384883;636988;654030.7298463477;654460;670218;673172;85406.71889921532;100140;110808;111348;117358;1058.9199017002613;1058.9364638121738;1081.853949716778;1082.118073769875;1089.6948854320804;15455.61360965985;16763.49709508717;18378.72431913549;19718.014099295266;19784.406467805413;32354.029379118663;32508.699652013656;41346.759597212134;43414.56585434105;47478.050438990336;70295;70715;71367.64316178385;71437.6428117877;71591;8021.478603890729;8101.918980810116;8116.147804480681;8150.18498150204;8235.094139644754;13697.520586779416;13726.588202353945;13972;14105.929470352583;14118.2940852959;11489.310641361211;12020.879791202326;12052.397380131133;12062;12110.667826538898;11364;11764.647060588197;11782.784345799979;11904.821427678418;12066.396680166132;11607.535698571963;11851;12069.939650301692;12151;12163;8095.352371810123;8169.79575510617;8410.6215220314;8479.448835825651;8667.696630617898;10997.670069897917;11912.40437978115;11921.165518413627;12008.63974080779;12128 08:34:24 INFO - PROCESS | 1991 | |3;mootools.html;1644.0710998285967;1679.8404151605598;1833.8721686163005;1975.861689681723;2026.9898650506746;7525.435592330577;8332.2917552008;8484.490930544172;9235.953820230907;9245.4452732836;8730.5634718264;8933.642654293837;9057.864132038008;9064.818703625924;9067.95466022669;2535.0493564913204;2541.745825417462;2542.478791847667;2542.6821647294087;2551.9362015949655;2478.5166892455977;2549.1970029440668;2558.961615575768;2559.7696207341337;2562.0520407449176;2521.722610512842;2543.109911530968;2543.7074736405366;2545.5163518931345;2563.1797824696105;2282.9771702282933;2522.445062086338;2557.8081643876785;2567.499337629163;2570.5887058070807;2520.382506285972;2538.504991526653;2538.6192071189284;2555.9361015974564;2565.256075738034;9116.179543841086;9119.680811171644;9126.315526335486;9161.404508706979;9186.44881307117;4700;5482.424345443751;5589.329280486327;5639.7462114204545;5657.377688454267;3623.7825730456257;3690.0774806298427;3737.3272810894027;3779.565349984732;3790.8673196438267;1061.0556604621893;1070.6199299248733;1079.3416016230094;1081.259337353915;1087.3747595132752;12214.450349734283;12282.75434491314;12394.504219831197;12457.314847683374;12478.18891772041;4091.6317531422314;4927;5019.498050194951;5055.9241611375855;5057.747112644353;10463.372197668165;10619.256652034283;10625.5218515167;10631.202659800545;10641.201909856793;4801.447833499193;4822.68652537584;5629.634073785191;5665.348484924204;5708.914366284509;4179.226843034048;4455.598996090367;5041.521055499795;5081.796728130834;5112.182050871843;3816.790076545761;3869.2454971280895;3893.396523538856;3943.8028098594955;3944.36890097583;1356.4235200039943;1357.429879450633;1360.9115407498482;1367.3641756583236;1368.7125703602155;1310.829592153014;1346.1317450244537;1352.5333759852836;1354.7696891528465;1407.3315175291655;7128.964355178191;8518.87221691675;8549.743507694655;8605.096464871223;8609.354298427643;1122.354646078492;1219.4756254810338;1223.3944197622234;1296.708240645866;1304.851730477174;6239.875202495925;6406.103145559626;6425.389587989227;6471.935280647133;6482.740690372332;10643.946780266204;10957.50691218897;11033.448327583588;11034.227604067799;11039.613613523648;10490.790184196274;10753.247272690836;10773.24587278883;10883.67348979532;11244;8760.211580957744;8906.55467226636;8921.643134274556;8962.507062111647;8972.102789721106;7895.368370530229;8149.6332665031405;8308.875366869623;8339.166083391612;8445.95777021111;9824;10105.89894101079;10186.847197291898;10243.334183278062;10277.486125693536;9723.85414218773;9946.651867184613;9956.701298961043;9977.650782222587;10636.734081648021;7703.191164927602;7714.344280735976;7762.68949242024;7815.491993020435;7832.608369581612;8416.032156302104;8420.4947703138;8463.74608761738;8470.025947015925;8496.53269070207;7508.511946723664;7671.961640191764;7687.284075556828;7688.077430708127;7735.7679269622;7663.770086897402;7695.345895598937;7717.2282771722375;7766.339861111869;7857.528548287121;8200.466969646954;8202.38482113832;8247.876281855657;8262.917370826455;8315.501069935823;7338.596377199092;7404.96297518509;7435.107787065586;7442.404607631484;7467.215942325977;7527.059117610299;7533.359664428585;7544.547327160388;7605.581693006938;7621.580813055113 08:34:24 INFO - PROCESS | 1991 | |4;prototype.html;333.5230620213095;336.71042903103313;337.2395248714149;342.9194139377246;344.6536231087757;7028.226895041541;7056.294370562941;7056.812388159674;7138.500304978654;7144.357007869291;7023.40301074408;7042.330978557042;7053.400460960812;7098.680559374828;7111;4956.752162391884;5062.215356619711;5144.125498665236;5153.149730294497;5195.116830138885;3923.8228531440595;4705.541282202511;4962.900741985158;5166.948330516684;5250.7112108834;5155.355580552431;5163.044836705221;5167.209706758346;5172.6379153459275;5200.92198617021;5109.259157422191;5162.354705661793;5168.896622067557;5193.844184674465;5205.921911171355;4413.514513403523;4428.756418396987;4435.334699795024;4439.955600443986;4440.933385999213;6275.592086514362;6628.403443690043;6671.799846004627;6745.628990405526;6819.5908245505425;4859.562639362474;5286.973565132188;5668.43315668434;6028.246469191351;6063.18147050147;7511.511751736174;7526.8118297042465;7531.435142364345;7559.3196612305155;7591.696332146707;4941.530554597308;4961.032598643266;4970.776315065831;4970.87572810679;4984.975075124637;7058.400035996947;7111.701782172263;7528.134264559591;7945.165757595427;7981.161977992343;4874.147823826923;4919.532644398776;4980.950190498121;4994.625403094709;5018.924716129261;4649.67452278344;4877.3903262092235;5093.847184584469;5100.795968161232;5104.719240441811;5978.103284507271;5985.22192115031;5993.70031498432;6001;6005.249343832021;6359.777407790798;7345.0084238627105;7594.5063570867715;7601.809954751176;7611.4291428143115;1646.8929519581188;1764.5588602849289;1770.628168084691;1771.0790388997907;1771.2295151609092;1071.137734124022;1071.3411252079916;1078.7464945737745;1081.734974931131;1085.3867564825848;5596.664200148004;6904.1024666794;6905.516613837083;6939.93060069403;6944.375006249462;7783.649735761905;7793.571353575494;7821.530708157528;7821.960890195513;7832.138464768871;6910.654467276616;6938.098047253926;6941.201761797357;6948.93051069493;7003.369696727319;4004.8598299059395;4091.590840915944;4125.195586860594;4136.689748268892;4149.294619914622;8168.632411541495;8182.959085204536;8224.588770561448;8248.216419440143;8248.793780155544;8132.674693012332;8158.265756081981;8186.713465028695;8193.959030204811;8199.95900020496;6617.66911654425;8227.917720822836;8249.628766705393;8259.463134896212;8262.545559994258;7606.429517786299;7873.842523149619;7901.486403383762;7912.208779122042;7930.762077137695;7694.807629809299;7718.884216736866;7736.226377362219;7761.7671469855995;7782.105057918186;8047.396445266511;8204.507729536246;8204.794880128045;8216.424850260424;8221.30118939873;4829.2997515359375;4875.6099512038245;4877.95122048775;4908.950910490849;4909.975450122869;6545.919923212617;7516.924830751623;7523.360514356341;7732.574708390867;7916.485428447132;7550.735724249625;7559.28186822251;7561.924380756122;7564.167941526318;7576.4317676173405;7559.395248380227;7574.242575742382;7583.05211848519;7592.696292148252;7608.2011388805595;7073.363397294268;7345.081864766904;7353.448491363062;7387;7424.96287518559;7515.549067055994;7524.435667325082;7586.24137586237;7588.354989825927;7622.123455802654;7382.298681625237;7397.001404810497;7413.332800048021;7414.480986331121;7415.073115860518 08:34:24 INFO - PROCESS | 1991 | |5;yui.html;702.3012102957557;744.7728442824939;745.9776206713799;760.7375455467861;776.064841865552;13059.151155174919;13117.278549679764;15389.076655400684;15414.998025128372;15522.611934701637;13935.790963135536;13973.650658733537;14006.369713362898;14035.438582456714;14039.859601403983;739.0909181706504;909.0636644256426;931.4411353188084;936.5925822267302;941.9105185007413;936.9203617692505;946.2571881073359;952.3714348529971;956.6077908057698;960.150267013691;1004.9145822605087;1005.3465247589053;1010.4493051287067;1011.9324113060718;1013.1034034879148;985.4333758089056;990.8513722941544;994.0904072773403;1002.9197664186884;1003.9548220330103;743.6319022084103;744.4193529047352;747.1781040855016;751.7030772844751;752.0899711349274;14528.273586320747;14864.70270594582;14865.182414967172;14884.62788430298;14926.70146597073;13085.084044116915;13094.934525327408;13136.6715832104;13179.670508237275;13210.933945330307;8154.429189956705;9631.277654175894;9639.518024098837;9910.702678919644;9933.75165620858;3537.6816086552335;3547.5565554305713;3554.3957527220437;3613.0786649404236;3740.3828368319196;83984;84934.30131397399;89022.5548872258;89940.55029724874;90970;9380.624775008922;9525.857112143323;9580.856287155699;9606.66376676827;9929.007099290158;18194.727079093824;22322;22666.66000010001;22845.657315140284;22905.08379664795;7284.344409003215;7310.34206921369;7346.595937223397;7505.962470187724;7623.656935437919;3415.9316813663586;3990.2418540477797;4127.484064491939;4130.938035929464;4139.089400331922;3709.870154544578;3742.045778326564;3750.9062273443383;3758.962410375916;3774.6036666149657;683.8700646877078;694.2675477371422;708.7200555780541;711.6868577825741;722.9349358557755;516.6022162934595;583.4952765857588;588.9558283128782;595.6515438468458;610.9266887973472;6824.317568243236;7858.528488290721;8256.215659512336;8308.54303013328;8334.49993000422;527.4725274725274;582;608.8873558391712;621.940915613016;648.6594537867658;3649.3978493548266;3911.4328422378594;3929.3713005918917;3955.3327074052318;4063.4920634920636;96793;98283;99347;99698;99701.50149249352;81567.59216203881;84121;84456.57771711102;84952.57523712341;86805.26389472175;75502.62248688831;76706;77148.22851771522;77201.61399192968;78556.60721696354;7757.689692412466;7894.644740986554;7903.920960790549;7951.443398962017;8169.305609023299;52283.215751763;52521.424357269345;52711.736441317546;52754.73622631862;52861.20708189457;48302.06791728292;67545.32454675391;76183.61908190424;76566.61716691381;78190;9958.651447199314;9959.502024898871;10139;10309.587616495257;10404.75142982847;10671.839922401015;10926;10982.945085274523;10986.615468458565;11266.436678165896;10234.53944572511;10352.637657681946;10645.308054976402;10662.306950048222;10717.035466808025;9656.613735450785;9985.85162706298;10308.845367319645;10461;10787.892121078688;10168.949155254473;10229.539670714985;10262;10282.640107596199;10816.79134417466;8615.181557752003;8819.823603527766;8948.642054318016;9236.399634023766;9926.950365248127;8974.461532308082;9382.906170938477;9710.70867873965;9922;10097.141742951932 08:34:24 INFO - PROCESS | 1991 | __end_tp_report 08:34:24 INFO - PROCESS | 1991 | __start_cc_report 08:34:24 INFO - PROCESS | 1991 | _x_x_mozilla_cycle_collect,363 08:34:24 INFO - PROCESS | 1991 | __end_cc_report 08:34:24 INFO - PROCESS | 1991 | __startTimestamp1460648064040__endTimestamp 08:34:24 INFO - PROCESS | 1991 | 08:34:24 INFO - PROCESS | 1991 | ------- Summary: start ------- 08:34:24 INFO - PROCESS | 1991 | Number of tests: 6 08:34:24 INFO - PROCESS | 1991 | 08:34:24 INFO - PROCESS | 1991 | [#0] dojo.html Cycles:165 Average:5937.76 Median:6200.98 stddev:675.28 (10.9%) stddev-sans-first:636.71 08:34:24 INFO - PROCESS | 1991 | Values: 2996.5 3214.4 3570.1 3626.4 3634.2 6013.3 6018.8 6018.8 6043.5 6065.2 6056.8 6061.7 6067.8 6085.1 6090.2 5416.9 5437.1 5439.5 5498.7 5546.9 5028.2 5388.1 5443.6 5533.4 5569.0 5466.4 5489.8 5496.9 5531.8 5531.8 4445.8 5486.0 5486.1 5536.3 5575.1 5259.7 5325.3 5357.7 5467.9 5469.9 4684.4 5946.6 5981.4 5984.6 5991.7 6322.4 6326.5 6354.9 6360.2 6362.4 6267.6 6389.2 6429.8 6493.4 6506.3 6175.6 6201.0 6210.4 6217.3 6256.4 6311.7 6573.4 6586.8 6607.9 6630.0 6070.2 6114.0 6130.8 6144.5 6146.4 5418.1 6407.4 6435.9 6444.7 6444.8 6199.7 6226.6 6356.0 6359.0 6365.8 6246.5 6344.7 6360.1 6377.8 6427.1 5053.3 5058.1 5064.9 5090.8 5110.7 4447.6 4498.6 4541.0 4578.1 4643.4 6024.5 6048.8 6100.5 6101.9 6115.7 6319.1 6332.8 6382.9 6399.1 6427.3 5967.4 6052.4 6100.2 6105.3 6127.7 5438.3 5478.2 5481.2 5562.0 5614.3 6608.1 6624.4 6635.5 6636.9 6638.4 6416.4 6416.6 6427.3 6436.2 6448.3 6381.1 6534.7 6616.7 6622.6 6664.4 6295.4 6330.6 6340.1 6344.7 6352.6 6312.7 6373.1 6374.8 6414.7 6420.0 6085.1 6203.3 6219.8 6282.3 6286.5 6209.2 6239.8 6247.3 6280.4 6281.6 6077.8 6119.2 6285.1 6295.7 6315.1 6201.3 6219.2 6242.3 6247.6 6254.6 6187.8 6236.1 6254.5 6257.3 6285.6 08:34:24 INFO - PROCESS | 1991 | 08:34:24 INFO - PROCESS | 1991 | [#1] ext.html Cycles:180 Average:65719.98 Median:40785.59 stddev:136673.62 (335.1%) stddev-sans-first:136969.28 08:34:24 INFO - PROCESS | 1991 | Values: 490.8 560.9 587.7 669.0 675.4 38899.4 39651.6 40367.6 40379.8 40500.8 41675.4 42089.6 42204.8 42546.4 42608.8 9472.7 9639.2 9675.6 9686.6 9719.3 8373.3 9600.6 9732.0 9757.9 9837.2 9768.3 9773.1 9778.9 9849.6 9868.8 9746.3 9771.0 9826.1 9856.0 9869.9 9683.6 9735.0 9788.7 9802.1 9814.6 40807.4 41010.4 41121.6 41171.4 41450.0 3329.6 3426.7 3486.6 3523.5 3864.6 28679.4 29002.7 29603.0 29823.3 29832.9 2734.1 2796.7 2816.2 2869.4 2885.2 458225.0 469202.0 491362.5 505527.0 506304.0 49008.0 49063.0 49576.0 71565.9 73370.6 46987.5 48082.0 48115.0 48244.0 48305.5 16689.0 16784.5 17081.3 17122.9 17323.3 13317.2 13448.2 13494.9 13524.1 13536.1 15406.8 15619.0 15801.6 15809.8 15811.9 6541.5 6588.2 6612.8 6619.1 6642.3 950.2 1011.5 1077.7 1120.2 1151.6 30981.4 31046.7 31160.8 31448.5 31715.2 1064.4 1120.8 1131.2 1213.9 1230.7 13753.6 14230.4 15777.4 15928.1 16037.0 496048.0 543122.0 544182.0 549189.0 554906.0 62207.7 63624.0 63792.0 63830.7 64509.7 1319.8 1511.3 1517.6 1531.4 1553.7 25199.9 30378.4 30555.0 30558.0 30975.7 54875.2 54876.7 55335.7 55434.7 55661.2 507535.0 514897.0 516826.0 517363.0 521682.0 34736.5 35452.8 35482.5 35909.8 45460.1 45466.3 46969.6 47642.8 48330.0 49089.5 38876.8 39414.0 39840.4 39893.0 40574.6 30740.2 30890.4 38534.6 39311.8 39501.8 39638.0 40190.4 40763.8 41625.2 41765.0 31705.5 34560.3 34860.5 34878.0 35083.8 21861.7 26195.7 26228.8 26290.2 26400.9 08:34:24 INFO - PROCESS | 1991 | 08:34:24 INFO - PROCESS | 1991 | [#2] jquery.html Cycles:180 Average:35786.23 Median:12132.06 stddev:108554.01 (894.8%) stddev-sans-first:108825.89 08:34:24 INFO - PROCESS | 1991 | Values: 334.5 347.2 374.4 383.6 384.0 20306.8 20825.9 21276.4 22002.3 22049.7 21144.8 21886.5 21957.7 22146.7 22274.8 5864.2 5947.9 6108.5 6122.2 6131.1 4901.5 5908.7 6009.0 6018.5 6040.4 5626.4 5943.6 5979.6 5986.2 5993.6 5917.7 5931.4 5955.8 5956.2 6022.9 5119.5 5180.1 5183.2 5221.1 5227.3 26494.9 26713.7 26817.2 26969.5 27075.9 2214.4 2267.1 2308.6 2359.1 2490.4 14809.7 15069.7 15160.7 15315.0 15351.5 1706.3 1727.9 1734.3 1746.3 1753.8 108883.9 113323.0 115122.0 115611.0 115801.4 9839.3 10493.7 10678.8 10909.8 10964.9 13586.3 13707.1 13714.5 13753.2 13762.0 8838.1 8918.1 9039.6 9084.8 9106.4 9398.0 9440.2 9476.1 9487.9 9508.5 6183.8 6264.7 6333.6 6356.7 6366.1 1844.1 1862.0 1867.7 1898.9 1902.2 926.3 1005.8 1045.2 1074.0 1169.1 21282.9 21566.4 21663.2 21684.0 21709.2 865.8 913.6 914.7 994.7 1008.7 10491.9 11217.0 11669.9 11692.5 11815.7 636988.0 654030.7 654460.0 670218.0 673172.0 85406.7 100140.0 110808.0 111348.0 117358.0 1058.9 1058.9 1081.9 1082.1 1089.7 15455.6 16763.5 18378.7 19718.0 19784.4 32354.0 32508.7 41346.8 43414.6 47478.1 70295.0 70715.0 71367.6 71437.6 71591.0 8021.5 8101.9 8116.1 8150.2 8235.1 13697.5 13726.6 13972.0 14105.9 14118.3 11489.3 12020.9 12052.4 12062.0 12110.7 11364.0 11764.6 11782.8 11904.8 12066.4 11607.5 11851.0 12069.9 12151.0 12163.0 8095.4 8169.8 8410.6 8479.4 8667.7 10997.7 11912.4 11921.2 12008.6 12128.0 08:34:24 INFO - PROCESS | 1991 | 08:34:24 INFO - PROCESS | 1991 | [#3] mootools.html Cycles:180 Average:6270.68 Median:4874.84 stddev:3305.26 (67.8%) stddev-sans-first:3296.24 08:34:24 INFO - PROCESS | 1991 | Values: 1644.1 1679.8 1833.9 1975.9 2027.0 7525.4 8332.3 8484.5 9236.0 9245.4 8730.6 8933.6 9057.9 9064.8 9068.0 2535.0 2541.7 2542.5 2542.7 2551.9 2478.5 2549.2 2559.0 2559.8 2562.1 2521.7 2543.1 2543.7 2545.5 2563.2 2283.0 2522.4 2557.8 2567.5 2570.6 2520.4 2538.5 2538.6 2555.9 2565.3 9116.2 9119.7 9126.3 9161.4 9186.4 4700.0 5482.4 5589.3 5639.7 5657.4 3623.8 3690.1 3737.3 3779.6 3790.9 1061.1 1070.6 1079.3 1081.3 1087.4 12214.5 12282.8 12394.5 12457.3 12478.2 4091.6 4927.0 5019.5 5055.9 5057.7 10463.4 10619.3 10625.5 10631.2 10641.2 4801.4 4822.7 5629.6 5665.3 5708.9 4179.2 4455.6 5041.5 5081.8 5112.2 3816.8 3869.2 3893.4 3943.8 3944.4 1356.4 1357.4 1360.9 1367.4 1368.7 1310.8 1346.1 1352.5 1354.8 1407.3 7129.0 8518.9 8549.7 8605.1 8609.4 1122.4 1219.5 1223.4 1296.7 1304.9 6239.9 6406.1 6425.4 6471.9 6482.7 10643.9 10957.5 11033.4 11034.2 11039.6 10490.8 10753.2 10773.2 10883.7 11244.0 8760.2 8906.6 8921.6 8962.5 8972.1 7895.4 8149.6 8308.9 8339.2 8446.0 9824.0 10105.9 10186.8 10243.3 10277.5 9723.9 9946.7 9956.7 9977.7 10636.7 7703.2 7714.3 7762.7 7815.5 7832.6 8416.0 8420.5 8463.7 8470.0 8496.5 7508.5 7672.0 7687.3 7688.1 7735.8 7663.8 7695.3 7717.2 7766.3 7857.5 8200.5 8202.4 8247.9 8262.9 8315.5 7338.6 7405.0 7435.1 7442.4 7467.2 7527.1 7533.4 7544.5 7605.6 7621.6 08:34:24 INFO - PROCESS | 1991 | 08:34:24 INFO - PROCESS | 1991 | [#4] prototype.html Cycles:180 Average:6133.50 Median:6946.65 stddev:1987.42 (28.6%) stddev-sans-first:1944.73 08:34:24 INFO - PROCESS | 1991 | Values: 333.5 336.7 337.2 342.9 344.7 7028.2 7056.3 7056.8 7138.5 7144.4 7023.4 7042.3 7053.4 7098.7 7111.0 4956.8 5062.2 5144.1 5153.1 5195.1 3923.8 4705.5 4962.9 5166.9 5250.7 5155.4 5163.0 5167.2 5172.6 5200.9 5109.3 5162.4 5168.9 5193.8 5205.9 4413.5 4428.8 4435.3 4440.0 4440.9 6275.6 6628.4 6671.8 6745.6 6819.6 4859.6 5287.0 5668.4 6028.2 6063.2 7511.5 7526.8 7531.4 7559.3 7591.7 4941.5 4961.0 4970.8 4970.9 4985.0 7058.4 7111.7 7528.1 7945.2 7981.2 4874.1 4919.5 4981.0 4994.6 5018.9 4649.7 4877.4 5093.8 5100.8 5104.7 5978.1 5985.2 5993.7 6001.0 6005.2 6359.8 7345.0 7594.5 7601.8 7611.4 1646.9 1764.6 1770.6 1771.1 1771.2 1071.1 1071.3 1078.7 1081.7 1085.4 5596.7 6904.1 6905.5 6939.9 6944.4 7783.6 7793.6 7821.5 7822.0 7832.1 6910.7 6938.1 6941.2 6948.9 7003.4 4004.9 4091.6 4125.2 4136.7 4149.3 8168.6 8183.0 8224.6 8248.2 8248.8 8132.7 8158.3 8186.7 8194.0 8200.0 6617.7 8227.9 8249.6 8259.5 8262.5 7606.4 7873.8 7901.5 7912.2 7930.8 7694.8 7718.9 7736.2 7761.8 7782.1 8047.4 8204.5 8204.8 8216.4 8221.3 4829.3 4875.6 4878.0 4909.0 4910.0 6545.9 7516.9 7523.4 7732.6 7916.5 7550.7 7559.3 7561.9 7564.2 7576.4 7559.4 7574.2 7583.1 7592.7 7608.2 7073.4 7345.1 7353.4 7387.0 7425.0 7515.5 7524.4 7586.2 7588.4 7622.1 7382.3 7397.0 7413.3 7414.5 7415.1 08:34:24 INFO - PROCESS | 1991 | 08:34:24 INFO - PROCESS | 1991 | [#5] yui.html Cycles:180 Average:18996.68 Median:37184.82 stddev:27798.04 (74.8%) stddev-sans-first:27842.08 08:34:24 INFO - PROCESS | 1991 | Values: 702.3 744.8 746.0 760.7 776.1 13059.2 13117.3 15389.1 15415.0 15522.6 13935.8 13973.7 14006.4 14035.4 14039.9 739.1 909.1 931.4 936.6 941.9 936.9 946.3 952.4 956.6 960.2 1004.9 1005.3 1010.4 1011.9 1013.1 985.4 990.9 994.1 1002.9 1004.0 743.6 744.4 747.2 751.7 752.1 14528.3 14864.7 14865.2 14884.6 14926.7 13085.1 13094.9 13136.7 13179.7 13210.9 8154.4 9631.3 9639.5 9910.7 9933.8 3537.7 3547.6 3554.4 3613.1 3740.4 83984.0 84934.3 89022.6 89940.6 90970.0 9380.6 9525.9 9580.9 9606.7 9929.0 18194.7 22322.0 22666.7 22845.7 22905.1 7284.3 7310.3 7346.6 7506.0 7623.7 3415.9 3990.2 4127.5 4130.9 4139.1 3709.9 3742.0 3750.9 3759.0 3774.6 683.9 694.3 708.7 711.7 722.9 516.6 583.5 589.0 595.7 610.9 6824.3 7858.5 8256.2 8308.5 8334.5 527.5 582.0 608.9 621.9 648.7 3649.4 3911.4 3929.4 3955.3 4063.5 96793.0 98283.0 99347.0 99698.0 99701.5 81567.6 84121.0 84456.6 84952.6 86805.3 75502.6 76706.0 77148.2 77201.6 78556.6 7757.7 7894.6 7903.9 7951.4 8169.3 52283.2 52521.4 52711.7 52754.7 52861.2 48302.1 67545.3 76183.6 76566.6 78190.0 9958.7 9959.5 10139.0 10309.6 10404.8 10671.8 10926.0 10982.9 10986.6 11266.4 10234.5 10352.6 10645.3 10662.3 10717.0 9656.6 9985.9 10308.8 10461.0 10787.9 10168.9 10229.5 10262.0 10282.6 10816.8 8615.2 8819.8 8948.6 9236.4 9927.0 8974.5 9382.9 9710.7 9922.0 10097.1 08:34:24 INFO - PROCESS | 1991 | -------- Summary: end -------- 08:34:24 INFO - PROCESS | 1991 | 08:34:24 INFO - TEST-INFO | 1991: exit 0 08:34:24 INFO - TEST-OK | dromaeo_css | took 1110591ms 08:34:24 INFO - TEST-START | kraken 08:34:24 INFO - operating with platform_type : mac_ 08:34:24 INFO - Initialising browser for kraken test... 08:34:24 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpOnW04Y/profile http://localhost:51244/getInfo.html) 08:34:27 INFO - PROCESS | 1997 | __metrics Screen width/height:1600/1200 08:34:27 INFO - PROCESS | 1997 | colorDepth:24 08:34:27 INFO - PROCESS | 1997 | Browser inner width/height: 1024/689 08:34:27 INFO - PROCESS | 1997 | __metrics 08:34:27 ERROR - PROCESS | 1997 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:34:27 INFO - TEST-INFO | 1997: exit 0 08:34:27 INFO - Browser initialized. 08:34:27 INFO - Running cycle 1/1 for kraken test... 08:34:27 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpOnW04Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:39 INFO - PROCESS | 2000 | RSS: Main: 218181632 08:34:39 INFO - PROCESS | 2000 | 08:34:42 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51244/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:43 INFO - PROCESS | 2000 | RSS: Main: 230215680 08:34:43 INFO - PROCESS | 2000 | 08:34:45 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51244/tests/kraken/driver.html?testName=audio-dft) 08:34:46 INFO - PROCESS | 2000 | RSS: Main: 238964736 08:34:46 INFO - PROCESS | 2000 | 08:34:49 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51244/tests/kraken/driver.html?testName=audio-fft) 08:34:50 INFO - PROCESS | 2000 | RSS: Main: 242524160 08:34:50 INFO - PROCESS | 2000 | 08:34:52 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51244/tests/kraken/driver.html?testName=audio-oscillator) 08:34:52 INFO - PROCESS | 2000 | RSS: Main: 244260864 08:34:52 INFO - PROCESS | 2000 | 08:34:54 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:55 INFO - PROCESS | 2000 | RSS: Main: 244817920 08:34:55 INFO - PROCESS | 2000 | 08:34:58 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51244/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:58 INFO - PROCESS | 2000 | RSS: Main: 244826112 08:34:58 INFO - PROCESS | 2000 | 08:35:01 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51244/tests/kraken/driver.html?testName=imaging-desaturate) 08:35:02 INFO - PROCESS | 2000 | RSS: Main: 244711424 08:35:02 INFO - PROCESS | 2000 | 08:35:05 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51244/tests/kraken/driver.html?testName=json-parse-financial) 08:35:05 INFO - PROCESS | 2000 | RSS: Main: 244572160 08:35:05 INFO - PROCESS | 2000 | 08:35:07 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:35:08 INFO - PROCESS | 2000 | RSS: Main: 244224000 08:35:08 INFO - PROCESS | 2000 | 08:35:09 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51244/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:35:10 INFO - PROCESS | 2000 | RSS: Main: 244494336 08:35:10 INFO - PROCESS | 2000 | 08:35:12 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:35:13 INFO - PROCESS | 2000 | RSS: Main: 244854784 08:35:13 INFO - PROCESS | 2000 | 08:35:15 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:35:16 INFO - PROCESS | 2000 | RSS: Main: 244924416 08:35:16 INFO - PROCESS | 2000 | 08:35:18 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:35:19 INFO - PROCESS | 2000 | RSS: Main: 245088256 08:35:19 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:51244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51244/tests/kraken/driver.html?testName=ai-astar) 08:35:21 INFO - PROCESS | 2000 | RSS: Main: 246743040 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | __start_tp_report 08:35:21 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 08:35:21 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 08:35:21 INFO - PROCESS | 2000 | |i|pagename|runs| 08:35:21 INFO - PROCESS | 2000 | |0;ai-astar;116;110;114;115;116;129;116;115;116;114 08:35:21 INFO - PROCESS | 2000 | |1;audio-beat-detection;156;147;165;159;129;137;121;159;148;121 08:35:21 INFO - PROCESS | 2000 | |2;audio-dft;194;188;198;203;199;196;197;226;199;201 08:35:21 INFO - PROCESS | 2000 | |3;audio-fft;73;74;72;111;57;56;55;59;123;57 08:35:21 INFO - PROCESS | 2000 | |4;audio-oscillator;81;88;122;82;106;123;161;82;79;120 08:35:21 INFO - PROCESS | 2000 | |5;imaging-gaussian-blur;91;88;89;88;90;74;135;128;93;87 08:35:21 INFO - PROCESS | 2000 | |6;imaging-darkroom;95;98;95;97;96;95;96;96;97;113 08:35:21 INFO - PROCESS | 2000 | |7;imaging-desaturate;146;151;92;91;92;89;92;115;147;116 08:35:21 INFO - PROCESS | 2000 | |8;json-parse-financial;55;59;59;61;62;62;62;73;57;59 08:35:21 INFO - PROCESS | 2000 | |9;json-stringify-tinderbox;63;64;74;68;80;74;69;63;68;69 08:35:21 INFO - PROCESS | 2000 | |10;stanford-crypto-aes;79;80;84;84;98;108;97;84;83;87 08:35:21 INFO - PROCESS | 2000 | |11;stanford-crypto-ccm;131;133;136;135;120;113;124;121;136;102 08:35:21 INFO - PROCESS | 2000 | |12;stanford-crypto-pbkdf2;134;157;160;135;140;134;141;140;172;139 08:35:21 INFO - PROCESS | 2000 | |13;stanford-crypto-sha256-iterative;73;80;71;58;95;54;59;77;93;90 08:35:21 INFO - PROCESS | 2000 | __end_tp_report 08:35:21 INFO - PROCESS | 2000 | __start_cc_report 08:35:21 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,935 08:35:21 INFO - PROCESS | 2000 | __end_cc_report 08:35:21 INFO - PROCESS | 2000 | __startTimestamp1460648121613__endTimestamp 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | ------- Summary: start ------- 08:35:21 INFO - PROCESS | 2000 | Number of tests: 14 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#0] ai-astar Cycles:10 Average:116.10 Median:116.00 stddev:4.89 (4.2%) stddev-sans-first:5.18 08:35:21 INFO - PROCESS | 2000 | Values: 116.0 110.0 114.0 115.0 116.0 129.0 116.0 115.0 116.0 114.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:152.00 stddev:16.30 (10.7%) stddev-sans-first:16.72 08:35:21 INFO - PROCESS | 2000 | Values: 156.0 147.0 165.0 159.0 129.0 137.0 121.0 159.0 148.0 121.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#2] audio-dft Cycles:10 Average:200.10 Median:199.00 stddev:9.98 (5.0%) stddev-sans-first:10.34 08:35:21 INFO - PROCESS | 2000 | Values: 194.0 188.0 198.0 203.0 199.0 196.0 197.0 226.0 199.0 201.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#3] audio-fft Cycles:10 Average:73.70 Median:58.00 stddev:24.18 (41.7%) stddev-sans-first:25.65 08:35:21 INFO - PROCESS | 2000 | Values: 73.0 74.0 72.0 111.0 57.0 56.0 55.0 59.0 123.0 57.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:80.00 stddev:27.02 (33.8%) stddev-sans-first:27.30 08:35:21 INFO - PROCESS | 2000 | Values: 81.0 88.0 122.0 82.0 106.0 123.0 161.0 82.0 79.0 120.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:88.50 stddev:19.31 (21.8%) stddev-sans-first:20.39 08:35:21 INFO - PROCESS | 2000 | Values: 91.0 88.0 89.0 88.0 90.0 74.0 135.0 128.0 93.0 87.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#6] imaging-darkroom Cycles:10 Average:97.80 Median:96.00 stddev:5.43 (5.7%) stddev-sans-first:5.67 08:35:21 INFO - PROCESS | 2000 | Values: 95.0 98.0 95.0 97.0 96.0 95.0 96.0 96.0 97.0 113.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#7] imaging-desaturate Cycles:10 Average:113.10 Median:90.00 stddev:26.00 (28.9%) stddev-sans-first:24.70 08:35:21 INFO - PROCESS | 2000 | Values: 146.0 151.0 92.0 91.0 92.0 89.0 92.0 115.0 147.0 116.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.50 stddev:4.84 (7.9%) stddev-sans-first:4.64 08:35:21 INFO - PROCESS | 2000 | Values: 55.0 59.0 59.0 61.0 62.0 62.0 62.0 73.0 57.0 59.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:5.47 (7.9%) stddev-sans-first:5.33 08:35:21 INFO - PROCESS | 2000 | Values: 63.0 64.0 74.0 68.0 80.0 74.0 69.0 63.0 68.0 69.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:84.00 stddev:9.42 (11.2%) stddev-sans-first:9.36 08:35:21 INFO - PROCESS | 2000 | Values: 79.0 80.0 84.0 84.0 98.0 108.0 97.0 84.0 83.0 87.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:132.00 stddev:11.34 (8.6%) stddev-sans-first:11.82 08:35:21 INFO - PROCESS | 2000 | Values: 131.0 133.0 136.0 135.0 120.0 113.0 124.0 121.0 136.0 102.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:140.50 stddev:13.09 (9.3%) stddev-sans-first:13.24 08:35:21 INFO - PROCESS | 2000 | Values: 134.0 157.0 160.0 135.0 140.0 134.0 141.0 140.0 172.0 139.0 08:35:21 INFO - PROCESS | 2000 | 08:35:21 INFO - PROCESS | 2000 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:78.50 stddev:14.85 (18.9%) stddev-sans-first:15.73 08:35:21 INFO - PROCESS | 2000 | Values: 73.0 80.0 71.0 58.0 95.0 54.0 59.0 77.0 93.0 90.0 08:35:21 INFO - PROCESS | 2000 | -------- Summary: end -------- 08:35:21 INFO - PROCESS | 2000 | 08:35:22 INFO - TEST-INFO | 2000: exit 0 08:35:22 INFO - TEST-OK | kraken | took 57963ms 08:35:22 INFO - SUITE-END | took 1168s 08:35:22 INFO - Completed test suite (00:19:28) 08:35:22 INFO - javascript benchmark 08:35:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2996.535536991767, 3214.4214041472533, 3570.0717813368533, 3626.4379021251716, 3634.200475895302, 6013.278406591216, 6018.759249630009, 6018.849528761783, 6043.486303664188, 6065.181200537926, 6056.818295451132, 6061.66660833654, 6067.757289708417, 6085.056816193497, 6090.208272924514, 5416.945830541684, 5437.13005919052, 5439.456054394568, 5498.697571633558, 5546.944530554703, 5028.195488721805, 5388.137897936331, 5443.618946673734, 5533.363663178726, 5568.972155139219, 5466.371367292752, 5489.807856725015, 5496.917546236809, 5531.778728850841, 5531.834044978657, 4445.84439544616, 5486.0125177468235, 5486.094794358926, 5536.256407704168, 5575.107982722745, 5259.684418934838, 5325.254464374991, 5357.651752636105, 5467.917981230285, 5469.917951230735, 4684.36761037259, 5946.643201407929, 5981.401859814027, 5984.551158663117, 5991.700414979277, 6322.36776322364, 6326.462250708695, 6354.904676429811, 6360.204974378203, 6362.363763623647, 6267.592606480564, 6389.233292004943, 6429.807105786834, 6493.350664933469, 6506.349365063503, 6175.5985860919345, 6200.976838821634, 6210.4100110489435, 6217.3471785462325, 6256.374362563753, 6311.747530098836, 6573.375529324707, 6586.8353291168105, 6607.933920660732, 6630.0, 6070.150178974947, 6113.962834745988, 6130.769115614378, 6144.477719393902, 6146.446819786241, 5418.133098704188, 6407.423331900058, 6435.903461448082, 6444.742210311629, 6444.8388790280615, 6199.721012554446, 6226.62640241587, 6356.046593011085, 6359.046143078575, 6365.840853978688, 6246.500279977591, 6344.651044192614, 6360.077788720702, 6377.840553986095, 6427.132337134521, 5053.31780209667, 5058.140116180258, 5064.898702026013, 5090.77091530882, 5110.6678065926335, 4447.62195213404, 4498.617617502484, 4540.954590454119, 4578.130155270488, 4643.396358473445, 6024.518038556905, 6048.818535443944, 6100.542459315569, 6101.877962440726, 6115.737177244448, 6319.0837328587095, 6332.778352757631, 6382.904256436157, 6399.136116624196, 6427.2929977702415, 5967.433093856163, 6052.394760524, 6100.23747031621, 6105.267367915879, 6127.724252408652, 5438.293021907127, 5478.233047373371, 5481.177823326533, 5561.972190139023, 5614.29821272341, 6608.140941677647, 6624.403803657694, 6635.469162467088, 6636.933630663728, 6638.402543770987, 6416.390442907917, 6416.615003099829, 6427.260865000398, 6436.195475565554, 6448.258970077959, 6381.106645069601, 6534.673266336569, 6616.702248398929, 6622.63575503352, 6664.366885145903, 6295.370462953668, 6330.556861019684, 6340.144080549251, 6344.651044192614, 6352.555321127662, 6312.747490100528, 6373.075903993988, 6374.840628984312, 6414.711337989895, 6420.0, 6085.087236914498, 6203.286622038523, 6219.751209951552, 6282.3089460158435, 6286.497080233662, 6209.192804935329, 6239.844003899939, 6247.312795592572, 6280.434760871543, 6281.59169653971, 6077.787277445268, 6119.167450728499, 6285.088662143872, 6295.685215739286, 6315.147455093687, 6201.348858369986, 6219.222597175353, 6242.28213755424, 6247.625142491283, 6254.6247225166635, 6187.783427580013, 6236.064590311489, 6254.4996400286955, 6257.311695713377, 6285.5600107992], "unit": "score", "name": "dojo.html", "value": 5893.936980266888}, {"lowerIsBetter": false, "replicates": [490.842930262316, 560.9398237331442, 587.7325816753378, 668.953088416628, 675.4393853101924, 38899.41650875232, 39651.603483965155, 40367.59632403675, 40379.79810100949, 40500.797496012514, 41675.37486937691, 42089.57910420895, 42204.788976055075, 42546.36180457295, 42608.786956065254, 9472.715818525437, 9639.180669643054, 9675.612975481008, 9686.612535498607, 9719.319647624669, 8373.330133589297, 9600.567974441166, 9732.026797320246, 9757.853632195523, 9837.213022958182, 9768.316217864753, 9773.07155820196, 9778.902210977905, 9849.556769945333, 9868.753281167956, 9746.31775775696, 9771.022897710243, 9826.1156495915, 9856.014398560159, 9869.901300987007, 9683.564239609235, 9734.951325243328, 9788.657396991142, 9802.117809397118, 9814.558344874498, 40807.387889181686, 41010.38484422736, 41121.58878411208, 41171.38242926358, 41450.0, 3329.583802024747, 3426.7429942754393, 3486.6339034401276, 3523.524324216249, 3864.574896761354, 28679.426411471653, 29002.70997290021, 29603.0, 29823.25441863949, 29832.8508357459, 2734.1387462949106, 2796.6923638399758, 2816.155153453956, 2869.426114777032, 2885.2209903326193, 458225.0, 469202.0, 491362.54318728537, 505527.0, 506304.0, 49008.0, 49063.01873962501, 49576.008479830205, 71565.92651110237, 73370.63314683392, 46987.530124698314, 48082.0, 48115.0, 48244.0, 48305.51694483081, 16688.998660080433, 16784.496465106065, 17081.316747330216, 17122.91438542824, 17323.307067717404, 13317.200967941955, 13448.193108413527, 13494.865051349558, 13524.053316267768, 13536.052476326562, 15406.845931540765, 15618.984765990173, 15801.577857992836, 15809.841901581067, 15811.920940395225, 6541.495456045136, 6588.24235212947, 6612.801615951529, 6619.073329733841, 6642.269350371455, 950.1970834644715, 1011.549860312154, 1077.6928575355985, 1120.2214460949563, 1151.6238095475826, 30981.380372392425, 31046.689533104833, 31160.812977365546, 31448.52827207594, 31715.207119821727, 1064.3986147826454, 1120.8206686930052, 1131.2194585735815, 1213.9453724582415, 1230.6923269182705, 13753.635798632691, 14230.359633816295, 15777.368905243891, 15928.147879378275, 16037.0, 496048.0, 543122.0, 544182.0, 549189.0, 554906.0, 62207.68896155581, 63624.0, 63792.0, 63830.6808465964, 64509.67745161338, 1319.8416190057255, 1511.3350125944548, 1517.590250632323, 1531.3568301313476, 1553.673728517024, 25199.87400062988, 30378.39243215079, 30554.95971865466, 30558.0, 30975.69024309728, 54875.17687234774, 54876.72561637166, 55335.72332138474, 55434.72282638561, 55661.1650825246, 507535.0, 514897.0, 516826.0, 517363.0, 521682.0, 34736.478952815225, 35452.822735886155, 35482.467762984095, 35909.820450897576, 45460.09079818319, 45466.31800523061, 46969.59091227269, 47642.808929777035, 48330.0, 49089.50910490992, 38876.80561597174, 39414.01464963399, 39840.402393964694, 39893.0, 40574.59425405826, 30740.231494212825, 30890.382192355577, 38534.6146538531, 39311.820645380685, 39501.80249098851, 39638.0, 40190.397144042276, 40763.79618101891, 41625.1674966505, 41765.0, 31705.524417134224, 34560.30879382348, 34860.47709284312, 34878.0, 35083.824580876935, 21861.67207491857, 26195.73804261933, 26228.819703113026, 26290.211293660457, 26400.86799566067], "unit": "score", "name": "ext.html", "value": 20046.64891643954}, {"lowerIsBetter": false, "replicates": [334.47487444711805, 347.15640992388484, 374.40843467321633, 383.64896120050156, 383.98436136419156, 20306.796932030677, 20825.895870520646, 21276.36170914875, 22002.339929802092, 22049.669254961147, 21144.788552114474, 21886.45283867904, 21957.67063494049, 22146.667799982974, 22274.774887381187, 5864.23764910561, 5947.851303717398, 6108.450239478446, 6122.234720659918, 6131.110988906606, 4901.534354236342, 5908.67502287374, 6009.038553831388, 6018.458338749511, 6040.365761595035, 5626.352969408509, 5943.554233432488, 5979.641221526722, 5986.221791167142, 5993.580449368546, 5917.733701983399, 5931.406859314077, 5955.761769529214, 5956.195913551658, 6022.879542409128, 5119.462456442095, 5180.067587834188, 5183.222516622499, 5221.06020916235, 5227.268182454422, 26494.86752566244, 26713.664316784278, 26817.195484135507, 26969.460610787675, 27075.86462067677, 2214.446388402899, 2267.127156044918, 2308.5729140108965, 2359.079958816063, 2490.3774056485877, 14809.703805923822, 15069.698606027818, 15160.696786064216, 15315.004524705859, 15351.462698805488, 1706.3260012295198, 1727.8790484666079, 1734.2889415339775, 1746.2840235503509, 1753.8070812210774, 108883.91116088816, 113323.0, 115122.0, 115611.0, 115801.42099289618, 9839.262055345878, 10493.737656558495, 10678.786424271471, 10909.781804364027, 10964.890351096547, 13586.32068396596, 13707.109037912503, 13714.51999180024, 13753.174809511462, 13762.0, 8838.07200243978, 8918.063603321687, 9039.638414463348, 9084.772880678036, 9106.408083474553, 9398.0, 9440.24478041755, 9476.099770521789, 9487.905120948702, 9508.477033763209, 6183.752649894044, 6264.68676566179, 6333.556651034383, 6356.745730170742, 6366.108744775735, 1844.087176847469, 1861.9627607447776, 1867.6918308478948, 1898.8670793044355, 1902.1820617134765, 926.3191554207652, 1005.8038682456997, 1045.2160879340495, 1073.9850840955223, 1169.053067015703, 21282.89358553228, 21566.353009409744, 21663.241786537397, 21684.02421891019, 21709.240176593743, 865.8354912566592, 913.6025828764509, 914.7255823252998, 994.6518718448485, 1008.6721815410021, 10491.94754026225, 11216.9904708575, 11669.883301167049, 11692.47383867728, 11815.704607384883, 636988.0, 654030.7298463477, 654460.0, 670218.0, 673172.0, 85406.71889921532, 100140.0, 110808.0, 111348.0, 117358.0, 1058.9199017002613, 1058.9364638121738, 1081.853949716778, 1082.118073769875, 1089.6948854320804, 15455.61360965985, 16763.49709508717, 18378.72431913549, 19718.014099295266, 19784.406467805413, 32354.029379118663, 32508.699652013656, 41346.759597212134, 43414.56585434105, 47478.050438990336, 70295.0, 70715.0, 71367.64316178385, 71437.6428117877, 71591.0, 8021.478603890729, 8101.918980810116, 8116.147804480681, 8150.18498150204, 8235.094139644754, 13697.520586779416, 13726.588202353945, 13972.0, 14105.929470352583, 14118.2940852959, 11489.310641361211, 12020.879791202326, 12052.397380131133, 12062.0, 12110.667826538898, 11364.0, 11764.647060588197, 11782.784345799979, 11904.821427678418, 12066.396680166132, 11607.535698571963, 11851.0, 12069.939650301692, 12151.0, 12163.0, 8095.352371810123, 8169.79575510617, 8410.6215220314, 8479.448835825651, 8667.696630617898, 10997.670069897917, 11912.40437978115, 11921.165518413627, 12008.63974080779, 12128.0], "unit": "score", "name": "jquery.html", "value": 9809.890971032155}, {"lowerIsBetter": false, "replicates": [1644.0710998285967, 1679.8404151605598, 1833.8721686163005, 1975.861689681723, 2026.9898650506746, 7525.435592330577, 8332.2917552008, 8484.490930544172, 9235.953820230907, 9245.4452732836, 8730.5634718264, 8933.642654293837, 9057.864132038008, 9064.818703625924, 9067.95466022669, 2535.0493564913204, 2541.745825417462, 2542.478791847667, 2542.6821647294087, 2551.9362015949655, 2478.5166892455977, 2549.1970029440668, 2558.961615575768, 2559.7696207341337, 2562.0520407449176, 2521.722610512842, 2543.109911530968, 2543.7074736405366, 2545.5163518931345, 2563.1797824696105, 2282.9771702282933, 2522.445062086338, 2557.8081643876785, 2567.499337629163, 2570.5887058070807, 2520.382506285972, 2538.504991526653, 2538.6192071189284, 2555.9361015974564, 2565.256075738034, 9116.179543841086, 9119.680811171644, 9126.315526335486, 9161.404508706979, 9186.44881307117, 4700.0, 5482.424345443751, 5589.329280486327, 5639.7462114204545, 5657.377688454267, 3623.7825730456257, 3690.0774806298427, 3737.3272810894027, 3779.565349984732, 3790.8673196438267, 1061.0556604621893, 1070.6199299248733, 1079.3416016230094, 1081.259337353915, 1087.3747595132752, 12214.450349734283, 12282.75434491314, 12394.504219831197, 12457.314847683374, 12478.18891772041, 4091.6317531422314, 4927.0, 5019.498050194951, 5055.9241611375855, 5057.747112644353, 10463.372197668165, 10619.256652034283, 10625.5218515167, 10631.202659800545, 10641.201909856793, 4801.447833499193, 4822.68652537584, 5629.634073785191, 5665.348484924204, 5708.914366284509, 4179.226843034048, 4455.598996090367, 5041.521055499795, 5081.796728130834, 5112.182050871843, 3816.790076545761, 3869.2454971280895, 3893.396523538856, 3943.8028098594955, 3944.36890097583, 1356.4235200039943, 1357.429879450633, 1360.9115407498482, 1367.3641756583236, 1368.7125703602155, 1310.829592153014, 1346.1317450244537, 1352.5333759852836, 1354.7696891528465, 1407.3315175291655, 7128.964355178191, 8518.87221691675, 8549.743507694655, 8605.096464871223, 8609.354298427643, 1122.354646078492, 1219.4756254810338, 1223.3944197622234, 1296.708240645866, 1304.851730477174, 6239.875202495925, 6406.103145559626, 6425.389587989227, 6471.935280647133, 6482.740690372332, 10643.946780266204, 10957.50691218897, 11033.448327583588, 11034.227604067799, 11039.613613523648, 10490.790184196274, 10753.247272690836, 10773.24587278883, 10883.67348979532, 11244.0, 8760.211580957744, 8906.55467226636, 8921.643134274556, 8962.507062111647, 8972.102789721106, 7895.368370530229, 8149.6332665031405, 8308.875366869623, 8339.166083391612, 8445.95777021111, 9824.0, 10105.89894101079, 10186.847197291898, 10243.334183278062, 10277.486125693536, 9723.85414218773, 9946.651867184613, 9956.701298961043, 9977.650782222587, 10636.734081648021, 7703.191164927602, 7714.344280735976, 7762.68949242024, 7815.491993020435, 7832.608369581612, 8416.032156302104, 8420.4947703138, 8463.74608761738, 8470.025947015925, 8496.53269070207, 7508.511946723664, 7671.961640191764, 7687.284075556828, 7688.077430708127, 7735.7679269622, 7663.770086897402, 7695.345895598937, 7717.2282771722375, 7766.339861111869, 7857.528548287121, 8200.466969646954, 8202.38482113832, 8247.876281855657, 8262.917370826455, 8315.501069935823, 7338.596377199092, 7404.96297518509, 7435.107787065586, 7442.404607631484, 7467.215942325977, 7527.059117610299, 7533.359664428585, 7544.547327160388, 7605.581693006938, 7621.580813055113], "unit": "score", "name": "mootools.html", "value": 5124.1923579948025}, {"lowerIsBetter": false, "replicates": [333.5230620213095, 336.71042903103313, 337.2395248714149, 342.9194139377246, 344.6536231087757, 7028.226895041541, 7056.294370562941, 7056.812388159674, 7138.500304978654, 7144.357007869291, 7023.40301074408, 7042.330978557042, 7053.400460960812, 7098.680559374828, 7111.0, 4956.752162391884, 5062.215356619711, 5144.125498665236, 5153.149730294497, 5195.116830138885, 3923.8228531440595, 4705.541282202511, 4962.900741985158, 5166.948330516684, 5250.7112108834, 5155.355580552431, 5163.044836705221, 5167.209706758346, 5172.6379153459275, 5200.92198617021, 5109.259157422191, 5162.354705661793, 5168.896622067557, 5193.844184674465, 5205.921911171355, 4413.514513403523, 4428.756418396987, 4435.334699795024, 4439.955600443986, 4440.933385999213, 6275.592086514362, 6628.403443690043, 6671.799846004627, 6745.628990405526, 6819.5908245505425, 4859.562639362474, 5286.973565132188, 5668.43315668434, 6028.246469191351, 6063.18147050147, 7511.511751736174, 7526.8118297042465, 7531.435142364345, 7559.3196612305155, 7591.696332146707, 4941.530554597308, 4961.032598643266, 4970.776315065831, 4970.87572810679, 4984.975075124637, 7058.400035996947, 7111.701782172263, 7528.134264559591, 7945.165757595427, 7981.161977992343, 4874.147823826923, 4919.532644398776, 4980.950190498121, 4994.625403094709, 5018.924716129261, 4649.67452278344, 4877.3903262092235, 5093.847184584469, 5100.795968161232, 5104.719240441811, 5978.103284507271, 5985.22192115031, 5993.70031498432, 6001.0, 6005.249343832021, 6359.777407790798, 7345.0084238627105, 7594.5063570867715, 7601.809954751176, 7611.4291428143115, 1646.8929519581188, 1764.5588602849289, 1770.628168084691, 1771.0790388997907, 1771.2295151609092, 1071.137734124022, 1071.3411252079916, 1078.7464945737745, 1081.734974931131, 1085.3867564825848, 5596.664200148004, 6904.1024666794, 6905.516613837083, 6939.93060069403, 6944.375006249462, 7783.649735761905, 7793.571353575494, 7821.530708157528, 7821.960890195513, 7832.138464768871, 6910.654467276616, 6938.098047253926, 6941.201761797357, 6948.93051069493, 7003.369696727319, 4004.8598299059395, 4091.590840915944, 4125.195586860594, 4136.689748268892, 4149.294619914622, 8168.632411541495, 8182.959085204536, 8224.588770561448, 8248.216419440143, 8248.793780155544, 8132.674693012332, 8158.265756081981, 8186.713465028695, 8193.959030204811, 8199.95900020496, 6617.66911654425, 8227.917720822836, 8249.628766705393, 8259.463134896212, 8262.545559994258, 7606.429517786299, 7873.842523149619, 7901.486403383762, 7912.208779122042, 7930.762077137695, 7694.807629809299, 7718.884216736866, 7736.226377362219, 7761.7671469855995, 7782.105057918186, 8047.396445266511, 8204.507729536246, 8204.794880128045, 8216.424850260424, 8221.30118939873, 4829.2997515359375, 4875.6099512038245, 4877.95122048775, 4908.950910490849, 4909.975450122869, 6545.919923212617, 7516.924830751623, 7523.360514356341, 7732.574708390867, 7916.485428447132, 7550.735724249625, 7559.28186822251, 7561.924380756122, 7564.167941526318, 7576.4317676173405, 7559.395248380227, 7574.242575742382, 7583.05211848519, 7592.696292148252, 7608.2011388805595, 7073.363397294268, 7345.081864766904, 7353.448491363062, 7387.0, 7424.96287518559, 7515.549067055994, 7524.435667325082, 7586.24137586237, 7588.354989825927, 7622.123455802654, 7382.298681625237, 7397.001404810497, 7413.332800048021, 7414.480986331121, 7415.073115860518], "unit": "score", "name": "prototype.html", "value": 5461.441952397025}, {"lowerIsBetter": false, "replicates": [702.3012102957557, 744.7728442824939, 745.9776206713799, 760.7375455467861, 776.064841865552, 13059.151155174919, 13117.278549679764, 15389.076655400684, 15414.998025128372, 15522.611934701637, 13935.790963135536, 13973.650658733537, 14006.369713362898, 14035.438582456714, 14039.859601403983, 739.0909181706504, 909.0636644256426, 931.4411353188084, 936.5925822267302, 941.9105185007413, 936.9203617692505, 946.2571881073359, 952.3714348529971, 956.6077908057698, 960.150267013691, 1004.9145822605087, 1005.3465247589053, 1010.4493051287067, 1011.9324113060718, 1013.1034034879148, 985.4333758089056, 990.8513722941544, 994.0904072773403, 1002.9197664186884, 1003.9548220330103, 743.6319022084103, 744.4193529047352, 747.1781040855016, 751.7030772844751, 752.0899711349274, 14528.273586320747, 14864.70270594582, 14865.182414967172, 14884.62788430298, 14926.70146597073, 13085.084044116915, 13094.934525327408, 13136.6715832104, 13179.670508237275, 13210.933945330307, 8154.429189956705, 9631.277654175894, 9639.518024098837, 9910.702678919644, 9933.75165620858, 3537.6816086552335, 3547.5565554305713, 3554.3957527220437, 3613.0786649404236, 3740.3828368319196, 83984.0, 84934.30131397399, 89022.5548872258, 89940.55029724874, 90970.0, 9380.624775008922, 9525.857112143323, 9580.856287155699, 9606.66376676827, 9929.007099290158, 18194.727079093824, 22322.0, 22666.66000010001, 22845.657315140284, 22905.08379664795, 7284.344409003215, 7310.34206921369, 7346.595937223397, 7505.962470187724, 7623.656935437919, 3415.9316813663586, 3990.2418540477797, 4127.484064491939, 4130.938035929464, 4139.089400331922, 3709.870154544578, 3742.045778326564, 3750.9062273443383, 3758.962410375916, 3774.6036666149657, 683.8700646877078, 694.2675477371422, 708.7200555780541, 711.6868577825741, 722.9349358557755, 516.6022162934595, 583.4952765857588, 588.9558283128782, 595.6515438468458, 610.9266887973472, 6824.317568243236, 7858.528488290721, 8256.215659512336, 8308.54303013328, 8334.49993000422, 527.4725274725274, 582.0, 608.8873558391712, 621.940915613016, 648.6594537867658, 3649.3978493548266, 3911.4328422378594, 3929.3713005918917, 3955.3327074052318, 4063.4920634920636, 96793.0, 98283.0, 99347.0, 99698.0, 99701.50149249352, 81567.59216203881, 84121.0, 84456.57771711102, 84952.57523712341, 86805.26389472175, 75502.62248688831, 76706.0, 77148.22851771522, 77201.61399192968, 78556.60721696354, 7757.689692412466, 7894.644740986554, 7903.920960790549, 7951.443398962017, 8169.305609023299, 52283.215751763, 52521.424357269345, 52711.736441317546, 52754.73622631862, 52861.20708189457, 48302.06791728292, 67545.32454675391, 76183.61908190424, 76566.61716691381, 78190.0, 9958.651447199314, 9959.502024898871, 10139.0, 10309.587616495257, 10404.75142982847, 10671.839922401015, 10926.0, 10982.945085274523, 10986.615468458565, 11266.436678165896, 10234.53944572511, 10352.637657681946, 10645.308054976402, 10662.306950048222, 10717.035466808025, 9656.613735450785, 9985.85162706298, 10308.845367319645, 10461.0, 10787.892121078688, 10168.949155254473, 10229.539670714985, 10262.0, 10282.640107596199, 10816.79134417466, 8615.181557752003, 8819.823603527766, 8948.642054318016, 9236.399634023766, 9926.950365248127, 8974.461532308082, 9382.906170938477, 9710.70867873965, 9922.0, 10097.141742951932], "unit": "score", "name": "yui.html", "value": 6943.855105596524}], "name": "dromaeo_css", "value": 7800.328093838952}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 110.0, 114.0, 115.0, 116.0, 129.0, 116.0, 115.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 116.1}, {"lowerIsBetter": true, "replicates": [156.0, 147.0, 165.0, 159.0, 129.0, 137.0, 121.0, 159.0, 148.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [194.0, 188.0, 198.0, 203.0, 199.0, 196.0, 197.0, 226.0, 199.0, 201.0], "unit": "score", "name": "audio-dft", "value": 200.1}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 72.0, 111.0, 57.0, 56.0, 55.0, 59.0, 123.0, 57.0], "unit": "score", "name": "audio-fft", "value": 73.7}, {"lowerIsBetter": true, "replicates": [81.0, 88.0, 122.0, 82.0, 106.0, 123.0, 161.0, 82.0, 79.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 104.4}, {"lowerIsBetter": true, "replicates": [91.0, 88.0, 89.0, 88.0, 90.0, 74.0, 135.0, 128.0, 93.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.3}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 95.0, 97.0, 96.0, 95.0, 96.0, 96.0, 97.0, 113.0], "unit": "score", "name": "imaging-darkroom", "value": 97.8}, {"lowerIsBetter": true, "replicates": [146.0, 151.0, 92.0, 91.0, 92.0, 89.0, 92.0, 115.0, 147.0, 116.0], "unit": "score", "name": "imaging-desaturate", "value": 113.1}, {"lowerIsBetter": true, "replicates": [55.0, 59.0, 59.0, 61.0, 62.0, 62.0, 62.0, 73.0, 57.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 74.0, 68.0, 80.0, 74.0, 69.0, 63.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 84.0, 84.0, 98.0, 108.0, 97.0, 84.0, 83.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.4}, {"lowerIsBetter": true, "replicates": [131.0, 133.0, 136.0, 135.0, 120.0, 113.0, 124.0, 121.0, 136.0, 102.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [134.0, 157.0, 160.0, 135.0, 140.0, 134.0, 141.0, 140.0, 172.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [73.0, 80.0, 71.0, 58.0, 95.0, 54.0, 59.0, 77.0, 93.0, 90.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.0}], "name": "kraken", "value": 1509.5}]} 08:35:22 INFO - Return code: 0 08:35:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:35:22 ERROR - # TBPL SUCCESS # 08:35:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:35:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:35:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:35:22 INFO - 2016-04-14 08:35:22.904 screenresolution[2005:67796] starting screenresolution argv=screenresolution get 08:35:22 INFO - 2016-04-14 08:35:22.907 screenresolution[2005:67796] Display 0: 1600x1200x32@60 08:35:22 INFO - 2016-04-14 08:35:22.913 screenresolution[2006:67799] starting screenresolution argv=screenresolution list 08:35:22 INFO - Available Modes on Display 0 08:35:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:35:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:35:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:35:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:35:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:35:23 INFO - Intel Iris: 08:35:23 INFO - Chipset Model: Intel Iris 08:35:23 INFO - Type: GPU 08:35:23 INFO - Bus: Built-In 08:35:23 INFO - VRAM (Dynamic, Max): 1536 MB 08:35:23 INFO - Vendor: Intel (0x8086) 08:35:23 INFO - Device ID: 0x0a2e 08:35:23 INFO - Revision ID: 0x0009 08:35:23 INFO - Displays: 08:35:23 INFO - Display: 08:35:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:35:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:35:23 INFO - Display Serial Number: 1600x1200 60 08:35:23 INFO - Main Display: Yes 08:35:23 INFO - Mirror: Off 08:35:23 INFO - Online: Yes 08:35:23 INFO - Rotation: Supported 08:35:23 INFO - Return code: 0 08:35:23 INFO - Running post-action listener: _resource_record_post_action 08:35:23 INFO - Running post-run listener: _resource_record_post_run 08:35:24 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 204800; Write bytes: 666024448; Read time: 4; Write time: 2225 08:35:24 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 352985600; Write bytes: 353822208; Read time: 27991; Write time: 654 08:35:24 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 200704; Write bytes: 301863936; Read time: 3; Write time: 1537 08:35:24 INFO - Running post-run listener: _upload_blobber_files 08:35:24 INFO - Blob upload gear active. 08:35:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:35:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:35:24 INFO - (blobuploader) - INFO - Open directory for files ... 08:35:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:35:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:35:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:25 INFO - (blobuploader) - INFO - Done attempting. 08:35:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:35:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:35:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:26 INFO - (blobuploader) - INFO - Done attempting. 08:35:26 INFO - (blobuploader) - INFO - Iteration through files over. 08:35:26 INFO - Return code: 0 08:35:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:35:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:35:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c495e198198632fe003a9a24b330e947fa35c2280a4f3de6abd1b706ac17453a22ce9471513720e786a3247513c467d9d9247c8ac722b8e06cb1cf7d4c478186", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f81454b6d74829e892ca0fa74e6f0714afa8e26947b2d743d40d533e59aeec6bd2234cdd73b0aaca9166cc1375e1cc71c9fafbaeb30d0e20134065a9db4db2aa"} 08:35:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:35:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:35:26 INFO - Contents: 08:35:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c495e198198632fe003a9a24b330e947fa35c2280a4f3de6abd1b706ac17453a22ce9471513720e786a3247513c467d9d9247c8ac722b8e06cb1cf7d4c478186", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f81454b6d74829e892ca0fa74e6f0714afa8e26947b2d743d40d533e59aeec6bd2234cdd73b0aaca9166cc1375e1cc71c9fafbaeb30d0e20134065a9db4db2aa"} 08:35:26 INFO - Running post-run listener: copy_logs_to_upload_dir 08:35:26 INFO - Copying logs to upload dir... 08:35:26 INFO - mkdir: /builds/slave/test/build/upload/logs 08:35:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.193158 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-14 08:35:26.322063) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 08:35:26.325578) ========= 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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c495e198198632fe003a9a24b330e947fa35c2280a4f3de6abd1b706ac17453a22ce9471513720e786a3247513c467d9d9247c8ac722b8e06cb1cf7d4c478186", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f81454b6d74829e892ca0fa74e6f0714afa8e26947b2d743d40d533e59aeec6bd2234cdd73b0aaca9166cc1375e1cc71c9fafbaeb30d0e20134065a9db4db2aa"} build_url:https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/CUvoU-9xR3OeMErfAOHa3g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c495e198198632fe003a9a24b330e947fa35c2280a4f3de6abd1b706ac17453a22ce9471513720e786a3247513c467d9d9247c8ac722b8e06cb1cf7d4c478186", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f81454b6d74829e892ca0fa74e6f0714afa8e26947b2d743d40d533e59aeec6bd2234cdd73b0aaca9166cc1375e1cc71c9fafbaeb30d0e20134065a9db4db2aa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 08:35:26.353259) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:35:26.353588) ========= 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.tVBMwnIzmK/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.nRUSVZMn2f/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.005165 ========= master_lag: 0.22 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:35:26.579133) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 08:35:26.579444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 08:35:26.579829) ========= ========= Total master_lag: 0.33 =========