builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0174 starttime: 1461190919.52 results: success (0) buildid: 20160420124848 builduid: 14f1902e36504275a22e0ce4fd4777ec revision: 4e06b79654439c156c079d58892c989faa18a227 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 15:21:59.518951) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 15:21:59.519377) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 15:21:59.519664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 15:21:59.544453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:21:59.544813) ========= 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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-20 15:21:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 34.6M=0s 2016-04-20 15:21:59 (34.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089483 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:21:59.651491) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:21:59.651816) ========= 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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.027000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:21:59.700310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:21:59.700951) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4e06b79654439c156c079d58892c989faa18a227 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4e06b79654439c156c079d58892c989faa18a227 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-20 15:21:59,774 truncating revision to first 12 chars 2016-04-20 15:21:59,774 Setting DEBUG logging. 2016-04-20 15:21:59,774 attempt 1/10 2016-04-20 15:21:59,774 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4e06b7965443?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 15:22:00,408 unpacking tar archive at: fx-team-4e06b7965443/testing/mozharness/ program finished with exit code 0 elapsedTime=0.881553 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:22:00.598965) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 15:22:00.599288) ========= script_repo_revision: 4e06b79654439c156c079d58892c989faa18a227 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 15:22:00.599693) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 15:22:00.599961) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 15:22:00.615581) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-04-20 15:22:00.615941) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:22:00 INFO - MultiFileLogger online at 20160420 15:22:00 in /builds/slave/test 15:22:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:22:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:22:00 INFO - {'append_to_log': False, 15:22:00 INFO - 'base_work_dir': '/builds/slave/test', 15:22:00 INFO - 'blob_upload_branch': 'Fx-Team', 15:22:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:22:00 INFO - 'branch': 'Fx-Team', 15:22:00 INFO - 'buildbot_json_path': 'buildprops.json', 15:22:00 INFO - 'config_files': ('talos/mac_config.py',), 15:22:00 INFO - 'default_actions': ('clobber', 15:22:00 INFO - 'read-buildbot-config', 15:22:00 INFO - 'download-and-extract', 15:22:00 INFO - 'populate-webroot', 15:22:00 INFO - 'create-virtualenv', 15:22:00 INFO - 'install', 15:22:00 INFO - 'run-tests'), 15:22:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:22:00 INFO - 'download_minidump_stackwalk': True, 15:22:00 INFO - 'download_symbols': 'ondemand', 15:22:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:22:00 INFO - 'tooltool.py': '/tools/tooltool.py', 15:22:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:22:00 INFO - '/tools/misc-python/virtualenv.py')}, 15:22:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:22:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:22:00 INFO - 'installer_path': 'installer.exe', 15:22:00 INFO - 'log_level': 'info', 15:22:00 INFO - 'log_name': 'talos', 15:22:00 INFO - 'log_to_console': True, 15:22:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:22:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:22:00 INFO - 'opt_config_files': (), 15:22:00 INFO - 'pip_index': False, 15:22:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:22:00 INFO - 'cmd': ('bash', 15:22:00 INFO - '-c', 15:22:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:22:00 INFO - 'enabled': True, 15:22:00 INFO - 'halt_on_failure': False, 15:22:00 INFO - 'name': 'check_screen_resolution'},), 15:22:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:22:00 INFO - 'cmd': ('bash', 15:22:00 INFO - '-c', 15:22:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:22:00 INFO - 'enabled': True, 15:22:00 INFO - 'halt_on_failure': False, 15:22:00 INFO - 'name': 'check_screen_resolution'},), 15:22:00 INFO - 'run_cmd_checks_enabled': True, 15:22:00 INFO - 'sps_profile': False, 15:22:00 INFO - 'sps_profile_interval': 0, 15:22:00 INFO - 'suite': 'dromaeojs', 15:22:00 INFO - 'system_bits': '32', 15:22:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:22:00 INFO - 'title': 't-yosemite-r7-0174', 15:22:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:22:00 INFO - 'use_talos_json': True, 15:22:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:22:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:22:00 INFO - 'work_dir': 'build'} 15:22:00 INFO - ##### 15:22:00 INFO - ##### Running clobber step. 15:22:00 INFO - ##### 15:22:00 INFO - Running pre-action listener: _resource_record_pre_action 15:22:00 INFO - Running main action method: clobber 15:22:00 INFO - rmtree: /builds/slave/test/build 15:22:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:22:02 INFO - Running post-action listener: _resource_record_post_action 15:22:02 INFO - ##### 15:22:02 INFO - ##### Running read-buildbot-config step. 15:22:02 INFO - ##### 15:22:02 INFO - Running pre-action listener: _resource_record_pre_action 15:22:02 INFO - Running main action method: read_buildbot_config 15:22:02 INFO - Using buildbot properties: 15:22:02 INFO - { 15:22:02 INFO - "project": "", 15:22:02 INFO - "product": "firefox", 15:22:02 INFO - "script_repo_revision": "production", 15:22:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:22:02 INFO - "repository": "", 15:22:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:22:02 INFO - "buildid": "20160420124848", 15:22:02 INFO - "pgo_build": "False", 15:22:02 INFO - "basedir": "/builds/slave/test", 15:22:02 INFO - "buildnumber": 743, 15:22:02 INFO - "slavename": "t-yosemite-r7-0174", 15:22:02 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:22:02 INFO - "platform": "yosemite_r7", 15:22:02 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:22:02 INFO - "branch": "fx-team", 15:22:02 INFO - "repo_path": "integration/fx-team", 15:22:02 INFO - "revision": "4e06b79654439c156c079d58892c989faa18a227", 15:22:02 INFO - "stage_platform": "macosx64", 15:22:02 INFO - "builduid": "14f1902e36504275a22e0ce4fd4777ec", 15:22:02 INFO - "slavebuilddir": "test" 15:22:02 INFO - } 15:22:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 15:22:02 INFO - Running post-action listener: _resource_record_post_action 15:22:02 INFO - ##### 15:22:02 INFO - ##### Running download-and-extract step. 15:22:02 INFO - ##### 15:22:02 INFO - Running pre-action listener: _resource_record_pre_action 15:22:02 INFO - Running main action method: download_and_extract 15:22:02 INFO - mkdir: /builds/slave/test/build/tests 15:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:02 INFO - https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:22:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:22:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:22:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 15:22:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 15:22:03 INFO - Downloaded 1199 bytes. 15:22:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 15:22:03 INFO - Using the following test package requirements: 15:22:03 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:22:03 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:22:03 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 15:22:03 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:22:03 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 15:22:03 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:22:03 INFO - u'jsshell-mac.zip'], 15:22:03 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:22:03 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 15:22:03 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:22:03 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:22:03 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 15:22:03 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:22:03 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 15:22:03 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:22:03 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 15:22:03 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:22:03 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 15:22:03 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:03 INFO - https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:22:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:22:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:22:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:22:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:22:06 INFO - Downloaded 18096153 bytes. 15:22:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:22:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:22:09 INFO - Return code: 0 15:22:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:09 INFO - https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:22:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:22:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:22:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:22:10 INFO - Downloaded 18096153 bytes. 15:22:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:22:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:22:14 INFO - Return code: 0 15:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:14 INFO - https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:22:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:22:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:22:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:22:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:22:15 INFO - Downloaded 10845952 bytes. 15:22:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:22:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:22:15 INFO - Return code: 0 15:22: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')]} 15:22:15 INFO - https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:22:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:22:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:22:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 15:22:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 15:22:19 INFO - Downloaded 110022223 bytes. 15:22:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:22:19 INFO - mkdir: /builds/slave/test/properties 15:22:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:22:19 INFO - Writing to file /builds/slave/test/properties/build_url 15:22:19 INFO - Contents: 15:22:19 INFO - build_url:https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:22:19 INFO - Running post-action listener: _resource_record_post_action 15:22:19 INFO - Running post-action listener: set_extra_try_arguments 15:22:19 INFO - ##### 15:22:19 INFO - ##### Running populate-webroot step. 15:22:19 INFO - ##### 15:22:19 INFO - Running pre-action listener: _resource_record_pre_action 15:22:19 INFO - Running main action method: populate_webroot 15:22:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:22:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:22:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:22:19 INFO - '--tppagecycles', 15:22:19 INFO - '7'], 15:22:19 INFO - 'tests': ['tsvgm']}}, 15:22:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:22:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:22:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:22:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:22:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:22:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:22:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:19 INFO - 'talos_options': ['--disable-e10s'], 15:22:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:19 INFO - 'talos_options': ['--disable-e10s'], 15:22:19 INFO - 'tests': ['damp', 'tps']}, 15:22:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:19 INFO - 'tests': ['damp', 'tps']}, 15:22:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:22:19 INFO - 'tests': ['dromaeo_dom']}, 15:22:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:22:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:22:19 INFO - 'tests': ['a11yr', 15:22:19 INFO - 'ts_paint', 15:22:19 INFO - 'tpaint', 15:22:19 INFO - 'sessionrestore', 15:22:19 INFO - 'sessionrestore_no_auto_restore', 15:22:19 INFO - 'tabpaint']}, 15:22:19 INFO - 'other-e10s': {'tests': ['a11yr', 15:22:19 INFO - 'ts_paint', 15:22:19 INFO - 'tpaint', 15:22:19 INFO - 'sessionrestore', 15:22:19 INFO - 'sessionrestore_no_auto_restore', 15:22:19 INFO - 'tabpaint']}, 15:22:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:22:19 INFO - 'ts_paint', 15:22:19 INFO - 'tpaint', 15:22:19 INFO - 'sessionrestore', 15:22:19 INFO - 'sessionrestore_no_auto_restore', 15:22:19 INFO - 'tabpaint']}, 15:22:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:22:19 INFO - 'ts_paint', 15:22:19 INFO - 'tpaint', 15:22:19 INFO - 'sessionrestore', 15:22:19 INFO - 'sessionrestore_no_auto_restore', 15:22:19 INFO - 'tabpaint']}, 15:22:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:22:19 INFO - 'tests': ['a11yr', 15:22:19 INFO - 'ts_paint', 15:22:19 INFO - 'tpaint', 15:22:19 INFO - 'sessionrestore', 15:22:19 INFO - 'sessionrestore_no_auto_restore', 15:22:19 INFO - 'tabpaint']}, 15:22:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:22:19 INFO - 'tests': ['a11yr', 15:22:19 INFO - 'ts_paint', 15:22:19 INFO - 'tpaint', 15:22:19 INFO - 'sessionrestore', 15:22:19 INFO - 'sessionrestore_no_auto_restore', 15:22:19 INFO - 'tabpaint']}, 15:22:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:22:19 INFO - 'tests': ['tsvgx', 15:22:19 INFO - 'tsvgr_opacity', 15:22:19 INFO - 'tart', 15:22:19 INFO - 'tscrollx', 15:22:19 INFO - 'cart']}, 15:22:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:22:19 INFO - 'tsvgr_opacity', 15:22:19 INFO - 'tart', 15:22:19 INFO - 'tscrollx', 15:22:19 INFO - 'cart']}, 15:22:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:19 INFO - 'talos_options': ['--disable-e10s'], 15:22:19 INFO - 'tests': ['tp5o']}, 15:22:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:19 INFO - 'tests': ['tp5o']}, 15:22:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:19 INFO - 'talos_options': ['--disable-e10s', 15:22:19 INFO - '--xperf_path', 15:22:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:19 INFO - 'tests': ['tp5n']}, 15:22:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:19 INFO - 'talos_options': ['--xperf_path', 15:22:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:19 INFO - 'tests': ['tp5n']}}, 15:22:19 INFO - 'talos.zip': {'path': '', 15:22:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:22:19 INFO - Running post-action listener: _resource_record_post_action 15:22:19 INFO - ##### 15:22:19 INFO - ##### Running create-virtualenv step. 15:22:19 INFO - ##### 15:22:19 INFO - Running pre-action listener: _resource_record_pre_action 15:22:19 INFO - Running main action method: create_virtualenv 15:22:19 INFO - Creating virtualenv /builds/slave/test/build/venv 15:22:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:22:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:22:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:22:20 INFO - Using real prefix '/tools/python27' 15:22:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:22:20 INFO - Installing distribute.............................................................................................................................................................................................done. 15:22:23 INFO - Installing pip.................done. 15:22:23 INFO - Return code: 0 15:22:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10660da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95434cee10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ace00>, '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 0x1062d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064a7b20>, '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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:22:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XfOjPc1BYJ/Render', 15:22:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:23 INFO - 'HOME': '/Users/cltbld', 15:22:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:23 INFO - 'LOGNAME': 'cltbld', 15:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:23 INFO - 'MOZ_NO_REMOTE': '1', 15:22:23 INFO - 'NO_EM_RESTART': '1', 15:22:23 INFO - 'PAGER': '/bin/cat', 15:22:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:23 INFO - 'PWD': '/builds/slave/test', 15:22:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:23 INFO - 'SHELL': '/bin/bash', 15:22:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wRMgfpVYnF/Listeners', 15:22:23 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:22:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:23 INFO - 'USER': 'cltbld', 15:22:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:23 INFO - 'XPC_FLAGS': '0x0', 15:22:23 INFO - 'XPC_SERVICE_NAME': '0', 15:22:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:22:23 INFO - Cleaning up... 15:22:23 INFO - Return code: 0 15:22:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10660da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95434cee10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ace00>, '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 0x1062d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064a7b20>, '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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:22:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XfOjPc1BYJ/Render', 15:22:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:23 INFO - 'HOME': '/Users/cltbld', 15:22:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:23 INFO - 'LOGNAME': 'cltbld', 15:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:23 INFO - 'MOZ_NO_REMOTE': '1', 15:22:23 INFO - 'NO_EM_RESTART': '1', 15:22:23 INFO - 'PAGER': '/bin/cat', 15:22:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:23 INFO - 'PWD': '/builds/slave/test', 15:22:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:23 INFO - 'SHELL': '/bin/bash', 15:22:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wRMgfpVYnF/Listeners', 15:22:23 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:22:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:23 INFO - 'USER': 'cltbld', 15:22:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:23 INFO - 'XPC_FLAGS': '0x0', 15:22:23 INFO - 'XPC_SERVICE_NAME': '0', 15:22:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:24 INFO - Downloading/unpacking psutil>=0.7.1 15:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:22:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:27 INFO - Installing collected packages: psutil 15:22:27 INFO - Running setup.py install for psutil 15:22:27 INFO - building 'psutil._psutil_osx' extension 15:22:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:22:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:22:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:22:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:22:27 INFO - building 'psutil._psutil_posix' extension 15:22:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:22:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:22:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:22:28 INFO - ^ 15:22:28 INFO - 1 warning generated. 15:22:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:22:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:28 INFO - Successfully installed psutil 15:22:28 INFO - Cleaning up... 15:22:28 INFO - Return code: 0 15:22:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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')]} 15:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:28 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 0x10660da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95434cee10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ace00>, '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 0x1062d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064a7b20>, '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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:22:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XfOjPc1BYJ/Render', 15:22:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:28 INFO - 'HOME': '/Users/cltbld', 15:22:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:28 INFO - 'LOGNAME': 'cltbld', 15:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:28 INFO - 'MOZ_NO_REMOTE': '1', 15:22:28 INFO - 'NO_EM_RESTART': '1', 15:22:28 INFO - 'PAGER': '/bin/cat', 15:22:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:28 INFO - 'PWD': '/builds/slave/test', 15:22:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:28 INFO - 'SHELL': '/bin/bash', 15:22:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wRMgfpVYnF/Listeners', 15:22:28 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:22:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:28 INFO - 'USER': 'cltbld', 15:22:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:28 INFO - 'XPC_FLAGS': '0x0', 15:22:28 INFO - 'XPC_SERVICE_NAME': '0', 15:22:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:22:31 INFO - Installing collected packages: mozsystemmonitor 15:22:31 INFO - Running setup.py install for mozsystemmonitor 15:22:31 INFO - Successfully installed mozsystemmonitor 15:22:31 INFO - Cleaning up... 15:22:31 INFO - Return code: 0 15:22:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:31 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 0x10660da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95434cee10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ace00>, '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 0x1062d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064a7b20>, '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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:22:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XfOjPc1BYJ/Render', 15:22:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:31 INFO - 'HOME': '/Users/cltbld', 15:22:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:31 INFO - 'LOGNAME': 'cltbld', 15:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:31 INFO - 'MOZ_NO_REMOTE': '1', 15:22:31 INFO - 'NO_EM_RESTART': '1', 15:22:31 INFO - 'PAGER': '/bin/cat', 15:22:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:31 INFO - 'PWD': '/builds/slave/test', 15:22:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:31 INFO - 'SHELL': '/bin/bash', 15:22:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wRMgfpVYnF/Listeners', 15:22:31 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:22:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:31 INFO - 'USER': 'cltbld', 15:22:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:31 INFO - 'XPC_FLAGS': '0x0', 15:22:31 INFO - 'XPC_SERVICE_NAME': '0', 15:22:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:31 INFO - Downloading/unpacking blobuploader==1.2.4 15:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:34 INFO - Downloading blobuploader-1.2.4.tar.gz 15:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:22:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:22:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:35 INFO - Downloading docopt-0.6.1.tar.gz 15:22:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:22:35 INFO - Installing collected packages: blobuploader, requests, docopt 15:22:35 INFO - Running setup.py install for blobuploader 15:22:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:22:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:22:35 INFO - Running setup.py install for requests 15:22:35 INFO - Running setup.py install for docopt 15:22:36 INFO - Successfully installed blobuploader requests docopt 15:22:36 INFO - Cleaning up... 15:22:36 INFO - Return code: 0 15:22:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:36 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 0x10660da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95434cee10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ace00>, '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 0x1062d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064a7b20>, '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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:22:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XfOjPc1BYJ/Render', 15:22:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:36 INFO - 'HOME': '/Users/cltbld', 15:22:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:36 INFO - 'LOGNAME': 'cltbld', 15:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:36 INFO - 'MOZ_NO_REMOTE': '1', 15:22:36 INFO - 'NO_EM_RESTART': '1', 15:22:36 INFO - 'PAGER': '/bin/cat', 15:22:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:36 INFO - 'PWD': '/builds/slave/test', 15:22:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:36 INFO - 'SHELL': '/bin/bash', 15:22:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wRMgfpVYnF/Listeners', 15:22:36 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:22:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:36 INFO - 'USER': 'cltbld', 15:22:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:36 INFO - 'XPC_FLAGS': '0x0', 15:22:36 INFO - 'XPC_SERVICE_NAME': '0', 15:22:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:36 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Q8qDRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:36 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-UbJtIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:36 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-P4pWqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:36 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-BlBrms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:36 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-c8DVHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:37 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-OUV5Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:37 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-WP52h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:37 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-xqCntE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:37 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-xK9Nmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:37 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-HyDO3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:37 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-01_jOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:37 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-5rJc99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:37 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-sPx61y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:37 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Arj3jS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:37 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-CW6mu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:38 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-QI0uZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:38 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-FhKZE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:22:38 INFO - Running setup.py install for manifestparser 15:22:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:22:38 INFO - Running setup.py install for mozcrash 15:22:38 INFO - Running setup.py install for mozdebug 15:22:38 INFO - Running setup.py install for mozdevice 15:22:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:22:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:22:38 INFO - Running setup.py install for mozfile 15:22:38 INFO - Running setup.py install for mozhttpd 15:22:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:22:39 INFO - Running setup.py install for mozinfo 15:22:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:22:39 INFO - Running setup.py install for mozInstall 15:22:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:22:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:22:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:22:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:22:39 INFO - Running setup.py install for mozleak 15:22:39 INFO - Running setup.py install for mozlog 15:22:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:22:39 INFO - Running setup.py install for moznetwork 15:22:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:22:39 INFO - Running setup.py install for mozprocess 15:22:40 INFO - Running setup.py install for mozprofile 15:22:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Running setup.py install for mozrunner 15:22:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Running setup.py install for mozscreenshot 15:22:40 INFO - Running setup.py install for moztest 15:22:40 INFO - Running setup.py install for mozversion 15:22:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:22:40 INFO - Cleaning up... 15:22:40 INFO - Return code: 0 15:22:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:40 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 0x10660da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95434cee10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ace00>, '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 0x1062d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064a7b20>, '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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:22:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XfOjPc1BYJ/Render', 15:22:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:40 INFO - 'HOME': '/Users/cltbld', 15:22:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:40 INFO - 'LOGNAME': 'cltbld', 15:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:40 INFO - 'MOZ_NO_REMOTE': '1', 15:22:40 INFO - 'NO_EM_RESTART': '1', 15:22:40 INFO - 'PAGER': '/bin/cat', 15:22:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:40 INFO - 'PWD': '/builds/slave/test', 15:22:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:40 INFO - 'SHELL': '/bin/bash', 15:22:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wRMgfpVYnF/Listeners', 15:22:40 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:22:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:40 INFO - 'USER': 'cltbld', 15:22:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:40 INFO - 'XPC_FLAGS': '0x0', 15:22:40 INFO - 'XPC_SERVICE_NAME': '0', 15:22:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-I8YKN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-HYh6y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-P9oM61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-loHHnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-JisRrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-AdrSVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-JbMl_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-p3kfPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-1_8PwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-9eWR52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-rOeTpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Po5bww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-R3xFFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-KU8rJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-SG30WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-UWhgnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-sSU1eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:45 INFO - Downloading blessings-1.6.tar.gz 15:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:22:45 INFO - Installing collected packages: blessings 15:22:45 INFO - Running setup.py install for blessings 15:22:45 INFO - Successfully installed blessings 15:22:45 INFO - Cleaning up... 15:22:45 INFO - Return code: 0 15:22:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:45 INFO - Reading from file tmpfile_stdout 15:22:45 INFO - Current package versions: 15:22:45 INFO - blessings == 1.6 15:22:45 INFO - blobuploader == 1.2.4 15:22:45 INFO - docopt == 0.6.1 15:22:45 INFO - manifestparser == 1.1 15:22:45 INFO - mozInstall == 1.12 15:22:45 INFO - mozcrash == 0.17 15:22:45 INFO - mozdebug == 0.1 15:22:45 INFO - mozdevice == 0.48 15:22:45 INFO - mozfile == 1.2 15:22:45 INFO - mozhttpd == 0.7 15:22:45 INFO - mozinfo == 0.9 15:22:45 INFO - mozleak == 0.1 15:22:45 INFO - mozlog == 3.1 15:22:45 INFO - moznetwork == 0.27 15:22:45 INFO - mozprocess == 0.22 15:22:45 INFO - mozprofile == 0.28 15:22:45 INFO - mozrunner == 6.11 15:22:45 INFO - mozscreenshot == 0.1 15:22:45 INFO - mozsystemmonitor == 0.0 15:22:45 INFO - moztest == 0.7 15:22:45 INFO - mozversion == 1.4 15:22:45 INFO - psutil == 3.1.1 15:22:45 INFO - requests == 1.2.3 15:22:45 INFO - wsgiref == 0.1.2 15:22:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:45 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 0x10660da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95434cee10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ace00>, '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 0x1062d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064a7b20>, '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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:22:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XfOjPc1BYJ/Render', 15:22:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:45 INFO - 'HOME': '/Users/cltbld', 15:22:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:45 INFO - 'LOGNAME': 'cltbld', 15:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:45 INFO - 'MOZ_NO_REMOTE': '1', 15:22:45 INFO - 'NO_EM_RESTART': '1', 15:22:45 INFO - 'PAGER': '/bin/cat', 15:22:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:45 INFO - 'PWD': '/builds/slave/test', 15:22:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:45 INFO - 'SHELL': '/bin/bash', 15:22:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wRMgfpVYnF/Listeners', 15:22:45 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:22:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:45 INFO - 'USER': 'cltbld', 15:22:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:45 INFO - 'XPC_FLAGS': '0x0', 15:22:45 INFO - 'XPC_SERVICE_NAME': '0', 15:22:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:22:46 INFO - Cleaning up... 15:22:46 INFO - Return code: 0 15:22:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:46 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 0x10660da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95434cee10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ace00>, '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 0x1062d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064a7b20>, '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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:22:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XfOjPc1BYJ/Render', 15:22:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:46 INFO - 'HOME': '/Users/cltbld', 15:22:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:46 INFO - 'LOGNAME': 'cltbld', 15:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:46 INFO - 'MOZ_NO_REMOTE': '1', 15:22:46 INFO - 'NO_EM_RESTART': '1', 15:22:46 INFO - 'PAGER': '/bin/cat', 15:22:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:46 INFO - 'PWD': '/builds/slave/test', 15:22:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:46 INFO - 'SHELL': '/bin/bash', 15:22:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wRMgfpVYnF/Listeners', 15:22:46 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:22:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:46 INFO - 'USER': 'cltbld', 15:22:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:46 INFO - 'XPC_FLAGS': '0x0', 15:22:46 INFO - 'XPC_SERVICE_NAME': '0', 15:22:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:46 INFO - Downloading/unpacking jsonschema 15:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:22:48 INFO - Downloading/unpacking functools32 (from jsonschema) 15:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:49 INFO - Downloading functools32-3.2.3-2.tar.gz 15:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:22:49 INFO - warning: no files found matching '*.txt' 15:22:49 INFO - no previously-included directories found matching 'build' 15:22:49 INFO - no previously-included directories found matching 'dist' 15:22:49 INFO - no previously-included directories found matching '.git*' 15:22:49 INFO - Installing collected packages: jsonschema, functools32 15:22:49 INFO - Running setup.py install for functools32 15:22:49 INFO - warning: no files found matching '*.txt' 15:22:49 INFO - no previously-included directories found matching 'build' 15:22:49 INFO - no previously-included directories found matching 'dist' 15:22:49 INFO - no previously-included directories found matching '.git*' 15:22:49 INFO - Successfully installed jsonschema functools32 15:22:49 INFO - Cleaning up... 15:22:49 INFO - Return code: 0 15:22:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:50 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 0x10660da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95434cee10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ace00>, '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 0x1062d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064a7b20>, '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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:22:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XfOjPc1BYJ/Render', 15:22:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:50 INFO - 'HOME': '/Users/cltbld', 15:22:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:50 INFO - 'LOGNAME': 'cltbld', 15:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:50 INFO - 'MOZ_NO_REMOTE': '1', 15:22:50 INFO - 'NO_EM_RESTART': '1', 15:22:50 INFO - 'PAGER': '/bin/cat', 15:22:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:50 INFO - 'PWD': '/builds/slave/test', 15:22:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:50 INFO - 'SHELL': '/bin/bash', 15:22:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wRMgfpVYnF/Listeners', 15:22:50 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:22:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:50 INFO - 'USER': 'cltbld', 15:22:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:50 INFO - 'XPC_FLAGS': '0x0', 15:22:50 INFO - 'XPC_SERVICE_NAME': '0', 15:22:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:50 INFO - Downloading/unpacking flake8 15:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:22:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:22: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 15:22: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 15:22: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 15:22: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 15:22: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 15:22: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 15:22:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:22:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:22: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 15:22: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 15:22: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 15:22: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 15:22: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 15:22: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 15:22:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:22: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 15:22: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 15:22: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 15:22: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 15:22: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 15:22: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 15:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:22:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:22:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:22:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:22:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:22:54 INFO - no previously-included directories found matching 'docs/_build' 15:22:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:22:54 INFO - Running setup.py install for pep8 15:22:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:22:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:22:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:22:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:22:54 INFO - no previously-included directories found matching 'docs/_build' 15:22:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:22:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:22:54 INFO - Cleaning up... 15:22:54 INFO - Return code: 0 15:22:54 INFO - Running post-action listener: _resource_record_post_action 15:22:54 INFO - Running post-action listener: _start_resource_monitoring 15:22:54 INFO - Starting resource monitoring. 15:22:54 INFO - ##### 15:22:54 INFO - ##### Running install step. 15:22:54 INFO - ##### 15:22:54 INFO - Running pre-action listener: _resource_record_pre_action 15:22:54 INFO - Running main action method: install 15:22:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:55 INFO - Reading from file tmpfile_stdout 15:22:55 INFO - Detecting whether we're running mozinstall >=1.0... 15:22:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:22:55 INFO - Reading from file tmpfile_stdout 15:22:55 INFO - Output received: 15:22:55 INFO - Usage: mozinstall [options] installer 15:22:55 INFO - Options: 15:22:55 INFO - -h, --help show this help message and exit 15:22:55 INFO - -d DEST, --destination=DEST 15:22:55 INFO - Directory to install application into. [default: 15:22:55 INFO - "/builds/slave/test"] 15:22:55 INFO - --app=APP Application being installed. [default: firefox] 15:22:55 INFO - mkdir: /builds/slave/test/build/application 15:22:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:23:28 INFO - Reading from file tmpfile_stdout 15:23:28 INFO - Output received: 15:23:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:23:28 INFO - Running post-action listener: _resource_record_post_action 15:23:28 INFO - ##### 15:23:28 INFO - ##### Running run-tests step. 15:23:28 INFO - ##### 15:23:28 INFO - Running pre-action listener: _resource_record_pre_action 15:23:28 INFO - Running main action method: run_tests 15:23:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:23:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:23:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:23:28 INFO - 2016-04-20 15:23:28.638 screenresolution[1638:7584] starting screenresolution argv=screenresolution get 15:23:28 INFO - 2016-04-20 15:23:28.640 screenresolution[1638:7584] Display 0: 1600x1200x32@60 15:23:28 INFO - 2016-04-20 15:23:28.646 screenresolution[1639:7586] starting screenresolution argv=screenresolution list 15:23:28 INFO - Available Modes on Display 0 15:23:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:23:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:23:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:23:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:23:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:23:28 INFO - Intel Iris: 15:23:28 INFO - Chipset Model: Intel Iris 15:23:28 INFO - Type: GPU 15:23:28 INFO - Bus: Built-In 15:23:28 INFO - VRAM (Dynamic, Max): 1536 MB 15:23:28 INFO - Vendor: Intel (0x8086) 15:23:28 INFO - Device ID: 0x0a2e 15:23:28 INFO - Revision ID: 0x0009 15:23:28 INFO - Displays: 15:23:28 INFO - Display: 15:23:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:23:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:23:28 INFO - Display Serial Number: 1600x1200 60 15:23:28 INFO - Main Display: Yes 15:23:28 INFO - Mirror: Off 15:23:28 INFO - Online: Yes 15:23:28 INFO - Rotation: Supported 15:23:28 INFO - Return code: 0 15:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:23:28 INFO - Python 2.7.3 15:23:28 INFO - Return code: 0 15:23:28 INFO - grabbing minidump binary from tooltool 15:23: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')]} 15:23:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ace00>, '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 0x1062d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064a7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:23:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:23:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:23:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:23:28 INFO - Return code: 0 15:23:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:23:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:23:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:23:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:23:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:23:30 INFO - Return code: 0 15:23:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0174 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:23:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XfOjPc1BYJ/Render', 15:23:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:30 INFO - 'HOME': '/Users/cltbld', 15:23:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:30 INFO - 'LOGNAME': 'cltbld', 15:23:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:23:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:30 INFO - 'MOZ_NO_REMOTE': '1', 15:23:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:23:30 INFO - 'NO_EM_RESTART': '1', 15:23:30 INFO - 'PAGER': '/bin/cat', 15:23:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:30 INFO - 'PWD': '/builds/slave/test', 15:23:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:23:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:30 INFO - 'SHELL': '/bin/bash', 15:23:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wRMgfpVYnF/Listeners', 15:23:30 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:23:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:30 INFO - 'USER': 'cltbld', 15:23:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:30 INFO - 'XPC_FLAGS': '0x0', 15:23:30 INFO - 'XPC_SERVICE_NAME': '0', 15:23:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:23:30 INFO - mozversion application_buildid: 20160420124848 15:23:30 INFO - mozversion application_changeset: 4e06b79654439c156c079d58892c989faa18a227 15:23:30 INFO - mozversion application_display_name: Nightly 15:23:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:23:30 INFO - mozversion application_name: Firefox 15:23:30 INFO - mozversion application_remotingname: firefox 15:23:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:23:30 INFO - mozversion application_vendor: Mozilla 15:23:30 INFO - mozversion application_version: 48.0a1 15:23:30 INFO - mozversion platform_buildid: 20160420124848 15:23:30 INFO - mozversion platform_changeset: 4e06b79654439c156c079d58892c989faa18a227 15:23:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:23:30 INFO - mozversion platform_version: 48.0a1 15:23:30 INFO - using testdate: 1461191010 15:23:30 INFO - actual date: 1461191010 15:23:30 INFO - starting webserver on 'localhost:49276' 15:23:30 INFO - SUITE-START | Running 2 tests 15:23:30 INFO - TEST-START | dromaeo_css 15:23:30 INFO - operating with platform_type : mac_ 15:23:30 INFO - Initialising browser for dromaeo_css test... 15:23:30 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpLj4wSj/profile http://localhost:49276/getInfo.html) 15:23:32 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 15:23:32 INFO - PROCESS | 1657 | colorDepth:24 15:23:32 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 15:23:32 INFO - PROCESS | 1657 | __metrics 15:23:32 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:23:32 ERROR - PROCESS | 1657 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:23:33 INFO - TEST-INFO | 1657: exit 0 15:23:33 INFO - Browser initialized. 15:23:33 INFO - Running cycle 1/1 for dromaeo_css test... 15:23:33 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpLj4wSj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:45 INFO - PROCESS | 1659 | RSS: Main: 237694976 15:23:45 INFO - PROCESS | 1659 | 15:24:36 INFO - PROCESS | 1659 | 1461191076738 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:26:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 15:26:48 INFO - PROCESS | 1659 | RSS: Main: 333234176 15:26:48 INFO - PROCESS | 1659 | 15:29:51 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 15:29:51 INFO - PROCESS | 1659 | RSS: Main: 380899328 15:29:51 INFO - PROCESS | 1659 | 15:32:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 15:32:54 INFO - PROCESS | 1659 | RSS: Main: 376188928 15:32:54 INFO - PROCESS | 1659 | 15:35:56 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 15:35:57 INFO - PROCESS | 1659 | RSS: Main: 356331520 15:35:57 INFO - PROCESS | 1659 | 15:39:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 15:39:01 INFO - PROCESS | 1659 | RSS: Main: 342351872 15:39:01 INFO - PROCESS | 1659 | 15:42:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 15:42:04 INFO - PROCESS | 1659 | RSS: Main: 383127552 15:42:04 INFO - PROCESS | 1659 | 15:42:04 INFO - PROCESS | 1659 | __start_tp_report 15:42:04 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 15:42:04 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 15:42:04 INFO - PROCESS | 1659 | |i|pagename|runs| 15:42:04 INFO - PROCESS | 1659 | |0;dojo.html;2830.5895645131454;3439.7076248518874;3469.028671971849;3471.531343268658;3500.1424650960503;5496.395396506391;5608.691521966291;5679;5693.943060569393;5706.429357064291;5738.5409167266625;5805.216295800076;5860.882782344351;5861.970690146543;5867.413258674131;5099.005693889693;5148.639595228336;5201.193814958688;5231;5243.003829272445;4324.6107850293465;5260.552853007499;5267.1045922193125;5308.150695888658;5331.493508116722;5120.155174396239;5134.974325128351;5222.9337542583635;5242.816501422432;5273.419923808417;5202.557782588485;5203.089459344599;5241.895162096775;5246.947530524684;5270.49930256625;5166.664166829181;5186.118359878829;5228.79084836606;5233.188855727369;5258.106121959276;5525.364583072957;5582.33012038558;5635.7463914123555;5709.857253568653;5717.942820571824;6248.78129265478;6276.246850377984;6277.152584401093;6279.246490421178;6287.528435367366;6240.968795155995;6329.208848893888;6329.936700632981;6338.556301058928;6349.904751428732;5650.067738823089;5739.856503587402;5773.769049238025;5867.794627188028;5906.202662640489;6274.435300822856;6281.371862813773;6295.024271237966;6304.495640348761;6313.337099604567;6168.506519478431;6181.505479561714;6188.597741146811;6193.1329613854095;6204.255489341218;6116.113163591254;6194.287656919422;6210.254769427607;6218.875622487525;6303;4889.535494128052;6241.251049874044;6281.937180628135;6283;6292.276388215414;6287.654179020198;6290.937090629127;6306.653134077578;6307.5269354798575;6313.179286692701;4769.785359658824;4885.975570122127;4896.975515122473;4934.975325123423;4983.90032199354;4435.756033418193;4456.286994080931;4515.074409745994;4515.683902126885;4523.344115103291;5646.774129034875;5710.628809127394;5719.685417302005;5728;5737.454941780524;6260.436560709467;6278.215223097113;6285.96857015712;6289.96855015722;6292.590981586182;5676.659400435905;5728.455796699307;5746.4253574643035;5747.597668163188;5777.19119323295;5303.284056652303;5363.222332761728;5408.972295263966;5450.345958485007;5456.590755693339;6264.749410023548;6312.274088479791;6317.241930968313;6320.146780184708;6320.71556779946;6268.874622507616;6269.247690277196;6310.432061114522;6315.179026726496;6328.810135695937;6244.1570387997035;6287.18266625354;6344.651044192614;6352.809415717536;6373.267074286517;6165.475934545614;6221.782237621662;6237.96881015592;6242.625442473466;6248.5313601479165;6143.631382116909;6294.716737746904;6304.5271604628915;6311.053341998737;6316.210473690789;5613.663180209201;6061.7575296987625;6117.663528505796;6161.106639537153;6188.195534580475;6116.694165291807;6139.2325959255095;6171.1668924694595;6177.598456100519;6184.319724830175;5743.253377060955;6006.519478441627;6022.578419510767;6024.578279520391;6037.698115094316;5156.845294641167;5967.850803729942;6105.175801266772;6152.477039451696;6181;5987.850303742442;6021.307549631849;6043.607165534227;6049.818505444844;6057.969710151421 15:42:04 INFO - PROCESS | 1659 | |1;ext.html;531.3013387395574;534.911739562972;587.5417174603809;592.4786188154424;616.831105055919;29943.700562994363;37905.05237369064;39128.80435597825;39163.804180979125;39230.21539569214;41436.79281603588;42061.57938420615;42075;42149.57850421495;42276;9346.205572526344;9544.95227523865;9568.80862382752;9577.76055598612;9584;9394.107559781844;9549.37929034614;9554;9592.136707696305;9625;9557.187639050655;9637.903620963805;9642.903570964305;9653.71038868835;9661.420314781135;9539.570719317648;9603.17539667461;9619.470929098898;9619.615215391375;9645;9367.672131475365;9512.28657850657;9518.666846660333;9524.714258572254;9525.333226674136;39888.800555997324;40341.39487907684;40389.99025024368;40445.393319100236;40483.19033619341;3160.8577614007195;3216.4371235033777;3598.838052287653;3673.3204357194004;3784.9810750946344;28147.718522814714;28895.71104288972;29971.801127954855;30247;30290.84854575735;2728.7544121029005;2728.9727102728916;2771.1270949650793;2824.124521398373;2853.7003614620376;362587;363918;366223;366290;366705;54261.72869135708;63357.366426335146;63542.046869296995;63857;65038;61835;61941;62110.37889621136;62279.6886015567;62295.75408491805;16436.342546298252;16638.667226655398;16656.666866662843;16666.50000499987;16668.83331166697;11864.703382415508;12080.697982550331;12104.757904841854;12106.092043096627;12852.357382130856;18023.098845057695;18463.446096616855;18614.44156675302;18730.96979666104;18775.436736897915;7141.607211603307;7298.890516642255;7300.598467084362;7342.851289021685;7362.876788998178;946.6402766948515;965.75856035991;994.3983889746744;994.6568433890296;1092.6066616018227;29313.267168320963;29727.40545189084;29781.808727651085;30008;30302.84848575787;942.9292803039799;1050.753073027838;1100.147385776014;1105.8949399807007;1123.1969142063465;14514.564563063124;14710.117392956243;14824.481143159937;14948.252587370587;15037.473688420852;602863;603790;613659;614415.9279203576;614947;58282.12576811351;58751.70624146937;58805.41194587999;58848.41151588515;58890.705546471996;1348.9527866524625;1385.2796545796332;1386.6741315790982;1510.9924450377678;1531.1425601662881;29549.55675664824;29837.70162298436;30426.54360184643;30921.8453907729;31080;53261.201081983025;54108;54181.72909135429;54369.72815136057;54402.45597544132;465967;491439;491796;492008;492034;23728;24346;24349;26452.73547264503;26866.462670746867;33851.239345163085;39138;44296.11407771891;46693;47008;34357.312853743286;35254.471182932786;35573.64426355807;36531.634683652825;36922.63077369192;35652.64347356493;35704.28591428105;36716.81641591775;37567.62432375641;37571;36386.4542031875;36467.45298820467;37548.812255938545;37718.62281377151;37830.43254351242;30637;31521.527177091903;32254.516182257754;32265.193370165933;32492.350152996336;19520.511987200432;19627;24386.878065610268;24554;24941 15:42:04 INFO - PROCESS | 1659 | |2;jquery.html;397.46937837986286;400.24753463488656;400.7935913004802;401.97588144711335;412.6595558664101;14554.708905821904;19957;20855.85292808895;20864.582708345824;20869.68695469569;19693.803061969375;19941.40175794725;21195.894020529915;21544.784552154473;21584.460388490297;5747.655140691561;6004.789832355868;6098.664573448458;6102.389761023885;6108.083787431899;5445.809396671118;5928.3775203603645;6014.578979471439;6027.668478233717;6079.1793107930525;5807.419258074201;5941.168236446901;5950.880982380349;5981.641101533922;5988.820335389945;5828.5337173026055;5902.291724993007;5912.408759124096;5918.112283157518;5918.112283157539;5021.347224860781;5172.767225474862;5196.454372290893;5202.76587553561;5206.453322401131;25768.969241230327;26038.46115542815;26163.73836261632;26468.60297095545;26531.336716582045;2147.7744836792067;2240.6863039174527;2340.8010319122895;2559.923202303934;2588.715241323453;12419.689507762288;13624.250666213355;14388;15350.539483815392;15557.688846223125;1722.078687901979;1782.287085165931;1798.8830726002898;1808.7558179645712;1816.4096668582763;116613.41693291564;119182.40408797901;120147;120863.91360863844;121121;9828.557714902847;10287.897121028844;10880.803111657711;11565.306081635128;11670.76658466826;12287.631371058882;13412.262325572186;13979.930100349637;14135.57593272183;15010.549683509294;8531.317494600416;8534.573271336409;8577.914220857836;8699.91300086991;8711;8452.281556067803;8461.915380846236;8469.491830490191;8557.315414766803;8605.913940860637;4453.866384008485;4565.726056436624;4585.770711464414;4632.86101416958;4644.58198762113;1624;1930.1217945834612;1942.9125689344014;1945;1968.557074658219;824.2622852547057;888.0941439731566;939.7885475767897;1013.341328136717;1019.4698756646502;19637.60724785496;20457.386278411373;20476;20490.897545512475;20495.4876128098;957.9281553883486;995.5619527407918;1020.6682828080903;1028.2391030637275;1043.2853495355705;8839.558022098869;10684.839727404094;10772.245942784086;10798.568057277778;10831.07935825448;574211;575683;581027;581605;592185;73570;73614.63192684003;97968;119024.8097519031;121878;878.4816957994814;1016.2733645443543;1042.9739256518649;1045.9477026148813;1046.4558429616557;17612.38356657562;17831.643367132325;17877.37429189972;17884.374046908295;18176.545586360447;44593.55406445894;47539.762301188275;47587;48769.756151219015;50155.49844501508;71102;72424;72756.63621681857;74162.51674966363;74243.51512969818;6614.140161778938;7838.098618658927;8128.065272493503;8174.427790054639;8475.872861906953;10684.83972740394;12288.87711122913;12580.937095314464;12686.302253376152;12722.300273485047;10574.471276436301;10746.408947507962;11090.334579925231;11112.499937502671;11199.384033877888;10658.253922225369;10710.196735244732;10844.349339039683;10972.890271097187;11239.550417983517;11109.944450277697;11161.218714689894;11210.215284929976;11469.08247340194;11568.595099171489;6889.517733758589;7336.334711584741;7352.558846469229;7541.924580754342;8397.286230670217;7776.41676874248;10795.920407959142;11106.889311069152;11238.845406052342;11272.098232141572 15:42:04 INFO - PROCESS | 1659 | |3;mootools.html;1435.2464955898158;1617.9029258244507;1628.3323837226737;1902.657521646103;2018.6568283391832;7814.335781458576;8479.152084791518;8700.782480437992;8709.2597129244;8714.17215364541;8342.499450032987;8595.054544000155;8600.139986001397;8600.56997150143;8603.569821508916;2133.232036466871;2361.3624321433203;2414.3601945484415;2441.8779061046966;2452.2152911068465;2468.5556599812026;2488;2493.9002439902383;2494.625806129077;2499.250224932522;2398.424378149249;2445.0464318915547;2445.4742230420457;2445.8165637577254;2446.5718499262557;2107.725995620575;2306.9307920762403;2388.2477019738726;2391.210900402863;2421.2978236311446;2441.4750828571764;2449.2529778417575;2452.6198439241766;2453.9631905521433;2456.2876765737915;8524.659013639446;8623.956880215621;8625.741227763177;8631.223189912938;8632.093630168867;5004.924926126111;5322.121849894801;5335.466453354672;5337.226102215157;5342.946570534284;3501.77238479498;3511.490833829106;3572.089117275078;3602.8919132426067;3611.855525778966;1014.8071866345371;1032.1897310611134;1034.0280136671504;1035.3425574760006;1037.3879411147384;11628.825567616492;11676.299422034705;11684.941575292069;11694.356810375426;11699.941500292443;4624.05206932578;4715.41057367829;4905.411350637875;4931.334269873593;4935.407751069894;9941.353812002197;9962.551685174185;9980.301378903552;9985.30102892805;10015.349002314826;5395.325584301962;5406.107992181324;5407.810726624628;5434.402215756264;5438.211459338374;3535.681788639035;4499.370088187657;4503;4510;4602.456876594652;3743.457198706172;3864.0146762575364;3867.3425517662067;4105.3020986432375;4137.110521237948;1214.7912826737452;1295.8185853980451;1335.419092694681;1343.2761620681083;1372.0944176843434;819.4304958054214;829.1998221716073;874.6719980007497;878.3061381508537;911.5032307392487;5505.201745746845;5638.859028524238;5683.931468365459;5818.040023396177;5958.433948774859;1001.8697569316088;1040.5889673579045;1058.4866339825178;1064.020921086778;1076.3757020927842;3743.9438408423894;3756.6431189037;3881.4760007399204;3883.980580097138;3933.547642021147;10279.280450368551;10498.842517362245;10618.522166502526;10677.359358438518;10810.459477026117;10586.629467968583;10731.087857532197;10731.463426828628;10784.838227426595;10884.183686223565;7912.643931023118;8226.876596851052;8257.091719910804;8303.709370172015;8304.584770761438;4598.724076555417;5539.833804985857;5650.0959846424375;5685.857853553694;5721.685307307972;7873.133955264801;9830.164436022733;9952.850707239253;9963.651272205438;9993.500324983866;7981.800454988439;9804.607815687292;9920.107190352903;9933.453660048766;9948.900510994798;7363.521371111075;7386.889196661947;7528.2308657464355;7578.583177925267;7585.734499292719;8101.10887802353;8126.75619731409;8234.752957411287;8249.670013199404;8251.216134467217;7177;7278.781636550912;7328.853422931618;7414.962925185555;7450.143233527997;7133.785986420416;7147.928520714726;7204.783856484314;7235.602041887536;7302.160251571137;6887.965560172167;7040.542364746275;7041.119860017498;7049.154101507852;7060.94085887121;3951.84192632303;4693.577578017995;4781.6891902026255;4791.161546729378;4861.368022157097;4780.11567859947;4847.660663753503;4881.9511804881495;4885.438174609965;5006.249062640487 15:42:04 INFO - PROCESS | 1659 | |4;prototype.html;296.6766224814952;310.1532815413921;326.9967300326997;329.79223089453643;330.9751768617354;5916.852078698029;5919.260092488434;5948.464638182562;6001.399860014002;6015.669138197398;5606.271184745988;5647.475181700938;5716.885662286762;5749.798757043504;5924.659759395047;3968.4642573252604;4270.807813648377;4508.706934049293;4534.166146158651;4572.337011133383;4208.221479026374;4504.256797628387;4522.570355816192;4523.977380113095;4535.954640453603;3782.565005024416;4417.955820441803;4482.708623939449;4485.215087359699;4500.662450316223;4412.161689279027;4447.155040542319;4457.5765302296395;4471.552844715502;4479.619232365253;3865.536135663738;3877.7867217303037;3879.1853710720784;3885.4754608127823;3895.668868146211;5303.390110137307;5637.913971830408;5704.714764261812;5740.712964351766;5744.195812586241;4435.800388982471;4817.771468275602;4954.108260513106;4985.750712464399;5033.949660503385;5195.922061169085;5486.423925487807;6190.535709821736;6213.198172529961;6222.657753823538;3912.960870391288;4153.875383738493;4158.979205103986;4202.138561594866;4218.831246750126;5746.626469279484;6392.616443013434;6536.54244202906;6570.178727659043;6581.86836263272;4228.879346973054;4240.6395456385935;4259.957400425956;4262.211490874136;4263.914721705549;3617.317947154586;4002.7398219115667;4256.616904478612;4267.231898258343;4273.1240095780295;4980.327655766425;4990.850274491771;5008.348914641073;5015.498450155028;5025.899482010339;5254.868628284324;5645.2096706461125;6151.98492248774;6309.179806625109;6313.453203965058;1302.8045793130916;1312.783390740536;1401.4324198699544;1402.9057335278499;1483.3399137383976;793.7221074070742;999.240577161348;1028.83024300991;1033.3180101133366;1041.3803786746873;5128;5473.987312347229;5723.6851973141875;5742.253507044057;5753.741081651336;5301.761420736076;5460.726963651801;5983.815907193843;6379.776707815297;6451.41937225652;5530.336359636869;5780.72823978724;5789.218455508452;5794.159846822187;5802.3037235531165;2941.691122432114;3190.2343437574814;3193.1378527797365;3390.627031026585;3406.4549672052353;5850.707464626752;6152.138700581922;6575.736970521126;6632.8673426531195;6666.83332916681;5472.91790623141;6485.805425837232;6524.836879077966;6533.542652014408;6597.60414375139;6612.669366531654;6621.503387245976;6633.9336606633315;6636.203655561267;6652.70062847173;5486.0125177468435;5722.2561067061015;6151.200343955257;6160.414760597736;6196.504279657706;5793.971030144822;6293.716782744696;6329.582025706251;6335.3981371769605;6360.236771587439;5770.596058275881;5797.623154494944;5899.882002359843;6331.620102793847;6691.498137639599;3668.6514781095752;3772.4152756322815;4023.8994025149605;4212.64192543625;4241.448611680462;5471.179323101566;6228.72991679372;6520.380563846427;6529.314421985623;6546.443552297917;5878.529717622494;5906.202662640489;6281.905771413524;6290.685465726787;6314.6842657866;5219.76511057011;5590.937721832839;6245.375462453719;6277.955191732098;6285.182926219562;5506.733451306302;5666.943330566642;5688.40271771458;5870.823875283749;6133.26400831903;6146.354632763496;6217.875642487034;6298.937010630018;6301.180846489927;6305.054241863757;5839.737211825393;6155.384461553809;6178.320384757583;6189.40045181016;6208.534359922934 15:42:04 INFO - PROCESS | 1659 | |5;yui.html;571.7084287013622;673.9831504212398;698.7135274537441;729.2925861913945;729.9708011679535;15007.474738384159;15144.924275378622;15351.232438378092;15363.3086511107;15427.92286038571;13730.450781968735;13867.653308667288;13989.650258743537;14059.226742529183;14067;913.1690161952624;931.7111695374422;938.3244064273712;938.7606160429115;942.5569982108398;743.2790193512285;771.2518856709012;905.1446383167909;922.0272612393921;943.693299677604;991.7074463033423;993.2054356514795;993.2103977337997;995.1193194023269;997.326804407026;762.6415584675194;976.8632391465201;977.8582105594649;982.219135787051;983.2674657380226;704.1690804850275;726.8509955459172;730.0837449001469;732.1397358104259;733.4828945593343;14803.703925921529;15358.769618455732;15386;15413.5375938722;15416.768748468781;12513.874861251363;12731;12812.743745125046;13053.608391748263;13131;9905.702828915144;10028.448435336053;10142.137918276956;10397.220208484394;10664.407961934166;3497.5453191085;3550.680438760524;3569.803660798655;3602.8198590070656;3669.853205871762;70220.6488967557;77362.61318693426;77568;77712;77748.61125694335;9716.61133554664;9938.900610993942;10057;10151.086402223835;10217.080462758388;19433.902830485757;21956.89021554882;21972.560548788933;22021.22925697625;22035.338939831832;7474.364679002237;7476.364509016795;7705.30652241301;7876.645550950221;7977.282044616012;3954.4661470701662;4084.8570300039355;4117.464729585195;4134.813933373005;4223.303154979394;3529.3647143514413;3666.944995825065;3671.706263498914;3676.0809797550614;3811.904702382463;664.9800505984731;686.1663079358603;703.265087983059;706.6396137969673;708.1325376413955;517.0785064386248;602.8071017274518;606.7876243314804;607.1287702147345;612.4090252905967;7680.385569154454;7706.173503430795;7818.609069546614;7960.56216908064;8229.094799572042;569.9914501282484;577.9913301300484;591.4617697894895;597.2146627185238;605.1769593353036;3694.704423646102;3778.848846046127;3792.5069740934055;3794.5446546414605;3964.365701487806;88345;88491.55754221187;89138;89486.55256723675;89802.65296020565;73611;74090;74191.62904185553;74225.25774742184;74656.62671686607;58913.70543147257;60021.39978600158;65805;66580;67194.66402668053;7716.717221941876;7866.016747906512;7938.285554300141;8012.158723333966;8100.675972961016;37644.81177594094;39440;40467.79766101151;40624.390634141106;42404;45209.41767038138;53923.73038134784;58053.709731452764;58840.70579647246;59485.702571486865;8921.732348029569;10577.735556610838;10596.2582619219;10778.784424311627;11026.393548354597;9618.326717129734;11810.468528916392;12328.420802165054;12359.938200308941;12696.682582935131;11399.829002564802;11463.828042579202;11590.420478976186;11763.588274410355;11849.526018959144;11128.332300062022;11152.55389784432;11321.207515473838;11520.193586448868;12167.087468439726;10705.250632455965;10728;10755.731106722082;11334.036606888507;11663.59177428786;7712.383009359126;9591.28065395112;9632.614695412105;9637.37357071788;9674.177694896012;8865.955670221607;9198.908010919806;9259.120383563552;9289.442633442015;9352.812943740952 15:42:04 INFO - PROCESS | 1659 | __end_tp_report 15:42:04 INFO - PROCESS | 1659 | __start_cc_report 15:42:04 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1245 15:42:04 INFO - PROCESS | 1659 | __end_cc_report 15:42:04 INFO - PROCESS | 1659 | __startTimestamp1461192124773__endTimestamp 15:42:04 INFO - PROCESS | 1659 | 15:42:04 INFO - PROCESS | 1659 | ------- Summary: start ------- 15:42:04 INFO - PROCESS | 1659 | Number of tests: 6 15:42:04 INFO - PROCESS | 1659 | 15:42:04 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5750.40 Median:6021.31 stddev:663.56 (11.0%) stddev-sans-first:624.81 15:42:04 INFO - PROCESS | 1659 | Values: 2830.6 3439.7 3469.0 3471.5 3500.1 5496.4 5608.7 5679.0 5693.9 5706.4 5738.5 5805.2 5860.9 5862.0 5867.4 5099.0 5148.6 5201.2 5231.0 5243.0 4324.6 5260.6 5267.1 5308.2 5331.5 5120.2 5135.0 5222.9 5242.8 5273.4 5202.6 5203.1 5241.9 5246.9 5270.5 5166.7 5186.1 5228.8 5233.2 5258.1 5525.4 5582.3 5635.7 5709.9 5717.9 6248.8 6276.2 6277.2 6279.2 6287.5 6241.0 6329.2 6329.9 6338.6 6349.9 5650.1 5739.9 5773.8 5867.8 5906.2 6274.4 6281.4 6295.0 6304.5 6313.3 6168.5 6181.5 6188.6 6193.1 6204.3 6116.1 6194.3 6210.3 6218.9 6303.0 4889.5 6241.3 6281.9 6283.0 6292.3 6287.7 6290.9 6306.7 6307.5 6313.2 4769.8 4886.0 4897.0 4935.0 4983.9 4435.8 4456.3 4515.1 4515.7 4523.3 5646.8 5710.6 5719.7 5728.0 5737.5 6260.4 6278.2 6286.0 6290.0 6292.6 5676.7 5728.5 5746.4 5747.6 5777.2 5303.3 5363.2 5409.0 5450.3 5456.6 6264.7 6312.3 6317.2 6320.1 6320.7 6268.9 6269.2 6310.4 6315.2 6328.8 6244.2 6287.2 6344.7 6352.8 6373.3 6165.5 6221.8 6238.0 6242.6 6248.5 6143.6 6294.7 6304.5 6311.1 6316.2 5613.7 6061.8 6117.7 6161.1 6188.2 6116.7 6139.2 6171.2 6177.6 6184.3 5743.3 6006.5 6022.6 6024.6 6037.7 5156.8 5967.9 6105.2 6152.5 6181.0 5987.9 6021.3 6043.6 6049.8 6058.0 15:42:04 INFO - PROCESS | 1659 | 15:42:04 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:62961.27 Median:20807.71 stddev:132725.31 (637.9%) stddev-sans-first:133014.87 15:42:04 INFO - PROCESS | 1659 | Values: 531.3 534.9 587.5 592.5 616.8 29943.7 37905.1 39128.8 39163.8 39230.2 41436.8 42061.6 42075.0 42149.6 42276.0 9346.2 9545.0 9568.8 9577.8 9584.0 9394.1 9549.4 9554.0 9592.1 9625.0 9557.2 9637.9 9642.9 9653.7 9661.4 9539.6 9603.2 9619.5 9619.6 9645.0 9367.7 9512.3 9518.7 9524.7 9525.3 39888.8 40341.4 40390.0 40445.4 40483.2 3160.9 3216.4 3598.8 3673.3 3785.0 28147.7 28895.7 29971.8 30247.0 30290.8 2728.8 2729.0 2771.1 2824.1 2853.7 362587.0 363918.0 366223.0 366290.0 366705.0 54261.7 63357.4 63542.0 63857.0 65038.0 61835.0 61941.0 62110.4 62279.7 62295.8 16436.3 16638.7 16656.7 16666.5 16668.8 11864.7 12080.7 12104.8 12106.1 12852.4 18023.1 18463.4 18614.4 18731.0 18775.4 7141.6 7298.9 7300.6 7342.9 7362.9 946.6 965.8 994.4 994.7 1092.6 29313.3 29727.4 29781.8 30008.0 30302.8 942.9 1050.8 1100.1 1105.9 1123.2 14514.6 14710.1 14824.5 14948.3 15037.5 602863.0 603790.0 613659.0 614415.9 614947.0 58282.1 58751.7 58805.4 58848.4 58890.7 1349.0 1385.3 1386.7 1511.0 1531.1 29549.6 29837.7 30426.5 30921.8 31080.0 53261.2 54108.0 54181.7 54369.7 54402.5 465967.0 491439.0 491796.0 492008.0 492034.0 23728.0 24346.0 24349.0 26452.7 26866.5 33851.2 39138.0 44296.1 46693.0 47008.0 34357.3 35254.5 35573.6 36531.6 36922.6 35652.6 35704.3 36716.8 37567.6 37571.0 36386.5 36467.5 37548.8 37718.6 37830.4 30637.0 31521.5 32254.5 32265.2 32492.4 19520.5 19627.0 24386.9 24554.0 24941.0 15:42:04 INFO - PROCESS | 1659 | 15:42:04 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:33427.10 Median:2450.36 stddev:96453.37 (3936.3%) stddev-sans-first:96692.07 15:42:04 INFO - PROCESS | 1659 | Values: 397.5 400.2 400.8 402.0 412.7 14554.7 19957.0 20855.9 20864.6 20869.7 19693.8 19941.4 21195.9 21544.8 21584.5 5747.7 6004.8 6098.7 6102.4 6108.1 5445.8 5928.4 6014.6 6027.7 6079.2 5807.4 5941.2 5950.9 5981.6 5988.8 5828.5 5902.3 5912.4 5918.1 5918.1 5021.3 5172.8 5196.5 5202.8 5206.5 25769.0 26038.5 26163.7 26468.6 26531.3 2147.8 2240.7 2340.8 2559.9 2588.7 12419.7 13624.3 14388.0 15350.5 15557.7 1722.1 1782.3 1798.9 1808.8 1816.4 116613.4 119182.4 120147.0 120863.9 121121.0 9828.6 10287.9 10880.8 11565.3 11670.8 12287.6 13412.3 13979.9 14135.6 15010.5 8531.3 8534.6 8577.9 8699.9 8711.0 8452.3 8461.9 8469.5 8557.3 8605.9 4453.9 4565.7 4585.8 4632.9 4644.6 1624.0 1930.1 1942.9 1945.0 1968.6 824.3 888.1 939.8 1013.3 1019.5 19637.6 20457.4 20476.0 20490.9 20495.5 957.9 995.6 1020.7 1028.2 1043.3 8839.6 10684.8 10772.2 10798.6 10831.1 574211.0 575683.0 581027.0 581605.0 592185.0 73570.0 73614.6 97968.0 119024.8 121878.0 878.5 1016.3 1043.0 1045.9 1046.5 17612.4 17831.6 17877.4 17884.4 18176.5 44593.6 47539.8 47587.0 48769.8 50155.5 71102.0 72424.0 72756.6 74162.5 74243.5 6614.1 7838.1 8128.1 8174.4 8475.9 10684.8 12288.9 12580.9 12686.3 12722.3 10574.5 10746.4 11090.3 11112.5 11199.4 10658.3 10710.2 10844.3 10972.9 11239.6 11109.9 11161.2 11210.2 11469.1 11568.6 6889.5 7336.3 7352.6 7541.9 8397.3 7776.4 10795.9 11106.9 11238.8 11272.1 15:42:04 INFO - PROCESS | 1659 | 15:42:04 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5637.73 Median:4871.66 stddev:3140.15 (64.5%) stddev-sans-first:3133.08 15:42:04 INFO - PROCESS | 1659 | Values: 1435.2 1617.9 1628.3 1902.7 2018.7 7814.3 8479.2 8700.8 8709.3 8714.2 8342.5 8595.1 8600.1 8600.6 8603.6 2133.2 2361.4 2414.4 2441.9 2452.2 2468.6 2488.0 2493.9 2494.6 2499.3 2398.4 2445.0 2445.5 2445.8 2446.6 2107.7 2306.9 2388.2 2391.2 2421.3 2441.5 2449.3 2452.6 2454.0 2456.3 8524.7 8624.0 8625.7 8631.2 8632.1 5004.9 5322.1 5335.5 5337.2 5342.9 3501.8 3511.5 3572.1 3602.9 3611.9 1014.8 1032.2 1034.0 1035.3 1037.4 11628.8 11676.3 11684.9 11694.4 11699.9 4624.1 4715.4 4905.4 4931.3 4935.4 9941.4 9962.6 9980.3 9985.3 10015.3 5395.3 5406.1 5407.8 5434.4 5438.2 3535.7 4499.4 4503.0 4510.0 4602.5 3743.5 3864.0 3867.3 4105.3 4137.1 1214.8 1295.8 1335.4 1343.3 1372.1 819.4 829.2 874.7 878.3 911.5 5505.2 5638.9 5683.9 5818.0 5958.4 1001.9 1040.6 1058.5 1064.0 1076.4 3743.9 3756.6 3881.5 3884.0 3933.5 10279.3 10498.8 10618.5 10677.4 10810.5 10586.6 10731.1 10731.5 10784.8 10884.2 7912.6 8226.9 8257.1 8303.7 8304.6 4598.7 5539.8 5650.1 5685.9 5721.7 7873.1 9830.2 9952.9 9963.7 9993.5 7981.8 9804.6 9920.1 9933.5 9948.9 7363.5 7386.9 7528.2 7578.6 7585.7 8101.1 8126.8 8234.8 8249.7 8251.2 7177.0 7278.8 7328.9 7415.0 7450.1 7133.8 7147.9 7204.8 7235.6 7302.2 6888.0 7040.5 7041.1 7049.2 7060.9 3951.8 4693.6 4781.7 4791.2 4861.4 4780.1 4847.7 4882.0 4885.4 5006.2 15:42:04 INFO - PROCESS | 1659 | 15:42:04 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:5012.46 Median:5646.34 stddev:1554.04 (27.5%) stddev-sans-first:1517.56 15:42:04 INFO - PROCESS | 1659 | Values: 296.7 310.2 327.0 329.8 331.0 5916.9 5919.3 5948.5 6001.4 6015.7 5606.3 5647.5 5716.9 5749.8 5924.7 3968.5 4270.8 4508.7 4534.2 4572.3 4208.2 4504.3 4522.6 4524.0 4536.0 3782.6 4418.0 4482.7 4485.2 4500.7 4412.2 4447.2 4457.6 4471.6 4479.6 3865.5 3877.8 3879.2 3885.5 3895.7 5303.4 5637.9 5704.7 5740.7 5744.2 4435.8 4817.8 4954.1 4985.8 5033.9 5195.9 5486.4 6190.5 6213.2 6222.7 3913.0 4153.9 4159.0 4202.1 4218.8 5746.6 6392.6 6536.5 6570.2 6581.9 4228.9 4240.6 4260.0 4262.2 4263.9 3617.3 4002.7 4256.6 4267.2 4273.1 4980.3 4990.9 5008.3 5015.5 5025.9 5254.9 5645.2 6152.0 6309.2 6313.5 1302.8 1312.8 1401.4 1402.9 1483.3 793.7 999.2 1028.8 1033.3 1041.4 5128.0 5474.0 5723.7 5742.3 5753.7 5301.8 5460.7 5983.8 6379.8 6451.4 5530.3 5780.7 5789.2 5794.2 5802.3 2941.7 3190.2 3193.1 3390.6 3406.5 5850.7 6152.1 6575.7 6632.9 6666.8 5472.9 6485.8 6524.8 6533.5 6597.6 6612.7 6621.5 6633.9 6636.2 6652.7 5486.0 5722.3 6151.2 6160.4 6196.5 5794.0 6293.7 6329.6 6335.4 6360.2 5770.6 5797.6 5899.9 6331.6 6691.5 3668.7 3772.4 4023.9 4212.6 4241.4 5471.2 6228.7 6520.4 6529.3 6546.4 5878.5 5906.2 6281.9 6290.7 6314.7 5219.8 5590.9 6245.4 6278.0 6285.2 5506.7 5666.9 5688.4 5870.8 6133.3 6146.4 6217.9 6298.9 6301.2 6305.1 5839.7 6155.4 6178.3 6189.4 6208.5 15:42:04 INFO - PROCESS | 1659 | 15:42:04 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:17157.31 Median:30041.46 stddev:23594.73 (78.5%) stddev-sans-first:23628.05 15:42:04 INFO - PROCESS | 1659 | Values: 571.7 674.0 698.7 729.3 730.0 15007.5 15144.9 15351.2 15363.3 15427.9 13730.5 13867.7 13989.7 14059.2 14067.0 913.2 931.7 938.3 938.8 942.6 743.3 771.3 905.1 922.0 943.7 991.7 993.2 993.2 995.1 997.3 762.6 976.9 977.9 982.2 983.3 704.2 726.9 730.1 732.1 733.5 14803.7 15358.8 15386.0 15413.5 15416.8 12513.9 12731.0 12812.7 13053.6 13131.0 9905.7 10028.4 10142.1 10397.2 10664.4 3497.5 3550.7 3569.8 3602.8 3669.9 70220.6 77362.6 77568.0 77712.0 77748.6 9716.6 9938.9 10057.0 10151.1 10217.1 19433.9 21956.9 21972.6 22021.2 22035.3 7474.4 7476.4 7705.3 7876.6 7977.3 3954.5 4084.9 4117.5 4134.8 4223.3 3529.4 3666.9 3671.7 3676.1 3811.9 665.0 686.2 703.3 706.6 708.1 517.1 602.8 606.8 607.1 612.4 7680.4 7706.2 7818.6 7960.6 8229.1 570.0 578.0 591.5 597.2 605.2 3694.7 3778.8 3792.5 3794.5 3964.4 88345.0 88491.6 89138.0 89486.6 89802.7 73611.0 74090.0 74191.6 74225.3 74656.6 58913.7 60021.4 65805.0 66580.0 67194.7 7716.7 7866.0 7938.3 8012.2 8100.7 37644.8 39440.0 40467.8 40624.4 42404.0 45209.4 53923.7 58053.7 58840.7 59485.7 8921.7 10577.7 10596.3 10778.8 11026.4 9618.3 11810.5 12328.4 12359.9 12696.7 11399.8 11463.8 11590.4 11763.6 11849.5 11128.3 11152.6 11321.2 11520.2 12167.1 10705.3 10728.0 10755.7 11334.0 11663.6 7712.4 9591.3 9632.6 9637.4 9674.2 8866.0 9198.9 9259.1 9289.4 9352.8 15:42:04 INFO - PROCESS | 1659 | -------- Summary: end -------- 15:42:04 INFO - PROCESS | 1659 | 15:42:05 INFO - TEST-INFO | 1659: exit 0 15:42:05 INFO - TEST-OK | dromaeo_css | took 1114935ms 15:42:05 INFO - TEST-START | kraken 15:42:05 INFO - operating with platform_type : mac_ 15:42:05 INFO - Initialising browser for kraken test... 15:42:05 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp6IIYKb/profile http://localhost:49276/getInfo.html) 15:42:07 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 15:42:07 INFO - PROCESS | 1670 | colorDepth:24 15:42:07 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 15:42:07 INFO - PROCESS | 1670 | __metrics 15:42:07 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:42:07 ERROR - PROCESS | 1670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:42:08 INFO - TEST-INFO | 1670: exit 0 15:42:08 INFO - Browser initialized. 15:42:08 INFO - Running cycle 1/1 for kraken test... 15:42:08 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp6IIYKb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:42:20 INFO - PROCESS | 1672 | RSS: Main: 238989312 15:42:20 INFO - PROCESS | 1672 | 15:42:22 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 15:42:23 INFO - PROCESS | 1672 | RSS: Main: 286621696 15:42:23 INFO - PROCESS | 1672 | 15:42:26 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 15:42:27 INFO - PROCESS | 1672 | RSS: Main: 299298816 15:42:27 INFO - PROCESS | 1672 | 15:42:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 15:42:31 INFO - PROCESS | 1672 | RSS: Main: 385982464 15:42:31 INFO - PROCESS | 1672 | 15:42:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 15:42:34 INFO - PROCESS | 1672 | RSS: Main: 285700096 15:42:34 INFO - PROCESS | 1672 | 15:42:36 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:42:36 INFO - PROCESS | 1672 | RSS: Main: 291573760 15:42:36 INFO - PROCESS | 1672 | 15:42:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 15:42:40 INFO - PROCESS | 1672 | RSS: Main: 329904128 15:42:40 INFO - PROCESS | 1672 | 15:42:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 15:42:43 INFO - PROCESS | 1672 | RSS: Main: 330805248 15:42:43 INFO - PROCESS | 1672 | 15:42:46 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 15:42:46 INFO - PROCESS | 1672 | RSS: Main: 329486336 15:42:46 INFO - PROCESS | 1672 | 15:42:48 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:42:49 INFO - PROCESS | 1672 | RSS: Main: 320282624 15:42:49 INFO - PROCESS | 1672 | 15:42:50 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:42:51 INFO - PROCESS | 1672 | RSS: Main: 327708672 15:42:51 INFO - PROCESS | 1672 | 15:42:53 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:42:54 INFO - PROCESS | 1672 | RSS: Main: 329961472 15:42:54 INFO - PROCESS | 1672 | 15:42:57 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:42:57 INFO - PROCESS | 1672 | RSS: Main: 334815232 15:42:57 INFO - PROCESS | 1672 | 15:43:00 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:43:01 INFO - PROCESS | 1672 | RSS: Main: 332541952 15:43:01 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 15:43:03 INFO - PROCESS | 1672 | RSS: Main: 397266944 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | __start_tp_report 15:43:03 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 15:43:03 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 15:43:03 INFO - PROCESS | 1672 | |i|pagename|runs| 15:43:03 INFO - PROCESS | 1672 | |0;ai-astar;114;111;156;167;113;113;118;112;113;114 15:43:03 INFO - PROCESS | 1672 | |1;audio-beat-detection;154;121;143;169;118;142;141;117;172;118 15:43:03 INFO - PROCESS | 1672 | |2;audio-dft;185;211;266;190;184;187;184;186;183;182 15:43:03 INFO - PROCESS | 1672 | |3;audio-fft;76;77;87;96;79;85;82;89;91;54 15:43:03 INFO - PROCESS | 1672 | |4;audio-oscillator;97;93;133;76;78;79;123;79;76;122 15:43:03 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;88;84;87;86;86;85;88;83;88;84 15:43:03 INFO - PROCESS | 1672 | |6;imaging-darkroom;93;92;94;94;93;93;94;93;93;93 15:43:03 INFO - PROCESS | 1672 | |7;imaging-desaturate;87;86;84;85;84;83;84;88;85;83 15:43:03 INFO - PROCESS | 1672 | |8;json-parse-financial;59;60;57;58;58;58;58;73;60;56 15:43:03 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;62;62;62;74;74;70;67;66;67;68 15:43:03 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;81;83;83;82;81;80;81;81;84;83 15:43:03 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;139;139;138;137;136;138;142;123;185;157 15:43:03 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;169;225;176;169;167;170;171;162;166;163 15:43:03 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;70;65;70;66;68;67;66;70;66;67 15:43:03 INFO - PROCESS | 1672 | __end_tp_report 15:43:03 INFO - PROCESS | 1672 | __start_cc_report 15:43:03 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1968 15:43:03 INFO - PROCESS | 1672 | __end_cc_report 15:43:03 INFO - PROCESS | 1672 | __startTimestamp1461192183278__endTimestamp 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | ------- Summary: start ------- 15:43:03 INFO - PROCESS | 1672 | Number of tests: 14 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:123.10 Median:114.00 stddev:20.49 (18.0%) stddev-sans-first:21.46 15:43:03 INFO - PROCESS | 1672 | Values: 114.0 111.0 156.0 167.0 113.0 113.0 118.0 112.0 113.0 114.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:142.50 stddev:20.90 (14.7%) stddev-sans-first:21.50 15:43:03 INFO - PROCESS | 1672 | Values: 154.0 121.0 143.0 169.0 118.0 142.0 141.0 117.0 172.0 118.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:195.80 Median:186.50 stddev:26.07 (14.0%) stddev-sans-first:27.35 15:43:03 INFO - PROCESS | 1672 | Values: 185.0 211.0 266.0 190.0 184.0 187.0 184.0 186.0 183.0 182.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:81.60 Median:86.00 stddev:11.61 (13.5%) stddev-sans-first:12.13 15:43:03 INFO - PROCESS | 1672 | Values: 76.0 77.0 87.0 96.0 79.0 85.0 82.0 89.0 91.0 54.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:78.50 stddev:22.32 (28.4%) stddev-sans-first:23.67 15:43:03 INFO - PROCESS | 1672 | Values: 97.0 93.0 133.0 76.0 78.0 79.0 123.0 79.0 76.0 122.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:86.50 stddev:1.85 (2.1%) stddev-sans-first:1.80 15:43:03 INFO - PROCESS | 1672 | Values: 88.0 84.0 87.0 86.0 86.0 85.0 88.0 83.0 88.0 84.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 15:43:03 INFO - PROCESS | 1672 | Values: 93.0 92.0 94.0 94.0 93.0 93.0 94.0 93.0 93.0 93.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.66 (2.0%) stddev-sans-first:1.58 15:43:03 INFO - PROCESS | 1672 | Values: 87.0 86.0 84.0 85.0 84.0 83.0 84.0 88.0 85.0 83.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:58.50 stddev:4.83 (8.3%) stddev-sans-first:5.12 15:43:03 INFO - PROCESS | 1672 | Values: 59.0 60.0 57.0 58.0 58.0 58.0 58.0 73.0 60.0 56.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.50 stddev:4.52 (6.7%) stddev-sans-first:4.38 15:43:03 INFO - PROCESS | 1672 | Values: 62.0 62.0 62.0 74.0 74.0 70.0 67.0 66.0 67.0 68.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.50 stddev:1.29 (1.6%) stddev-sans-first:1.32 15:43:03 INFO - PROCESS | 1672 | Values: 81.0 83.0 83.0 82.0 81.0 80.0 81.0 81.0 84.0 83.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:139.00 stddev:16.75 (12.1%) stddev-sans-first:17.69 15:43:03 INFO - PROCESS | 1672 | Values: 139.0 139.0 138.0 137.0 136.0 138.0 142.0 123.0 185.0 157.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:169.50 stddev:18.43 (10.9%) stddev-sans-first:19.47 15:43:03 INFO - PROCESS | 1672 | Values: 169.0 225.0 176.0 169.0 167.0 170.0 171.0 162.0 166.0 163.0 15:43:03 INFO - PROCESS | 1672 | 15:43:03 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.90 (2.8%) stddev-sans-first:1.79 15:43:03 INFO - PROCESS | 1672 | Values: 70.0 65.0 70.0 66.0 68.0 67.0 66.0 70.0 66.0 67.0 15:43:03 INFO - PROCESS | 1672 | -------- Summary: end -------- 15:43:03 INFO - PROCESS | 1672 | 15:43:04 INFO - TEST-INFO | 1672: exit 0 15:43:04 INFO - TEST-OK | kraken | took 58722ms 15:43:04 INFO - SUITE-END | took 1173s 15:43:04 INFO - Completed test suite (00:19:34) 15:43:04 INFO - javascript benchmark 15:43:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2830.5895645131454, 3439.7076248518874, 3469.028671971849, 3471.531343268658, 3500.1424650960503, 5496.395396506391, 5608.691521966291, 5679.0, 5693.943060569393, 5706.429357064291, 5738.5409167266625, 5805.216295800076, 5860.882782344351, 5861.970690146543, 5867.413258674131, 5099.005693889693, 5148.639595228336, 5201.193814958688, 5231.0, 5243.003829272445, 4324.6107850293465, 5260.552853007499, 5267.1045922193125, 5308.150695888658, 5331.493508116722, 5120.155174396239, 5134.974325128351, 5222.9337542583635, 5242.816501422432, 5273.419923808417, 5202.557782588485, 5203.089459344599, 5241.895162096775, 5246.947530524684, 5270.49930256625, 5166.664166829181, 5186.118359878829, 5228.79084836606, 5233.188855727369, 5258.106121959276, 5525.364583072957, 5582.33012038558, 5635.7463914123555, 5709.857253568653, 5717.942820571824, 6248.78129265478, 6276.246850377984, 6277.152584401093, 6279.246490421178, 6287.528435367366, 6240.968795155995, 6329.208848893888, 6329.936700632981, 6338.556301058928, 6349.904751428732, 5650.067738823089, 5739.856503587402, 5773.769049238025, 5867.794627188028, 5906.202662640489, 6274.435300822856, 6281.371862813773, 6295.024271237966, 6304.495640348761, 6313.337099604567, 6168.506519478431, 6181.505479561714, 6188.597741146811, 6193.1329613854095, 6204.255489341218, 6116.113163591254, 6194.287656919422, 6210.254769427607, 6218.875622487525, 6303.0, 4889.535494128052, 6241.251049874044, 6281.937180628135, 6283.0, 6292.276388215414, 6287.654179020198, 6290.937090629127, 6306.653134077578, 6307.5269354798575, 6313.179286692701, 4769.785359658824, 4885.975570122127, 4896.975515122473, 4934.975325123423, 4983.90032199354, 4435.756033418193, 4456.286994080931, 4515.074409745994, 4515.683902126885, 4523.344115103291, 5646.774129034875, 5710.628809127394, 5719.685417302005, 5728.0, 5737.454941780524, 6260.436560709467, 6278.215223097113, 6285.96857015712, 6289.96855015722, 6292.590981586182, 5676.659400435905, 5728.455796699307, 5746.4253574643035, 5747.597668163188, 5777.19119323295, 5303.284056652303, 5363.222332761728, 5408.972295263966, 5450.345958485007, 5456.590755693339, 6264.749410023548, 6312.274088479791, 6317.241930968313, 6320.146780184708, 6320.71556779946, 6268.874622507616, 6269.247690277196, 6310.432061114522, 6315.179026726496, 6328.810135695937, 6244.1570387997035, 6287.18266625354, 6344.651044192614, 6352.809415717536, 6373.267074286517, 6165.475934545614, 6221.782237621662, 6237.96881015592, 6242.625442473466, 6248.5313601479165, 6143.631382116909, 6294.716737746904, 6304.5271604628915, 6311.053341998737, 6316.210473690789, 5613.663180209201, 6061.7575296987625, 6117.663528505796, 6161.106639537153, 6188.195534580475, 6116.694165291807, 6139.2325959255095, 6171.1668924694595, 6177.598456100519, 6184.319724830175, 5743.253377060955, 6006.519478441627, 6022.578419510767, 6024.578279520391, 6037.698115094316, 5156.845294641167, 5967.850803729942, 6105.175801266772, 6152.477039451696, 6181.0, 5987.850303742442, 6021.307549631849, 6043.607165534227, 6049.818505444844, 6057.969710151421], "value": 5707.564911995059, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.3013387395574, 534.911739562972, 587.5417174603809, 592.4786188154424, 616.831105055919, 29943.700562994363, 37905.05237369064, 39128.80435597825, 39163.804180979125, 39230.21539569214, 41436.79281603588, 42061.57938420615, 42075.0, 42149.57850421495, 42276.0, 9346.205572526344, 9544.95227523865, 9568.80862382752, 9577.76055598612, 9584.0, 9394.107559781844, 9549.37929034614, 9554.0, 9592.136707696305, 9625.0, 9557.187639050655, 9637.903620963805, 9642.903570964305, 9653.71038868835, 9661.420314781135, 9539.570719317648, 9603.17539667461, 9619.470929098898, 9619.615215391375, 9645.0, 9367.672131475365, 9512.28657850657, 9518.666846660333, 9524.714258572254, 9525.333226674136, 39888.800555997324, 40341.39487907684, 40389.99025024368, 40445.393319100236, 40483.19033619341, 3160.8577614007195, 3216.4371235033777, 3598.838052287653, 3673.3204357194004, 3784.9810750946344, 28147.718522814714, 28895.71104288972, 29971.801127954855, 30247.0, 30290.84854575735, 2728.7544121029005, 2728.9727102728916, 2771.1270949650793, 2824.124521398373, 2853.7003614620376, 362587.0, 363918.0, 366223.0, 366290.0, 366705.0, 54261.72869135708, 63357.366426335146, 63542.046869296995, 63857.0, 65038.0, 61835.0, 61941.0, 62110.37889621136, 62279.6886015567, 62295.75408491805, 16436.342546298252, 16638.667226655398, 16656.666866662843, 16666.50000499987, 16668.83331166697, 11864.703382415508, 12080.697982550331, 12104.757904841854, 12106.092043096627, 12852.357382130856, 18023.098845057695, 18463.446096616855, 18614.44156675302, 18730.96979666104, 18775.436736897915, 7141.607211603307, 7298.890516642255, 7300.598467084362, 7342.851289021685, 7362.876788998178, 946.6402766948515, 965.75856035991, 994.3983889746744, 994.6568433890296, 1092.6066616018227, 29313.267168320963, 29727.40545189084, 29781.808727651085, 30008.0, 30302.84848575787, 942.9292803039799, 1050.753073027838, 1100.147385776014, 1105.8949399807007, 1123.1969142063465, 14514.564563063124, 14710.117392956243, 14824.481143159937, 14948.252587370587, 15037.473688420852, 602863.0, 603790.0, 613659.0, 614415.9279203576, 614947.0, 58282.12576811351, 58751.70624146937, 58805.41194587999, 58848.41151588515, 58890.705546471996, 1348.9527866524625, 1385.2796545796332, 1386.6741315790982, 1510.9924450377678, 1531.1425601662881, 29549.55675664824, 29837.70162298436, 30426.54360184643, 30921.8453907729, 31080.0, 53261.201081983025, 54108.0, 54181.72909135429, 54369.72815136057, 54402.45597544132, 465967.0, 491439.0, 491796.0, 492008.0, 492034.0, 23728.0, 24346.0, 24349.0, 26452.73547264503, 26866.462670746867, 33851.239345163085, 39138.0, 44296.11407771891, 46693.0, 47008.0, 34357.312853743286, 35254.471182932786, 35573.64426355807, 36531.634683652825, 36922.63077369192, 35652.64347356493, 35704.28591428105, 36716.81641591775, 37567.62432375641, 37571.0, 36386.4542031875, 36467.45298820467, 37548.812255938545, 37718.62281377151, 37830.43254351242, 30637.0, 31521.527177091903, 32254.516182257754, 32265.193370165933, 32492.350152996336, 19520.511987200432, 19627.0, 24386.878065610268, 24554.0, 24941.0], "value": 19394.104642839422, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.46937837986286, 400.24753463488656, 400.7935913004802, 401.97588144711335, 412.6595558664101, 14554.708905821904, 19957.0, 20855.85292808895, 20864.582708345824, 20869.68695469569, 19693.803061969375, 19941.40175794725, 21195.894020529915, 21544.784552154473, 21584.460388490297, 5747.655140691561, 6004.789832355868, 6098.664573448458, 6102.389761023885, 6108.083787431899, 5445.809396671118, 5928.3775203603645, 6014.578979471439, 6027.668478233717, 6079.1793107930525, 5807.419258074201, 5941.168236446901, 5950.880982380349, 5981.641101533922, 5988.820335389945, 5828.5337173026055, 5902.291724993007, 5912.408759124096, 5918.112283157518, 5918.112283157539, 5021.347224860781, 5172.767225474862, 5196.454372290893, 5202.76587553561, 5206.453322401131, 25768.969241230327, 26038.46115542815, 26163.73836261632, 26468.60297095545, 26531.336716582045, 2147.7744836792067, 2240.6863039174527, 2340.8010319122895, 2559.923202303934, 2588.715241323453, 12419.689507762288, 13624.250666213355, 14388.0, 15350.539483815392, 15557.688846223125, 1722.078687901979, 1782.287085165931, 1798.8830726002898, 1808.7558179645712, 1816.4096668582763, 116613.41693291564, 119182.40408797901, 120147.0, 120863.91360863844, 121121.0, 9828.557714902847, 10287.897121028844, 10880.803111657711, 11565.306081635128, 11670.76658466826, 12287.631371058882, 13412.262325572186, 13979.930100349637, 14135.57593272183, 15010.549683509294, 8531.317494600416, 8534.573271336409, 8577.914220857836, 8699.91300086991, 8711.0, 8452.281556067803, 8461.915380846236, 8469.491830490191, 8557.315414766803, 8605.913940860637, 4453.866384008485, 4565.726056436624, 4585.770711464414, 4632.86101416958, 4644.58198762113, 1624.0, 1930.1217945834612, 1942.9125689344014, 1945.0, 1968.557074658219, 824.2622852547057, 888.0941439731566, 939.7885475767897, 1013.341328136717, 1019.4698756646502, 19637.60724785496, 20457.386278411373, 20476.0, 20490.897545512475, 20495.4876128098, 957.9281553883486, 995.5619527407918, 1020.6682828080903, 1028.2391030637275, 1043.2853495355705, 8839.558022098869, 10684.839727404094, 10772.245942784086, 10798.568057277778, 10831.07935825448, 574211.0, 575683.0, 581027.0, 581605.0, 592185.0, 73570.0, 73614.63192684003, 97968.0, 119024.8097519031, 121878.0, 878.4816957994814, 1016.2733645443543, 1042.9739256518649, 1045.9477026148813, 1046.4558429616557, 17612.38356657562, 17831.643367132325, 17877.37429189972, 17884.374046908295, 18176.545586360447, 44593.55406445894, 47539.762301188275, 47587.0, 48769.756151219015, 50155.49844501508, 71102.0, 72424.0, 72756.63621681857, 74162.51674966363, 74243.51512969818, 6614.140161778938, 7838.098618658927, 8128.065272493503, 8174.427790054639, 8475.872861906953, 10684.83972740394, 12288.87711122913, 12580.937095314464, 12686.302253376152, 12722.300273485047, 10574.471276436301, 10746.408947507962, 11090.334579925231, 11112.499937502671, 11199.384033877888, 10658.253922225369, 10710.196735244732, 10844.349339039683, 10972.890271097187, 11239.550417983517, 11109.944450277697, 11161.218714689894, 11210.215284929976, 11469.08247340194, 11568.595099171489, 6889.517733758589, 7336.334711584741, 7352.558846469229, 7541.924580754342, 8397.286230670217, 7776.41676874248, 10795.920407959142, 11106.889311069152, 11238.845406052342, 11272.098232141572], "value": 9455.257273336189, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.2464955898158, 1617.9029258244507, 1628.3323837226737, 1902.657521646103, 2018.6568283391832, 7814.335781458576, 8479.152084791518, 8700.782480437992, 8709.2597129244, 8714.17215364541, 8342.499450032987, 8595.054544000155, 8600.139986001397, 8600.56997150143, 8603.569821508916, 2133.232036466871, 2361.3624321433203, 2414.3601945484415, 2441.8779061046966, 2452.2152911068465, 2468.5556599812026, 2488.0, 2493.9002439902383, 2494.625806129077, 2499.250224932522, 2398.424378149249, 2445.0464318915547, 2445.4742230420457, 2445.8165637577254, 2446.5718499262557, 2107.725995620575, 2306.9307920762403, 2388.2477019738726, 2391.210900402863, 2421.2978236311446, 2441.4750828571764, 2449.2529778417575, 2452.6198439241766, 2453.9631905521433, 2456.2876765737915, 8524.659013639446, 8623.956880215621, 8625.741227763177, 8631.223189912938, 8632.093630168867, 5004.924926126111, 5322.121849894801, 5335.466453354672, 5337.226102215157, 5342.946570534284, 3501.77238479498, 3511.490833829106, 3572.089117275078, 3602.8919132426067, 3611.855525778966, 1014.8071866345371, 1032.1897310611134, 1034.0280136671504, 1035.3425574760006, 1037.3879411147384, 11628.825567616492, 11676.299422034705, 11684.941575292069, 11694.356810375426, 11699.941500292443, 4624.05206932578, 4715.41057367829, 4905.411350637875, 4931.334269873593, 4935.407751069894, 9941.353812002197, 9962.551685174185, 9980.301378903552, 9985.30102892805, 10015.349002314826, 5395.325584301962, 5406.107992181324, 5407.810726624628, 5434.402215756264, 5438.211459338374, 3535.681788639035, 4499.370088187657, 4503.0, 4510.0, 4602.456876594652, 3743.457198706172, 3864.0146762575364, 3867.3425517662067, 4105.3020986432375, 4137.110521237948, 1214.7912826737452, 1295.8185853980451, 1335.419092694681, 1343.2761620681083, 1372.0944176843434, 819.4304958054214, 829.1998221716073, 874.6719980007497, 878.3061381508537, 911.5032307392487, 5505.201745746845, 5638.859028524238, 5683.931468365459, 5818.040023396177, 5958.433948774859, 1001.8697569316088, 1040.5889673579045, 1058.4866339825178, 1064.020921086778, 1076.3757020927842, 3743.9438408423894, 3756.6431189037, 3881.4760007399204, 3883.980580097138, 3933.547642021147, 10279.280450368551, 10498.842517362245, 10618.522166502526, 10677.359358438518, 10810.459477026117, 10586.629467968583, 10731.087857532197, 10731.463426828628, 10784.838227426595, 10884.183686223565, 7912.643931023118, 8226.876596851052, 8257.091719910804, 8303.709370172015, 8304.584770761438, 4598.724076555417, 5539.833804985857, 5650.0959846424375, 5685.857853553694, 5721.685307307972, 7873.133955264801, 9830.164436022733, 9952.850707239253, 9963.651272205438, 9993.500324983866, 7981.800454988439, 9804.607815687292, 9920.107190352903, 9933.453660048766, 9948.900510994798, 7363.521371111075, 7386.889196661947, 7528.2308657464355, 7578.583177925267, 7585.734499292719, 8101.10887802353, 8126.75619731409, 8234.752957411287, 8249.670013199404, 8251.216134467217, 7177.0, 7278.781636550912, 7328.853422931618, 7414.962925185555, 7450.143233527997, 7133.785986420416, 7147.928520714726, 7204.783856484314, 7235.602041887536, 7302.160251571137, 6887.965560172167, 7040.542364746275, 7041.119860017498, 7049.154101507852, 7060.94085887121, 3951.84192632303, 4693.577578017995, 4781.6891902026255, 4791.161546729378, 4861.368022157097, 4780.11567859947, 4847.660663753503, 4881.9511804881495, 4885.438174609965, 5006.249062640487], "value": 4562.971241855361, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.6766224814952, 310.1532815413921, 326.9967300326997, 329.79223089453643, 330.9751768617354, 5916.852078698029, 5919.260092488434, 5948.464638182562, 6001.399860014002, 6015.669138197398, 5606.271184745988, 5647.475181700938, 5716.885662286762, 5749.798757043504, 5924.659759395047, 3968.4642573252604, 4270.807813648377, 4508.706934049293, 4534.166146158651, 4572.337011133383, 4208.221479026374, 4504.256797628387, 4522.570355816192, 4523.977380113095, 4535.954640453603, 3782.565005024416, 4417.955820441803, 4482.708623939449, 4485.215087359699, 4500.662450316223, 4412.161689279027, 4447.155040542319, 4457.5765302296395, 4471.552844715502, 4479.619232365253, 3865.536135663738, 3877.7867217303037, 3879.1853710720784, 3885.4754608127823, 3895.668868146211, 5303.390110137307, 5637.913971830408, 5704.714764261812, 5740.712964351766, 5744.195812586241, 4435.800388982471, 4817.771468275602, 4954.108260513106, 4985.750712464399, 5033.949660503385, 5195.922061169085, 5486.423925487807, 6190.535709821736, 6213.198172529961, 6222.657753823538, 3912.960870391288, 4153.875383738493, 4158.979205103986, 4202.138561594866, 4218.831246750126, 5746.626469279484, 6392.616443013434, 6536.54244202906, 6570.178727659043, 6581.86836263272, 4228.879346973054, 4240.6395456385935, 4259.957400425956, 4262.211490874136, 4263.914721705549, 3617.317947154586, 4002.7398219115667, 4256.616904478612, 4267.231898258343, 4273.1240095780295, 4980.327655766425, 4990.850274491771, 5008.348914641073, 5015.498450155028, 5025.899482010339, 5254.868628284324, 5645.2096706461125, 6151.98492248774, 6309.179806625109, 6313.453203965058, 1302.8045793130916, 1312.783390740536, 1401.4324198699544, 1402.9057335278499, 1483.3399137383976, 793.7221074070742, 999.240577161348, 1028.83024300991, 1033.3180101133366, 1041.3803786746873, 5128.0, 5473.987312347229, 5723.6851973141875, 5742.253507044057, 5753.741081651336, 5301.761420736076, 5460.726963651801, 5983.815907193843, 6379.776707815297, 6451.41937225652, 5530.336359636869, 5780.72823978724, 5789.218455508452, 5794.159846822187, 5802.3037235531165, 2941.691122432114, 3190.2343437574814, 3193.1378527797365, 3390.627031026585, 3406.4549672052353, 5850.707464626752, 6152.138700581922, 6575.736970521126, 6632.8673426531195, 6666.83332916681, 5472.91790623141, 6485.805425837232, 6524.836879077966, 6533.542652014408, 6597.60414375139, 6612.669366531654, 6621.503387245976, 6633.9336606633315, 6636.203655561267, 6652.70062847173, 5486.0125177468435, 5722.2561067061015, 6151.200343955257, 6160.414760597736, 6196.504279657706, 5793.971030144822, 6293.716782744696, 6329.582025706251, 6335.3981371769605, 6360.236771587439, 5770.596058275881, 5797.623154494944, 5899.882002359843, 6331.620102793847, 6691.498137639599, 3668.6514781095752, 3772.4152756322815, 4023.8994025149605, 4212.64192543625, 4241.448611680462, 5471.179323101566, 6228.72991679372, 6520.380563846427, 6529.314421985623, 6546.443552297917, 5878.529717622494, 5906.202662640489, 6281.905771413524, 6290.685465726787, 6314.6842657866, 5219.76511057011, 5590.937721832839, 6245.375462453719, 6277.955191732098, 6285.182926219562, 5506.733451306302, 5666.943330566642, 5688.40271771458, 5870.823875283749, 6133.26400831903, 6146.354632763496, 6217.875642487034, 6298.937010630018, 6301.180846489927, 6305.054241863757, 5839.737211825393, 6155.384461553809, 6178.320384757583, 6189.40045181016, 6208.534359922934], "value": 4505.68444831018, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.7084287013622, 673.9831504212398, 698.7135274537441, 729.2925861913945, 729.9708011679535, 15007.474738384159, 15144.924275378622, 15351.232438378092, 15363.3086511107, 15427.92286038571, 13730.450781968735, 13867.653308667288, 13989.650258743537, 14059.226742529183, 14067.0, 913.1690161952624, 931.7111695374422, 938.3244064273712, 938.7606160429115, 942.5569982108398, 743.2790193512285, 771.2518856709012, 905.1446383167909, 922.0272612393921, 943.693299677604, 991.7074463033423, 993.2054356514795, 993.2103977337997, 995.1193194023269, 997.326804407026, 762.6415584675194, 976.8632391465201, 977.8582105594649, 982.219135787051, 983.2674657380226, 704.1690804850275, 726.8509955459172, 730.0837449001469, 732.1397358104259, 733.4828945593343, 14803.703925921529, 15358.769618455732, 15386.0, 15413.5375938722, 15416.768748468781, 12513.874861251363, 12731.0, 12812.743745125046, 13053.608391748263, 13131.0, 9905.702828915144, 10028.448435336053, 10142.137918276956, 10397.220208484394, 10664.407961934166, 3497.5453191085, 3550.680438760524, 3569.803660798655, 3602.8198590070656, 3669.853205871762, 70220.6488967557, 77362.61318693426, 77568.0, 77712.0, 77748.61125694335, 9716.61133554664, 9938.900610993942, 10057.0, 10151.086402223835, 10217.080462758388, 19433.902830485757, 21956.89021554882, 21972.560548788933, 22021.22925697625, 22035.338939831832, 7474.364679002237, 7476.364509016795, 7705.30652241301, 7876.645550950221, 7977.282044616012, 3954.4661470701662, 4084.8570300039355, 4117.464729585195, 4134.813933373005, 4223.303154979394, 3529.3647143514413, 3666.944995825065, 3671.706263498914, 3676.0809797550614, 3811.904702382463, 664.9800505984731, 686.1663079358603, 703.265087983059, 706.6396137969673, 708.1325376413955, 517.0785064386248, 602.8071017274518, 606.7876243314804, 607.1287702147345, 612.4090252905967, 7680.385569154454, 7706.173503430795, 7818.609069546614, 7960.56216908064, 8229.094799572042, 569.9914501282484, 577.9913301300484, 591.4617697894895, 597.2146627185238, 605.1769593353036, 3694.704423646102, 3778.848846046127, 3792.5069740934055, 3794.5446546414605, 3964.365701487806, 88345.0, 88491.55754221187, 89138.0, 89486.55256723675, 89802.65296020565, 73611.0, 74090.0, 74191.62904185553, 74225.25774742184, 74656.62671686607, 58913.70543147257, 60021.39978600158, 65805.0, 66580.0, 67194.66402668053, 7716.717221941876, 7866.016747906512, 7938.285554300141, 8012.158723333966, 8100.675972961016, 37644.81177594094, 39440.0, 40467.79766101151, 40624.390634141106, 42404.0, 45209.41767038138, 53923.73038134784, 58053.709731452764, 58840.70579647246, 59485.702571486865, 8921.732348029569, 10577.735556610838, 10596.2582619219, 10778.784424311627, 11026.393548354597, 9618.326717129734, 11810.468528916392, 12328.420802165054, 12359.938200308941, 12696.682582935131, 11399.829002564802, 11463.828042579202, 11590.420478976186, 11763.588274410355, 11849.526018959144, 11128.332300062022, 11152.55389784432, 11321.207515473838, 11520.193586448868, 12167.087468439726, 10705.250632455965, 10728.0, 10755.731106722082, 11334.036606888507, 11663.59177428786, 7712.383009359126, 9591.28065395112, 9632.614695412105, 9637.37357071788, 9674.177694896012, 8865.955670221607, 9198.908010919806, 9259.120383563552, 9289.442633442015, 9352.812943740952], "value": 6787.360071223851, "unit": "score"}], "name": "dromaeo_css", "value": 7257.004141981634, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 156.0, 167.0, 113.0, 113.0, 118.0, 112.0, 113.0, 114.0], "value": 123.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 143.0, 169.0, 118.0, 142.0, 141.0, 117.0, 172.0, 118.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 211.0, 266.0, 190.0, 184.0, 187.0, 184.0, 186.0, 183.0, 182.0], "value": 195.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 87.0, 96.0, 79.0, 85.0, 82.0, 89.0, 91.0, 54.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 93.0, 133.0, 76.0, 78.0, 79.0, 123.0, 79.0, 76.0, 122.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 86.0, 86.0, 85.0, 88.0, 83.0, 88.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 94.0, 94.0, 93.0, 93.0, 94.0, 93.0, 93.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 85.0, 84.0, 83.0, 84.0, 88.0, 85.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 57.0, 58.0, 58.0, 58.0, 58.0, 73.0, 60.0, 56.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 74.0, 74.0, 70.0, 67.0, 66.0, 67.0, 68.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 83.0, 82.0, 81.0, 80.0, 81.0, 81.0, 84.0, 83.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 138.0, 137.0, 136.0, 138.0, 142.0, 123.0, 185.0, 157.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 225.0, 176.0, 169.0, 167.0, 170.0, 171.0, 162.0, 166.0, 163.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 70.0, 66.0, 68.0, 67.0, 66.0, 70.0, 66.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1493.1000000000001, "alertThreshold": 2.0}]} 15:43:04 INFO - Return code: 0 15:43:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:43:04 ERROR - # TBPL SUCCESS # 15:43:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:43:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:43:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:43:04 INFO - 2016-04-20 15:43:04.586 screenresolution[1676:9953] starting screenresolution argv=screenresolution get 15:43:04 INFO - 2016-04-20 15:43:04.589 screenresolution[1676:9953] Display 0: 1600x1200x32@60 15:43:04 INFO - 2016-04-20 15:43:04.594 screenresolution[1677:9956] starting screenresolution argv=screenresolution list 15:43:04 INFO - Available Modes on Display 0 15:43:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:43:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:43:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:43:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:43:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:43:04 INFO - Intel Iris: 15:43:04 INFO - Chipset Model: Intel Iris 15:43:04 INFO - Type: GPU 15:43:04 INFO - Bus: Built-In 15:43:04 INFO - VRAM (Dynamic, Max): 1536 MB 15:43:04 INFO - Vendor: Intel (0x8086) 15:43:04 INFO - Device ID: 0x0a2e 15:43:04 INFO - Revision ID: 0x0009 15:43:04 INFO - Displays: 15:43:04 INFO - Display: 15:43:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:43:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:43:04 INFO - Display Serial Number: 1600x1200 60 15:43:04 INFO - Main Display: Yes 15:43:04 INFO - Mirror: Off 15:43:04 INFO - Online: Yes 15:43:04 INFO - Rotation: Supported 15:43:04 INFO - Return code: 0 15:43:04 INFO - Running post-action listener: _resource_record_post_action 15:43:04 INFO - Running post-run listener: _resource_record_post_run 15:43:05 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37725696; Write bytes: 695773696; Read time: 394; Write time: 1843 15:43:05 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 380021248; Write bytes: 374876160; Read time: 28357; Write time: 700 15:43:05 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 36759040; Write bytes: 297792000; Read time: 378; Write time: 1099 15:43:05 INFO - Running post-run listener: _upload_blobber_files 15:43:05 INFO - Blob upload gear active. 15:43:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:43:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:43:05 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:43:05 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:43:06 INFO - (blobuploader) - INFO - Open directory for files ... 15:43:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:43:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:43:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:43:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:43:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:43:07 INFO - (blobuploader) - INFO - Done attempting. 15:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:43:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:43:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:43:08 INFO - (blobuploader) - INFO - Done attempting. 15:43:08 INFO - (blobuploader) - INFO - Iteration through files over. 15:43:08 INFO - Return code: 0 15:43:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:43:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:43:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/086da4eb5d69e706e9b4f2f206a9ef3f3d9363dc58b5d3216d427df4a1e64277d25ab7cc57d1f66fdb9ab3c9aea8522f48850c7a69560c46560b06548e984668", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4c0f101e690cac5d66f4c8239c221523609324bfc8ae2f6c7d1cf87aca304117559cce6a3fe6f7d85a73e01cb94d1e1bf54b782d4b6a27bd98b04755c500cff"} 15:43:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:43:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:43:08 INFO - Contents: 15:43:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/086da4eb5d69e706e9b4f2f206a9ef3f3d9363dc58b5d3216d427df4a1e64277d25ab7cc57d1f66fdb9ab3c9aea8522f48850c7a69560c46560b06548e984668", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4c0f101e690cac5d66f4c8239c221523609324bfc8ae2f6c7d1cf87aca304117559cce6a3fe6f7d85a73e01cb94d1e1bf54b782d4b6a27bd98b04755c500cff"} 15:43:08 INFO - Running post-run listener: copy_logs_to_upload_dir 15:43:08 INFO - Copying logs to upload dir... 15:43:08 INFO - mkdir: /builds/slave/test/build/upload/logs 15:43:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.749676 ========= master_lag: 5.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-04-20 15:43:14.222349) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-20 15:43:14.232056) ========= 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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/086da4eb5d69e706e9b4f2f206a9ef3f3d9363dc58b5d3216d427df4a1e64277d25ab7cc57d1f66fdb9ab3c9aea8522f48850c7a69560c46560b06548e984668", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4c0f101e690cac5d66f4c8239c221523609324bfc8ae2f6c7d1cf87aca304117559cce6a3fe6f7d85a73e01cb94d1e1bf54b782d4b6a27bd98b04755c500cff"} build_url:https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011146 build_url: 'https://queue.taskcluster.net/v1/task/BVbLdpynSRe4JtzLKlVUyg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/086da4eb5d69e706e9b4f2f206a9ef3f3d9363dc58b5d3216d427df4a1e64277d25ab7cc57d1f66fdb9ab3c9aea8522f48850c7a69560c46560b06548e984668", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4c0f101e690cac5d66f4c8239c221523609324bfc8ae2f6c7d1cf87aca304117559cce6a3fe6f7d85a73e01cb94d1e1bf54b782d4b6a27bd98b04755c500cff"}' ========= master_lag: 3.64 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-20 15:43:17.878331) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-04-20 15:43:17.878642) ========= 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.XfOjPc1BYJ/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.wRMgfpVYnF/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005281 ========= master_lag: 5.22 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-04-20 15:43:23.100839) ========= ========= Started reboot skipped (results: 3, elapsed: 6 secs) (at 2016-04-20 15:43:23.101135) ========= ========= Finished reboot skipped (results: 3, elapsed: 6 secs) (at 2016-04-20 15:43:29.780835) ========= ========= Total master_lag: 14.76 =========