builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0251 starttime: 1466696499.71 results: success (0) buildid: 20160623064024 builduid: 314d1193ae694552b164a237028a94d8 revision: 44f094a357abce33721a9568032094bde85f9c92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 08:41:39.709583) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 08:41:39.710088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 08:41:39.710425) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 08:41:39.736266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:41:39.736629) ========= 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.mm5220xBE8/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.SFDhO5l8ly/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-23 08:41:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-06-23 08:41:39 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127588 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:41:39.902734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:41:39.903081) ========= 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.mm5220xBE8/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.SFDhO5l8ly/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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.025857 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:41:39.954468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 08:41:39.955333) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 44f094a357abce33721a9568032094bde85f9c92 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 44f094a357abce33721a9568032094bde85f9c92 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mm5220xBE8/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.SFDhO5l8ly/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-23 08:41:40,037 truncating revision to first 12 chars 2016-06-23 08:41:40,037 Setting DEBUG logging. 2016-06-23 08:41:40,037 attempt 1/10 2016-06-23 08:41:40,037 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/44f094a357ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 08:41:41,156 unpacking tar archive at: mozilla-beta-44f094a357ab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.639341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 08:41:41.619377) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 08:41:41.619779) ========= script_repo_revision: 44f094a357abce33721a9568032094bde85f9c92 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 08:41:41.620293) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 08:41:41.620628) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 08:41:41.638605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-23 08:41:41.639015) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mm5220xBE8/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.SFDhO5l8ly/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:41:41 INFO - MultiFileLogger online at 20160623 08:41:41 in /builds/slave/test 08:41:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:41:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:41:41 INFO - {'append_to_log': False, 08:41:41 INFO - 'base_work_dir': '/builds/slave/test', 08:41:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:41:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:41:41 INFO - 'branch': 'Mozilla-Beta', 08:41:41 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:41 INFO - 'config_files': ('talos/mac_config.py',), 08:41:41 INFO - 'default_actions': ('clobber', 08:41:41 INFO - 'read-buildbot-config', 08:41:41 INFO - 'download-and-extract', 08:41:41 INFO - 'populate-webroot', 08:41:41 INFO - 'create-virtualenv', 08:41:41 INFO - 'install', 08:41:41 INFO - 'run-tests'), 08:41:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:41 INFO - 'download_minidump_stackwalk': True, 08:41:41 INFO - 'download_symbols': 'ondemand', 08:41:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:41:41 INFO - 'tooltool.py': '/tools/tooltool.py', 08:41:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:41:41 INFO - '/tools/misc-python/virtualenv.py')}, 08:41:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:41 INFO - 'installer_path': 'installer.exe', 08:41:41 INFO - 'log_level': 'info', 08:41:41 INFO - 'log_name': 'talos', 08:41:41 INFO - 'log_to_console': True, 08:41:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:41:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:41:41 INFO - 'opt_config_files': (), 08:41:41 INFO - 'pip_index': False, 08:41:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:41:41 INFO - 'cmd': ('bash', 08:41:41 INFO - '-c', 08:41:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:41:41 INFO - 'enabled': True, 08:41:41 INFO - 'halt_on_failure': False, 08:41:41 INFO - 'name': 'check_screen_resolution'},), 08:41:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:41:41 INFO - 'cmd': ('bash', 08:41:41 INFO - '-c', 08:41:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:41:41 INFO - 'enabled': True, 08:41:41 INFO - 'halt_on_failure': False, 08:41:41 INFO - 'name': 'check_screen_resolution'},), 08:41:41 INFO - 'run_cmd_checks_enabled': True, 08:41:41 INFO - 'sps_profile': False, 08:41:41 INFO - 'sps_profile_interval': 0, 08:41:41 INFO - 'suite': 'dromaeojs', 08:41:41 INFO - 'system_bits': '32', 08:41:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:41 INFO - 'title': 't-yosemite-r7-0251', 08:41:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:41:41 INFO - 'use_talos_json': True, 08:41:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:41:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:41 INFO - 'work_dir': 'build'} 08:41:41 INFO - ##### 08:41:41 INFO - ##### Running clobber step. 08:41:41 INFO - ##### 08:41:41 INFO - Running pre-action listener: _resource_record_pre_action 08:41:41 INFO - Running main action method: clobber 08:41:41 INFO - rmtree: /builds/slave/test/build 08:41:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:41:43 INFO - Running post-action listener: _resource_record_post_action 08:41:43 INFO - ##### 08:41:43 INFO - ##### Running read-buildbot-config step. 08:41:43 INFO - ##### 08:41:43 INFO - Running pre-action listener: _resource_record_pre_action 08:41:43 INFO - Running main action method: read_buildbot_config 08:41:43 INFO - Using buildbot properties: 08:41:43 INFO - { 08:41:43 INFO - "project": "", 08:41:43 INFO - "product": "firefox", 08:41:43 INFO - "script_repo_revision": "production", 08:41:43 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:41:43 INFO - "repository": "", 08:41:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:41:43 INFO - "buildid": "20160623064024", 08:41:43 INFO - "pgo_build": "False", 08:41:43 INFO - "basedir": "/builds/slave/test", 08:41:43 INFO - "buildnumber": 5, 08:41:43 INFO - "slavename": "t-yosemite-r7-0251", 08:41:43 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:41:43 INFO - "platform": "yosemite_r7", 08:41:43 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:41:43 INFO - "branch": "mozilla-beta", 08:41:43 INFO - "repo_path": "releases/mozilla-beta", 08:41:43 INFO - "revision": "44f094a357abce33721a9568032094bde85f9c92", 08:41:43 INFO - "stage_platform": "macosx64", 08:41:43 INFO - "builduid": "314d1193ae694552b164a237028a94d8", 08:41:43 INFO - "slavebuilddir": "test" 08:41:43 INFO - } 08:41:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 08:41:43 INFO - Running post-action listener: _resource_record_post_action 08:41:43 INFO - ##### 08:41:43 INFO - ##### Running download-and-extract step. 08:41:43 INFO - ##### 08:41:43 INFO - Running pre-action listener: _resource_record_pre_action 08:41:43 INFO - Running main action method: download_and_extract 08:41:43 INFO - mkdir: /builds/slave/test/build/tests 08:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:43 INFO - https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:41:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:41:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:41:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:41:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 08:41:45 INFO - Downloaded 1165 bytes. 08:41:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:41:45 INFO - Using the following test package requirements: 08:41:45 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:41:45 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:41:45 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 08:41:45 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:41:45 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 08:41:45 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:41:45 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:41:45 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 08:41:45 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:41:45 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:41:45 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 08:41:45 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:41:45 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 08:41:45 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:41:45 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 08:41:45 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:41:45 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 08:41:45 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 08:41: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')]} 08:41:45 INFO - https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:41:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:41:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:41:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 08:41:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 08:41:46 INFO - Downloaded 18301205 bytes. 08:41:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:41:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:41:49 INFO - Return code: 0 08:41:49 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:49 INFO - https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:41:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:41:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:41:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 08:41:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 08:41:51 INFO - Downloaded 18301205 bytes. 08:41:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:41:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:41:54 INFO - Return code: 0 08:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:54 INFO - https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:41:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:41:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:41:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 08:41:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 08:41:55 INFO - Downloaded 10840145 bytes. 08:41:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:41:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:41:56 INFO - Return code: 0 08:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:56 INFO - https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 08:41:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:41:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:41:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 08:41:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 08:41:58 INFO - Downloaded 86251738 bytes. 08:41:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:41:58 INFO - mkdir: /builds/slave/test/properties 08:41:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:41:58 INFO - Writing to file /builds/slave/test/properties/build_url 08:41:58 INFO - Contents: 08:41:58 INFO - build_url:https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:41:59 INFO - Running post-action listener: _resource_record_post_action 08:41:59 INFO - Running post-action listener: set_extra_try_arguments 08:41:59 INFO - ##### 08:41:59 INFO - ##### Running populate-webroot step. 08:41:59 INFO - ##### 08:41:59 INFO - Running pre-action listener: _resource_record_pre_action 08:41:59 INFO - Running main action method: populate_webroot 08:41:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:41:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:41:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:41:59 INFO - '--tppagecycles', 08:41:59 INFO - '7'], 08:41:59 INFO - 'tests': ['tsvgm']}}, 08:41:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:41:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:41:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:41:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:41:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:41:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:41:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:59 INFO - 'talos_options': ['--disable-e10s'], 08:41:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:59 INFO - 'talos_options': ['--disable-e10s'], 08:41:59 INFO - 'tests': ['damp', 'tps']}, 08:41:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:59 INFO - 'tests': ['damp', 'tps']}, 08:41:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:41:59 INFO - 'tests': ['dromaeo_dom']}, 08:41:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:41:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:41:59 INFO - 'tests': ['a11yr', 08:41:59 INFO - 'ts_paint', 08:41:59 INFO - 'tpaint', 08:41:59 INFO - 'sessionrestore', 08:41:59 INFO - 'sessionrestore_no_auto_restore', 08:41:59 INFO - 'tabpaint']}, 08:41:59 INFO - 'other-e10s': {'tests': ['a11yr', 08:41:59 INFO - 'ts_paint', 08:41:59 INFO - 'tpaint', 08:41:59 INFO - 'sessionrestore', 08:41:59 INFO - 'sessionrestore_no_auto_restore', 08:41:59 INFO - 'tabpaint']}, 08:41:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:41:59 INFO - 'ts_paint', 08:41:59 INFO - 'tpaint', 08:41:59 INFO - 'sessionrestore', 08:41:59 INFO - 'sessionrestore_no_auto_restore', 08:41:59 INFO - 'tabpaint']}, 08:41:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:41:59 INFO - 'ts_paint', 08:41:59 INFO - 'tpaint', 08:41:59 INFO - 'sessionrestore', 08:41:59 INFO - 'sessionrestore_no_auto_restore', 08:41:59 INFO - 'tabpaint']}, 08:41:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:41:59 INFO - 'tests': ['a11yr', 08:41:59 INFO - 'ts_paint', 08:41:59 INFO - 'tpaint', 08:41:59 INFO - 'sessionrestore', 08:41:59 INFO - 'sessionrestore_no_auto_restore', 08:41:59 INFO - 'tabpaint']}, 08:41:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:41:59 INFO - 'tests': ['a11yr', 08:41:59 INFO - 'ts_paint', 08:41:59 INFO - 'tpaint', 08:41:59 INFO - 'sessionrestore', 08:41:59 INFO - 'sessionrestore_no_auto_restore', 08:41:59 INFO - 'tabpaint']}, 08:41:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:41:59 INFO - 'tests': ['tsvgx', 08:41:59 INFO - 'tsvgr_opacity', 08:41:59 INFO - 'tart', 08:41:59 INFO - 'tscrollx', 08:41:59 INFO - 'cart']}, 08:41:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:41:59 INFO - 'tsvgr_opacity', 08:41:59 INFO - 'tart', 08:41:59 INFO - 'tscrollx', 08:41:59 INFO - 'cart']}, 08:41:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:59 INFO - 'talos_options': ['--disable-e10s'], 08:41:59 INFO - 'tests': ['tp5o']}, 08:41:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:59 INFO - 'tests': ['tp5o']}, 08:41:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:59 INFO - 'talos_options': ['--disable-e10s', 08:41:59 INFO - '--xperf_path', 08:41:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:59 INFO - 'tests': ['tp5n']}, 08:41:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:59 INFO - 'talos_options': ['--xperf_path', 08:41:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:59 INFO - 'tests': ['tp5n']}}, 08:41:59 INFO - 'talos.zip': {'path': '', 08:41:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:41:59 INFO - Running post-action listener: _resource_record_post_action 08:41:59 INFO - ##### 08:41:59 INFO - ##### Running create-virtualenv step. 08:41:59 INFO - ##### 08:41:59 INFO - Running pre-action listener: _resource_record_pre_action 08:41:59 INFO - Running main action method: create_virtualenv 08:41:59 INFO - Creating virtualenv /builds/slave/test/build/venv 08:41:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:41:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:41:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:41:59 INFO - Using real prefix '/tools/python27' 08:41:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:00 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:03 INFO - Installing pip.................done. 08:42:03 INFO - Return code: 0 08:42:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:03 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 0x106381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106391420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9daa571800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106220e00>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621bb20>, '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.mm5220xBE8/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.SFDhO5l8ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:42:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mm5220xBE8/Render', 08:42:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:03 INFO - 'HOME': '/Users/cltbld', 08:42:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:03 INFO - 'LOGNAME': 'cltbld', 08:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:03 INFO - 'MOZ_NO_REMOTE': '1', 08:42:03 INFO - 'NO_EM_RESTART': '1', 08:42:03 INFO - 'PAGER': '/bin/cat', 08:42:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:03 INFO - 'PWD': '/builds/slave/test', 08:42:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:03 INFO - 'SHELL': '/bin/bash', 08:42:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SFDhO5l8ly/Listeners', 08:42:03 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 08:42:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:03 INFO - 'USER': 'cltbld', 08:42:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:03 INFO - 'XPC_FLAGS': '0x0', 08:42:03 INFO - 'XPC_SERVICE_NAME': '0', 08:42:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:42:03 INFO - Cleaning up... 08:42:03 INFO - Return code: 0 08:42:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:03 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 0x106381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106391420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9daa571800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106220e00>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621bb20>, '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.mm5220xBE8/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.SFDhO5l8ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:42:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mm5220xBE8/Render', 08:42:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:03 INFO - 'HOME': '/Users/cltbld', 08:42:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:03 INFO - 'LOGNAME': 'cltbld', 08:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:03 INFO - 'MOZ_NO_REMOTE': '1', 08:42:03 INFO - 'NO_EM_RESTART': '1', 08:42:03 INFO - 'PAGER': '/bin/cat', 08:42:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:03 INFO - 'PWD': '/builds/slave/test', 08:42:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:03 INFO - 'SHELL': '/bin/bash', 08:42:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SFDhO5l8ly/Listeners', 08:42:03 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 08:42:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:03 INFO - 'USER': 'cltbld', 08:42:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:03 INFO - 'XPC_FLAGS': '0x0', 08:42:03 INFO - 'XPC_SERVICE_NAME': '0', 08:42:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:03 INFO - Downloading/unpacking psutil>=0.7.1 08:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:06 INFO - Installing collected packages: psutil 08:42:06 INFO - Running setup.py install for psutil 08:42:06 INFO - building 'psutil._psutil_osx' extension 08:42:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:42:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:42:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:42:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:42:07 INFO - building 'psutil._psutil_posix' extension 08:42:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:42:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:42:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:42:07 INFO - ^ 08:42:07 INFO - 1 warning generated. 08:42:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:42:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:07 INFO - Successfully installed psutil 08:42:07 INFO - Cleaning up... 08:42:07 INFO - Return code: 0 08:42:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:07 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 0x106381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106391420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9daa571800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106220e00>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621bb20>, '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.mm5220xBE8/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.SFDhO5l8ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:42:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mm5220xBE8/Render', 08:42:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:07 INFO - 'HOME': '/Users/cltbld', 08:42:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:07 INFO - 'LOGNAME': 'cltbld', 08:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:07 INFO - 'MOZ_NO_REMOTE': '1', 08:42:07 INFO - 'NO_EM_RESTART': '1', 08:42:07 INFO - 'PAGER': '/bin/cat', 08:42:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:07 INFO - 'PWD': '/builds/slave/test', 08:42:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:07 INFO - 'SHELL': '/bin/bash', 08:42:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SFDhO5l8ly/Listeners', 08:42:07 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 08:42:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:07 INFO - 'USER': 'cltbld', 08:42:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:07 INFO - 'XPC_FLAGS': '0x0', 08:42:07 INFO - 'XPC_SERVICE_NAME': '0', 08:42:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:42:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:42:10 INFO - Installing collected packages: mozsystemmonitor 08:42:10 INFO - Running setup.py install for mozsystemmonitor 08:42:10 INFO - Successfully installed mozsystemmonitor 08:42:10 INFO - Cleaning up... 08:42:10 INFO - Return code: 0 08:42:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:10 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 0x106381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106391420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9daa571800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106220e00>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621bb20>, '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.mm5220xBE8/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.SFDhO5l8ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:42:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mm5220xBE8/Render', 08:42:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:10 INFO - 'HOME': '/Users/cltbld', 08:42:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:10 INFO - 'LOGNAME': 'cltbld', 08:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:10 INFO - 'MOZ_NO_REMOTE': '1', 08:42:10 INFO - 'NO_EM_RESTART': '1', 08:42:10 INFO - 'PAGER': '/bin/cat', 08:42:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:10 INFO - 'PWD': '/builds/slave/test', 08:42:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:10 INFO - 'SHELL': '/bin/bash', 08:42:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SFDhO5l8ly/Listeners', 08:42:10 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 08:42:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:10 INFO - 'USER': 'cltbld', 08:42:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:10 INFO - 'XPC_FLAGS': '0x0', 08:42:10 INFO - 'XPC_SERVICE_NAME': '0', 08:42:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:10 INFO - Downloading/unpacking blobuploader==1.2.4 08:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:13 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:14 INFO - Downloading docopt-0.6.1.tar.gz 08:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:14 INFO - Running setup.py install for blobuploader 08:42:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:14 INFO - Running setup.py install for requests 08:42:15 INFO - Running setup.py install for docopt 08:42:15 INFO - Successfully installed blobuploader requests docopt 08:42:15 INFO - Cleaning up... 08:42:15 INFO - Return code: 0 08:42:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:15 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 0x106381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106391420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9daa571800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106220e00>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621bb20>, '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.mm5220xBE8/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.SFDhO5l8ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:42:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mm5220xBE8/Render', 08:42:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:15 INFO - 'HOME': '/Users/cltbld', 08:42:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:15 INFO - 'LOGNAME': 'cltbld', 08:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:15 INFO - 'MOZ_NO_REMOTE': '1', 08:42:15 INFO - 'NO_EM_RESTART': '1', 08:42:15 INFO - 'PAGER': '/bin/cat', 08:42:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:15 INFO - 'PWD': '/builds/slave/test', 08:42:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:15 INFO - 'SHELL': '/bin/bash', 08:42:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SFDhO5l8ly/Listeners', 08:42:15 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 08:42:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:15 INFO - 'USER': 'cltbld', 08:42:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:15 INFO - 'XPC_FLAGS': '0x0', 08:42:15 INFO - 'XPC_SERVICE_NAME': '0', 08:42:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:15 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-Gx1GYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:15 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-2dMrVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:15 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-KYjNgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:16 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-uUZiGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:16 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-okQvBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:16 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-BTrsIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:16 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-9XYT5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:16 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-Iv1p_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:16 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-8DD_AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:16 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-mOsnqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:16 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-hbLXWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:16 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-IUuXA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:17 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-1k4etK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:17 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-IZGbSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:17 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-iXVS3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:17 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-831iCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:17 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-c9AKhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:17 INFO - Running setup.py install for manifestparser 08:42:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:17 INFO - Running setup.py install for mozcrash 08:42:17 INFO - Running setup.py install for mozdebug 08:42:17 INFO - Running setup.py install for mozdevice 08:42:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:18 INFO - Running setup.py install for mozfile 08:42:18 INFO - Running setup.py install for mozhttpd 08:42:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:18 INFO - Running setup.py install for mozinfo 08:42:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:18 INFO - Running setup.py install for mozInstall 08:42:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:18 INFO - Running setup.py install for mozleak 08:42:18 INFO - Running setup.py install for mozlog 08:42:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:19 INFO - Running setup.py install for moznetwork 08:42:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:19 INFO - Running setup.py install for mozprocess 08:42:19 INFO - Running setup.py install for mozprofile 08:42:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:19 INFO - Running setup.py install for mozrunner 08:42:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:19 INFO - Running setup.py install for mozscreenshot 08:42:19 INFO - Running setup.py install for moztest 08:42:19 INFO - Running setup.py install for mozversion 08:42:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:20 INFO - Cleaning up... 08:42:20 INFO - Return code: 0 08:42:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:20 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 0x106381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106391420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9daa571800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106220e00>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621bb20>, '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.mm5220xBE8/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.SFDhO5l8ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:42:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mm5220xBE8/Render', 08:42:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:20 INFO - 'HOME': '/Users/cltbld', 08:42:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:20 INFO - 'LOGNAME': 'cltbld', 08:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:20 INFO - 'MOZ_NO_REMOTE': '1', 08:42:20 INFO - 'NO_EM_RESTART': '1', 08:42:20 INFO - 'PAGER': '/bin/cat', 08:42:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:20 INFO - 'PWD': '/builds/slave/test', 08:42:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:20 INFO - 'SHELL': '/bin/bash', 08:42:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SFDhO5l8ly/Listeners', 08:42:20 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 08:42:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:20 INFO - 'USER': 'cltbld', 08:42:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:20 INFO - 'XPC_FLAGS': '0x0', 08:42:20 INFO - 'XPC_SERVICE_NAME': '0', 08:42:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:20 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-lWmRDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:20 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-Q1lFoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:20 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-JZMvzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:20 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-rihY2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:20 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-s5GsNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:20 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-Gf7UaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:21 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-jqfL8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:21 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-hvdClS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:21 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-KJaRWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:21 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-kREAX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:21 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-mFIMyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:21 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-h5psAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:21 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-JpI_El-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:21 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-AhLaGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:21 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-I9uaiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:21 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-q8RoAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:22 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-FPihX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:24 INFO - Downloading blessings-1.6.tar.gz 08:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:24 INFO - Installing collected packages: blessings 08:42:24 INFO - Running setup.py install for blessings 08:42:24 INFO - Successfully installed blessings 08:42:24 INFO - Cleaning up... 08:42:25 INFO - Return code: 0 08:42:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:25 INFO - Reading from file tmpfile_stdout 08:42:25 INFO - Current package versions: 08:42:25 INFO - blessings == 1.6 08:42:25 INFO - blobuploader == 1.2.4 08:42:25 INFO - docopt == 0.6.1 08:42:25 INFO - manifestparser == 1.1 08:42:25 INFO - mozInstall == 1.12 08:42:25 INFO - mozcrash == 0.17 08:42:25 INFO - mozdebug == 0.1 08:42:25 INFO - mozdevice == 0.48 08:42:25 INFO - mozfile == 1.2 08:42:25 INFO - mozhttpd == 0.7 08:42:25 INFO - mozinfo == 0.9 08:42:25 INFO - mozleak == 0.1 08:42:25 INFO - mozlog == 3.1 08:42:25 INFO - moznetwork == 0.27 08:42:25 INFO - mozprocess == 0.22 08:42:25 INFO - mozprofile == 0.28 08:42:25 INFO - mozrunner == 6.11 08:42:25 INFO - mozscreenshot == 0.1 08:42:25 INFO - mozsystemmonitor == 0.0 08:42:25 INFO - moztest == 0.7 08:42:25 INFO - mozversion == 1.4 08:42:25 INFO - psutil == 3.1.1 08:42:25 INFO - requests == 1.2.3 08:42:25 INFO - wsgiref == 0.1.2 08:42:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:25 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 0x106381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106391420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9daa571800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106220e00>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621bb20>, '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.mm5220xBE8/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.SFDhO5l8ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mm5220xBE8/Render', 08:42:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:25 INFO - 'HOME': '/Users/cltbld', 08:42:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:25 INFO - 'LOGNAME': 'cltbld', 08:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:25 INFO - 'MOZ_NO_REMOTE': '1', 08:42:25 INFO - 'NO_EM_RESTART': '1', 08:42:25 INFO - 'PAGER': '/bin/cat', 08:42:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:25 INFO - 'PWD': '/builds/slave/test', 08:42:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:25 INFO - 'SHELL': '/bin/bash', 08:42:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SFDhO5l8ly/Listeners', 08:42:25 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 08:42:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:25 INFO - 'USER': 'cltbld', 08:42:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:25 INFO - 'XPC_FLAGS': '0x0', 08:42:25 INFO - 'XPC_SERVICE_NAME': '0', 08:42:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:42:25 INFO - Cleaning up... 08:42:25 INFO - Return code: 0 08:42:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:25 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 0x106381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106391420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9daa571800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106220e00>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621bb20>, '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.mm5220xBE8/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.SFDhO5l8ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:42:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mm5220xBE8/Render', 08:42:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:25 INFO - 'HOME': '/Users/cltbld', 08:42:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:25 INFO - 'LOGNAME': 'cltbld', 08:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:25 INFO - 'MOZ_NO_REMOTE': '1', 08:42:25 INFO - 'NO_EM_RESTART': '1', 08:42:25 INFO - 'PAGER': '/bin/cat', 08:42:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:25 INFO - 'PWD': '/builds/slave/test', 08:42:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:25 INFO - 'SHELL': '/bin/bash', 08:42:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SFDhO5l8ly/Listeners', 08:42:25 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 08:42:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:25 INFO - 'USER': 'cltbld', 08:42:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:25 INFO - 'XPC_FLAGS': '0x0', 08:42:25 INFO - 'XPC_SERVICE_NAME': '0', 08:42:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:25 INFO - Downloading/unpacking jsonschema 08:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:28 INFO - Downloading/unpacking functools32 (from jsonschema) 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:28 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:28 INFO - warning: no files found matching '*.txt' 08:42:28 INFO - no previously-included directories found matching 'build' 08:42:28 INFO - no previously-included directories found matching 'dist' 08:42:28 INFO - no previously-included directories found matching '.git*' 08:42:28 INFO - Installing collected packages: jsonschema, functools32 08:42:28 INFO - Running setup.py install for functools32 08:42:28 INFO - warning: no files found matching '*.txt' 08:42:28 INFO - no previously-included directories found matching 'build' 08:42:28 INFO - no previously-included directories found matching 'dist' 08:42:28 INFO - no previously-included directories found matching '.git*' 08:42:28 INFO - Successfully installed jsonschema functools32 08:42:28 INFO - Cleaning up... 08:42:29 INFO - Return code: 0 08:42:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106391420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9daa571800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106220e00>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621bb20>, '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.mm5220xBE8/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.SFDhO5l8ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:42:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mm5220xBE8/Render', 08:42:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:29 INFO - 'HOME': '/Users/cltbld', 08:42:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:29 INFO - 'LOGNAME': 'cltbld', 08:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:29 INFO - 'MOZ_NO_REMOTE': '1', 08:42:29 INFO - 'NO_EM_RESTART': '1', 08:42:29 INFO - 'PAGER': '/bin/cat', 08:42:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:29 INFO - 'PWD': '/builds/slave/test', 08:42:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:29 INFO - 'SHELL': '/bin/bash', 08:42:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SFDhO5l8ly/Listeners', 08:42:29 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 08:42:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:29 INFO - 'USER': 'cltbld', 08:42:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:29 INFO - 'XPC_FLAGS': '0x0', 08:42:29 INFO - 'XPC_SERVICE_NAME': '0', 08:42:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:29 INFO - Downloading/unpacking flake8 08:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:42:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:42:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:42:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:42:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:42:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:42:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:42:32 INFO - no previously-included directories found matching 'docs/_build' 08:42:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:42:33 INFO - Running setup.py install for pep8 08:42:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:42:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:42:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:42:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:42:33 INFO - no previously-included directories found matching 'docs/_build' 08:42:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:42:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:42:33 INFO - Cleaning up... 08:42:33 INFO - Return code: 0 08:42:33 INFO - Running post-action listener: _resource_record_post_action 08:42:33 INFO - Running post-action listener: _start_resource_monitoring 08:42:33 INFO - Starting resource monitoring. 08:42:33 INFO - ##### 08:42:33 INFO - ##### Running install step. 08:42:33 INFO - ##### 08:42:33 INFO - Running pre-action listener: _resource_record_pre_action 08:42:33 INFO - Running main action method: install 08:42:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:33 INFO - Reading from file tmpfile_stdout 08:42:33 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:33 INFO - Reading from file tmpfile_stdout 08:42:33 INFO - Output received: 08:42:33 INFO - Usage: mozinstall [options] installer 08:42:33 INFO - Options: 08:42:33 INFO - -h, --help show this help message and exit 08:42:33 INFO - -d DEST, --destination=DEST 08:42:33 INFO - Directory to install application into. [default: 08:42:33 INFO - "/builds/slave/test"] 08:42:33 INFO - --app=APP Application being installed. [default: firefox] 08:42:33 INFO - mkdir: /builds/slave/test/build/application 08:42:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:42:55 INFO - Reading from file tmpfile_stdout 08:42:55 INFO - Output received: 08:42:55 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:42:55 INFO - Running post-action listener: _resource_record_post_action 08:42:55 INFO - ##### 08:42:55 INFO - ##### Running run-tests step. 08:42:55 INFO - ##### 08:42:55 INFO - Running pre-action listener: _resource_record_pre_action 08:42:55 INFO - Running main action method: run_tests 08:42:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:42:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:42:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:42:55 INFO - 2016-06-23 08:42:55.606 screenresolution[1643:7566] starting screenresolution argv=screenresolution get 08:42:55 INFO - 2016-06-23 08:42:55.609 screenresolution[1643:7566] Display 0: 1600x1200x32@60 08:42:55 INFO - 2016-06-23 08:42:55.615 screenresolution[1644:7569] starting screenresolution argv=screenresolution list 08:42:55 INFO - Available Modes on Display 0 08:42:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:42:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:42:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:42:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:42:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:42:55 INFO - Intel Iris: 08:42:55 INFO - Chipset Model: Intel Iris 08:42:55 INFO - Type: GPU 08:42:55 INFO - Bus: Built-In 08:42:55 INFO - VRAM (Dynamic, Max): 1536 MB 08:42:55 INFO - Vendor: Intel (0x8086) 08:42:55 INFO - Device ID: 0x0a2e 08:42:55 INFO - Revision ID: 0x0009 08:42:55 INFO - Displays: 08:42:55 INFO - Display: 08:42:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:42:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:42:55 INFO - Display Serial Number: 1600x1200 60 08:42:55 INFO - Main Display: Yes 08:42:55 INFO - Mirror: Off 08:42:55 INFO - Online: Yes 08:42:55 INFO - Rotation: Supported 08:42:55 INFO - Return code: 0 08:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:42:55 INFO - Python 2.7.3 08:42:55 INFO - Return code: 0 08:42:55 INFO - grabbing minidump binary from tooltool 08:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:55 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 0x106220e00>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:42:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:42:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:42:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:42:55 INFO - Return code: 0 08:42:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:42:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:42:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:42:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:42:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:42:57 INFO - Return code: 0 08:42:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0251', '--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 08:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0251 --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 08:42:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mm5220xBE8/Render', 08:42:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:57 INFO - 'HOME': '/Users/cltbld', 08:42:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:57 INFO - 'LOGNAME': 'cltbld', 08:42:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:42:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:57 INFO - 'MOZ_NO_REMOTE': '1', 08:42:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:42:57 INFO - 'NO_EM_RESTART': '1', 08:42:57 INFO - 'PAGER': '/bin/cat', 08:42:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:57 INFO - 'PWD': '/builds/slave/test', 08:42:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:42:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:57 INFO - 'SHELL': '/bin/bash', 08:42:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SFDhO5l8ly/Listeners', 08:42:57 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 08:42:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:57 INFO - 'USER': 'cltbld', 08:42:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:57 INFO - 'XPC_FLAGS': '0x0', 08:42:57 INFO - 'XPC_SERVICE_NAME': '0', 08:42:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0251', '--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 08:42:57 INFO - mozversion application_buildid: 20160623064024 08:42:57 INFO - mozversion application_changeset: 44f094a357abce33721a9568032094bde85f9c92 08:42:57 INFO - mozversion application_display_name: Firefox 08:42:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:42:57 INFO - mozversion application_name: Firefox 08:42:57 INFO - mozversion application_remotingname: firefox 08:42:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:42:57 INFO - mozversion application_vendor: Mozilla 08:42:57 INFO - mozversion application_version: 48.0 08:42:57 INFO - mozversion platform_buildid: 20160623064024 08:42:57 INFO - mozversion platform_changeset: 44f094a357abce33721a9568032094bde85f9c92 08:42:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:42:57 INFO - mozversion platform_version: 48.0 08:42:57 INFO - using testdate: 1466696577 08:42:57 INFO - actual date: 1466696577 08:42:57 INFO - starting webserver on 'localhost:49270' 08:42:57 INFO - SUITE-START | Running 2 tests 08:42:57 INFO - TEST-START | dromaeo_css 08:42:57 INFO - operating with platform_type : mac_ 08:42:57 INFO - Initialising browser for dromaeo_css test... 08:42:57 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmpzDqF9S/profile http://localhost:49270/getInfo.html) 08:42:59 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 08:42:59 INFO - PROCESS | 1662 | colorDepth:24 08:42:59 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 08:42:59 INFO - PROCESS | 1662 | __metrics 08:42:59 INFO - PROCESS | 1662 | 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" 08:42:59 ERROR - PROCESS | 1662 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:43:00 INFO - TEST-INFO | 1662: exit 0 08:43:00 INFO - Browser initialized. 08:43:00 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:00 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmpzDqF9S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:12 INFO - PROCESS | 1665 | RSS: Main: 161382400 08:43:12 INFO - PROCESS | 1665 | 08:44:03 INFO - PROCESS | 1665 | 1466696643029 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:46:12 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 08:46:14 INFO - PROCESS | 1665 | RSS: Main: 266592256 08:46:14 INFO - PROCESS | 1665 | 08:49:16 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 08:49:17 INFO - PROCESS | 1665 | RSS: Main: 301019136 08:49:17 INFO - PROCESS | 1665 | 08:52:19 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 08:52:19 INFO - PROCESS | 1665 | RSS: Main: 306225152 08:52:19 INFO - PROCESS | 1665 | 08:55:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 08:55:22 INFO - PROCESS | 1665 | RSS: Main: 305700864 08:55:22 INFO - PROCESS | 1665 | 08:58:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 08:58:26 INFO - PROCESS | 1665 | RSS: Main: 272293888 08:58:26 INFO - PROCESS | 1665 | 09:01:28 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 09:01:28 INFO - PROCESS | 1665 | RSS: Main: 311947264 09:01:28 INFO - PROCESS | 1665 | 09:01:28 INFO - PROCESS | 1665 | __start_tp_report 09:01:28 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 09:01:28 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 09:01:28 INFO - PROCESS | 1665 | |i|pagename|runs| 09:01:28 INFO - PROCESS | 1665 | |0;dojo.html;2935.324875278686;3575.4279315309554;3597.640235976403;3613;3656.542932133483;5695.943040569593;5710.714464276791;5714.3999880012625;5724.7996320128805;5765.740541675619;4696.248600223965;5748.425157484249;5754.539636829054;5758.971205143979;5761.107028410593;5164.715940623264;5170.560502357294;5187.48125187482;5199.168133098705;5251.76367063483;5238.790448382079;5264.710440925747;5273.419923808378;5276.762545685453;5287.444818294081;5212.6611770235;5277.762500687459;5288.867778305535;5303.7082960437165;5331.706756128411;5279.5512381447625;5280.2343660169445;5295.682259064469;5297.231901374318;5308.309919710413;5111.693298402108;5132.076226279269;5144.948550514484;5235.58115350771;5248.6588371755715;5554.2779438672715;5577.776888924438;5598.1602759585985;5675.460831221028;5732.570057245724;4493.73037617744;6303.621782693053;6320.841978950517;6324.272708638519;6326.2092238470195;4794.832180873687;6205.7517699291975;6337.936620633827;6349.2698339690605;6377.01156320771;5903.881922361572;5916.9645312070215;5938;5938.584299099021;5978.40215978403;6379.043143528415;6385.48916086712;6394.424501794768;6400.23197216337;6410.487161027107;6100.633961962208;6178.289496707846;6225.190725205694;6268.529860260407;6282.465990390868;6319;6328.936710632835;6335.176427064452;6336.271328797156;6343.9682801585695;6246;6253.906191407133;6283.434490895841;6309.33751956038;6322.083297921776;6125.845966769368;6155.938440615626;6270.31026587075;6271.717772700239;6282.623042617458;4995.425526064549;5022.4977502249485;5025.648204625714;5035.370578677665;5038.521340472649;4520.005598768265;4531.592156705847;4538.205813982606;4554;4554.111948170075;5817.331006934172;5884.823455296348;5949.2266005419015;6001.789937352171;6027.336992930774;6313.968430157912;6348.238211414568;6351.745930162834;6353.174087368612;6365.3316401778075;5990.520758339322;5990.5507086968655;5993.190919225936;5998.850028749316;6001.849953751192;5298.97350513245;5381.219723140122;5390.110631745718;5504.862378440571;5510.448955104538;6439.710213040425;6440.806775796734;6455.61266324022;6469.514786390945;6473.838154046092;4988.176950803077;6319.304876463493;6322.3045464997895;6343.397377249154;6344.809655710336;6311;6368.299487056513;6440.967795160994;6448.161738973903;6453.645049522322;6234.064890266496;6249.500039996698;6276.246850377984;6309.589876658002;6313.779017734358;6203.2245969253845;6326.936730632635;6337.429631333202;6357.618542887441;6370.77702280418;6125.050617154348;6185.072239164161;6194.318624951342;6200.968995154995;6220.875582488235;6198.969005154945;6205.565610407228;6225.62646241227;6231.657258850807;6253.3121356651645;5833.649981001154;5958.463738263577;6071.089336599545;6077;6093.512518998381;6015.338312785678;6188.288346840171;6235.719392627433;6237.96881015592;6252.093446450148;5026.396832380138;6106.542009349406;6126.203593532812;6128.662923539248;6145.631262124287 09:01:28 INFO - PROCESS | 1665 | |1;ext.html;529.6530772344114;542.067643652917;551.5532418740818;570.8768836838348;602.5089552015107;26218;33312;40022.999425014386;40408.59591404085;40426;43415.565844341545;43660.78169609155;43692.563074369245;43781.7810910945;43922;7697.615119244043;9672.661456849011;9885.654002109928;9890.357126786736;11725.296482211095;11729.765404691901;11857.288562686266;11869.584564540242;11872.287662740264;11879.584214552493;11815.704607384798;11901.821472677917;11919.58281460149;11924.403779811018;11951.342676152808;11827.822582661267;11874.465649045813;11911.04711623068;11912.106592005548;11913.94043029788;11736.413179340998;11783.234089784137;11823.527058917633;12054.517819287306;12056.336901470415;41527.7923610383;42037.78981105106;42045.789771051255;42076.368854467204;42119.94700132491;3325.118843506473;3395.337909107725;3483.512308276843;3705.980855264797;3892.805359732002;29199.56200656992;29951.251218719488;29980.800767969475;30157.849210753804;30312.696873031207;2795.9860200699068;2807.6771171315154;2818;2828.61813655156;2859.999000349861;359305;361995.3800461988;362857;363307;363895.9999999974;39221.80389098093;64344;64630.67684661547;64702;64730.67634661797;38060.23879522394;38309;38341.616583833806;38393.23213535714;38473.230535389695;16145.677086458205;16547.255373507982;16558.089305088335;16560.420385286456;16567.834321656872;12752.936235318764;12843.357832108357;13534.864651353557;13555.728885422433;13636.045476816726;8564.400491965502;8673.956630216808;8691.174338437839;8725.912740872636;8826;3558.857645694195;3610.783352998776;3625.148090198801;3628.800415977094;3654.579723331851;968.9467079310565;977.6333874796951;986.6546708652058;1029.0892560084378;1069.9946500267604;31453.213669657984;31457.741690332587;31494.685053149635;31897;32003.559839807265;1057.4237040812775;1198.406788639629;1241.7330273991136;1255.1465003797323;1274.9808752868714;11532.769344613229;17011.029905621253;17067.914660426617;17429.82570174282;17473.301067957138;655301;656465;663431;663687;663754;63990.68004659947;64640.353596463436;64689.67655161788;64780.676096619216;64869.67565162144;1421.6730152065084;1422.9328003997002;1580.2493815437574;1588.6425554250202;1603.7915071040923;30170.547441787952;31217;31775.68224317727;31848.681513184572;32215;52261;52405.7379713099;52737.47262527326;52809.67975800636;52888;432167;435521;435970;436840;437139;24294.75705242925;26500.602490962265;28864.278393040342;29229;29232.853835730686;44097.410512175295;45112.54887451084;45150.54849451463;45298.32052519149;45863.31205031861;38480.615193847705;38751.41872871853;39770.204595907344;41459.585404145575;41677.58322416737;37925;39157.804210978764;39284.82145535639;39727.60272397239;40074.79962600168;38407;38833.41749873698;39378;39501.40747888727;39546.011349715336;30929;31495.58269877815;32612.510812338307;34652;34664.480032800035;25556.488870222864;25922.96308147653;25941;26372.208833735018;26419.867900661142 09:01:28 INFO - PROCESS | 1665 | |2;jquery.html;417.2302102620666;418.1407208187175;422.1599017954272;422.36012441151644;433.0537774961709;20635.587288254246;20753;20950;21428.357149285526;21481.46296342588;21378.46553836151;21898.343049708536;22342.776572234274;22547.210847620336;22568.322950311518;5908.202392676976;6182.690865456731;6184.84537886552;6244.406781355764;6246.625202487842;5895.646261224319;6049.516038716892;6095.177151084613;6191.721372538246;6199.349068347804;6083.452489275965;6098.756049758004;6109.266887973427;6113.602615829956;6119.66341851198;5908.409159084057;5980.312264089642;6096.878062438748;6097.634141951497;6097.908531372011;5294.947050529484;5338;5341.4925582069645;5345.866353341159;5354.009508240988;13409.128406653535;26559.07043253477;27356;27697.307567310778;27709.86145069282;2149.9140034398606;2155.1594877997595;2262.0951619352227;2464.8151388645924;2517.609770485578;9848.458334791583;10154.136898363648;10344.896551034468;10595.894041059644;10839.945800271027;1756.6398888227882;1776.2983621469577;1844.1332573690345;1898.3830255167127;1918.6450506656174;117417;118475.4076229622;120170;128897.71102289045;142021.99999999895;9600.75998100053;11739.88260117405;11918.404079795975;11981.46083426248;12099.87900121005;15775.763363549557;15848.76226856598;15873;15880.682386352439;15903.68192636164;7465.85068298631;9016.954915225513;9139.360244782934;9193.816123677489;9254;9096.545172741337;9119.772005699911;9121.17909388145;9130.26957843371;9246.214071803837;4833.081714474239;4865.9756701216975;4883.145449546386;4884.242942343943;4935.235038569028;1689.552268648809;1738.7044202485608;2029.0014335879148;2059.7322348094654;2074.2325339624435;801.9639116239783;958.9723162716618;1004.6232662751469;1019.4953498018529;1054.847047178155;19862.00689965496;19890.30383936555;20620.587588248152;20984.95075246262;21204.893975530333;1014.2595904989251;1017.6133069433567;1034.9223808214263;1070.9143268538498;1117.061668198717;10922.235443518877;11237.887621123848;11239.943800280946;11275.605353812578;11286.435678216221;656171;662742;674187;682763;684764;87198;121188;131961;133838;138329;860.9096044915194;977.8973207813077;986.9851952220722;1006.8892421833445;1007.5012868629929;18001.909990449964;18100.909495452437;18137.27450901949;18488.722669159706;18788.060596970372;49208.507914920396;49795.751021244665;51006.46980590588;51591.226131607305;52631;76261.6186919084;76804;77479.22520774945;79875.20124798677;81060;6640.800775976729;8411.61208400607;8475.194856488624;8486.575671216538;8561.01548321951;11942.761144776881;12635.684107897376;12808.423620936894;13049.543265986025;13085.738285234052;10830.837537437103;11125.83311250348;11291.548338066385;11322;11443;10787;11007.834882476609;11136.053435458076;11255.493502792231;11348.773024539629;10706.197035222234;10706.982836630508;11392.829107563559;11746.882531174579;11785.351805650771;8258.174182581934;8372.204640559137;8394.0766515682;8413.200745929127;8521.67913973335;8612.224899759052;10937.125029997422;11147.554097835995;11375.943120284346;11480.311181329147 09:01:28 INFO - PROCESS | 1665 | |3;mootools.html;1278.7889998150306;1617.3934774459578;1630.494546690526;1897.8197071278232;2006.2476571285777;8332.416730828836;9025.54872256387;9188.356815022951;9199.724008279754;9202.63189472422;8864.069272726367;9162.26701863851;9166.495842728647;9171.724848254546;9177.77055573611;2549.133294679804;2574.613807928816;2577.9355516112155;2580.380708629925;2581.1095172165574;2502.912398066068;2543.8092143089248;2544.3257536752776;2546.4525127097672;2550.7321731218235;2505.0856437400307;2539.8095142864267;2547.872606369674;2548.171844150649;2554.6168074788743;2521.798256139514;2552.8595927223996;2558.6929568451906;2560.6671132752717;2575.2874338564834;2504.8497090174465;2559.7312282210473;2565.0124701989866;2573.1251374532562;2575.0858445252043;8761.693340733107;9184.586693598803;9273.536323183882;9274.90725092754;9288.90711092894;5481.287432633772;5659.830205093854;5680.829575112712;5689.374168841466;5709.371969083398;3633.7638053526703;3715.071232191952;3762.059485128718;3770.4344348347695;3777.773333599993;1063.4310643805527;1068.647346375694;1072.5066469424075;1090.6128324444787;1093.278436232083;12486.75026499474;12560.685982850411;12632.052596055333;12646.304453255067;12653.493860245579;4750.667453278306;4795.328653988445;4808.676590283766;4856.854294371175;4902.607791376681;9650.420974741539;9685.70942871715;9694.466804325688;9697.127258546765;9723.02769723022;4669.603083737852;5492.066348720727;5507.228987941691;5524;5558.416366281483;4590.931136032962;4681.110588988081;4697.107549565571;4753.215719406259;5169.06956747789;3871.090293780959;3881.8835434936996;3952.940705889414;3953.683705303569;3958.7030972677167;1222.9877701223052;1242.8135779633128;1247.5571172233908;1253.7680529102145;1270.4791035675328;885.198895000026;924.3021518753433;972.1445128287062;986;1008.566316483919;5484.533814625722;5793.884122317614;6101.969490152521;6200.410960958701;6220.035894436279;980.2550061952967;980.519545422752;985.1330828870548;1004.8844382895915;1022.6880801355658;4040.9797951010055;4098.180363927167;4106.753594784323;4110.383442483651;4173.123644034726;10777.676669699922;11199.21605487608;11293.774124517464;11299.548018079186;11299.661010169708;10982.231243812856;10995.505202265917;11110.333379997226;11163.888361116447;11183.384913829817;8313.83372332562;8517.403781735218;8606.741797746077;8677.696280630274;8726.996395414608;5109.846704598868;6067.180930574316;6178.598391104564;6242.625442473466;6250.781222657185;9856.901430985597;9892.950535247277;9900.851487227841;10232.23258255619;10242.180625550087;9777.80444391094;9917.553710083208;9918.156956658764;10125.949370253102;10175.93152718954;6950.965245173944;7567.848643026999;7694.269044440769;7699.153093159636;7712.074551053685;7849.764507064797;7902.407319451179;7918.129005809472;7923.841523169389;8197.918020819954;7388.408927285696;7567.167611562833;7599.848003040019;7670.808229794076;7697.499662521918;7343.522671026366;7377.151627562685;7435.330820226206;7484.738034168778;7527.360174385239;7054.365107140382;7132.500724949411;7133.82165445868;7137.1435427749;7140;4932.383452068491;4942.1598328285;4944.15949288629;5052.090623687772;5058.671186372874;4959.727215003065;4967.900641987212;5010.173321401928;5123.28274041627;5243.790248390174 09:01:28 INFO - PROCESS | 1665 | |4;prototype.html;333.81662008180996;336.51911224900476;342.7874717675041;349.2369173356215;349.26828294722577;6379.617222966625;6561.77033803817;6603.207615086197;6607.0089486577035;6735.393814556689;6573.211214654236;6639.73441062357;6654.3012983636745;6660.100886380337;6670.199576050881;4300.3764454154125;4874.951885344659;4906.754662266891;4914.97542512287;4921.606271498272;4912.410510738717;4930.827421040264;4936.111499930011;4941.357623508939;4947.03532811102;4884.755762211893;4909.754512274372;4915.6313276504225;4923.753812309388;4925.310456536088;4607.976960115211;4821.276808478756;4907.4356449008465;4911.140550403683;4934.1611925972675;4072.063425412172;4106.301928672133;4111.09555897705;4118.320477121301;4126.855560055414;5139.820106296262;6314.589551679126;6351.714172862232;6389.201349831271;6405.871882562369;5680.971595142039;5682.147677848315;5682.54539636828;5683.039351423794;5690.715464226772;7036.894446583254;7039.472039597051;7044.964775176091;7060.682269297894;7062.646867656648;4471.441069866267;4580.587747102777;4600.470945841238;4622.306654001893;4629.421322334708;7215.206327303992;7383.556986580822;7418.925810741877;7537.321641052332;7546.924530754677;4608.769561521911;4627.838025669085;4651.116287905287;4661.137689527381;4676.158291507561;4042.7372220805555;4770.0936822003705;4776.307435421844;4783.1868582341085;4784.067106914118;4552;5364.7049412282695;5487.204355368529;5490.227435145226;5559.6664200148125;6905.516613836983;7064.7174113035935;7131.572105673677;7177;7192.92807071933;1631.6981358448725;1655.8509734123986;1656.685229806333;1657.3619156624545;1658.5687721192576;1033.3128469567653;1043.639944219243;1060.6287799270194;1065.142560239015;1070.0476575847501;6748.257691653914;6772.83067923296;6786.491013174032;6793.626350550767;6794.898076528856;6266;7341.265873412616;7345.926540734525;7358.705651773977;7369.336759691653;6764.188297404343;6772.83067923296;6772.830679233059;6777.762778302736;6784.525083244125;3787.659110680052;3873.205992771475;3922.1371298314325;3929.685625149981;3931.76409415436;6343.270523889812;7703.807404814813;7705.190954949761;7730.420218483636;7732.226777322223;6418.711157997901;7594.7088994871;7607.087149542091;7619.657115429708;7623.313901748869;7701.961490192513;7708.460407771514;7710.421718371144;7716.151223365538;7723.189065148304;6097.908531371944;7138.714451421885;7220.0613920190035;7346.155192152971;7353.0441042664115;7289.489735718449;7301.707931682886;7351.926480735124;7357;7384.150822655463;7497.9250207497225;7737.883931741141;7765.990421245202;7794.493357931717;7796.10344810354;4641.930371044505;4735.408073990751;4744.193487107131;4749.643776716691;4755.976220118877;7389.556626602421;7399.963000184965;7405.8148546286775;7424;7428.2571742825285;7181.712731490891;7182.604956727221;7184.137903451619;7191.993120962965;7192.352688258082;6931.237563868071;7142.178649455172;7150.821229469305;7154.177269613853;7196.0285361475535;5631.63394379364;6974.058502102152;6976.02335672996;6977;6999.1950925644205;5730.255066841451;7146.142462904485;7151.60666163366;7158.105236845395;7165.605891675799;6989.860202796017;6997.440204783707;6997.47518936092;6997.650117494003;7020.473464490082 09:01:28 INFO - PROCESS | 1665 | |5;yui.html;716.7348081209952;778.1945686214768;790.3795520516396;798.4929569723228;803.1446509467419;15756.369745210191;15848.28682709278;15998.280077396515;16004.599885002881;16005.879588428814;14645.780313295283;14740.262986850668;14759.631009224775;14774.556763297118;14782.630434239149;776.4642396746241;798.9892785626188;945.7493764152505;987.53585814667;993.2203220471931;971.5433746139339;972.222222222223;983.1593987140963;985.581128020592;986.6398764450995;1035.2390992620417;1054.0408228512056;1054.8206804843196;1055.9809783558865;1057.5452555401175;822.9958850205741;829.3282441222628;843.1821133500525;843.8227972125861;1032.3908893752684;663.8672265546861;778.5640041576735;778.979536806785;779.4232268121606;781.316348195329;15296.694066118727;15470.303836327279;15531.767023494656;15552.533423997298;15554.688906221925;12216.816747748791;12528.686782830411;12618;12638.936805315914;12792.936035319764;10395.584176632925;10436.07789818852;10839.83740243897;10958.506867190996;11093.611723589716;3666.4133738601695;3669.7064234861414;3720.9441858372147;3721.702263818888;3808.086059345737;80527;81193.18806811975;81197.18802811955;81472.18527814705;82213.17786822114;9794.265430092772;9805.166560842408;9870.753231169278;10068.59725610982;10187;23837.642435363483;23875;23889.163879264142;23902.521949560913;23915.282541523782;7713.3443657288635;7720.652570634223;7841.333486653584;7843.764687059397;8038.397120216007;4100.200460910094;4119.691023173274;4123.113530590937;4135.214309281227;4149.356849688304;3730.235301763132;3785.73499855013;3793.1465420280215;3793.8103094845146;3796.1079146401125;655.5312951239887;664.4285914113858;674.6103027762824;686.361683634225;701.3932947999944;542.4710906865853;613.294711082259;615.5721773367467;639.5139693832627;641.9679016049179;6947.478939079489;7355.374793142642;8292.502449853027;8672.262857657044;8889;607.4654304212265;611.2939554814196;621.810347843903;636.7834936121741;643.3759253524074;3143.811371317728;3328.589618755159;3900.4539364488996;3987.960120398817;4022.2156679447226;88526;90697.54651226701;91724.54137729268;91799.16401672062;94486.52756736173;79176;79730.80403793948;80273.59863200647;80479;80792.59603701944;66268.67462650816;69881.65059174671;70107.64946175237;71676.64161679262;72094.63952680203;8619.525926074126;8715.389922705603;8720.520371379635;8775;8869.246114080117;48651;50317.24524132068;51109.722256943875;51323;51333.48666513287;66285.67428651304;68546;70596;70644.94032589618;71310;11028.117750579773;11205.383703896037;11280.661580152608;11418;12129.454174562343;11764.764704705687;11852.585159519376;11967.162298639012;12167.878321216675;12878.35608219604;11365.715857103638;11706.531738730697;11765.941170294094;12016.519339226334;12069;11591.420428978687;11650.650141204922;11690.415479226174;11735.706607334543;11840.940795295968;11530.769384612093;11533.480993355151;11697.356645384245;11844.111691623335;11913.523459061887;9542.522873856418;9631.662891798753;9917.950410247902;9923.950380248052;10018.148457381205;9509.476978766234;9564.521773911416;9616.182624476998;9618;9647.951760241154 09:01:28 INFO - PROCESS | 1665 | __end_tp_report 09:01:28 INFO - PROCESS | 1665 | __start_cc_report 09:01:28 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1020 09:01:28 INFO - PROCESS | 1665 | __end_cc_report 09:01:28 INFO - PROCESS | 1665 | __startTimestamp1466697688930__endTimestamp 09:01:28 INFO - PROCESS | 1665 | 09:01:28 INFO - PROCESS | 1665 | ------- Summary: start ------- 09:01:28 INFO - PROCESS | 1665 | Number of tests: 6 09:01:28 INFO - PROCESS | 1665 | 09:01:28 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5794.27 Median:6071.09 stddev:668.61 (11.0%) stddev-sans-first:631.93 09:01:28 INFO - PROCESS | 1665 | Values: 2935.3 3575.4 3597.6 3613.0 3656.5 5695.9 5710.7 5714.4 5724.8 5765.7 4696.2 5748.4 5754.5 5759.0 5761.1 5164.7 5170.6 5187.5 5199.2 5251.8 5238.8 5264.7 5273.4 5276.8 5287.4 5212.7 5277.8 5288.9 5303.7 5331.7 5279.6 5280.2 5295.7 5297.2 5308.3 5111.7 5132.1 5144.9 5235.6 5248.7 5554.3 5577.8 5598.2 5675.5 5732.6 4493.7 6303.6 6320.8 6324.3 6326.2 4794.8 6205.8 6337.9 6349.3 6377.0 5903.9 5917.0 5938.0 5938.6 5978.4 6379.0 6385.5 6394.4 6400.2 6410.5 6100.6 6178.3 6225.2 6268.5 6282.5 6319.0 6328.9 6335.2 6336.3 6344.0 6246.0 6253.9 6283.4 6309.3 6322.1 6125.8 6155.9 6270.3 6271.7 6282.6 4995.4 5022.5 5025.6 5035.4 5038.5 4520.0 4531.6 4538.2 4554.0 4554.1 5817.3 5884.8 5949.2 6001.8 6027.3 6314.0 6348.2 6351.7 6353.2 6365.3 5990.5 5990.6 5993.2 5998.9 6001.8 5299.0 5381.2 5390.1 5504.9 5510.4 6439.7 6440.8 6455.6 6469.5 6473.8 4988.2 6319.3 6322.3 6343.4 6344.8 6311.0 6368.3 6441.0 6448.2 6453.6 6234.1 6249.5 6276.2 6309.6 6313.8 6203.2 6326.9 6337.4 6357.6 6370.8 6125.1 6185.1 6194.3 6201.0 6220.9 6199.0 6205.6 6225.6 6231.7 6253.3 5833.6 5958.5 6071.1 6077.0 6093.5 6015.3 6188.3 6235.7 6238.0 6252.1 5026.4 6106.5 6126.2 6128.7 6145.6 09:01:28 INFO - PROCESS | 1665 | 09:01:28 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:62897.52 Median:182803.08 stddev:134278.11 (73.5%) stddev-sans-first:134573.14 09:01:28 INFO - PROCESS | 1665 | Values: 529.7 542.1 551.6 570.9 602.5 26218.0 33312.0 40023.0 40408.6 40426.0 43415.6 43660.8 43692.6 43781.8 43922.0 7697.6 9672.7 9885.7 9890.4 11725.3 11729.8 11857.3 11869.6 11872.3 11879.6 11815.7 11901.8 11919.6 11924.4 11951.3 11827.8 11874.5 11911.0 11912.1 11913.9 11736.4 11783.2 11823.5 12054.5 12056.3 41527.8 42037.8 42045.8 42076.4 42119.9 3325.1 3395.3 3483.5 3706.0 3892.8 29199.6 29951.3 29980.8 30157.8 30312.7 2796.0 2807.7 2818.0 2828.6 2860.0 359305.0 361995.4 362857.0 363307.0 363896.0 39221.8 64344.0 64630.7 64702.0 64730.7 38060.2 38309.0 38341.6 38393.2 38473.2 16145.7 16547.3 16558.1 16560.4 16567.8 12752.9 12843.4 13534.9 13555.7 13636.0 8564.4 8674.0 8691.2 8725.9 8826.0 3558.9 3610.8 3625.1 3628.8 3654.6 968.9 977.6 986.7 1029.1 1070.0 31453.2 31457.7 31494.7 31897.0 32003.6 1057.4 1198.4 1241.7 1255.1 1275.0 11532.8 17011.0 17067.9 17429.8 17473.3 655301.0 656465.0 663431.0 663687.0 663754.0 63990.7 64640.4 64689.7 64780.7 64869.7 1421.7 1422.9 1580.2 1588.6 1603.8 30170.5 31217.0 31775.7 31848.7 32215.0 52261.0 52405.7 52737.5 52809.7 52888.0 432167.0 435521.0 435970.0 436840.0 437139.0 24294.8 26500.6 28864.3 29229.0 29232.9 44097.4 45112.5 45150.5 45298.3 45863.3 38480.6 38751.4 39770.2 41459.6 41677.6 37925.0 39157.8 39284.8 39727.6 40074.8 38407.0 38833.4 39378.0 39501.4 39546.0 30929.0 31495.6 32612.5 34652.0 34664.5 25556.5 25923.0 25941.0 26372.2 26419.9 09:01:28 INFO - PROCESS | 1665 | 09:01:28 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:37225.79 Median:22120.56 stddev:111613.20 (504.6%) stddev-sans-first:111892.08 09:01:28 INFO - PROCESS | 1665 | Values: 417.2 418.1 422.2 422.4 433.1 20635.6 20753.0 20950.0 21428.4 21481.5 21378.5 21898.3 22342.8 22547.2 22568.3 5908.2 6182.7 6184.8 6244.4 6246.6 5895.6 6049.5 6095.2 6191.7 6199.3 6083.5 6098.8 6109.3 6113.6 6119.7 5908.4 5980.3 6096.9 6097.6 6097.9 5294.9 5338.0 5341.5 5345.9 5354.0 13409.1 26559.1 27356.0 27697.3 27709.9 2149.9 2155.2 2262.1 2464.8 2517.6 9848.5 10154.1 10344.9 10595.9 10839.9 1756.6 1776.3 1844.1 1898.4 1918.6 117417.0 118475.4 120170.0 128897.7 142022.0 9600.8 11739.9 11918.4 11981.5 12099.9 15775.8 15848.8 15873.0 15880.7 15903.7 7465.9 9017.0 9139.4 9193.8 9254.0 9096.5 9119.8 9121.2 9130.3 9246.2 4833.1 4866.0 4883.1 4884.2 4935.2 1689.6 1738.7 2029.0 2059.7 2074.2 802.0 959.0 1004.6 1019.5 1054.8 19862.0 19890.3 20620.6 20985.0 21204.9 1014.3 1017.6 1034.9 1070.9 1117.1 10922.2 11237.9 11239.9 11275.6 11286.4 656171.0 662742.0 674187.0 682763.0 684764.0 87198.0 121188.0 131961.0 133838.0 138329.0 860.9 977.9 987.0 1006.9 1007.5 18001.9 18100.9 18137.3 18488.7 18788.1 49208.5 49795.8 51006.5 51591.2 52631.0 76261.6 76804.0 77479.2 79875.2 81060.0 6640.8 8411.6 8475.2 8486.6 8561.0 11942.8 12635.7 12808.4 13049.5 13085.7 10830.8 11125.8 11291.5 11322.0 11443.0 10787.0 11007.8 11136.1 11255.5 11348.8 10706.2 10707.0 11392.8 11746.9 11785.4 8258.2 8372.2 8394.1 8413.2 8521.7 8612.2 10937.1 11147.6 11375.9 11480.3 09:01:28 INFO - PROCESS | 1665 | 09:01:28 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5862.60 Median:4963.81 stddev:3270.83 (65.9%) stddev-sans-first:3261.86 09:01:28 INFO - PROCESS | 1665 | Values: 1278.8 1617.4 1630.5 1897.8 2006.2 8332.4 9025.5 9188.4 9199.7 9202.6 8864.1 9162.3 9166.5 9171.7 9177.8 2549.1 2574.6 2577.9 2580.4 2581.1 2502.9 2543.8 2544.3 2546.5 2550.7 2505.1 2539.8 2547.9 2548.2 2554.6 2521.8 2552.9 2558.7 2560.7 2575.3 2504.8 2559.7 2565.0 2573.1 2575.1 8761.7 9184.6 9273.5 9274.9 9288.9 5481.3 5659.8 5680.8 5689.4 5709.4 3633.8 3715.1 3762.1 3770.4 3777.8 1063.4 1068.6 1072.5 1090.6 1093.3 12486.8 12560.7 12632.1 12646.3 12653.5 4750.7 4795.3 4808.7 4856.9 4902.6 9650.4 9685.7 9694.5 9697.1 9723.0 4669.6 5492.1 5507.2 5524.0 5558.4 4590.9 4681.1 4697.1 4753.2 5169.1 3871.1 3881.9 3952.9 3953.7 3958.7 1223.0 1242.8 1247.6 1253.8 1270.5 885.2 924.3 972.1 986.0 1008.6 5484.5 5793.9 6102.0 6200.4 6220.0 980.3 980.5 985.1 1004.9 1022.7 4041.0 4098.2 4106.8 4110.4 4173.1 10777.7 11199.2 11293.8 11299.5 11299.7 10982.2 10995.5 11110.3 11163.9 11183.4 8313.8 8517.4 8606.7 8677.7 8727.0 5109.8 6067.2 6178.6 6242.6 6250.8 9856.9 9893.0 9900.9 10232.2 10242.2 9777.8 9917.6 9918.2 10125.9 10175.9 6951.0 7567.8 7694.3 7699.2 7712.1 7849.8 7902.4 7918.1 7923.8 8197.9 7388.4 7567.2 7599.8 7670.8 7697.5 7343.5 7377.2 7435.3 7484.7 7527.4 7054.4 7132.5 7133.8 7137.1 7140.0 4932.4 4942.2 4944.2 5052.1 5058.7 4959.7 4967.9 5010.2 5123.3 5243.8 09:01:28 INFO - PROCESS | 1665 | 09:01:28 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5793.50 Median:6623.37 stddev:1863.58 (28.1%) stddev-sans-first:1823.20 09:01:28 INFO - PROCESS | 1665 | Values: 333.8 336.5 342.8 349.2 349.3 6379.6 6561.8 6603.2 6607.0 6735.4 6573.2 6639.7 6654.3 6660.1 6670.2 4300.4 4875.0 4906.8 4915.0 4921.6 4912.4 4930.8 4936.1 4941.4 4947.0 4884.8 4909.8 4915.6 4923.8 4925.3 4608.0 4821.3 4907.4 4911.1 4934.2 4072.1 4106.3 4111.1 4118.3 4126.9 5139.8 6314.6 6351.7 6389.2 6405.9 5681.0 5682.1 5682.5 5683.0 5690.7 7036.9 7039.5 7045.0 7060.7 7062.6 4471.4 4580.6 4600.5 4622.3 4629.4 7215.2 7383.6 7418.9 7537.3 7546.9 4608.8 4627.8 4651.1 4661.1 4676.2 4042.7 4770.1 4776.3 4783.2 4784.1 4552.0 5364.7 5487.2 5490.2 5559.7 6905.5 7064.7 7131.6 7177.0 7192.9 1631.7 1655.9 1656.7 1657.4 1658.6 1033.3 1043.6 1060.6 1065.1 1070.0 6748.3 6772.8 6786.5 6793.6 6794.9 6266.0 7341.3 7345.9 7358.7 7369.3 6764.2 6772.8 6772.8 6777.8 6784.5 3787.7 3873.2 3922.1 3929.7 3931.8 6343.3 7703.8 7705.2 7730.4 7732.2 6418.7 7594.7 7607.1 7619.7 7623.3 7702.0 7708.5 7710.4 7716.2 7723.2 6097.9 7138.7 7220.1 7346.2 7353.0 7289.5 7301.7 7351.9 7357.0 7384.2 7497.9 7737.9 7766.0 7794.5 7796.1 4641.9 4735.4 4744.2 4749.6 4756.0 7389.6 7400.0 7405.8 7424.0 7428.3 7181.7 7182.6 7184.1 7192.0 7192.4 6931.2 7142.2 7150.8 7154.2 7196.0 5631.6 6974.1 6976.0 6977.0 6999.2 5730.3 7146.1 7151.6 7158.1 7165.6 6989.9 6997.4 6997.5 6997.7 7020.5 09:01:28 INFO - PROCESS | 1665 | 09:01:28 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18651.23 Median:609.38 stddev:25871.43 (4245.5%) stddev-sans-first:25908.96 09:01:28 INFO - PROCESS | 1665 | Values: 716.7 778.2 790.4 798.5 803.1 15756.4 15848.3 15998.3 16004.6 16005.9 14645.8 14740.3 14759.6 14774.6 14782.6 776.5 799.0 945.7 987.5 993.2 971.5 972.2 983.2 985.6 986.6 1035.2 1054.0 1054.8 1056.0 1057.5 823.0 829.3 843.2 843.8 1032.4 663.9 778.6 779.0 779.4 781.3 15296.7 15470.3 15531.8 15552.5 15554.7 12216.8 12528.7 12618.0 12638.9 12792.9 10395.6 10436.1 10839.8 10958.5 11093.6 3666.4 3669.7 3720.9 3721.7 3808.1 80527.0 81193.2 81197.2 81472.2 82213.2 9794.3 9805.2 9870.8 10068.6 10187.0 23837.6 23875.0 23889.2 23902.5 23915.3 7713.3 7720.7 7841.3 7843.8 8038.4 4100.2 4119.7 4123.1 4135.2 4149.4 3730.2 3785.7 3793.1 3793.8 3796.1 655.5 664.4 674.6 686.4 701.4 542.5 613.3 615.6 639.5 642.0 6947.5 7355.4 8292.5 8672.3 8889.0 607.5 611.3 621.8 636.8 643.4 3143.8 3328.6 3900.5 3988.0 4022.2 88526.0 90697.5 91724.5 91799.2 94486.5 79176.0 79730.8 80273.6 80479.0 80792.6 66268.7 69881.7 70107.6 71676.6 72094.6 8619.5 8715.4 8720.5 8775.0 8869.2 48651.0 50317.2 51109.7 51323.0 51333.5 66285.7 68546.0 70596.0 70644.9 71310.0 11028.1 11205.4 11280.7 11418.0 12129.5 11764.8 11852.6 11967.2 12167.9 12878.4 11365.7 11706.5 11765.9 12016.5 12069.0 11591.4 11650.7 11690.4 11735.7 11840.9 11530.8 11533.5 11697.4 11844.1 11913.5 9542.5 9631.7 9918.0 9924.0 10018.1 9509.5 9564.5 9616.2 9618.0 9648.0 09:01:28 INFO - PROCESS | 1665 | -------- Summary: end -------- 09:01:28 INFO - PROCESS | 1665 | 09:01:29 INFO - TEST-INFO | 1665: exit 0 09:01:29 INFO - TEST-OK | dromaeo_css | took 1112297ms 09:01:29 INFO - TEST-START | kraken 09:01:29 INFO - operating with platform_type : mac_ 09:01:29 INFO - Initialising browser for kraken test... 09:01:29 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmp5Am0Aa/profile http://localhost:49270/getInfo.html) 09:01:31 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 09:01:31 INFO - PROCESS | 1674 | colorDepth:24 09:01:31 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 09:01:31 INFO - PROCESS | 1674 | __metrics 09:01:31 INFO - PROCESS | 1674 | 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" 09:01:31 ERROR - PROCESS | 1674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:01:32 INFO - TEST-INFO | 1674: exit 0 09:01:32 INFO - Browser initialized. 09:01:32 INFO - Running cycle 1/1 for kraken test... 09:01:32 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmp5Am0Aa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:44 INFO - PROCESS | 1677 | RSS: Main: 161517568 09:01:44 INFO - PROCESS | 1677 | 09:01:46 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 09:01:47 INFO - PROCESS | 1677 | RSS: Main: 224219136 09:01:47 INFO - PROCESS | 1677 | 09:01:50 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 09:01:50 INFO - PROCESS | 1677 | RSS: Main: 241184768 09:01:50 INFO - PROCESS | 1677 | 09:01:54 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 09:01:54 INFO - PROCESS | 1677 | RSS: Main: 324767744 09:01:54 INFO - PROCESS | 1677 | 09:01:56 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 09:01:57 INFO - PROCESS | 1677 | RSS: Main: 231694336 09:01:57 INFO - PROCESS | 1677 | 09:01:59 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:00 INFO - PROCESS | 1677 | RSS: Main: 232501248 09:02:00 INFO - PROCESS | 1677 | 09:02:02 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:03 INFO - PROCESS | 1677 | RSS: Main: 270331904 09:02:03 INFO - PROCESS | 1677 | 09:02:06 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:07 INFO - PROCESS | 1677 | RSS: Main: 270020608 09:02:07 INFO - PROCESS | 1677 | 09:02:09 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 09:02:10 INFO - PROCESS | 1677 | RSS: Main: 268685312 09:02:10 INFO - PROCESS | 1677 | 09:02:12 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:12 INFO - PROCESS | 1677 | RSS: Main: 260620288 09:02:12 INFO - PROCESS | 1677 | 09:02:14 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:15 INFO - PROCESS | 1677 | RSS: Main: 268238848 09:02:15 INFO - PROCESS | 1677 | 09:02:17 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:17 INFO - PROCESS | 1677 | RSS: Main: 271040512 09:02:17 INFO - PROCESS | 1677 | 09:02:20 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:21 INFO - PROCESS | 1677 | RSS: Main: 278159360 09:02:21 INFO - PROCESS | 1677 | 09:02:23 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:24 INFO - PROCESS | 1677 | RSS: Main: 275038208 09:02:24 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 09:02:26 INFO - PROCESS | 1677 | RSS: Main: 336482304 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | __start_tp_report 09:02:26 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 09:02:26 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 09:02:26 INFO - PROCESS | 1677 | |i|pagename|runs| 09:02:26 INFO - PROCESS | 1677 | |0;ai-astar;111;111;118;113;111;112;112;111;111;133 09:02:26 INFO - PROCESS | 1677 | |1;audio-beat-detection;159;121;141;169;117;138;144;97;181;148 09:02:26 INFO - PROCESS | 1677 | |2;audio-dft;183;185;196;263;202;182;183;182;185;184 09:02:26 INFO - PROCESS | 1677 | |3;audio-fft;70;83;96;191;46;61;73;81;139;55 09:02:26 INFO - PROCESS | 1677 | |4;audio-oscillator;89;88;146;113;122;122;120;79;79;126 09:02:26 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;88;86;88;86;88;84;89;86;88;85 09:02:26 INFO - PROCESS | 1677 | |6;imaging-darkroom;93;93;120;148;116;94;93;92;93;92 09:02:26 INFO - PROCESS | 1677 | |7;imaging-desaturate;85;84;84;86;85;84;84;83;85;104 09:02:26 INFO - PROCESS | 1677 | |8;json-parse-financial;60;62;63;61;61;62;61;76;58;56 09:02:26 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;60;62;61;71;69;71;68;64;64;65 09:02:26 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;81;102;100;104;80;80;80;79;82;84 09:02:26 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;124;124;125;115;142;144;120;125;142;137 09:02:26 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;165;160;156;169;162;165;162;163;162;160 09:02:26 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;66;67;69;68;67;66;65;67;66;68 09:02:26 INFO - PROCESS | 1677 | __end_tp_report 09:02:26 INFO - PROCESS | 1677 | __start_cc_report 09:02:26 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1921 09:02:26 INFO - PROCESS | 1677 | __end_cc_report 09:02:26 INFO - PROCESS | 1677 | __startTimestamp1466697746487__endTimestamp 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | ------- Summary: start ------- 09:02:26 INFO - PROCESS | 1677 | Number of tests: 14 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:114.30 Median:112.00 stddev:6.91 (6.2%) stddev-sans-first:7.23 09:02:26 INFO - PROCESS | 1677 | Values: 111.0 111.0 118.0 113.0 111.0 112.0 112.0 111.0 111.0 133.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:153.50 stddev:25.13 (16.4%) stddev-sans-first:25.85 09:02:26 INFO - PROCESS | 1677 | Values: 159.0 121.0 141.0 169.0 117.0 138.0 144.0 97.0 181.0 148.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:194.50 Median:185.00 stddev:24.99 (13.5%) stddev-sans-first:26.15 09:02:26 INFO - PROCESS | 1677 | Values: 183.0 185.0 196.0 263.0 202.0 182.0 183.0 182.0 185.0 184.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:89.50 Median:71.50 stddev:44.04 (61.6%) stddev-sans-first:46.14 09:02:26 INFO - PROCESS | 1677 | Values: 70.0 83.0 96.0 191.0 46.0 61.0 73.0 81.0 139.0 55.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:112.50 stddev:23.02 (20.5%) stddev-sans-first:23.32 09:02:26 INFO - PROCESS | 1677 | Values: 89.0 88.0 146.0 113.0 122.0 122.0 120.0 79.0 79.0 126.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:88.00 stddev:1.62 (1.8%) stddev-sans-first:1.66 09:02:26 INFO - PROCESS | 1677 | Values: 88.0 86.0 88.0 86.0 88.0 84.0 89.0 86.0 88.0 85.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:93.00 stddev:18.87 (20.3%) stddev-sans-first:19.63 09:02:26 INFO - PROCESS | 1677 | Values: 93.0 93.0 120.0 148.0 116.0 94.0 93.0 92.0 93.0 92.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:84.50 stddev:6.24 (7.4%) stddev-sans-first:6.60 09:02:26 INFO - PROCESS | 1677 | Values: 85.0 84.0 84.0 86.0 85.0 84.0 84.0 83.0 85.0 104.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:61.50 stddev:5.33 (8.7%) stddev-sans-first:5.61 09:02:26 INFO - PROCESS | 1677 | Values: 60.0 62.0 63.0 61.0 61.0 62.0 61.0 76.0 58.0 56.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.50 stddev:4.03 (6.1%) stddev-sans-first:3.76 09:02:26 INFO - PROCESS | 1677 | Values: 60.0 62.0 61.0 71.0 69.0 71.0 68.0 64.0 64.0 65.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:80.00 stddev:10.35 (12.9%) stddev-sans-first:10.73 09:02:26 INFO - PROCESS | 1677 | Values: 81.0 102.0 100.0 104.0 80.0 80.0 80.0 79.0 82.0 84.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:131.00 stddev:10.43 (8.0%) stddev-sans-first:10.85 09:02:26 INFO - PROCESS | 1677 | Values: 124.0 124.0 125.0 115.0 142.0 144.0 120.0 125.0 142.0 137.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:162.50 stddev:3.50 (2.2%) stddev-sans-first:3.59 09:02:26 INFO - PROCESS | 1677 | Values: 165.0 160.0 156.0 169.0 162.0 165.0 162.0 163.0 162.0 160.0 09:02:26 INFO - PROCESS | 1677 | 09:02:26 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.22 09:02:26 INFO - PROCESS | 1677 | Values: 66.0 67.0 69.0 68.0 67.0 66.0 65.0 67.0 66.0 68.0 09:02:26 INFO - PROCESS | 1677 | -------- Summary: end -------- 09:02:26 INFO - PROCESS | 1677 | 09:02:27 INFO - TEST-INFO | 1677: exit 0 09:02:27 INFO - TEST-OK | kraken | took 57694ms 09:02:27 INFO - SUITE-END | took 1169s 09:02:27 INFO - Completed test suite (00:19:30) 09:02:27 INFO - javascript benchmark 09:02:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2935.324875278686, 3575.4279315309554, 3597.640235976403, 3613.0, 3656.542932133483, 5695.943040569593, 5710.714464276791, 5714.3999880012625, 5724.7996320128805, 5765.740541675619, 4696.248600223965, 5748.425157484249, 5754.539636829054, 5758.971205143979, 5761.107028410593, 5164.715940623264, 5170.560502357294, 5187.48125187482, 5199.168133098705, 5251.76367063483, 5238.790448382079, 5264.710440925747, 5273.419923808378, 5276.762545685453, 5287.444818294081, 5212.6611770235, 5277.762500687459, 5288.867778305535, 5303.7082960437165, 5331.706756128411, 5279.5512381447625, 5280.2343660169445, 5295.682259064469, 5297.231901374318, 5308.309919710413, 5111.693298402108, 5132.076226279269, 5144.948550514484, 5235.58115350771, 5248.6588371755715, 5554.2779438672715, 5577.776888924438, 5598.1602759585985, 5675.460831221028, 5732.570057245724, 4493.73037617744, 6303.621782693053, 6320.841978950517, 6324.272708638519, 6326.2092238470195, 4794.832180873687, 6205.7517699291975, 6337.936620633827, 6349.2698339690605, 6377.01156320771, 5903.881922361572, 5916.9645312070215, 5938.0, 5938.584299099021, 5978.40215978403, 6379.043143528415, 6385.48916086712, 6394.424501794768, 6400.23197216337, 6410.487161027107, 6100.633961962208, 6178.289496707846, 6225.190725205694, 6268.529860260407, 6282.465990390868, 6319.0, 6328.936710632835, 6335.176427064452, 6336.271328797156, 6343.9682801585695, 6246.0, 6253.906191407133, 6283.434490895841, 6309.33751956038, 6322.083297921776, 6125.845966769368, 6155.938440615626, 6270.31026587075, 6271.717772700239, 6282.623042617458, 4995.425526064549, 5022.4977502249485, 5025.648204625714, 5035.370578677665, 5038.521340472649, 4520.005598768265, 4531.592156705847, 4538.205813982606, 4554.0, 4554.111948170075, 5817.331006934172, 5884.823455296348, 5949.2266005419015, 6001.789937352171, 6027.336992930774, 6313.968430157912, 6348.238211414568, 6351.745930162834, 6353.174087368612, 6365.3316401778075, 5990.520758339322, 5990.5507086968655, 5993.190919225936, 5998.850028749316, 6001.849953751192, 5298.97350513245, 5381.219723140122, 5390.110631745718, 5504.862378440571, 5510.448955104538, 6439.710213040425, 6440.806775796734, 6455.61266324022, 6469.514786390945, 6473.838154046092, 4988.176950803077, 6319.304876463493, 6322.3045464997895, 6343.397377249154, 6344.809655710336, 6311.0, 6368.299487056513, 6440.967795160994, 6448.161738973903, 6453.645049522322, 6234.064890266496, 6249.500039996698, 6276.246850377984, 6309.589876658002, 6313.779017734358, 6203.2245969253845, 6326.936730632635, 6337.429631333202, 6357.618542887441, 6370.77702280418, 6125.050617154348, 6185.072239164161, 6194.318624951342, 6200.968995154995, 6220.875582488235, 6198.969005154945, 6205.565610407228, 6225.62646241227, 6231.657258850807, 6253.3121356651645, 5833.649981001154, 5958.463738263577, 6071.089336599545, 6077.0, 6093.512518998381, 6015.338312785678, 6188.288346840171, 6235.719392627433, 6237.96881015592, 6252.093446450148, 5026.396832380138, 6106.542009349406, 6126.203593532812, 6128.662923539248, 6145.631262124287], "value": 5754.464788007159, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.6530772344114, 542.067643652917, 551.5532418740818, 570.8768836838348, 602.5089552015107, 26218.0, 33312.0, 40022.999425014386, 40408.59591404085, 40426.0, 43415.565844341545, 43660.78169609155, 43692.563074369245, 43781.7810910945, 43922.0, 7697.615119244043, 9672.661456849011, 9885.654002109928, 9890.357126786736, 11725.296482211095, 11729.765404691901, 11857.288562686266, 11869.584564540242, 11872.287662740264, 11879.584214552493, 11815.704607384798, 11901.821472677917, 11919.58281460149, 11924.403779811018, 11951.342676152808, 11827.822582661267, 11874.465649045813, 11911.04711623068, 11912.106592005548, 11913.94043029788, 11736.413179340998, 11783.234089784137, 11823.527058917633, 12054.517819287306, 12056.336901470415, 41527.7923610383, 42037.78981105106, 42045.789771051255, 42076.368854467204, 42119.94700132491, 3325.118843506473, 3395.337909107725, 3483.512308276843, 3705.980855264797, 3892.805359732002, 29199.56200656992, 29951.251218719488, 29980.800767969475, 30157.849210753804, 30312.696873031207, 2795.9860200699068, 2807.6771171315154, 2818.0, 2828.61813655156, 2859.999000349861, 359305.0, 361995.3800461988, 362857.0, 363307.0, 363895.9999999974, 39221.80389098093, 64344.0, 64630.67684661547, 64702.0, 64730.67634661797, 38060.23879522394, 38309.0, 38341.616583833806, 38393.23213535714, 38473.230535389695, 16145.677086458205, 16547.255373507982, 16558.089305088335, 16560.420385286456, 16567.834321656872, 12752.936235318764, 12843.357832108357, 13534.864651353557, 13555.728885422433, 13636.045476816726, 8564.400491965502, 8673.956630216808, 8691.174338437839, 8725.912740872636, 8826.0, 3558.857645694195, 3610.783352998776, 3625.148090198801, 3628.800415977094, 3654.579723331851, 968.9467079310565, 977.6333874796951, 986.6546708652058, 1029.0892560084378, 1069.9946500267604, 31453.213669657984, 31457.741690332587, 31494.685053149635, 31897.0, 32003.559839807265, 1057.4237040812775, 1198.406788639629, 1241.7330273991136, 1255.1465003797323, 1274.9808752868714, 11532.769344613229, 17011.029905621253, 17067.914660426617, 17429.82570174282, 17473.301067957138, 655301.0, 656465.0, 663431.0, 663687.0, 663754.0, 63990.68004659947, 64640.353596463436, 64689.67655161788, 64780.676096619216, 64869.67565162144, 1421.6730152065084, 1422.9328003997002, 1580.2493815437574, 1588.6425554250202, 1603.7915071040923, 30170.547441787952, 31217.0, 31775.68224317727, 31848.681513184572, 32215.0, 52261.0, 52405.7379713099, 52737.47262527326, 52809.67975800636, 52888.0, 432167.0, 435521.0, 435970.0, 436840.0, 437139.0, 24294.75705242925, 26500.602490962265, 28864.278393040342, 29229.0, 29232.853835730686, 44097.410512175295, 45112.54887451084, 45150.54849451463, 45298.32052519149, 45863.31205031861, 38480.615193847705, 38751.41872871853, 39770.204595907344, 41459.585404145575, 41677.58322416737, 37925.0, 39157.804210978764, 39284.82145535639, 39727.60272397239, 40074.79962600168, 38407.0, 38833.41749873698, 39378.0, 39501.40747888727, 39546.011349715336, 30929.0, 31495.58269877815, 32612.510812338307, 34652.0, 34664.480032800035, 25556.488870222864, 25922.96308147653, 25941.0, 26372.208833735018, 26419.867900661142], "value": 19411.915670493538, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.2302102620666, 418.1407208187175, 422.1599017954272, 422.36012441151644, 433.0537774961709, 20635.587288254246, 20753.0, 20950.0, 21428.357149285526, 21481.46296342588, 21378.46553836151, 21898.343049708536, 22342.776572234274, 22547.210847620336, 22568.322950311518, 5908.202392676976, 6182.690865456731, 6184.84537886552, 6244.406781355764, 6246.625202487842, 5895.646261224319, 6049.516038716892, 6095.177151084613, 6191.721372538246, 6199.349068347804, 6083.452489275965, 6098.756049758004, 6109.266887973427, 6113.602615829956, 6119.66341851198, 5908.409159084057, 5980.312264089642, 6096.878062438748, 6097.634141951497, 6097.908531372011, 5294.947050529484, 5338.0, 5341.4925582069645, 5345.866353341159, 5354.009508240988, 13409.128406653535, 26559.07043253477, 27356.0, 27697.307567310778, 27709.86145069282, 2149.9140034398606, 2155.1594877997595, 2262.0951619352227, 2464.8151388645924, 2517.609770485578, 9848.458334791583, 10154.136898363648, 10344.896551034468, 10595.894041059644, 10839.945800271027, 1756.6398888227882, 1776.2983621469577, 1844.1332573690345, 1898.3830255167127, 1918.6450506656174, 117417.0, 118475.4076229622, 120170.0, 128897.71102289045, 142021.99999999895, 9600.75998100053, 11739.88260117405, 11918.404079795975, 11981.46083426248, 12099.87900121005, 15775.763363549557, 15848.76226856598, 15873.0, 15880.682386352439, 15903.68192636164, 7465.85068298631, 9016.954915225513, 9139.360244782934, 9193.816123677489, 9254.0, 9096.545172741337, 9119.772005699911, 9121.17909388145, 9130.26957843371, 9246.214071803837, 4833.081714474239, 4865.9756701216975, 4883.145449546386, 4884.242942343943, 4935.235038569028, 1689.552268648809, 1738.7044202485608, 2029.0014335879148, 2059.7322348094654, 2074.2325339624435, 801.9639116239783, 958.9723162716618, 1004.6232662751469, 1019.4953498018529, 1054.847047178155, 19862.00689965496, 19890.30383936555, 20620.587588248152, 20984.95075246262, 21204.893975530333, 1014.2595904989251, 1017.6133069433567, 1034.9223808214263, 1070.9143268538498, 1117.061668198717, 10922.235443518877, 11237.887621123848, 11239.943800280946, 11275.605353812578, 11286.435678216221, 656171.0, 662742.0, 674187.0, 682763.0, 684764.0, 87198.0, 121188.0, 131961.0, 133838.0, 138329.0, 860.9096044915194, 977.8973207813077, 986.9851952220722, 1006.8892421833445, 1007.5012868629929, 18001.909990449964, 18100.909495452437, 18137.27450901949, 18488.722669159706, 18788.060596970372, 49208.507914920396, 49795.751021244665, 51006.46980590588, 51591.226131607305, 52631.0, 76261.6186919084, 76804.0, 77479.22520774945, 79875.20124798677, 81060.0, 6640.800775976729, 8411.61208400607, 8475.194856488624, 8486.575671216538, 8561.01548321951, 11942.761144776881, 12635.684107897376, 12808.423620936894, 13049.543265986025, 13085.738285234052, 10830.837537437103, 11125.83311250348, 11291.548338066385, 11322.0, 11443.0, 10787.0, 11007.834882476609, 11136.053435458076, 11255.493502792231, 11348.773024539629, 10706.197035222234, 10706.982836630508, 11392.829107563559, 11746.882531174579, 11785.351805650771, 8258.174182581934, 8372.204640559137, 8394.0766515682, 8413.200745929127, 8521.67913973335, 8612.224899759052, 10937.125029997422, 11147.554097835995, 11375.943120284346, 11480.311181329147], "value": 9796.802659138159, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.7889998150306, 1617.3934774459578, 1630.494546690526, 1897.8197071278232, 2006.2476571285777, 8332.416730828836, 9025.54872256387, 9188.356815022951, 9199.724008279754, 9202.63189472422, 8864.069272726367, 9162.26701863851, 9166.495842728647, 9171.724848254546, 9177.77055573611, 2549.133294679804, 2574.613807928816, 2577.9355516112155, 2580.380708629925, 2581.1095172165574, 2502.912398066068, 2543.8092143089248, 2544.3257536752776, 2546.4525127097672, 2550.7321731218235, 2505.0856437400307, 2539.8095142864267, 2547.872606369674, 2548.171844150649, 2554.6168074788743, 2521.798256139514, 2552.8595927223996, 2558.6929568451906, 2560.6671132752717, 2575.2874338564834, 2504.8497090174465, 2559.7312282210473, 2565.0124701989866, 2573.1251374532562, 2575.0858445252043, 8761.693340733107, 9184.586693598803, 9273.536323183882, 9274.90725092754, 9288.90711092894, 5481.287432633772, 5659.830205093854, 5680.829575112712, 5689.374168841466, 5709.371969083398, 3633.7638053526703, 3715.071232191952, 3762.059485128718, 3770.4344348347695, 3777.773333599993, 1063.4310643805527, 1068.647346375694, 1072.5066469424075, 1090.6128324444787, 1093.278436232083, 12486.75026499474, 12560.685982850411, 12632.052596055333, 12646.304453255067, 12653.493860245579, 4750.667453278306, 4795.328653988445, 4808.676590283766, 4856.854294371175, 4902.607791376681, 9650.420974741539, 9685.70942871715, 9694.466804325688, 9697.127258546765, 9723.02769723022, 4669.603083737852, 5492.066348720727, 5507.228987941691, 5524.0, 5558.416366281483, 4590.931136032962, 4681.110588988081, 4697.107549565571, 4753.215719406259, 5169.06956747789, 3871.090293780959, 3881.8835434936996, 3952.940705889414, 3953.683705303569, 3958.7030972677167, 1222.9877701223052, 1242.8135779633128, 1247.5571172233908, 1253.7680529102145, 1270.4791035675328, 885.198895000026, 924.3021518753433, 972.1445128287062, 986.0, 1008.566316483919, 5484.533814625722, 5793.884122317614, 6101.969490152521, 6200.410960958701, 6220.035894436279, 980.2550061952967, 980.519545422752, 985.1330828870548, 1004.8844382895915, 1022.6880801355658, 4040.9797951010055, 4098.180363927167, 4106.753594784323, 4110.383442483651, 4173.123644034726, 10777.676669699922, 11199.21605487608, 11293.774124517464, 11299.548018079186, 11299.661010169708, 10982.231243812856, 10995.505202265917, 11110.333379997226, 11163.888361116447, 11183.384913829817, 8313.83372332562, 8517.403781735218, 8606.741797746077, 8677.696280630274, 8726.996395414608, 5109.846704598868, 6067.180930574316, 6178.598391104564, 6242.625442473466, 6250.781222657185, 9856.901430985597, 9892.950535247277, 9900.851487227841, 10232.23258255619, 10242.180625550087, 9777.80444391094, 9917.553710083208, 9918.156956658764, 10125.949370253102, 10175.93152718954, 6950.965245173944, 7567.848643026999, 7694.269044440769, 7699.153093159636, 7712.074551053685, 7849.764507064797, 7902.407319451179, 7918.129005809472, 7923.841523169389, 8197.918020819954, 7388.408927285696, 7567.167611562833, 7599.848003040019, 7670.808229794076, 7697.499662521918, 7343.522671026366, 7377.151627562685, 7435.330820226206, 7484.738034168778, 7527.360174385239, 7054.365107140382, 7132.500724949411, 7133.82165445868, 7137.1435427749, 7140.0, 4932.383452068491, 4942.1598328285, 4944.15949288629, 5052.090623687772, 5058.671186372874, 4959.727215003065, 4967.900641987212, 5010.173321401928, 5123.28274041627, 5243.790248390174], "value": 4735.156748796851, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.81662008180996, 336.51911224900476, 342.7874717675041, 349.2369173356215, 349.26828294722577, 6379.617222966625, 6561.77033803817, 6603.207615086197, 6607.0089486577035, 6735.393814556689, 6573.211214654236, 6639.73441062357, 6654.3012983636745, 6660.100886380337, 6670.199576050881, 4300.3764454154125, 4874.951885344659, 4906.754662266891, 4914.97542512287, 4921.606271498272, 4912.410510738717, 4930.827421040264, 4936.111499930011, 4941.357623508939, 4947.03532811102, 4884.755762211893, 4909.754512274372, 4915.6313276504225, 4923.753812309388, 4925.310456536088, 4607.976960115211, 4821.276808478756, 4907.4356449008465, 4911.140550403683, 4934.1611925972675, 4072.063425412172, 4106.301928672133, 4111.09555897705, 4118.320477121301, 4126.855560055414, 5139.820106296262, 6314.589551679126, 6351.714172862232, 6389.201349831271, 6405.871882562369, 5680.971595142039, 5682.147677848315, 5682.54539636828, 5683.039351423794, 5690.715464226772, 7036.894446583254, 7039.472039597051, 7044.964775176091, 7060.682269297894, 7062.646867656648, 4471.441069866267, 4580.587747102777, 4600.470945841238, 4622.306654001893, 4629.421322334708, 7215.206327303992, 7383.556986580822, 7418.925810741877, 7537.321641052332, 7546.924530754677, 4608.769561521911, 4627.838025669085, 4651.116287905287, 4661.137689527381, 4676.158291507561, 4042.7372220805555, 4770.0936822003705, 4776.307435421844, 4783.1868582341085, 4784.067106914118, 4552.0, 5364.7049412282695, 5487.204355368529, 5490.227435145226, 5559.6664200148125, 6905.516613836983, 7064.7174113035935, 7131.572105673677, 7177.0, 7192.92807071933, 1631.6981358448725, 1655.8509734123986, 1656.685229806333, 1657.3619156624545, 1658.5687721192576, 1033.3128469567653, 1043.639944219243, 1060.6287799270194, 1065.142560239015, 1070.0476575847501, 6748.257691653914, 6772.83067923296, 6786.491013174032, 6793.626350550767, 6794.898076528856, 6266.0, 7341.265873412616, 7345.926540734525, 7358.705651773977, 7369.336759691653, 6764.188297404343, 6772.83067923296, 6772.830679233059, 6777.762778302736, 6784.525083244125, 3787.659110680052, 3873.205992771475, 3922.1371298314325, 3929.685625149981, 3931.76409415436, 6343.270523889812, 7703.807404814813, 7705.190954949761, 7730.420218483636, 7732.226777322223, 6418.711157997901, 7594.7088994871, 7607.087149542091, 7619.657115429708, 7623.313901748869, 7701.961490192513, 7708.460407771514, 7710.421718371144, 7716.151223365538, 7723.189065148304, 6097.908531371944, 7138.714451421885, 7220.0613920190035, 7346.155192152971, 7353.0441042664115, 7289.489735718449, 7301.707931682886, 7351.926480735124, 7357.0, 7384.150822655463, 7497.9250207497225, 7737.883931741141, 7765.990421245202, 7794.493357931717, 7796.10344810354, 4641.930371044505, 4735.408073990751, 4744.193487107131, 4749.643776716691, 4755.976220118877, 7389.556626602421, 7399.963000184965, 7405.8148546286775, 7424.0, 7428.2571742825285, 7181.712731490891, 7182.604956727221, 7184.137903451619, 7191.993120962965, 7192.352688258082, 6931.237563868071, 7142.178649455172, 7150.821229469305, 7154.177269613853, 7196.0285361475535, 5631.63394379364, 6974.058502102152, 6976.02335672996, 6977.0, 6999.1950925644205, 5730.255066841451, 7146.142462904485, 7151.60666163366, 7158.105236845395, 7165.605891675799, 6989.860202796017, 6997.440204783707, 6997.47518936092, 6997.650117494003, 7020.473464490082], "value": 5175.105832593184, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7348081209952, 778.1945686214768, 790.3795520516396, 798.4929569723228, 803.1446509467419, 15756.369745210191, 15848.28682709278, 15998.280077396515, 16004.599885002881, 16005.879588428814, 14645.780313295283, 14740.262986850668, 14759.631009224775, 14774.556763297118, 14782.630434239149, 776.4642396746241, 798.9892785626188, 945.7493764152505, 987.53585814667, 993.2203220471931, 971.5433746139339, 972.222222222223, 983.1593987140963, 985.581128020592, 986.6398764450995, 1035.2390992620417, 1054.0408228512056, 1054.8206804843196, 1055.9809783558865, 1057.5452555401175, 822.9958850205741, 829.3282441222628, 843.1821133500525, 843.8227972125861, 1032.3908893752684, 663.8672265546861, 778.5640041576735, 778.979536806785, 779.4232268121606, 781.316348195329, 15296.694066118727, 15470.303836327279, 15531.767023494656, 15552.533423997298, 15554.688906221925, 12216.816747748791, 12528.686782830411, 12618.0, 12638.936805315914, 12792.936035319764, 10395.584176632925, 10436.07789818852, 10839.83740243897, 10958.506867190996, 11093.611723589716, 3666.4133738601695, 3669.7064234861414, 3720.9441858372147, 3721.702263818888, 3808.086059345737, 80527.0, 81193.18806811975, 81197.18802811955, 81472.18527814705, 82213.17786822114, 9794.265430092772, 9805.166560842408, 9870.753231169278, 10068.59725610982, 10187.0, 23837.642435363483, 23875.0, 23889.163879264142, 23902.521949560913, 23915.282541523782, 7713.3443657288635, 7720.652570634223, 7841.333486653584, 7843.764687059397, 8038.397120216007, 4100.200460910094, 4119.691023173274, 4123.113530590937, 4135.214309281227, 4149.356849688304, 3730.235301763132, 3785.73499855013, 3793.1465420280215, 3793.8103094845146, 3796.1079146401125, 655.5312951239887, 664.4285914113858, 674.6103027762824, 686.361683634225, 701.3932947999944, 542.4710906865853, 613.294711082259, 615.5721773367467, 639.5139693832627, 641.9679016049179, 6947.478939079489, 7355.374793142642, 8292.502449853027, 8672.262857657044, 8889.0, 607.4654304212265, 611.2939554814196, 621.810347843903, 636.7834936121741, 643.3759253524074, 3143.811371317728, 3328.589618755159, 3900.4539364488996, 3987.960120398817, 4022.2156679447226, 88526.0, 90697.54651226701, 91724.54137729268, 91799.16401672062, 94486.52756736173, 79176.0, 79730.80403793948, 80273.59863200647, 80479.0, 80792.59603701944, 66268.67462650816, 69881.65059174671, 70107.64946175237, 71676.64161679262, 72094.63952680203, 8619.525926074126, 8715.389922705603, 8720.520371379635, 8775.0, 8869.246114080117, 48651.0, 50317.24524132068, 51109.722256943875, 51323.0, 51333.48666513287, 66285.67428651304, 68546.0, 70596.0, 70644.94032589618, 71310.0, 11028.117750579773, 11205.383703896037, 11280.661580152608, 11418.0, 12129.454174562343, 11764.764704705687, 11852.585159519376, 11967.162298639012, 12167.878321216675, 12878.35608219604, 11365.715857103638, 11706.531738730697, 11765.941170294094, 12016.519339226334, 12069.0, 11591.420428978687, 11650.650141204922, 11690.415479226174, 11735.706607334543, 11840.940795295968, 11530.769384612093, 11533.480993355151, 11697.356645384245, 11844.111691623335, 11913.523459061887, 9542.522873856418, 9631.662891798753, 9917.950410247902, 9923.950380248052, 10018.148457381205, 9509.476978766234, 9564.521773911416, 9616.182624476998, 9618.0, 9647.951760241154], "value": 7132.506431246167, "unit": "score"}], "name": "dromaeo_css", "value": 7590.693888656926, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 118.0, 113.0, 111.0, 112.0, 112.0, 111.0, 111.0, 133.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 121.0, 141.0, 169.0, 117.0, 138.0, 144.0, 97.0, 181.0, 148.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 196.0, 263.0, 202.0, 182.0, 183.0, 182.0, 185.0, 184.0], "value": 194.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 83.0, 96.0, 191.0, 46.0, 61.0, 73.0, 81.0, 139.0, 55.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 146.0, 113.0, 122.0, 122.0, 120.0, 79.0, 79.0, 126.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 88.0, 84.0, 89.0, 86.0, 88.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 120.0, 148.0, 116.0, 94.0, 93.0, 92.0, 93.0, 92.0], "value": 103.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 86.0, 85.0, 84.0, 84.0, 83.0, 85.0, 104.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 63.0, 61.0, 61.0, 62.0, 61.0, 76.0, 58.0, 56.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 71.0, 69.0, 71.0, 68.0, 64.0, 64.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 102.0, 100.0, 104.0, 80.0, 80.0, 80.0, 79.0, 82.0, 84.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 125.0, 115.0, 142.0, 144.0, 120.0, 125.0, 142.0, 137.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 160.0, 156.0, 169.0, 162.0, 165.0, 162.0, 163.0, 162.0, 160.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 68.0, 67.0, 66.0, 65.0, 67.0, 66.0, 68.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1498.6, "alertThreshold": 2.0}]} 09:02:27 INFO - Return code: 0 09:02:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:02:27 ERROR - # TBPL SUCCESS # 09:02:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:02:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:02:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:02:27 INFO - 2016-06-23 09:02:27.809 screenresolution[1681:10112] starting screenresolution argv=screenresolution get 09:02:27 INFO - 2016-06-23 09:02:27.811 screenresolution[1681:10112] Display 0: 1600x1200x32@60 09:02:27 INFO - 2016-06-23 09:02:27.817 screenresolution[1682:10115] starting screenresolution argv=screenresolution list 09:02:27 INFO - Available Modes on Display 0 09:02:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:02:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:02:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:02:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:02:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:02:28 INFO - Intel Iris: 09:02:28 INFO - Chipset Model: Intel Iris 09:02:28 INFO - Type: GPU 09:02:28 INFO - Bus: Built-In 09:02:28 INFO - VRAM (Dynamic, Max): 1536 MB 09:02:28 INFO - Vendor: Intel (0x8086) 09:02:28 INFO - Device ID: 0x0a2e 09:02:28 INFO - Revision ID: 0x0009 09:02:28 INFO - Displays: 09:02:28 INFO - Display: 09:02:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:02:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:02:28 INFO - Display Serial Number: 1600x1200 60 09:02:28 INFO - Main Display: Yes 09:02:28 INFO - Mirror: Off 09:02:28 INFO - Online: Yes 09:02:28 INFO - Rotation: Supported 09:02:28 INFO - Return code: 0 09:02:28 INFO - Running post-action listener: _resource_record_post_action 09:02:28 INFO - Running post-run listener: _resource_record_post_run 09:02:29 INFO - Total resource usage - Wall time: 1194s; CPU: 52.0%; Read bytes: 37008896; Write bytes: 493256192; Read time: 238; Write time: 1560 09:02:29 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191300096; Write bytes: 186685440; Read time: 17310; Write time: 417 09:02:29 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 35227136; Write bytes: 295781888; Read time: 222; Write time: 1107 09:02:29 INFO - Running post-run listener: _upload_blobber_files 09:02:29 INFO - Blob upload gear active. 09:02:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:29 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 09:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:02:29 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:02:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:02:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:30 INFO - (blobuploader) - INFO - Done attempting. 09:02:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:02:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:02:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:31 INFO - (blobuploader) - INFO - Done attempting. 09:02:31 INFO - (blobuploader) - INFO - Iteration through files over. 09:02:31 INFO - Return code: 0 09:02:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:02:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:02:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e099e64c10adaae5a65eccd0e6d36c48de0bd6261aa1938693d8d7e4e16509fdc7402228bc01e25ae67009a5e240a94d59f6d689074f8611fc3fb096e01b9978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd9955a7e4b6f1d484732fcc8d66053c5b78c5171daacf51406d3332c772e6b8ddc3e833a05ee2982311ddab0669b1582e5fb521802b26eacdf9c60085f94db0"} 09:02:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:02:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:02:31 INFO - Contents: 09:02:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e099e64c10adaae5a65eccd0e6d36c48de0bd6261aa1938693d8d7e4e16509fdc7402228bc01e25ae67009a5e240a94d59f6d689074f8611fc3fb096e01b9978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd9955a7e4b6f1d484732fcc8d66053c5b78c5171daacf51406d3332c772e6b8ddc3e833a05ee2982311ddab0669b1582e5fb521802b26eacdf9c60085f94db0"} 09:02:31 INFO - Running post-run listener: copy_logs_to_upload_dir 09:02:31 INFO - Copying logs to upload dir... 09:02:31 INFO - mkdir: /builds/slave/test/build/upload/logs 09:02:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.578349 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-23 09:02:31.259850) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 09:02:31.263196) ========= 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.mm5220xBE8/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.SFDhO5l8ly/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e099e64c10adaae5a65eccd0e6d36c48de0bd6261aa1938693d8d7e4e16509fdc7402228bc01e25ae67009a5e240a94d59f6d689074f8611fc3fb096e01b9978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd9955a7e4b6f1d484732fcc8d66053c5b78c5171daacf51406d3332c772e6b8ddc3e833a05ee2982311ddab0669b1582e5fb521802b26eacdf9c60085f94db0"} build_url:https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010701 build_url: 'https://queue.taskcluster.net/v1/task/EZDRWxUiTYy075hvH2QDuA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e099e64c10adaae5a65eccd0e6d36c48de0bd6261aa1938693d8d7e4e16509fdc7402228bc01e25ae67009a5e240a94d59f6d689074f8611fc3fb096e01b9978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd9955a7e4b6f1d484732fcc8d66053c5b78c5171daacf51406d3332c772e6b8ddc3e833a05ee2982311ddab0669b1582e5fb521802b26eacdf9c60085f94db0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 09:02:31.299136) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:02:31.299522) ========= 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.mm5220xBE8/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.SFDhO5l8ly/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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.005146 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:02:31.348885) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 09:02:31.349246) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 09:02:31.349612) ========= ========= Total master_lag: 0.20 =========