builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0363 starttime: 1464211285.65 results: success (0) buildid: 20160525120742 builduid: 5354af42264947e7a3ea99b0e003bccf revision: 7abf386fee3f6aa34f9d3058dd033af8c495a5ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 14:21:25.655309) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 14:21:25.655997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 14:21:25.656515) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 14:21:25.678703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:21:25.679060) ========= 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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-25 14:21:25-- 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% 135M=0s 2016-05-25 14:21:25 (135 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078494 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:21:25.778567) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:21:25.779153) ========= 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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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.020153 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:21:25.829582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 14:21:25.830229) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7abf386fee3f6aa34f9d3058dd033af8c495a5ef --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 7abf386fee3f6aa34f9d3058dd033af8c495a5ef --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lDOyH5QTBG/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.w71t6Dn2SB/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-25 14:21:25,896 truncating revision to first 12 chars 2016-05-25 14:21:25,896 Setting DEBUG logging. 2016-05-25 14:21:25,896 attempt 1/10 2016-05-25 14:21:25,896 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7abf386fee3f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 14:21:27,464 unpacking tar archive at: mozilla-beta-7abf386fee3f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.834588 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 14:21:27.684450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 14:21:27.684779) ========= script_repo_revision: 7abf386fee3f6aa34f9d3058dd033af8c495a5ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 14:21:27.685148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 14:21:27.685408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 14:21:27.700993) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-25 14:21:27.701256) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 14:21:27 INFO - MultiFileLogger online at 20160525 14:21:27 in /builds/slave/test 14:21:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:21:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:21:27 INFO - {'append_to_log': False, 14:21:27 INFO - 'base_work_dir': '/builds/slave/test', 14:21:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:21:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:21:27 INFO - 'branch': 'Mozilla-Beta', 14:21:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:21:27 INFO - 'config_files': ('talos/mac_config.py',), 14:21:27 INFO - 'default_actions': ('clobber', 14:21:27 INFO - 'read-buildbot-config', 14:21:27 INFO - 'download-and-extract', 14:21:27 INFO - 'populate-webroot', 14:21:27 INFO - 'create-virtualenv', 14:21:27 INFO - 'install', 14:21:27 INFO - 'run-tests'), 14:21:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:21:27 INFO - 'download_minidump_stackwalk': True, 14:21:27 INFO - 'download_symbols': 'ondemand', 14:21:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:21:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:21:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:21:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:21:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:21:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:21:27 INFO - 'installer_path': 'installer.exe', 14:21:27 INFO - 'log_level': 'info', 14:21:27 INFO - 'log_name': 'talos', 14:21:27 INFO - 'log_to_console': True, 14:21:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:21:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:21:27 INFO - 'opt_config_files': (), 14:21:27 INFO - 'pip_index': False, 14:21:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:21:27 INFO - 'cmd': ('bash', 14:21:27 INFO - '-c', 14:21:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:21:27 INFO - 'enabled': True, 14:21:27 INFO - 'halt_on_failure': False, 14:21:27 INFO - 'name': 'check_screen_resolution'},), 14:21:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:21:27 INFO - 'cmd': ('bash', 14:21:27 INFO - '-c', 14:21:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:21:27 INFO - 'enabled': True, 14:21:27 INFO - 'halt_on_failure': False, 14:21:27 INFO - 'name': 'check_screen_resolution'},), 14:21:27 INFO - 'run_cmd_checks_enabled': True, 14:21:27 INFO - 'sps_profile': False, 14:21:27 INFO - 'sps_profile_interval': 0, 14:21:27 INFO - 'suite': 'dromaeojs-e10s', 14:21:27 INFO - 'system_bits': '32', 14:21:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:21:27 INFO - 'title': 't-yosemite-r7-0363', 14:21:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:21:27 INFO - 'use_talos_json': True, 14:21:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:21:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:21:27 INFO - 'work_dir': 'build'} 14:21:27 INFO - ##### 14:21:27 INFO - ##### Running clobber step. 14:21:27 INFO - ##### 14:21:27 INFO - Running pre-action listener: _resource_record_pre_action 14:21:27 INFO - Running main action method: clobber 14:21:27 INFO - rmtree: /builds/slave/test/build 14:21:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:21:29 INFO - Running post-action listener: _resource_record_post_action 14:21:29 INFO - ##### 14:21:29 INFO - ##### Running read-buildbot-config step. 14:21:29 INFO - ##### 14:21:29 INFO - Running pre-action listener: _resource_record_pre_action 14:21:29 INFO - Running main action method: read_buildbot_config 14:21:29 INFO - Using buildbot properties: 14:21:29 INFO - { 14:21:29 INFO - "project": "", 14:21:29 INFO - "product": "firefox", 14:21:29 INFO - "script_repo_revision": "production", 14:21:29 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:21:29 INFO - "repository": "", 14:21:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:21:29 INFO - "buildid": "20160525120742", 14:21:29 INFO - "pgo_build": "False", 14:21:29 INFO - "basedir": "/builds/slave/test", 14:21:29 INFO - "buildnumber": 23, 14:21:29 INFO - "slavename": "t-yosemite-r7-0363", 14:21:29 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:21:29 INFO - "platform": "yosemite_r7", 14:21:29 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:21:29 INFO - "branch": "mozilla-beta", 14:21:29 INFO - "repo_path": "releases/mozilla-beta", 14:21:29 INFO - "revision": "7abf386fee3f6aa34f9d3058dd033af8c495a5ef", 14:21:29 INFO - "stage_platform": "macosx64", 14:21:29 INFO - "builduid": "5354af42264947e7a3ea99b0e003bccf", 14:21:29 INFO - "slavebuilddir": "test" 14:21:29 INFO - } 14:21:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 14:21:29 INFO - Running post-action listener: _resource_record_post_action 14:21:29 INFO - ##### 14:21:29 INFO - ##### Running download-and-extract step. 14:21:29 INFO - ##### 14:21:29 INFO - Running pre-action listener: _resource_record_pre_action 14:21:29 INFO - Running main action method: download_and_extract 14:21:29 INFO - mkdir: /builds/slave/test/build/tests 14:21: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')]} 14:21:29 INFO - https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:21:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 14:21:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 14:21:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 14:21:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 14:21:31 INFO - Downloaded 1241 bytes. 14:21:31 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 14:21:31 INFO - Using the following test package requirements: 14:21:31 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:21:31 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:21:31 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 14:21:31 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:21:31 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 14:21:31 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:21:31 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:21:31 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 14:21:31 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:21:31 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:21:31 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 14:21:31 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:21:31 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 14:21:31 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:21:31 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 14:21:31 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:21:31 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:21:31 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 14:21:31 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 14:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:31 INFO - https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:21:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:21:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:21:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 14:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 14:21:38 INFO - Downloaded 17816932 bytes. 14:21:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:21:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:21:41 INFO - Return code: 0 14:21:41 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:41 INFO - https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:21:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:21:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:21:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 14:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 14:21:44 INFO - Downloaded 17816932 bytes. 14:21:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:21:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:21:47 INFO - Return code: 0 14:21:47 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')]} 14:21:47 INFO - https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:21:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 14:21:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 14:21:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 14:21:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 14:21:49 INFO - Downloaded 10845194 bytes. 14:21:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:21:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:21:49 INFO - Return code: 0 14:21: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')]} 14:21:49 INFO - https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 14:21:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:21:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:21:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 14:21:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 14:21:54 INFO - Downloaded 88465281 bytes. 14:21:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:21:54 INFO - mkdir: /builds/slave/test/properties 14:21:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:21:54 INFO - Writing to file /builds/slave/test/properties/build_url 14:21:54 INFO - Contents: 14:21:54 INFO - build_url:https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:21:55 INFO - Running post-action listener: _resource_record_post_action 14:21:55 INFO - Running post-action listener: set_extra_try_arguments 14:21:55 INFO - ##### 14:21:55 INFO - ##### Running populate-webroot step. 14:21:55 INFO - ##### 14:21:55 INFO - Running pre-action listener: _resource_record_pre_action 14:21:55 INFO - Running main action method: populate_webroot 14:21:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:21:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:21:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:21:55 INFO - '--tppagecycles', 14:21:55 INFO - '7'], 14:21:55 INFO - 'tests': ['tsvgm']}}, 14:21:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:21:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:21:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:21:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:21:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:21:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:21:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'talos_options': ['--e10s'], 14:21:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'tests': ['damp', 'tps']}, 14:21:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'talos_options': ['--e10s'], 14:21:55 INFO - 'tests': ['damp', 'tps']}, 14:21:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:21:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:21:55 INFO - 'other': {'tests': ['a11yr', 14:21:55 INFO - 'ts_paint', 14:21:55 INFO - 'tpaint', 14:21:55 INFO - 'sessionrestore', 14:21:55 INFO - 'sessionrestore_no_auto_restore', 14:21:55 INFO - 'tabpaint']}, 14:21:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:21:55 INFO - 'tests': ['a11yr', 14:21:55 INFO - 'ts_paint', 14:21:55 INFO - 'tpaint', 14:21:55 INFO - 'sessionrestore', 14:21:55 INFO - 'sessionrestore_no_auto_restore', 14:21:55 INFO - 'tabpaint']}, 14:21:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:21:55 INFO - 'tests': ['a11yr', 14:21:55 INFO - 'ts_paint', 14:21:55 INFO - 'tpaint', 14:21:55 INFO - 'sessionrestore', 14:21:55 INFO - 'sessionrestore_no_auto_restore', 14:21:55 INFO - 'tabpaint']}, 14:21:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:21:55 INFO - 'tests': ['a11yr', 14:21:55 INFO - 'ts_paint', 14:21:55 INFO - 'tpaint', 14:21:55 INFO - 'sessionrestore', 14:21:55 INFO - 'sessionrestore_no_auto_restore', 14:21:55 INFO - 'tabpaint']}, 14:21:55 INFO - 'other_l64': {'tests': ['a11yr', 14:21:55 INFO - 'ts_paint', 14:21:55 INFO - 'tpaint', 14:21:55 INFO - 'sessionrestore', 14:21:55 INFO - 'sessionrestore_no_auto_restore', 14:21:55 INFO - 'tabpaint']}, 14:21:55 INFO - 'other_nol64': {'tests': ['a11yr', 14:21:55 INFO - 'ts_paint', 14:21:55 INFO - 'tpaint', 14:21:55 INFO - 'sessionrestore', 14:21:55 INFO - 'sessionrestore_no_auto_restore', 14:21:55 INFO - 'tabpaint']}, 14:21:55 INFO - 'svgr': {'tests': ['tsvgx', 14:21:55 INFO - 'tsvgr_opacity', 14:21:55 INFO - 'tart', 14:21:55 INFO - 'tscrollx', 14:21:55 INFO - 'cart']}, 14:21:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:21:55 INFO - 'tests': ['tsvgx', 14:21:55 INFO - 'tsvgr_opacity', 14:21:55 INFO - 'tart', 14:21:55 INFO - 'tscrollx', 14:21:55 INFO - 'cart']}, 14:21:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'tests': ['tp5o']}, 14:21:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'talos_options': ['--e10s'], 14:21:55 INFO - 'tests': ['tp5o']}, 14:21:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'talos_options': ['--xperf_path', 14:21:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:55 INFO - 'tests': ['tp5n']}, 14:21:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'talos_options': ['--e10s', 14:21:55 INFO - '--xperf_path', 14:21:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:55 INFO - 'tests': ['tp5n']}}, 14:21:55 INFO - 'talos.zip': {'path': '', 14:21:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:21:55 INFO - Running post-action listener: _resource_record_post_action 14:21:55 INFO - ##### 14:21:55 INFO - ##### Running create-virtualenv step. 14:21:55 INFO - ##### 14:21:55 INFO - Running pre-action listener: _resource_record_pre_action 14:21:55 INFO - Running main action method: create_virtualenv 14:21:55 INFO - Creating virtualenv /builds/slave/test/build/venv 14:21:55 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 14:21:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:21:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:21:55 INFO - Using real prefix '/tools/python27' 14:21:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:21:56 INFO - Installing distribute.............................................................................................................................................................................................done. 14:21:59 INFO - Installing pip.................done. 14:21:59 INFO - Return code: 0 14:21:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:21:59 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')]} 14:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:59 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')]} 14:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:59 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 0x1031cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5624acce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103072d30>, '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 0x102ed6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103069b20>, '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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 14:21:59 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 14:21:59 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 14:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDOyH5QTBG/Render', 14:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:59 INFO - 'HOME': '/Users/cltbld', 14:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:59 INFO - 'LOGNAME': 'cltbld', 14:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:59 INFO - 'MOZ_NO_REMOTE': '1', 14:21:59 INFO - 'NO_EM_RESTART': '1', 14:21:59 INFO - 'PAGER': '/bin/cat', 14:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:59 INFO - 'PWD': '/builds/slave/test', 14:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:59 INFO - 'SHELL': '/bin/bash', 14:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w71t6Dn2SB/Listeners', 14:21:59 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 14:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:59 INFO - 'USER': 'cltbld', 14:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:59 INFO - 'XPC_FLAGS': '0x0', 14:21:59 INFO - 'XPC_SERVICE_NAME': '0', 14:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:59 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 14:21:59 INFO - Cleaning up... 14:21:59 INFO - Return code: 0 14:21:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:21:59 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')]} 14:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:59 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')]} 14:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:59 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 0x1031cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5624acce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103072d30>, '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 0x102ed6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103069b20>, '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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 14:21:59 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 14:21:59 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 14:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDOyH5QTBG/Render', 14:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:59 INFO - 'HOME': '/Users/cltbld', 14:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:59 INFO - 'LOGNAME': 'cltbld', 14:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:59 INFO - 'MOZ_NO_REMOTE': '1', 14:21:59 INFO - 'NO_EM_RESTART': '1', 14:21:59 INFO - 'PAGER': '/bin/cat', 14:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:59 INFO - 'PWD': '/builds/slave/test', 14:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:59 INFO - 'SHELL': '/bin/bash', 14:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w71t6Dn2SB/Listeners', 14:21:59 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 14:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:59 INFO - 'USER': 'cltbld', 14:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:59 INFO - 'XPC_FLAGS': '0x0', 14:21:59 INFO - 'XPC_SERVICE_NAME': '0', 14:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:00 INFO - Downloading/unpacking psutil>=0.7.1 14:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:22:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:03 INFO - Installing collected packages: psutil 14:22:03 INFO - Running setup.py install for psutil 14:22:03 INFO - building 'psutil._psutil_osx' extension 14:22:03 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 14:22:03 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 14:22:03 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 14:22:03 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 14:22:03 INFO - building 'psutil._psutil_posix' extension 14:22:03 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 14:22:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:22:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:22:03 INFO - ^ 14:22:03 INFO - 1 warning generated. 14:22:03 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 14:22:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:03 INFO - Successfully installed psutil 14:22:03 INFO - Cleaning up... 14:22:03 INFO - Return code: 0 14:22:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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', '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 0x1031cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5624acce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103072d30>, '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 0x102ed6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103069b20>, '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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 14:22: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:22: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 mozsystemmonitor==0.0.0 14:22:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDOyH5QTBG/Render', 14:22:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:03 INFO - 'HOME': '/Users/cltbld', 14:22:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:03 INFO - 'LOGNAME': 'cltbld', 14:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:03 INFO - 'MOZ_NO_REMOTE': '1', 14:22:03 INFO - 'NO_EM_RESTART': '1', 14:22:03 INFO - 'PAGER': '/bin/cat', 14:22:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:03 INFO - 'PWD': '/builds/slave/test', 14:22:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:03 INFO - 'SHELL': '/bin/bash', 14:22:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w71t6Dn2SB/Listeners', 14:22:03 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 14:22:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:03 INFO - 'USER': 'cltbld', 14:22:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:03 INFO - 'XPC_FLAGS': '0x0', 14:22:03 INFO - 'XPC_SERVICE_NAME': '0', 14:22:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:22:04 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 14:22:04 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 14:22:04 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 14:22:04 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 14:22:04 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 14:22:04 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 14:22:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:22:06 INFO - Installing collected packages: mozsystemmonitor 14:22:06 INFO - Running setup.py install for mozsystemmonitor 14:22:06 INFO - Successfully installed mozsystemmonitor 14:22:06 INFO - Cleaning up... 14:22:06 INFO - Return code: 0 14:22:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:06 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 0x1031cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5624acce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103072d30>, '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 0x102ed6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103069b20>, '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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 14:22:06 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 14:22:06 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 14:22:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDOyH5QTBG/Render', 14:22:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:06 INFO - 'HOME': '/Users/cltbld', 14:22:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:06 INFO - 'LOGNAME': 'cltbld', 14:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:06 INFO - 'MOZ_NO_REMOTE': '1', 14:22:06 INFO - 'NO_EM_RESTART': '1', 14:22:06 INFO - 'PAGER': '/bin/cat', 14:22:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:06 INFO - 'PWD': '/builds/slave/test', 14:22:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:06 INFO - 'SHELL': '/bin/bash', 14:22:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w71t6Dn2SB/Listeners', 14:22:06 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 14:22:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:06 INFO - 'USER': 'cltbld', 14:22:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:06 INFO - 'XPC_FLAGS': '0x0', 14:22:06 INFO - 'XPC_SERVICE_NAME': '0', 14:22:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:07 INFO - Downloading/unpacking blobuploader==1.2.4 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22:09 INFO - Downloading blobuploader-1.2.4.tar.gz 14:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:22:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:22:09 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 14:22:09 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 14:22:09 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 14:22:09 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 14:22:09 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 14:22:09 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 14:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:22:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22:10 INFO - Downloading docopt-0.6.1.tar.gz 14:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:22:10 INFO - Installing collected packages: blobuploader, requests, docopt 14:22:10 INFO - Running setup.py install for blobuploader 14:22:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:22:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:22:11 INFO - Running setup.py install for requests 14:22:11 INFO - Running setup.py install for docopt 14:22:11 INFO - Successfully installed blobuploader requests docopt 14:22:11 INFO - Cleaning up... 14:22:11 INFO - Return code: 0 14:22:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:11 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 0x1031cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5624acce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103072d30>, '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 0x102ed6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103069b20>, '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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 14:22:11 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 14:22:11 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 14:22:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDOyH5QTBG/Render', 14:22:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:11 INFO - 'HOME': '/Users/cltbld', 14:22:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:11 INFO - 'LOGNAME': 'cltbld', 14:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:11 INFO - 'MOZ_NO_REMOTE': '1', 14:22:11 INFO - 'NO_EM_RESTART': '1', 14:22:11 INFO - 'PAGER': '/bin/cat', 14:22:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:11 INFO - 'PWD': '/builds/slave/test', 14:22:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:11 INFO - 'SHELL': '/bin/bash', 14:22:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w71t6Dn2SB/Listeners', 14:22:11 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 14:22:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:11 INFO - 'USER': 'cltbld', 14:22:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:11 INFO - 'XPC_FLAGS': '0x0', 14:22:11 INFO - 'XPC_SERVICE_NAME': '0', 14:22:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:11 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-diwger-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:12 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-CFefbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:12 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-doK9pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:12 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-PjNxxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:12 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-6kXQ5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:12 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-ij5339-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:12 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-CDeZOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:12 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-RwSH5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:12 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-H9S5Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:12 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-mtSp_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:13 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-u66J7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:13 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-z_O1IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:13 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-yhVrlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:13 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-gvURPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:13 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-PL4la4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:13 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-OJfQsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:13 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-ATEvBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:22:13 INFO - Running setup.py install for manifestparser 14:22:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:22:13 INFO - Running setup.py install for mozcrash 14:22:14 INFO - Running setup.py install for mozdebug 14:22:14 INFO - Running setup.py install for mozdevice 14:22:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:22:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:22:14 INFO - Running setup.py install for mozfile 14:22:14 INFO - Running setup.py install for mozhttpd 14:22:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:22:14 INFO - Running setup.py install for mozinfo 14:22:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:22:14 INFO - Running setup.py install for mozInstall 14:22:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:22:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:22:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:22:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:22:14 INFO - Running setup.py install for mozleak 14:22:15 INFO - Running setup.py install for mozlog 14:22:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:22:15 INFO - Running setup.py install for moznetwork 14:22:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:22:15 INFO - Running setup.py install for mozprocess 14:22:15 INFO - Running setup.py install for mozprofile 14:22:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:22:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:22:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:22:15 INFO - Running setup.py install for mozrunner 14:22:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:22:15 INFO - Running setup.py install for mozscreenshot 14:22:15 INFO - Running setup.py install for moztest 14:22:16 INFO - Running setup.py install for mozversion 14:22:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:22:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:22:16 INFO - Cleaning up... 14:22:16 INFO - Return code: 0 14:22:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:16 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 0x1031cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5624acce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103072d30>, '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 0x102ed6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103069b20>, '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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 14:22:16 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 14:22:16 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 14:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDOyH5QTBG/Render', 14:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:16 INFO - 'HOME': '/Users/cltbld', 14:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:16 INFO - 'LOGNAME': 'cltbld', 14:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:16 INFO - 'MOZ_NO_REMOTE': '1', 14:22:16 INFO - 'NO_EM_RESTART': '1', 14:22:16 INFO - 'PAGER': '/bin/cat', 14:22:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:16 INFO - 'PWD': '/builds/slave/test', 14:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:16 INFO - 'SHELL': '/bin/bash', 14:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w71t6Dn2SB/Listeners', 14:22:16 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 14:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:16 INFO - 'USER': 'cltbld', 14:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:16 INFO - 'XPC_FLAGS': '0x0', 14:22:16 INFO - 'XPC_SERVICE_NAME': '0', 14:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:16 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-auFy2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:16 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)) 14:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:16 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-A1B8LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:16 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)) 14:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:16 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-hzfVYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:16 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)) 14:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:16 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-h6f_9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:16 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)) 14:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:16 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-BZk37N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:17 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)) 14:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:17 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-e_5AvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:17 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)) 14:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:17 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-ca2sre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:17 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)) 14:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:17 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-FGYU8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:17 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)) 14:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:17 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-dV3_sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:17 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)) 14:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:17 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-vsjtbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:17 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)) 14:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:17 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-74wmCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:17 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)) 14:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:17 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-2zIUuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:17 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)) 14:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:17 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-uGLG4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:17 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)) 14:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:17 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-Ah_yZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:18 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)) 14:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:18 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-HT2Dsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:18 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)) 14:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:18 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-K17bac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:18 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)) 14:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:18 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-P0Ro8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:18 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)) 14:22:18 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)) 14:22:18 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)) 14:22:18 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)) 14:22:18 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)) 14:22:18 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)) 14:22:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:20 INFO - Downloading blessings-1.6.tar.gz 14:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:22:20 INFO - Installing collected packages: blessings 14:22:20 INFO - Running setup.py install for blessings 14:22:20 INFO - Successfully installed blessings 14:22:20 INFO - Cleaning up... 14:22:21 INFO - Return code: 0 14:22:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:21 INFO - Reading from file tmpfile_stdout 14:22:21 INFO - Current package versions: 14:22:21 INFO - blessings == 1.6 14:22:21 INFO - blobuploader == 1.2.4 14:22:21 INFO - docopt == 0.6.1 14:22:21 INFO - manifestparser == 1.1 14:22:21 INFO - mozInstall == 1.12 14:22:21 INFO - mozcrash == 0.17 14:22:21 INFO - mozdebug == 0.1 14:22:21 INFO - mozdevice == 0.48 14:22:21 INFO - mozfile == 1.2 14:22:21 INFO - mozhttpd == 0.7 14:22:21 INFO - mozinfo == 0.9 14:22:21 INFO - mozleak == 0.1 14:22:21 INFO - mozlog == 3.1 14:22:21 INFO - moznetwork == 0.27 14:22:21 INFO - mozprocess == 0.22 14:22:21 INFO - mozprofile == 0.28 14:22:21 INFO - mozrunner == 6.11 14:22:21 INFO - mozscreenshot == 0.1 14:22:21 INFO - mozsystemmonitor == 0.0 14:22:21 INFO - moztest == 0.7 14:22:21 INFO - mozversion == 1.4 14:22:21 INFO - psutil == 3.1.1 14:22:21 INFO - requests == 1.2.3 14:22:21 INFO - wsgiref == 0.1.2 14:22:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:21 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')]} 14:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:21 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')]} 14:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:21 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 0x1031cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5624acce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103072d30>, '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 0x102ed6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103069b20>, '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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 14:22:21 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 14:22:21 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 14:22:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDOyH5QTBG/Render', 14:22:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:21 INFO - 'HOME': '/Users/cltbld', 14:22:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:21 INFO - 'LOGNAME': 'cltbld', 14:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:21 INFO - 'MOZ_NO_REMOTE': '1', 14:22:21 INFO - 'NO_EM_RESTART': '1', 14:22:21 INFO - 'PAGER': '/bin/cat', 14:22:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:21 INFO - 'PWD': '/builds/slave/test', 14:22:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:21 INFO - 'SHELL': '/bin/bash', 14:22:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w71t6Dn2SB/Listeners', 14:22:21 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 14:22:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:21 INFO - 'USER': 'cltbld', 14:22:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:21 INFO - 'XPC_FLAGS': '0x0', 14:22:21 INFO - 'XPC_SERVICE_NAME': '0', 14:22:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:21 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)) 14:22:21 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)) 14:22:21 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)) 14:22:21 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)) 14:22:21 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)) 14:22:21 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)) 14:22:21 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)) 14:22:21 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)) 14:22:21 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)) 14:22:21 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)) 14:22:21 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)) 14:22:21 INFO - Cleaning up... 14:22:21 INFO - Return code: 0 14:22:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:22:21 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')]} 14:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:21 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')]} 14:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:21 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 0x1031cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5624acce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103072d30>, '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 0x102ed6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103069b20>, '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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 14:22:21 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 14:22:21 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 14:22:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDOyH5QTBG/Render', 14:22:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:21 INFO - 'HOME': '/Users/cltbld', 14:22:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:21 INFO - 'LOGNAME': 'cltbld', 14:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:21 INFO - 'MOZ_NO_REMOTE': '1', 14:22:21 INFO - 'NO_EM_RESTART': '1', 14:22:21 INFO - 'PAGER': '/bin/cat', 14:22:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:21 INFO - 'PWD': '/builds/slave/test', 14:22:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:21 INFO - 'SHELL': '/bin/bash', 14:22:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w71t6Dn2SB/Listeners', 14:22:21 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 14:22:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:21 INFO - 'USER': 'cltbld', 14:22:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:21 INFO - 'XPC_FLAGS': '0x0', 14:22:21 INFO - 'XPC_SERVICE_NAME': '0', 14:22:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:21 INFO - Downloading/unpacking jsonschema 14:22:21 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 14:22:21 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 14:22:21 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 14:22:21 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 14:22:21 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 14:22:21 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 14:22:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:22:24 INFO - Downloading/unpacking functools32 (from jsonschema) 14:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:24 INFO - Downloading functools32-3.2.3-2.tar.gz 14:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:22:24 INFO - warning: no files found matching '*.txt' 14:22:24 INFO - no previously-included directories found matching 'build' 14:22:24 INFO - no previously-included directories found matching 'dist' 14:22:24 INFO - no previously-included directories found matching '.git*' 14:22:24 INFO - Installing collected packages: jsonschema, functools32 14:22:24 INFO - Running setup.py install for functools32 14:22:24 INFO - warning: no files found matching '*.txt' 14:22:24 INFO - no previously-included directories found matching 'build' 14:22:24 INFO - no previously-included directories found matching 'dist' 14:22:24 INFO - no previously-included directories found matching '.git*' 14:22:24 INFO - Successfully installed jsonschema functools32 14:22:24 INFO - Cleaning up... 14:22:25 INFO - Return code: 0 14:22:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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')]} 14:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1031cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5624acce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103072d30>, '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 0x102ed6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103069b20>, '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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 14:22: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', 'flake8'] in /builds/slave/test/build 14:22: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 flake8 14:22:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDOyH5QTBG/Render', 14:22:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:25 INFO - 'HOME': '/Users/cltbld', 14:22:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:25 INFO - 'LOGNAME': 'cltbld', 14:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:25 INFO - 'MOZ_NO_REMOTE': '1', 14:22:25 INFO - 'NO_EM_RESTART': '1', 14:22:25 INFO - 'PAGER': '/bin/cat', 14:22:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:25 INFO - 'PWD': '/builds/slave/test', 14:22:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:25 INFO - 'SHELL': '/bin/bash', 14:22:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w71t6Dn2SB/Listeners', 14:22:25 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 14:22:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:25 INFO - 'USER': 'cltbld', 14:22:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:25 INFO - 'XPC_FLAGS': '0x0', 14:22:25 INFO - 'XPC_SERVICE_NAME': '0', 14:22:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:25 INFO - Downloading/unpacking flake8 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:22:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:22:27 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 14:22:27 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 14:22:27 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 14:22:27 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 14:22:27 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 14:22:27 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 14:22:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:22:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:22:29 INFO - no previously-included directories found matching 'docs/_build' 14:22:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:22:29 INFO - Running setup.py install for pep8 14:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:22:29 INFO - no previously-included directories found matching 'docs/_build' 14:22:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:22:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:22:29 INFO - Cleaning up... 14:22:29 INFO - Return code: 0 14:22:29 INFO - Running post-action listener: _resource_record_post_action 14:22:29 INFO - Running post-action listener: _start_resource_monitoring 14:22:29 INFO - Starting resource monitoring. 14:22:29 INFO - ##### 14:22:29 INFO - ##### Running install step. 14:22:29 INFO - ##### 14:22:29 INFO - Running pre-action listener: _resource_record_pre_action 14:22:29 INFO - Running main action method: install 14:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:29 INFO - Reading from file tmpfile_stdout 14:22:29 INFO - Detecting whether we're running mozinstall >=1.0... 14:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:22:29 INFO - Reading from file tmpfile_stdout 14:22:29 INFO - Output received: 14:22:29 INFO - Usage: mozinstall [options] installer 14:22:29 INFO - Options: 14:22:29 INFO - -h, --help show this help message and exit 14:22:29 INFO - -d DEST, --destination=DEST 14:22:29 INFO - Directory to install application into. [default: 14:22:29 INFO - "/builds/slave/test"] 14:22:29 INFO - --app=APP Application being installed. [default: firefox] 14:22:29 INFO - mkdir: /builds/slave/test/build/application 14:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:22:52 INFO - Reading from file tmpfile_stdout 14:22:52 INFO - Output received: 14:22:52 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:22:52 INFO - Running post-action listener: _resource_record_post_action 14:22:52 INFO - ##### 14:22:52 INFO - ##### Running run-tests step. 14:22:52 INFO - ##### 14:22:52 INFO - Running pre-action listener: _resource_record_pre_action 14:22:52 INFO - Running main action method: run_tests 14:22:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:22:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:22:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:22:52 INFO - 2016-05-25 14:22:52.441 screenresolution[1952:18747] starting screenresolution argv=screenresolution get 14:22:52 INFO - 2016-05-25 14:22:52.443 screenresolution[1952:18747] Display 0: 1600x1200x32@60 14:22:52 INFO - 2016-05-25 14:22:52.449 screenresolution[1953:18750] starting screenresolution argv=screenresolution list 14:22:52 INFO - Available Modes on Display 0 14:22:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:22:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:22:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:22:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:22:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:22:52 INFO - Intel Iris: 14:22:52 INFO - Chipset Model: Intel Iris 14:22:52 INFO - Type: GPU 14:22:52 INFO - Bus: Built-In 14:22:52 INFO - VRAM (Dynamic, Max): 1536 MB 14:22:52 INFO - Vendor: Intel (0x8086) 14:22:52 INFO - Device ID: 0x0a2e 14:22:52 INFO - Revision ID: 0x0009 14:22:52 INFO - Displays: 14:22:52 INFO - Display: 14:22:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:22:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:22:52 INFO - Display Serial Number: 1600x1200 60 14:22:52 INFO - Main Display: Yes 14:22:52 INFO - Mirror: Off 14:22:52 INFO - Online: Yes 14:22:52 INFO - Rotation: Supported 14:22:52 INFO - Return code: 0 14:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:22:52 INFO - Python 2.7.3 14:22:52 INFO - Return code: 0 14:22:52 INFO - grabbing minidump binary from tooltool 14:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103072d30>, '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 0x102ed6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103069b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:22:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:22:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:22:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:22:52 INFO - Return code: 0 14:22:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:22:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:22:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:22:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:22:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:22:53 INFO - Return code: 0 14:22:53 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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0363', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:22:53 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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0363 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:22:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDOyH5QTBG/Render', 14:22:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:53 INFO - 'HOME': '/Users/cltbld', 14:22:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:53 INFO - 'LOGNAME': 'cltbld', 14:22:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:53 INFO - 'MOZ_NO_REMOTE': '1', 14:22:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:53 INFO - 'NO_EM_RESTART': '1', 14:22:53 INFO - 'PAGER': '/bin/cat', 14:22:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:53 INFO - 'PWD': '/builds/slave/test', 14:22:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:53 INFO - 'SHELL': '/bin/bash', 14:22:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w71t6Dn2SB/Listeners', 14:22:53 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 14:22:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:53 INFO - 'USER': 'cltbld', 14:22:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:53 INFO - 'XPC_FLAGS': '0x0', 14:22:53 INFO - 'XPC_SERVICE_NAME': '0', 14:22:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0363', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:22:54 INFO - mozversion application_buildid: 20160525120742 14:22:54 INFO - mozversion application_changeset: 7abf386fee3f6aa34f9d3058dd033af8c495a5ef 14:22:54 INFO - mozversion application_display_name: Firefox 14:22:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:22:54 INFO - mozversion application_name: Firefox 14:22:54 INFO - mozversion application_remotingname: firefox 14:22:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:22:54 INFO - mozversion application_vendor: Mozilla 14:22:54 INFO - mozversion application_version: 47.0 14:22:54 INFO - mozversion platform_buildid: 20160525120742 14:22:54 INFO - mozversion platform_changeset: 7abf386fee3f6aa34f9d3058dd033af8c495a5ef 14:22:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:22:54 INFO - mozversion platform_version: 47.0 14:22:54 INFO - using testdate: 1464211374 14:22:54 INFO - actual date: 1464211374 14:22:54 INFO - starting webserver on 'localhost:52751' 14:22:54 INFO - SUITE-START | Running 2 tests 14:22:54 INFO - TEST-START | dromaeo_css 14:22:54 INFO - operating with platform_type : mac_ 14:22:54 INFO - Initialising browser for dromaeo_css test... 14:22:54 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmp_T8YXj/profile http://localhost:52751/getInfo.html) 14:22:56 INFO - PROCESS | 1971 | __metrics Screen width/height:1600/1200 14:22:56 INFO - PROCESS | 1971 | colorDepth:24 14:22:56 INFO - PROCESS | 1971 | Browser inner width/height: 1024/689 14:22:56 INFO - PROCESS | 1971 | __metrics 14:22:56 ERROR - PROCESS | 1971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 14:22:57 INFO - TEST-INFO | 1971: exit 0 14:22:57 INFO - Browser initialized. 14:22:57 INFO - Running cycle 1/1 for dromaeo_css test... 14:22:57 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmp_T8YXj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:09 INFO - PROCESS | 1975 | RSS: Main: 168181760 14:23:09 INFO - PROCESS | 1975 | 14:23:58 INFO - PROCESS | 1975 | 1464211438965 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] 14:26:09 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:52751/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52751/tests/dromaeo/cssquery-ext.html) 14:26:10 INFO - PROCESS | 1975 | RSS: Main: 178683904 14:26:10 INFO - PROCESS | 1975 | 14:29:12 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:52751/tests/dromaeo/cssquery-ext.html (next: http://localhost:52751/tests/dromaeo/cssquery-jquery.html) 14:29:13 INFO - PROCESS | 1975 | RSS: Main: 190115840 14:29:13 INFO - PROCESS | 1975 | 14:32:15 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:52751/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52751/tests/dromaeo/cssquery-mootools.html) 14:32:15 INFO - PROCESS | 1975 | RSS: Main: 192274432 14:32:15 INFO - PROCESS | 1975 | 14:35:17 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:52751/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52751/tests/dromaeo/cssquery-prototype.html) 14:35:17 INFO - PROCESS | 1975 | RSS: Main: 195362816 14:35:17 INFO - PROCESS | 1975 | 14:38:20 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:52751/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52751/tests/dromaeo/cssquery-yui.html) 14:38:20 INFO - PROCESS | 1975 | RSS: Main: 194551808 14:38:20 INFO - PROCESS | 1975 | 14:41:22 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:52751/tests/dromaeo/cssquery-yui.html (next: http://localhost:52751/tests/dromaeo/cssquery-dojo.html) 14:41:23 INFO - PROCESS | 1975 | RSS: Main: 199921664 14:41:23 INFO - PROCESS | 1975 | 14:41:23 INFO - PROCESS | 1975 | __start_tp_report 14:41:23 INFO - PROCESS | 1975 | _x_x_mozilla_page_load 14:41:23 INFO - PROCESS | 1975 | _x_x_mozilla_page_load_details 14:41:23 INFO - PROCESS | 1975 | |i|pagename|runs| 14:41:23 INFO - PROCESS | 1975 | |0;dojo.html;3643.2167084076927;3652.086978255436;3672.8530858765653;3707.388280933645;3717.163638181408;5962.6124301920345;6033.095035744641;6048.8790224195545;6052.213212282408;6126.387361263883;6029.547783916213;6077.422644848743;6090.969545152279;6102.084687296908;6103.786367477139;5398.082326004579;5425.186222066702;5467.097928841737;5517.751701173457;5527.2538207342095;5388.595855310848;5437.157240627709;5460.590455715817;5509.118541033436;5528.585356098289;4667.6965997210245;4863.221884498481;5493.478119578654;5529.419410961831;5567.3040869891265;4419.911601767963;5491.450854914517;5533.889322213533;5569.582281328876;5600.8319750407145;5259.684418934876;5268.025415298143;5293.523582877521;5414.593905457106;5418;5782.653040817564;5859.824205273849;5918.437748413894;5952.9702351488395;5983.670898100646;6224.657643829588;6273.12176295319;6295.8740825183695;6324.272708638519;6347.365263473662;6172.87654246917;6303.873922521524;6371;6378.840528986766;6391.2330520337855;5227.26818245446;6136.815895523141;6170.228721409824;6201.844953876144;6211.875762484725;6301.369863013662;6462.1276127723095;6518.57629254097;6523.934760652332;6535.771248006392;6145.4161854623735;6180.969095154495;6229.906551401733;6248.250209974832;6260.906086408708;6297.2128483939505;6305.243370795442;6349.174607301022;6350.714217860207;6354.17395738551;4722.881927951828;5626.690532020696;6099.963006288942;6145.170401995762;6207.906881396782;6180.969095154495;6254.437100660963;6262.2172228471445;6278.591891527036;6317.084022816666;5057.266696329085;5122.513361230677;5139.383274007143;5142.717150556755;5145.871353216125;4511.751853648081;4532.841350552715;4538.205813982539;4579.038401935631;4630;5393.8112166074;6050.062240352752;6110.694465276719;6127.540434467343;6148.415900489446;5506.284183056177;6364.140840986408;6386.137871387396;6409.4231519163495;6431.710573024225;6018.488428483628;6036.849078773066;6086.543509236825;6130.47890929276;6171.907421388593;5592.748326325325;5608.6073974821375;5633.126865335879;5643.984082865041;5682.659040457585;5560.7219639018695;6602.10871532337;6630.53586248958;6633;6654.367835055662;6214.8135555933395;6293.213348331458;6311.431971122621;6343.777967771106;6366.490680745436;6507.642079685474;6517.837054073686;6531.11829902976;6541.443977261986;6542.803715888531;6228.875422491616;6245.875082498415;6257.812265632038;6261.029540421242;6282.654454005074;6182.536309776695;6242.781502647567;6299.527535434952;6303.747850086129;6315.810525684236;5031.823886163967;6205.348438413902;6215;6225.906611400923;6246.156768836149;6132.2947860996555;6230.00319948806;6232.127502149793;6237.656928868956;6246.812595622138;6124.295705993868;6145.955187618027;6147.323794382525;6155.076738489262;6183.783567575113;6196.907046394217;6200.7519699213335;6228.314885362697;6229.5327850410495;6240.126382306572;6117.188044311343;6230.15892854477;6247.187865577446;6252.968735156295;6271.153394291712 14:41:23 INFO - PROCESS | 1975 | |1;ext.html;515.8091506142728;602.1629934391196;620.8820324138417;658.9901151482728;669.1368135105714;39649.801750991275;39835.40246896295;40532;40670.99999999996;40679.79660101703;43569;43612.345814812805;43857.903552411204;44141;44162;9849.803003939916;9864.013598640151;9993.250506212027;10032;10037.397756134618;9872.506374681274;9906.058924402207;9945.552450139725;9966.455199444097;9987.101160895518;9869.358491698053;9942.751431214241;9977.503374493848;10010.749731256705;10066.043725846033;9868.358556693793;9881;9961.053699898497;9980.700578982642;9995.800083998352;9613.038696130401;9702.12680858719;9773.462459564722;9784.266180036526;9794.412335259907;35710.928672139875;40809.79595102005;40945.181096378205;41191.7940410296;41475.7926210367;2647.060293595784;3373.881914133018;3454.602720687103;3580.677739003502;4074.898127546835;27527.761250743766;29282.414351712847;29511;29728.8513557433;30348.78604855803;2774.0429551804596;2795.916122516328;2839.2901774556362;2900.4344152890194;2900.6809250982587;436186;437164;438009;440538;440647;38820;48022;74307;74707;74885;49524.75237623789;49961;50063.49936500588;50110.749446252536;50209.49790502121;17436.738448923275;17445.30218791234;17582.736258956127;17639.73540396895;17642.64714705699;14008.789868151986;14015.719685606231;14065.85934140666;14095.295235238196;14099.295035248197;15441;15506;15527.922360388126;15711.135887526296;15776.68446631061;6676.298988606223;6719.462443004548;6745.763898263537;6800.489963252776;6815.659217039129;865.7229686500259;957.8419560772534;1028.100412139378;1059.51262419288;1216.1365430544413;30373.544396834066;30415.847920760254;30428.84785576058;31076.067717968497;31114.377712445625;1108.894655007773;1139.1171841822488;1157.3403160198775;1187.6852634051984;1250.9687257818628;13310.866891331156;14593.78109328361;15020.549383518512;16014.599635008984;17035.48893533196;653364;689084;692534;701413;710042;66808.66595666991;66941.6570420033;66996.66501667461;67213;67288.66355668288;1564.2335255724613;1580.162513867652;1583.8732901367862;1587.8412158784029;1716.5794380376888;32021.519677205328;32021.679783202802;32097.679023209468;32205.51691724673;32507.674923250466;53249.733751331;53268;53859.46140538701;53987.730061349444;54037.459625403244;438279;443147.78426107665;443672;522406;524482.3775881096;33849.830750846086;34096.48855267123;35074.772382966476;35096.47355289622;35461.82269088638;46490;50523.74738126286;51047;51766.482335176166;51804;39091;39647.80176099101;40058.99852503711;40080.79959600183;41105.79447102865;38995.220095598495;39078.80460597679;39219.41170882496;39521.80239098786;40303.3954490677;38089;39090;39485.40771888482;39530;39655.60344396519;34072.31855362929;34157.487637685954;34758;34921.82539087288;34960.650393495736;26256.737432626192;26320.868395658665;26390.73609263883;26654;26750.59874101851 14:41:23 INFO - PROCESS | 1975 | |2;jquery.html;347.90084825824636;380.9771413715176;384.5558380071019;389.53839699955535;393.3843534867933;20612.793872061276;21330.146794128235;21823.345299640998;22148.781817000057;22188.445288867766;12465.376731163427;12742;12759.936200318985;12778.808317875239;12825.935870320636;5207.817726379578;5447.536959358459;5521.834344969658;5525.530329921961;5547.140193270029;4272.807723652428;6001.87996240075;6137.723802428902;6164;6245.875082498347;6103.328633850273;6183.845403864894;6236.095766113911;6242.1261023456755;6352.618842869442;6784.253732089491;6801.489888258376;6833.487488438363;6911.2397636259975;6917.27368626292;5362.785488580452;5425.914817036609;5914.319853216892;6702.798916032527;7415;28295.71704282972;28815;28907.42185156306;29106.854465727534;29854.850725746233;2270.750217476076;2301.2405906050963;2419.794317483016;2460.520198561281;2500.099964012954;15384.538463846102;15830.445934392355;16347.100909449975;17019.79022165444;17306;1895.2987394664062;1928.701051337045;1945.7956914524054;1976.6639671255778;2026.523766914774;124052;127639.36180319132;128210;129132;129690.3515482426;21075.68386474204;21295.574088518453;21547.81487018229;21555.78444215569;21568.89215553912;30043.098707038826;30991.690083099333;31075;31685.841570792;31814.727410903768;9703.660371887092;11191.328520288645;11644.70888227784;11690.824637630443;11719.648410547527;9804.558794854249;9867.703968880945;9934.950325248328;9950.80098398028;10003.449810260505;7358.595277259695;7520.924790752022;9078.319126065571;9142.131497507726;9160.404573702688;3370.5281260623533;3558.8255875561003;3571.8749843755345;3611.602723700391;3685.4287585424304;818.337146911004;980.3431700760508;1034.9534270957824;1036.5594622285498;1049.5382031905938;19121.61756764857;20207.787532748083;21157.471063223544;21168.894155529124;21665.458363541038;1019.4138370437029;1037.7457522906936;1043.6973277749519;1064.6060957445795;1067.9679609611724;11348.602798901999;11536;11612.361320127475;11616.43178170953;11628.1860269782;649359.753201231;651484;660029;664200;670678;120735.39632301782;125723.3713831425;128099;128857;128957.71042289457;1072.1958531101673;1073.5437439088357;1078.5577913055608;1081.810683130449;1083.1767856429328;18739;18903;19231.13459894336;19292.807071929103;19323.4202973911;52400.47599524108;54321;54669;54893.451065488836;55538.72230638821;74090.62954685192;76884.61557692176;79012.60493697495;79264;80457.59771201106;8116.675332986851;8424.98900131988;8429.957850210709;8457.450265732708;8466.153384661484;9781.951090244504;12341.444634991267;13553.79669304981;13778;13828.723425531232;11684.824727629262;11686.24039437434;11966.341851198267;12010.63968080959;12146;11636.243644163102;11661.35862527569;11727.882721172678;11837.993770529602;11968.521259149536;10054.341033729354;10815.67552973412;11863.87293207144;12392.380380981096;12489.125761196628;7594.240575942362;8338.916610833814;8398.664053438039;8561.14388561139;8572.485650860968;8999.685011024583;9710.368826026286;9949;11405.258658187524;11832.290062596272 14:41:23 INFO - PROCESS | 1975 | |3;mootools.html;1649.9505014849556;1667.3997360950057;1754.2807448945935;2002.639524885521;2046.396313087641;7710;8411.747647570568;9119.817603647924;9143.085691430853;9153.67962121326;8966.327525435585;9080.22818060464;9097.0902909709;9201.76995575111;9283.303752218577;2605.075198304603;2607.0223666125203;2619.6463477430493;2622.3313055170906;2637.525245455817;2560.3215147985798;2608.3609515668686;2615.2285075902655;2616.1497513308154;2622.8557429341377;2225.64235816152;2588.339973306804;2597.4545345477472;2610.099515667092;2641.3264617522505;2585.9741402586014;2600.3109176068356;2608.2092161387227;2613.150726014053;2622.108483115731;2109.440998135495;2198.4393979535116;2574.678165229346;2600.869956502186;2617.882195301216;9179.816403671955;9313.720588382359;9314.72055838326;9320.813583728355;9343.018983006754;5754;5870.823875283749;5971.014782560872;5999.430054144849;6045.637261764308;3584.193556449804;3601.135727425425;3631.074076110575;3807.4098514730263;3836.9040773980873;1081.334744493479;1100.0814320042773;1101.9779604407947;1103.536514663843;1133.6315697398295;12494.75010499794;12502.437390317367;12543.811842822273;12544.81182782259;12569.74860502794;5107.208382700687;5133.332666753298;5154.613403994716;5240.34495688039;5259.211118332204;10516.894831051592;10629.73425664349;10660.840087398696;10701.83947240792;10735.624253151102;5736.996025695486;5760.107183386582;5910.438508341701;5968.074948383008;5971.373005834324;4723.00816828463;5138.820141295037;5231.032259032091;5244.5542128918705;5272.6836389816735;4145.730527515701;4146.709730318909;4148.854790082332;4179.122384299331;4189.4344263524035;1241.2986662535639;1355.4103964775354;1373.409433943414;1379.8137251471123;1408.6689627937426;1136.6533207371665;1189.5063548627395;1203.4945322964202;1208.583038851595;1219.16487206264;7312.670929808171;8585.098564650747;8611.6985905493;8661.003984541732;8679.479231246145;1052.6368402900987;1221.7861874171983;1245.3773113443278;1268.2010333489843;1270.7038820403322;6498.772542960974;6583.111279977237;6597.637129957899;6616.86766264672;6622.86754264912;10977.39624320654;11233.494492747846;11275.267107637977;11289.379084150287;11309.208355415041;10961.671149865517;10972.561097556008;11007;11259.605913792979;11318.26431281964;8844;8861.512616806138;8964.506952117696;8965.193132618097;8985.786918766014;8022.358211343195;8129.390295727726;8312.792180195302;8367.874481882898;8376.455530390505;8188.549629770181;8498.617562209593;9912.15746661542;10013.938561203227;10019.448930308612;10230.897691022994;10446.582136714447;10448.2163837714;10538.525766340686;10603.257771955889;6355.904661430175;7349.081364829396;7377;7447.776566703008;7470.6264686766535;8651.134886511298;8725.781855453664;8740.344474164336;8748.25639820597;8762.386632935888;7600.467967242461;7673.462857599914;7697.576633285223;7701;7936.960315198618;7550.697972081275;7599.924000759922;7637.083549974039;7688;7740;7867.803304917423;7995.200479952191;7998.720044798637;8000.95999520022;8053.31546818527;7137.179224389054;7217.7112915484895;7222.855542889218;7235.384992275715;7254.927450725425;7434.405247580289;7456.51532650376;7465.514741541782;7492.925070749223;7514.924850751641 14:41:23 INFO - PROCESS | 1975 | |4;prototype.html;297.92402937250995;340.3499316305856;346.07597714103343;346.3678786215158;347.89910925831504;5722.856928576783;5882.647041177527;6630.569013014151;6673.299303573116;6717.865642687143;6540.607563546178;6575.57258778179;6659.234188068373;6666.466682665387;6680.832979175523;4347.869563913072;4363.887208761761;4480.551944805509;4950.55445009949;4956;4910.508949105097;4917.36074310341;4920.163572192718;4959.50404959503;4966.950330496703;4909.803607855682;4921.704697718131;5007.8982623822885;5026.924596131061;5043.965986972662;4988.501149885001;5026.170681837492;5028.296038554606;5041.344625198737;5059.544640982329;4286.8499602514075;4291.635211007068;4291.721038132543;4307;4316.5467625899455;6108.175396321484;6241.157443745127;6351.01559258311;6358;6364.395382438707;4938.506149385069;5888.440598143169;5897.498712609433;5903.940960590382;5917.733701983421;6794.796156115324;7039.577625342496;7098.929010709879;7110.253423390522;7112.075430194093;4773.236282194867;4777.665563410563;4780.641451891122;4781.6174706023785;4799.616030717534;7535.585542795144;7554.433417493655;7558.622068896588;7575.962120189419;7577.128630207487;4500.302453119772;4701.882452938636;4711.222648263067;4712.52874712526;4847.175980083394;4747.83382581608;4774.236122220428;4784.492884741365;4787.8563643090765;4794.304825800239;5726.341470730836;5729.427057294237;5737.483626473638;5745.770169193269;5746.626469279484;6021.5849275421115;7162.892556611655;7170.211276759553;7191.712331506681;7210.387117095106;1371.519968011208;1420.389232629979;1668.1825905306555;1673.916304184786;1676.1786724504905;1036.8444733290066;1067.9839802402971;1073.9958139139928;1079.5465904320047;1081.7566047639218;6636.070950066995;6665.166854143232;6684.331566843374;6691.7210566821905;6692.52764391833;7323.963380183065;7340;7355.8161045974275;7370.705171793175;7372.557646541225;6452.322506136882;6652.667366631649;6752.729890804313;6809.591424514545;6824.761133360308;3836.040989752562;3900.063984643722;3900.687944964396;3904.472896159039;3933.862314819025;7823.139454659983;7856.960715196502;7862.606869656609;7878.212178782076;7945.32464740492;7416.925830741731;7712.15166331703;7776.84446311082;7789.493682910593;7811.531308121531;6244.937550624527;6250.218722659668;6260.686965651699;7845.37237021037;7880.684772609032;5704.372519022987;7089.901065334881;7357.8160545986775;7505.174430812497;7514.9624251878395;6602.580445204112;6728.7308507659145;7348.448866335153;7374.926250737639;7424.480286379901;7488.138864030706;7840.882386764317;7859.4891332063235;7895.092064412436;7897.802554935943;4917.606591472602;4932.901341973069;4965.4289756678445;4966.8758281043265;4982;7344.70621175147;7351.26487351282;7356.632168391452;7374.741884034033;7385;7105.964470177616;7114.14630244374;7142.428605711427;7145.214026456982;7150.535215211203;6889.138857642794;7046.295370463118;7104.680289387094;7130.643467826484;7160.8925866113095;6866.416354609914;6893.586384816927;6910.585364878123;6945.861082778417;6953.235144134243;7068.964655176691;7105;7129.750458733919;7135.928640713526;7205.063341765537;5605;6908.689108990208;6937.965310173417;6958.199807022257;6964.199117101598 14:41:23 INFO - PROCESS | 1975 | |5;yui.html;660.6234446365568;666.8230573038587;682.68596445635;703.7747920665389;757.0423414380806;14791.852081479183;15401.460948866792;15689.686206275868;16254.674906501863;18711.25154993802;17101.31594736209;17486.950782953;17512.387066452677;17553;17583.208755605996;828;985.0641890204316;997.5461165169867;1009.0111690543272;1011.5751384418525;941.5715849288591;978.6281213138997;980.7793246519548;981.9214462842991;995.4873240281224;1012.3622118065608;1021.3820638513704;1042.9061384475397;1045.0751085289498;1062.4050531702271;988.4020167798523;1024.6567399921034;1027.1628622672536;1036.8548403223556;1039.230969082877;755.173085471408;761.2805898425989;768.7117331000875;779.2986312318901;791.5369508837337;15920.283587238486;16373.590660233589;16432.83567164337;16437.424690135787;16449.177541122895;12470.251784892935;12545.059120565995;12572.559960401342;12618.68453288666;12675.873241267562;10577.100946419563;10851;10887.782244355149;11064.502097405637;11088.944555277172;3571.1250743567994;3625.274945011008;3625.3655610268097;3634.200475895299;3862.7296089273764;65213.065412056094;80976.38047239023;82423.351532969;82812;83690.74463883047;8481.151884811592;9363.297752668577;9657.32398732096;9777.608895644236;10339.689809305733;21105.472363191042;21732.674009889863;21743.782562174492;21933.341999740034;21948.451288717908;7772.45592808498;7777.338926191224;7778.961105194551;7809.101953275446;8103.513789172668;3942;3977.2244412339314;4064.8170832312617;4247.87256382309;4334;3823.1971286030243;3841.5774264830848;3848.3265428549894;3899.3371126907928;3905.414187871842;592.6177615438105;649.3668673043744;692.2212510925209;734.1960553194244;734.3537686835657;581.7789240088824;604.1994357476361;612.1429998002832;612.8651696626735;635.7774778827466;8368.41421100517;8373.706920257762;8425.957870210732;8459.915400845914;8561.1866872647;573.2118337286231;580.0429291668696;586.604042271465;595.9433853783884;622.7384498510636;3523.894283171509;3970.662493688011;4021.557628660845;4027.194561087794;4073.6333729964445;95606;95654.08691826125;95993;96338.51830740801;97707;83736;83987.90030249293;85058;85200;85503.14496855077;72435.99999999895;72666;74760.25239747642;75409;76243;7825.804354890945;7850.764477065697;7949.3243074337015;8143.959280203561;8302.045264794626;50483.74758126333;50915.49084509107;51167.744161278955;52142;53402;49252.75373623109;63465;68651;69200;69860;9930.751731206778;10158.238132140266;10242.897571024194;10290.228232882713;10445;11279.492422841156;11290.379029153475;11516.366599837089;11563.479643416234;11626.418679066182;10627.89372106269;10698.572057117628;10832.187585931244;10982.231243812856;11210.88789112131;10597.735056623646;10641.89358106409;10738.19463540222;10766.676999690022;11127.054200393057;10267.640632577824;10562.996515331031;10576.312539684895;10745.892541074489;10772.407517586294;9043.095690430904;9186.678466253648;9282.72151835446;9289.396189247676;9354.953225234103;9278.675246366345;9333.25333973294;9334.859977100214;9340.626374944926;9401.294902882175 14:41:23 INFO - PROCESS | 1975 | __end_tp_report 14:41:23 INFO - PROCESS | 1975 | __start_cc_report 14:41:23 INFO - PROCESS | 1975 | _x_x_mozilla_cycle_collect,350 14:41:23 INFO - PROCESS | 1975 | __end_cc_report 14:41:23 INFO - PROCESS | 1975 | __startTimestamp1464212483145__endTimestamp 14:41:23 INFO - PROCESS | 1975 | 14:41:23 INFO - PROCESS | 1975 | ------- Summary: start ------- 14:41:23 INFO - PROCESS | 1975 | Number of tests: 6 14:41:23 INFO - PROCESS | 1975 | 14:41:23 INFO - PROCESS | 1975 | [#0] dojo.html Cycles:165 Average:5888.10 Median:6147.32 stddev:633.00 (10.3%) stddev-sans-first:609.95 14:41:23 INFO - PROCESS | 1975 | Values: 3643.2 3652.1 3672.9 3707.4 3717.2 5962.6 6033.1 6048.9 6052.2 6126.4 6029.5 6077.4 6091.0 6102.1 6103.8 5398.1 5425.2 5467.1 5517.8 5527.3 5388.6 5437.2 5460.6 5509.1 5528.6 4667.7 4863.2 5493.5 5529.4 5567.3 4419.9 5491.5 5533.9 5569.6 5600.8 5259.7 5268.0 5293.5 5414.6 5418.0 5782.7 5859.8 5918.4 5953.0 5983.7 6224.7 6273.1 6295.9 6324.3 6347.4 6172.9 6303.9 6371.0 6378.8 6391.2 5227.3 6136.8 6170.2 6201.8 6211.9 6301.4 6462.1 6518.6 6523.9 6535.8 6145.4 6181.0 6229.9 6248.3 6260.9 6297.2 6305.2 6349.2 6350.7 6354.2 4722.9 5626.7 6100.0 6145.2 6207.9 6181.0 6254.4 6262.2 6278.6 6317.1 5057.3 5122.5 5139.4 5142.7 5145.9 4511.8 4532.8 4538.2 4579.0 4630.0 5393.8 6050.1 6110.7 6127.5 6148.4 5506.3 6364.1 6386.1 6409.4 6431.7 6018.5 6036.8 6086.5 6130.5 6171.9 5592.7 5608.6 5633.1 5644.0 5682.7 5560.7 6602.1 6630.5 6633.0 6654.4 6214.8 6293.2 6311.4 6343.8 6366.5 6507.6 6517.8 6531.1 6541.4 6542.8 6228.9 6245.9 6257.8 6261.0 6282.7 6182.5 6242.8 6299.5 6303.7 6315.8 5031.8 6205.3 6215.0 6225.9 6246.2 6132.3 6230.0 6232.1 6237.7 6246.8 6124.3 6146.0 6147.3 6155.1 6183.8 6196.9 6200.8 6228.3 6229.5 6240.1 6117.2 6230.2 6247.2 6253.0 6271.2 14:41:23 INFO - PROCESS | 1975 | 14:41:23 INFO - PROCESS | 1975 | [#1] ext.html Cycles:180 Average:67927.54 Median:39947.20 stddev:145910.36 (365.3%) stddev-sans-first:146231.89 14:41:23 INFO - PROCESS | 1975 | Values: 515.8 602.2 620.9 659.0 669.1 39649.8 39835.4 40532.0 40671.0 40679.8 43569.0 43612.3 43857.9 44141.0 44162.0 9849.8 9864.0 9993.3 10032.0 10037.4 9872.5 9906.1 9945.6 9966.5 9987.1 9869.4 9942.8 9977.5 10010.7 10066.0 9868.4 9881.0 9961.1 9980.7 9995.8 9613.0 9702.1 9773.5 9784.3 9794.4 35710.9 40809.8 40945.2 41191.8 41475.8 2647.1 3373.9 3454.6 3580.7 4074.9 27527.8 29282.4 29511.0 29728.9 30348.8 2774.0 2795.9 2839.3 2900.4 2900.7 436186.0 437164.0 438009.0 440538.0 440647.0 38820.0 48022.0 74307.0 74707.0 74885.0 49524.8 49961.0 50063.5 50110.7 50209.5 17436.7 17445.3 17582.7 17639.7 17642.6 14008.8 14015.7 14065.9 14095.3 14099.3 15441.0 15506.0 15527.9 15711.1 15776.7 6676.3 6719.5 6745.8 6800.5 6815.7 865.7 957.8 1028.1 1059.5 1216.1 30373.5 30415.8 30428.8 31076.1 31114.4 1108.9 1139.1 1157.3 1187.7 1251.0 13310.9 14593.8 15020.5 16014.6 17035.5 653364.0 689084.0 692534.0 701413.0 710042.0 66808.7 66941.7 66996.7 67213.0 67288.7 1564.2 1580.2 1583.9 1587.8 1716.6 32021.5 32021.7 32097.7 32205.5 32507.7 53249.7 53268.0 53859.5 53987.7 54037.5 438279.0 443147.8 443672.0 522406.0 524482.4 33849.8 34096.5 35074.8 35096.5 35461.8 46490.0 50523.7 51047.0 51766.5 51804.0 39091.0 39647.8 40059.0 40080.8 41105.8 38995.2 39078.8 39219.4 39521.8 40303.4 38089.0 39090.0 39485.4 39530.0 39655.6 34072.3 34157.5 34758.0 34921.8 34960.7 26256.7 26320.9 26390.7 26654.0 26750.6 14:41:23 INFO - PROCESS | 1975 | 14:41:23 INFO - PROCESS | 1975 | [#2] jquery.html Cycles:180 Average:38208.91 Median:2360.52 stddev:109439.35 (4636.2%) stddev-sans-first:109709.44 14:41:23 INFO - PROCESS | 1975 | Values: 347.9 381.0 384.6 389.5 393.4 20612.8 21330.1 21823.3 22148.8 22188.4 12465.4 12742.0 12759.9 12778.8 12825.9 5207.8 5447.5 5521.8 5525.5 5547.1 4272.8 6001.9 6137.7 6164.0 6245.9 6103.3 6183.8 6236.1 6242.1 6352.6 6784.3 6801.5 6833.5 6911.2 6917.3 5362.8 5425.9 5914.3 6702.8 7415.0 28295.7 28815.0 28907.4 29106.9 29854.9 2270.8 2301.2 2419.8 2460.5 2500.1 15384.5 15830.4 16347.1 17019.8 17306.0 1895.3 1928.7 1945.8 1976.7 2026.5 124052.0 127639.4 128210.0 129132.0 129690.4 21075.7 21295.6 21547.8 21555.8 21568.9 30043.1 30991.7 31075.0 31685.8 31814.7 9703.7 11191.3 11644.7 11690.8 11719.6 9804.6 9867.7 9935.0 9950.8 10003.4 7358.6 7520.9 9078.3 9142.1 9160.4 3370.5 3558.8 3571.9 3611.6 3685.4 818.3 980.3 1035.0 1036.6 1049.5 19121.6 20207.8 21157.5 21168.9 21665.5 1019.4 1037.7 1043.7 1064.6 1068.0 11348.6 11536.0 11612.4 11616.4 11628.2 649359.8 651484.0 660029.0 664200.0 670678.0 120735.4 125723.4 128099.0 128857.0 128957.7 1072.2 1073.5 1078.6 1081.8 1083.2 18739.0 18903.0 19231.1 19292.8 19323.4 52400.5 54321.0 54669.0 54893.5 55538.7 74090.6 76884.6 79012.6 79264.0 80457.6 8116.7 8425.0 8430.0 8457.5 8466.2 9782.0 12341.4 13553.8 13778.0 13828.7 11684.8 11686.2 11966.3 12010.6 12146.0 11636.2 11661.4 11727.9 11838.0 11968.5 10054.3 10815.7 11863.9 12392.4 12489.1 7594.2 8338.9 8398.7 8561.1 8572.5 8999.7 9710.4 9949.0 11405.3 11832.3 14:41:23 INFO - PROCESS | 1975 | 14:41:23 INFO - PROCESS | 1975 | [#3] mootools.html Cycles:180 Average:6330.73 Median:5146.72 stddev:3319.20 (64.5%) stddev-sans-first:3309.87 14:41:23 INFO - PROCESS | 1975 | Values: 1650.0 1667.4 1754.3 2002.6 2046.4 7710.0 8411.7 9119.8 9143.1 9153.7 8966.3 9080.2 9097.1 9201.8 9283.3 2605.1 2607.0 2619.6 2622.3 2637.5 2560.3 2608.4 2615.2 2616.1 2622.9 2225.6 2588.3 2597.5 2610.1 2641.3 2586.0 2600.3 2608.2 2613.2 2622.1 2109.4 2198.4 2574.7 2600.9 2617.9 9179.8 9313.7 9314.7 9320.8 9343.0 5754.0 5870.8 5971.0 5999.4 6045.6 3584.2 3601.1 3631.1 3807.4 3836.9 1081.3 1100.1 1102.0 1103.5 1133.6 12494.8 12502.4 12543.8 12544.8 12569.7 5107.2 5133.3 5154.6 5240.3 5259.2 10516.9 10629.7 10660.8 10701.8 10735.6 5737.0 5760.1 5910.4 5968.1 5971.4 4723.0 5138.8 5231.0 5244.6 5272.7 4145.7 4146.7 4148.9 4179.1 4189.4 1241.3 1355.4 1373.4 1379.8 1408.7 1136.7 1189.5 1203.5 1208.6 1219.2 7312.7 8585.1 8611.7 8661.0 8679.5 1052.6 1221.8 1245.4 1268.2 1270.7 6498.8 6583.1 6597.6 6616.9 6622.9 10977.4 11233.5 11275.3 11289.4 11309.2 10961.7 10972.6 11007.0 11259.6 11318.3 8844.0 8861.5 8964.5 8965.2 8985.8 8022.4 8129.4 8312.8 8367.9 8376.5 8188.5 8498.6 9912.2 10013.9 10019.4 10230.9 10446.6 10448.2 10538.5 10603.3 6355.9 7349.1 7377.0 7447.8 7470.6 8651.1 8725.8 8740.3 8748.3 8762.4 7600.5 7673.5 7697.6 7701.0 7937.0 7550.7 7599.9 7637.1 7688.0 7740.0 7867.8 7995.2 7998.7 8001.0 8053.3 7137.2 7217.7 7222.9 7235.4 7254.9 7434.4 7456.5 7465.5 7492.9 7514.9 14:41:23 INFO - PROCESS | 1975 | 14:41:23 INFO - PROCESS | 1975 | [#4] prototype.html Cycles:180 Average:5821.04 Median:6589.08 stddev:1852.02 (28.1%) stddev-sans-first:1810.23 14:41:23 INFO - PROCESS | 1975 | Values: 297.9 340.3 346.1 346.4 347.9 5722.9 5882.6 6630.6 6673.3 6717.9 6540.6 6575.6 6659.2 6666.5 6680.8 4347.9 4363.9 4480.6 4950.6 4956.0 4910.5 4917.4 4920.2 4959.5 4967.0 4909.8 4921.7 5007.9 5026.9 5044.0 4988.5 5026.2 5028.3 5041.3 5059.5 4286.8 4291.6 4291.7 4307.0 4316.5 6108.2 6241.2 6351.0 6358.0 6364.4 4938.5 5888.4 5897.5 5903.9 5917.7 6794.8 7039.6 7098.9 7110.3 7112.1 4773.2 4777.7 4780.6 4781.6 4799.6 7535.6 7554.4 7558.6 7576.0 7577.1 4500.3 4701.9 4711.2 4712.5 4847.2 4747.8 4774.2 4784.5 4787.9 4794.3 5726.3 5729.4 5737.5 5745.8 5746.6 6021.6 7162.9 7170.2 7191.7 7210.4 1371.5 1420.4 1668.2 1673.9 1676.2 1036.8 1068.0 1074.0 1079.5 1081.8 6636.1 6665.2 6684.3 6691.7 6692.5 7324.0 7340.0 7355.8 7370.7 7372.6 6452.3 6652.7 6752.7 6809.6 6824.8 3836.0 3900.1 3900.7 3904.5 3933.9 7823.1 7857.0 7862.6 7878.2 7945.3 7416.9 7712.2 7776.8 7789.5 7811.5 6244.9 6250.2 6260.7 7845.4 7880.7 5704.4 7089.9 7357.8 7505.2 7515.0 6602.6 6728.7 7348.4 7374.9 7424.5 7488.1 7840.9 7859.5 7895.1 7897.8 4917.6 4932.9 4965.4 4966.9 4982.0 7344.7 7351.3 7356.6 7374.7 7385.0 7106.0 7114.1 7142.4 7145.2 7150.5 6889.1 7046.3 7104.7 7130.6 7160.9 6866.4 6893.6 6910.6 6945.9 6953.2 7069.0 7105.0 7129.8 7135.9 7205.1 5605.0 6908.7 6938.0 6958.2 6964.2 14:41:23 INFO - PROCESS | 1975 | 14:41:23 INFO - PROCESS | 1975 | [#5] yui.html Cycles:180 Average:18730.51 Median:52772.00 stddev:26505.70 (50.2%) stddev-sans-first:26545.32 14:41:23 INFO - PROCESS | 1975 | Values: 660.6 666.8 682.7 703.8 757.0 14791.9 15401.5 15689.7 16254.7 18711.3 17101.3 17487.0 17512.4 17553.0 17583.2 828.0 985.1 997.5 1009.0 1011.6 941.6 978.6 980.8 981.9 995.5 1012.4 1021.4 1042.9 1045.1 1062.4 988.4 1024.7 1027.2 1036.9 1039.2 755.2 761.3 768.7 779.3 791.5 15920.3 16373.6 16432.8 16437.4 16449.2 12470.3 12545.1 12572.6 12618.7 12675.9 10577.1 10851.0 10887.8 11064.5 11088.9 3571.1 3625.3 3625.4 3634.2 3862.7 65213.1 80976.4 82423.4 82812.0 83690.7 8481.2 9363.3 9657.3 9777.6 10339.7 21105.5 21732.7 21743.8 21933.3 21948.5 7772.5 7777.3 7779.0 7809.1 8103.5 3942.0 3977.2 4064.8 4247.9 4334.0 3823.2 3841.6 3848.3 3899.3 3905.4 592.6 649.4 692.2 734.2 734.4 581.8 604.2 612.1 612.9 635.8 8368.4 8373.7 8426.0 8459.9 8561.2 573.2 580.0 586.6 595.9 622.7 3523.9 3970.7 4021.6 4027.2 4073.6 95606.0 95654.1 95993.0 96338.5 97707.0 83736.0 83987.9 85058.0 85200.0 85503.1 72436.0 72666.0 74760.3 75409.0 76243.0 7825.8 7850.8 7949.3 8144.0 8302.0 50483.7 50915.5 51167.7 52142.0 53402.0 49252.8 63465.0 68651.0 69200.0 69860.0 9930.8 10158.2 10242.9 10290.2 10445.0 11279.5 11290.4 11516.4 11563.5 11626.4 10627.9 10698.6 10832.2 10982.2 11210.9 10597.7 10641.9 10738.2 10766.7 11127.1 10267.6 10563.0 10576.3 10745.9 10772.4 9043.1 9186.7 9282.7 9289.4 9355.0 9278.7 9333.3 9334.9 9340.6 9401.3 14:41:23 INFO - PROCESS | 1975 | -------- Summary: end -------- 14:41:23 INFO - PROCESS | 1975 | 14:41:23 INFO - TEST-INFO | 1975: exit 0 14:41:23 INFO - TEST-OK | dromaeo_css | took 1109467ms 14:41:23 INFO - TEST-START | kraken 14:41:23 INFO - operating with platform_type : mac_ 14:41:23 INFO - Initialising browser for kraken test... 14:41:23 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmptz_Bnq/profile http://localhost:52751/getInfo.html) 14:41:26 INFO - PROCESS | 1981 | __metrics Screen width/height:1600/1200 14:41:26 INFO - PROCESS | 1981 | colorDepth:24 14:41:26 INFO - PROCESS | 1981 | Browser inner width/height: 1024/689 14:41:26 INFO - PROCESS | 1981 | __metrics 14:41:26 ERROR - PROCESS | 1981 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 14:41:26 INFO - TEST-INFO | 1981: exit 0 14:41:26 INFO - Browser initialized. 14:41:26 INFO - Running cycle 1/1 for kraken test... 14:41:26 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmptz_Bnq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:38 INFO - PROCESS | 1985 | RSS: Main: 167780352 14:41:38 INFO - PROCESS | 1985 | 14:41:41 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52751/tests/kraken/driver.html?testName=audio-beat-detection) 14:41:42 INFO - PROCESS | 1985 | RSS: Main: 179404800 14:41:42 INFO - PROCESS | 1985 | 14:41:44 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52751/tests/kraken/driver.html?testName=audio-dft) 14:41:45 INFO - PROCESS | 1985 | RSS: Main: 188755968 14:41:45 INFO - PROCESS | 1985 | 14:41:48 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52751/tests/kraken/driver.html?testName=audio-fft) 14:41:49 INFO - PROCESS | 1985 | RSS: Main: 191918080 14:41:49 INFO - PROCESS | 1985 | 14:41:51 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52751/tests/kraken/driver.html?testName=audio-oscillator) 14:41:51 INFO - PROCESS | 1985 | RSS: Main: 193843200 14:41:51 INFO - PROCESS | 1985 | 14:41:53 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52751/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:41:54 INFO - PROCESS | 1985 | RSS: Main: 194355200 14:41:54 INFO - PROCESS | 1985 | 14:41:57 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52751/tests/kraken/driver.html?testName=imaging-darkroom) 14:41:57 INFO - PROCESS | 1985 | RSS: Main: 194678784 14:41:57 INFO - PROCESS | 1985 | 14:42:00 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52751/tests/kraken/driver.html?testName=imaging-desaturate) 14:42:01 INFO - PROCESS | 1985 | RSS: Main: 194560000 14:42:01 INFO - PROCESS | 1985 | 14:42:04 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52751/tests/kraken/driver.html?testName=json-parse-financial) 14:42:04 INFO - PROCESS | 1985 | RSS: Main: 194842624 14:42:04 INFO - PROCESS | 1985 | 14:42:06 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52751/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:42:07 INFO - PROCESS | 1985 | RSS: Main: 193822720 14:42:07 INFO - PROCESS | 1985 | 14:42:08 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52751/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:42:09 INFO - PROCESS | 1985 | RSS: Main: 193859584 14:42:09 INFO - PROCESS | 1985 | 14:42:11 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52751/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:42:12 INFO - PROCESS | 1985 | RSS: Main: 194002944 14:42:12 INFO - PROCESS | 1985 | 14:42:14 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:42:15 INFO - PROCESS | 1985 | RSS: Main: 194617344 14:42:15 INFO - PROCESS | 1985 | 14:42:17 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:42:18 INFO - PROCESS | 1985 | RSS: Main: 193986560 14:42:18 INFO - PROCESS | 1985 | 14:42:19 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:52751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52751/tests/kraken/driver.html?testName=ai-astar) 14:42:20 INFO - PROCESS | 1985 | RSS: Main: 195690496 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | __start_tp_report 14:42:20 INFO - PROCESS | 1985 | _x_x_mozilla_page_load 14:42:20 INFO - PROCESS | 1985 | _x_x_mozilla_page_load_details 14:42:20 INFO - PROCESS | 1985 | |i|pagename|runs| 14:42:20 INFO - PROCESS | 1985 | |0;ai-astar;115;107;116;116;115;128;115;99;115;156 14:42:20 INFO - PROCESS | 1985 | |1;audio-beat-detection;150;120;156;147;123;170;121;147;170;121 14:42:20 INFO - PROCESS | 1985 | |2;audio-dft;196;197;200;205;194;197;197;193;199;194 14:42:20 INFO - PROCESS | 1985 | |3;audio-fft;64;66;74;116;80;80;85;83;127;56 14:42:20 INFO - PROCESS | 1985 | |4;audio-oscillator;84;79;121;77;87;80;116;76;78;118 14:42:20 INFO - PROCESS | 1985 | |5;imaging-gaussian-blur;90;88;89;87;100;117;91;88;90;88 14:42:20 INFO - PROCESS | 1985 | |6;imaging-darkroom;103;126;94;131;149;94;95;94;95;95 14:42:20 INFO - PROCESS | 1985 | |7;imaging-desaturate;97;97;97;111;101;102;96;103;94;92 14:42:20 INFO - PROCESS | 1985 | |8;json-parse-financial;55;57;59;60;64;69;83;88;92;57 14:42:20 INFO - PROCESS | 1985 | |9;json-stringify-tinderbox;65;65;72;72;71;71;66;65;68;69 14:42:20 INFO - PROCESS | 1985 | |10;stanford-crypto-aes;80;83;82;85;82;80;84;81;82;88 14:42:20 INFO - PROCESS | 1985 | |11;stanford-crypto-ccm;118;125;136;141;135;120;129;126;126;141 14:42:20 INFO - PROCESS | 1985 | |12;stanford-crypto-pbkdf2;125;135;131;112;138;159;171;114;131;158 14:42:20 INFO - PROCESS | 1985 | |13;stanford-crypto-sha256-iterative;68;65;67;66;65;66;67;66;67;67 14:42:20 INFO - PROCESS | 1985 | __end_tp_report 14:42:20 INFO - PROCESS | 1985 | __start_cc_report 14:42:20 INFO - PROCESS | 1985 | _x_x_mozilla_cycle_collect,916 14:42:20 INFO - PROCESS | 1985 | __end_cc_report 14:42:20 INFO - PROCESS | 1985 | __startTimestamp1464212540206__endTimestamp 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | ------- Summary: start ------- 14:42:20 INFO - PROCESS | 1985 | Number of tests: 14 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#0] ai-astar Cycles:10 Average:118.20 Median:116.00 stddev:15.16 (13.1%) stddev-sans-first:16.04 14:42:20 INFO - PROCESS | 1985 | Values: 115.0 107.0 116.0 116.0 115.0 128.0 115.0 99.0 115.0 156.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:148.50 stddev:20.01 (13.5%) stddev-sans-first:21.04 14:42:20 INFO - PROCESS | 1985 | Values: 150.0 120.0 156.0 147.0 123.0 170.0 121.0 147.0 170.0 121.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#2] audio-dft Cycles:10 Average:197.20 Median:197.00 stddev:3.52 (1.8%) stddev-sans-first:3.71 14:42:20 INFO - PROCESS | 1985 | Values: 196.0 197.0 200.0 205.0 194.0 197.0 197.0 193.0 199.0 194.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#3] audio-fft Cycles:10 Average:83.10 Median:77.00 stddev:22.38 (29.1%) stddev-sans-first:22.64 14:42:20 INFO - PROCESS | 1985 | Values: 64.0 66.0 74.0 116.0 80.0 80.0 85.0 83.0 127.0 56.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:78.50 stddev:18.77 (23.9%) stddev-sans-first:19.70 14:42:20 INFO - PROCESS | 1985 | Values: 84.0 79.0 121.0 77.0 87.0 80.0 116.0 76.0 78.0 118.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:88.50 stddev:9.27 (10.5%) stddev-sans-first:9.78 14:42:20 INFO - PROCESS | 1985 | Values: 90.0 88.0 89.0 87.0 100.0 117.0 91.0 88.0 90.0 88.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#6] imaging-darkroom Cycles:10 Average:107.60 Median:94.00 stddev:20.15 (21.4%) stddev-sans-first:21.30 14:42:20 INFO - PROCESS | 1985 | Values: 103.0 126.0 94.0 131.0 149.0 94.0 95.0 94.0 95.0 95.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#7] imaging-desaturate Cycles:10 Average:99.00 Median:95.00 stddev:5.46 (5.7%) stddev-sans-first:5.74 14:42:20 INFO - PROCESS | 1985 | Values: 97.0 97.0 97.0 111.0 101.0 102.0 96.0 103.0 94.0 92.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:66.50 stddev:14.03 (21.1%) stddev-sans-first:14.02 14:42:20 INFO - PROCESS | 1985 | Values: 55.0 57.0 59.0 60.0 64.0 69.0 83.0 88.0 92.0 57.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:70.00 stddev:2.99 (4.3%) stddev-sans-first:2.91 14:42:20 INFO - PROCESS | 1985 | Values: 65.0 65.0 72.0 72.0 71.0 71.0 66.0 65.0 68.0 69.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:2.45 (3.0%) stddev-sans-first:2.40 14:42:20 INFO - PROCESS | 1985 | Values: 80.0 83.0 82.0 85.0 82.0 80.0 84.0 81.0 82.0 88.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:132.00 stddev:8.19 (6.2%) stddev-sans-first:7.52 14:42:20 INFO - PROCESS | 1985 | Values: 118.0 125.0 136.0 141.0 135.0 120.0 129.0 126.0 126.0 141.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.40 Median:136.50 stddev:19.59 (14.4%) stddev-sans-first:20.26 14:42:20 INFO - PROCESS | 1985 | Values: 125.0 135.0 131.0 112.0 138.0 159.0 171.0 114.0 131.0 158.0 14:42:20 INFO - PROCESS | 1985 | 14:42:20 INFO - PROCESS | 1985 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:0.83 14:42:20 INFO - PROCESS | 1985 | Values: 68.0 65.0 67.0 66.0 65.0 66.0 67.0 66.0 67.0 67.0 14:42:20 INFO - PROCESS | 1985 | -------- Summary: end -------- 14:42:20 INFO - PROCESS | 1985 | 14:42:21 INFO - TEST-INFO | 1985: exit 0 14:42:21 INFO - TEST-OK | kraken | took 57462ms 14:42:21 INFO - SUITE-END | took 1166s 14:42:21 INFO - Completed test suite (00:19:27) 14:42:21 INFO - javascript benchmark 14:42:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3643.2167084076927, 3652.086978255436, 3672.8530858765653, 3707.388280933645, 3717.163638181408, 5962.6124301920345, 6033.095035744641, 6048.8790224195545, 6052.213212282408, 6126.387361263883, 6029.547783916213, 6077.422644848743, 6090.969545152279, 6102.084687296908, 6103.786367477139, 5398.082326004579, 5425.186222066702, 5467.097928841737, 5517.751701173457, 5527.2538207342095, 5388.595855310848, 5437.157240627709, 5460.590455715817, 5509.118541033436, 5528.585356098289, 4667.6965997210245, 4863.221884498481, 5493.478119578654, 5529.419410961831, 5567.3040869891265, 4419.911601767963, 5491.450854914517, 5533.889322213533, 5569.582281328876, 5600.8319750407145, 5259.684418934876, 5268.025415298143, 5293.523582877521, 5414.593905457106, 5418.0, 5782.653040817564, 5859.824205273849, 5918.437748413894, 5952.9702351488395, 5983.670898100646, 6224.657643829588, 6273.12176295319, 6295.8740825183695, 6324.272708638519, 6347.365263473662, 6172.87654246917, 6303.873922521524, 6371.0, 6378.840528986766, 6391.2330520337855, 5227.26818245446, 6136.815895523141, 6170.228721409824, 6201.844953876144, 6211.875762484725, 6301.369863013662, 6462.1276127723095, 6518.57629254097, 6523.934760652332, 6535.771248006392, 6145.4161854623735, 6180.969095154495, 6229.906551401733, 6248.250209974832, 6260.906086408708, 6297.2128483939505, 6305.243370795442, 6349.174607301022, 6350.714217860207, 6354.17395738551, 4722.881927951828, 5626.690532020696, 6099.963006288942, 6145.170401995762, 6207.906881396782, 6180.969095154495, 6254.437100660963, 6262.2172228471445, 6278.591891527036, 6317.084022816666, 5057.266696329085, 5122.513361230677, 5139.383274007143, 5142.717150556755, 5145.871353216125, 4511.751853648081, 4532.841350552715, 4538.205813982539, 4579.038401935631, 4630.0, 5393.8112166074, 6050.062240352752, 6110.694465276719, 6127.540434467343, 6148.415900489446, 5506.284183056177, 6364.140840986408, 6386.137871387396, 6409.4231519163495, 6431.710573024225, 6018.488428483628, 6036.849078773066, 6086.543509236825, 6130.47890929276, 6171.907421388593, 5592.748326325325, 5608.6073974821375, 5633.126865335879, 5643.984082865041, 5682.659040457585, 5560.7219639018695, 6602.10871532337, 6630.53586248958, 6633.0, 6654.367835055662, 6214.8135555933395, 6293.213348331458, 6311.431971122621, 6343.777967771106, 6366.490680745436, 6507.642079685474, 6517.837054073686, 6531.11829902976, 6541.443977261986, 6542.803715888531, 6228.875422491616, 6245.875082498415, 6257.812265632038, 6261.029540421242, 6282.654454005074, 6182.536309776695, 6242.781502647567, 6299.527535434952, 6303.747850086129, 6315.810525684236, 5031.823886163967, 6205.348438413902, 6215.0, 6225.906611400923, 6246.156768836149, 6132.2947860996555, 6230.00319948806, 6232.127502149793, 6237.656928868956, 6246.812595622138, 6124.295705993868, 6145.955187618027, 6147.323794382525, 6155.076738489262, 6183.783567575113, 6196.907046394217, 6200.7519699213335, 6228.314885362697, 6229.5327850410495, 6240.126382306572, 6117.188044311343, 6230.15892854477, 6247.187865577446, 6252.968735156295, 6271.153394291712], "unit": "score", "name": "dojo.html", "value": 5852.932920147383}, {"lowerIsBetter": false, "replicates": [515.8091506142728, 602.1629934391196, 620.8820324138417, 658.9901151482728, 669.1368135105714, 39649.801750991275, 39835.40246896295, 40532.0, 40670.99999999996, 40679.79660101703, 43569.0, 43612.345814812805, 43857.903552411204, 44141.0, 44162.0, 9849.803003939916, 9864.013598640151, 9993.250506212027, 10032.0, 10037.397756134618, 9872.506374681274, 9906.058924402207, 9945.552450139725, 9966.455199444097, 9987.101160895518, 9869.358491698053, 9942.751431214241, 9977.503374493848, 10010.749731256705, 10066.043725846033, 9868.358556693793, 9881.0, 9961.053699898497, 9980.700578982642, 9995.800083998352, 9613.038696130401, 9702.12680858719, 9773.462459564722, 9784.266180036526, 9794.412335259907, 35710.928672139875, 40809.79595102005, 40945.181096378205, 41191.7940410296, 41475.7926210367, 2647.060293595784, 3373.881914133018, 3454.602720687103, 3580.677739003502, 4074.898127546835, 27527.761250743766, 29282.414351712847, 29511.0, 29728.8513557433, 30348.78604855803, 2774.0429551804596, 2795.916122516328, 2839.2901774556362, 2900.4344152890194, 2900.6809250982587, 436186.0, 437164.0, 438009.0, 440538.0, 440647.0, 38820.0, 48022.0, 74307.0, 74707.0, 74885.0, 49524.75237623789, 49961.0, 50063.49936500588, 50110.749446252536, 50209.49790502121, 17436.738448923275, 17445.30218791234, 17582.736258956127, 17639.73540396895, 17642.64714705699, 14008.789868151986, 14015.719685606231, 14065.85934140666, 14095.295235238196, 14099.295035248197, 15441.0, 15506.0, 15527.922360388126, 15711.135887526296, 15776.68446631061, 6676.298988606223, 6719.462443004548, 6745.763898263537, 6800.489963252776, 6815.659217039129, 865.7229686500259, 957.8419560772534, 1028.100412139378, 1059.51262419288, 1216.1365430544413, 30373.544396834066, 30415.847920760254, 30428.84785576058, 31076.067717968497, 31114.377712445625, 1108.894655007773, 1139.1171841822488, 1157.3403160198775, 1187.6852634051984, 1250.9687257818628, 13310.866891331156, 14593.78109328361, 15020.549383518512, 16014.599635008984, 17035.48893533196, 653364.0, 689084.0, 692534.0, 701413.0, 710042.0, 66808.66595666991, 66941.6570420033, 66996.66501667461, 67213.0, 67288.66355668288, 1564.2335255724613, 1580.162513867652, 1583.8732901367862, 1587.8412158784029, 1716.5794380376888, 32021.519677205328, 32021.679783202802, 32097.679023209468, 32205.51691724673, 32507.674923250466, 53249.733751331, 53268.0, 53859.46140538701, 53987.730061349444, 54037.459625403244, 438279.0, 443147.78426107665, 443672.0, 522406.0, 524482.3775881096, 33849.830750846086, 34096.48855267123, 35074.772382966476, 35096.47355289622, 35461.82269088638, 46490.0, 50523.74738126286, 51047.0, 51766.482335176166, 51804.0, 39091.0, 39647.80176099101, 40058.99852503711, 40080.79959600183, 41105.79447102865, 38995.220095598495, 39078.80460597679, 39219.41170882496, 39521.80239098786, 40303.3954490677, 38089.0, 39090.0, 39485.40771888482, 39530.0, 39655.60344396519, 34072.31855362929, 34157.487637685954, 34758.0, 34921.82539087288, 34960.650393495736, 26256.737432626192, 26320.868395658665, 26390.73609263883, 26654.0, 26750.59874101851], "unit": "score", "name": "ext.html", "value": 20402.22701261826}, {"lowerIsBetter": false, "replicates": [347.90084825824636, 380.9771413715176, 384.5558380071019, 389.53839699955535, 393.3843534867933, 20612.793872061276, 21330.146794128235, 21823.345299640998, 22148.781817000057, 22188.445288867766, 12465.376731163427, 12742.0, 12759.936200318985, 12778.808317875239, 12825.935870320636, 5207.817726379578, 5447.536959358459, 5521.834344969658, 5525.530329921961, 5547.140193270029, 4272.807723652428, 6001.87996240075, 6137.723802428902, 6164.0, 6245.875082498347, 6103.328633850273, 6183.845403864894, 6236.095766113911, 6242.1261023456755, 6352.618842869442, 6784.253732089491, 6801.489888258376, 6833.487488438363, 6911.2397636259975, 6917.27368626292, 5362.785488580452, 5425.914817036609, 5914.319853216892, 6702.798916032527, 7415.0, 28295.71704282972, 28815.0, 28907.42185156306, 29106.854465727534, 29854.850725746233, 2270.750217476076, 2301.2405906050963, 2419.794317483016, 2460.520198561281, 2500.099964012954, 15384.538463846102, 15830.445934392355, 16347.100909449975, 17019.79022165444, 17306.0, 1895.2987394664062, 1928.701051337045, 1945.7956914524054, 1976.6639671255778, 2026.523766914774, 124052.0, 127639.36180319132, 128210.0, 129132.0, 129690.3515482426, 21075.68386474204, 21295.574088518453, 21547.81487018229, 21555.78444215569, 21568.89215553912, 30043.098707038826, 30991.690083099333, 31075.0, 31685.841570792, 31814.727410903768, 9703.660371887092, 11191.328520288645, 11644.70888227784, 11690.824637630443, 11719.648410547527, 9804.558794854249, 9867.703968880945, 9934.950325248328, 9950.80098398028, 10003.449810260505, 7358.595277259695, 7520.924790752022, 9078.319126065571, 9142.131497507726, 9160.404573702688, 3370.5281260623533, 3558.8255875561003, 3571.8749843755345, 3611.602723700391, 3685.4287585424304, 818.337146911004, 980.3431700760508, 1034.9534270957824, 1036.5594622285498, 1049.5382031905938, 19121.61756764857, 20207.787532748083, 21157.471063223544, 21168.894155529124, 21665.458363541038, 1019.4138370437029, 1037.7457522906936, 1043.6973277749519, 1064.6060957445795, 1067.9679609611724, 11348.602798901999, 11536.0, 11612.361320127475, 11616.43178170953, 11628.1860269782, 649359.753201231, 651484.0, 660029.0, 664200.0, 670678.0, 120735.39632301782, 125723.3713831425, 128099.0, 128857.0, 128957.71042289457, 1072.1958531101673, 1073.5437439088357, 1078.5577913055608, 1081.810683130449, 1083.1767856429328, 18739.0, 18903.0, 19231.13459894336, 19292.807071929103, 19323.4202973911, 52400.47599524108, 54321.0, 54669.0, 54893.451065488836, 55538.72230638821, 74090.62954685192, 76884.61557692176, 79012.60493697495, 79264.0, 80457.59771201106, 8116.675332986851, 8424.98900131988, 8429.957850210709, 8457.450265732708, 8466.153384661484, 9781.951090244504, 12341.444634991267, 13553.79669304981, 13778.0, 13828.723425531232, 11684.824727629262, 11686.24039437434, 11966.341851198267, 12010.63968080959, 12146.0, 11636.243644163102, 11661.35862527569, 11727.882721172678, 11837.993770529602, 11968.521259149536, 10054.341033729354, 10815.67552973412, 11863.87293207144, 12392.380380981096, 12489.125761196628, 7594.240575942362, 8338.916610833814, 8398.664053438039, 8561.14388561139, 8572.485650860968, 8999.685011024583, 9710.368826026286, 9949.0, 11405.258658187524, 11832.290062596272], "unit": "score", "name": "jquery.html", "value": 10768.173248731391}, {"lowerIsBetter": false, "replicates": [1649.9505014849556, 1667.3997360950057, 1754.2807448945935, 2002.639524885521, 2046.396313087641, 7710.0, 8411.747647570568, 9119.817603647924, 9143.085691430853, 9153.67962121326, 8966.327525435585, 9080.22818060464, 9097.0902909709, 9201.76995575111, 9283.303752218577, 2605.075198304603, 2607.0223666125203, 2619.6463477430493, 2622.3313055170906, 2637.525245455817, 2560.3215147985798, 2608.3609515668686, 2615.2285075902655, 2616.1497513308154, 2622.8557429341377, 2225.64235816152, 2588.339973306804, 2597.4545345477472, 2610.099515667092, 2641.3264617522505, 2585.9741402586014, 2600.3109176068356, 2608.2092161387227, 2613.150726014053, 2622.108483115731, 2109.440998135495, 2198.4393979535116, 2574.678165229346, 2600.869956502186, 2617.882195301216, 9179.816403671955, 9313.720588382359, 9314.72055838326, 9320.813583728355, 9343.018983006754, 5754.0, 5870.823875283749, 5971.014782560872, 5999.430054144849, 6045.637261764308, 3584.193556449804, 3601.135727425425, 3631.074076110575, 3807.4098514730263, 3836.9040773980873, 1081.334744493479, 1100.0814320042773, 1101.9779604407947, 1103.536514663843, 1133.6315697398295, 12494.75010499794, 12502.437390317367, 12543.811842822273, 12544.81182782259, 12569.74860502794, 5107.208382700687, 5133.332666753298, 5154.613403994716, 5240.34495688039, 5259.211118332204, 10516.894831051592, 10629.73425664349, 10660.840087398696, 10701.83947240792, 10735.624253151102, 5736.996025695486, 5760.107183386582, 5910.438508341701, 5968.074948383008, 5971.373005834324, 4723.00816828463, 5138.820141295037, 5231.032259032091, 5244.5542128918705, 5272.6836389816735, 4145.730527515701, 4146.709730318909, 4148.854790082332, 4179.122384299331, 4189.4344263524035, 1241.2986662535639, 1355.4103964775354, 1373.409433943414, 1379.8137251471123, 1408.6689627937426, 1136.6533207371665, 1189.5063548627395, 1203.4945322964202, 1208.583038851595, 1219.16487206264, 7312.670929808171, 8585.098564650747, 8611.6985905493, 8661.003984541732, 8679.479231246145, 1052.6368402900987, 1221.7861874171983, 1245.3773113443278, 1268.2010333489843, 1270.7038820403322, 6498.772542960974, 6583.111279977237, 6597.637129957899, 6616.86766264672, 6622.86754264912, 10977.39624320654, 11233.494492747846, 11275.267107637977, 11289.379084150287, 11309.208355415041, 10961.671149865517, 10972.561097556008, 11007.0, 11259.605913792979, 11318.26431281964, 8844.0, 8861.512616806138, 8964.506952117696, 8965.193132618097, 8985.786918766014, 8022.358211343195, 8129.390295727726, 8312.792180195302, 8367.874481882898, 8376.455530390505, 8188.549629770181, 8498.617562209593, 9912.15746661542, 10013.938561203227, 10019.448930308612, 10230.897691022994, 10446.582136714447, 10448.2163837714, 10538.525766340686, 10603.257771955889, 6355.904661430175, 7349.081364829396, 7377.0, 7447.776566703008, 7470.6264686766535, 8651.134886511298, 8725.781855453664, 8740.344474164336, 8748.25639820597, 8762.386632935888, 7600.467967242461, 7673.462857599914, 7697.576633285223, 7701.0, 7936.960315198618, 7550.697972081275, 7599.924000759922, 7637.083549974039, 7688.0, 7740.0, 7867.803304917423, 7995.200479952191, 7998.720044798637, 8000.95999520022, 8053.31546818527, 7137.179224389054, 7217.7112915484895, 7222.855542889218, 7235.384992275715, 7254.927450725425, 7434.405247580289, 7456.51532650376, 7465.514741541782, 7492.925070749223, 7514.924850751641], "unit": "score", "name": "mootools.html", "value": 5165.873344349745}, {"lowerIsBetter": false, "replicates": [297.92402937250995, 340.3499316305856, 346.07597714103343, 346.3678786215158, 347.89910925831504, 5722.856928576783, 5882.647041177527, 6630.569013014151, 6673.299303573116, 6717.865642687143, 6540.607563546178, 6575.57258778179, 6659.234188068373, 6666.466682665387, 6680.832979175523, 4347.869563913072, 4363.887208761761, 4480.551944805509, 4950.55445009949, 4956.0, 4910.508949105097, 4917.36074310341, 4920.163572192718, 4959.50404959503, 4966.950330496703, 4909.803607855682, 4921.704697718131, 5007.8982623822885, 5026.924596131061, 5043.965986972662, 4988.501149885001, 5026.170681837492, 5028.296038554606, 5041.344625198737, 5059.544640982329, 4286.8499602514075, 4291.635211007068, 4291.721038132543, 4307.0, 4316.5467625899455, 6108.175396321484, 6241.157443745127, 6351.01559258311, 6358.0, 6364.395382438707, 4938.506149385069, 5888.440598143169, 5897.498712609433, 5903.940960590382, 5917.733701983421, 6794.796156115324, 7039.577625342496, 7098.929010709879, 7110.253423390522, 7112.075430194093, 4773.236282194867, 4777.665563410563, 4780.641451891122, 4781.6174706023785, 4799.616030717534, 7535.585542795144, 7554.433417493655, 7558.622068896588, 7575.962120189419, 7577.128630207487, 4500.302453119772, 4701.882452938636, 4711.222648263067, 4712.52874712526, 4847.175980083394, 4747.83382581608, 4774.236122220428, 4784.492884741365, 4787.8563643090765, 4794.304825800239, 5726.341470730836, 5729.427057294237, 5737.483626473638, 5745.770169193269, 5746.626469279484, 6021.5849275421115, 7162.892556611655, 7170.211276759553, 7191.712331506681, 7210.387117095106, 1371.519968011208, 1420.389232629979, 1668.1825905306555, 1673.916304184786, 1676.1786724504905, 1036.8444733290066, 1067.9839802402971, 1073.9958139139928, 1079.5465904320047, 1081.7566047639218, 6636.070950066995, 6665.166854143232, 6684.331566843374, 6691.7210566821905, 6692.52764391833, 7323.963380183065, 7340.0, 7355.8161045974275, 7370.705171793175, 7372.557646541225, 6452.322506136882, 6652.667366631649, 6752.729890804313, 6809.591424514545, 6824.761133360308, 3836.040989752562, 3900.063984643722, 3900.687944964396, 3904.472896159039, 3933.862314819025, 7823.139454659983, 7856.960715196502, 7862.606869656609, 7878.212178782076, 7945.32464740492, 7416.925830741731, 7712.15166331703, 7776.84446311082, 7789.493682910593, 7811.531308121531, 6244.937550624527, 6250.218722659668, 6260.686965651699, 7845.37237021037, 7880.684772609032, 5704.372519022987, 7089.901065334881, 7357.8160545986775, 7505.174430812497, 7514.9624251878395, 6602.580445204112, 6728.7308507659145, 7348.448866335153, 7374.926250737639, 7424.480286379901, 7488.138864030706, 7840.882386764317, 7859.4891332063235, 7895.092064412436, 7897.802554935943, 4917.606591472602, 4932.901341973069, 4965.4289756678445, 4966.8758281043265, 4982.0, 7344.70621175147, 7351.26487351282, 7356.632168391452, 7374.741884034033, 7385.0, 7105.964470177616, 7114.14630244374, 7142.428605711427, 7145.214026456982, 7150.535215211203, 6889.138857642794, 7046.295370463118, 7104.680289387094, 7130.643467826484, 7160.8925866113095, 6866.416354609914, 6893.586384816927, 6910.585364878123, 6945.861082778417, 6953.235144134243, 7068.964655176691, 7105.0, 7129.750458733919, 7135.928640713526, 7205.063341765537, 5605.0, 6908.689108990208, 6937.965310173417, 6958.199807022257, 6964.199117101598], "unit": "score", "name": "prototype.html", "value": 5199.249048240259}, {"lowerIsBetter": false, "replicates": [660.6234446365568, 666.8230573038587, 682.68596445635, 703.7747920665389, 757.0423414380806, 14791.852081479183, 15401.460948866792, 15689.686206275868, 16254.674906501863, 18711.25154993802, 17101.31594736209, 17486.950782953, 17512.387066452677, 17553.0, 17583.208755605996, 828.0, 985.0641890204316, 997.5461165169867, 1009.0111690543272, 1011.5751384418525, 941.5715849288591, 978.6281213138997, 980.7793246519548, 981.9214462842991, 995.4873240281224, 1012.3622118065608, 1021.3820638513704, 1042.9061384475397, 1045.0751085289498, 1062.4050531702271, 988.4020167798523, 1024.6567399921034, 1027.1628622672536, 1036.8548403223556, 1039.230969082877, 755.173085471408, 761.2805898425989, 768.7117331000875, 779.2986312318901, 791.5369508837337, 15920.283587238486, 16373.590660233589, 16432.83567164337, 16437.424690135787, 16449.177541122895, 12470.251784892935, 12545.059120565995, 12572.559960401342, 12618.68453288666, 12675.873241267562, 10577.100946419563, 10851.0, 10887.782244355149, 11064.502097405637, 11088.944555277172, 3571.1250743567994, 3625.274945011008, 3625.3655610268097, 3634.200475895299, 3862.7296089273764, 65213.065412056094, 80976.38047239023, 82423.351532969, 82812.0, 83690.74463883047, 8481.151884811592, 9363.297752668577, 9657.32398732096, 9777.608895644236, 10339.689809305733, 21105.472363191042, 21732.674009889863, 21743.782562174492, 21933.341999740034, 21948.451288717908, 7772.45592808498, 7777.338926191224, 7778.961105194551, 7809.101953275446, 8103.513789172668, 3942.0, 3977.2244412339314, 4064.8170832312617, 4247.87256382309, 4334.0, 3823.1971286030243, 3841.5774264830848, 3848.3265428549894, 3899.3371126907928, 3905.414187871842, 592.6177615438105, 649.3668673043744, 692.2212510925209, 734.1960553194244, 734.3537686835657, 581.7789240088824, 604.1994357476361, 612.1429998002832, 612.8651696626735, 635.7774778827466, 8368.41421100517, 8373.706920257762, 8425.957870210732, 8459.915400845914, 8561.1866872647, 573.2118337286231, 580.0429291668696, 586.604042271465, 595.9433853783884, 622.7384498510636, 3523.894283171509, 3970.662493688011, 4021.557628660845, 4027.194561087794, 4073.6333729964445, 95606.0, 95654.08691826125, 95993.0, 96338.51830740801, 97707.0, 83736.0, 83987.90030249293, 85058.0, 85200.0, 85503.14496855077, 72435.99999999895, 72666.0, 74760.25239747642, 75409.0, 76243.0, 7825.804354890945, 7850.764477065697, 7949.3243074337015, 8143.959280203561, 8302.045264794626, 50483.74758126333, 50915.49084509107, 51167.744161278955, 52142.0, 53402.0, 49252.75373623109, 63465.0, 68651.0, 69200.0, 69860.0, 9930.751731206778, 10158.238132140266, 10242.897571024194, 10290.228232882713, 10445.0, 11279.492422841156, 11290.379029153475, 11516.366599837089, 11563.479643416234, 11626.418679066182, 10627.89372106269, 10698.572057117628, 10832.187585931244, 10982.231243812856, 11210.88789112131, 10597.735056623646, 10641.89358106409, 10738.19463540222, 10766.676999690022, 11127.054200393057, 10267.640632577824, 10562.996515331031, 10576.312539684895, 10745.892541074489, 10772.407517586294, 9043.095690430904, 9186.678466253648, 9282.72151835446, 9289.396189247676, 9354.953225234103, 9278.675246366345, 9333.25333973294, 9334.859977100214, 9340.626374944926, 9401.294902882175], "unit": "score", "name": "yui.html", "value": 7087.579384080784}], "name": "dromaeo_css", "value": 7909.246590616209}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 107.0, 116.0, 116.0, 115.0, 128.0, 115.0, 99.0, 115.0, 156.0], "unit": "score", "name": "ai-astar", "value": 118.2}, {"lowerIsBetter": true, "replicates": [150.0, 120.0, 156.0, 147.0, 123.0, 170.0, 121.0, 147.0, 170.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [196.0, 197.0, 200.0, 205.0, 194.0, 197.0, 197.0, 193.0, 199.0, 194.0], "unit": "score", "name": "audio-dft", "value": 197.2}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 74.0, 116.0, 80.0, 80.0, 85.0, 83.0, 127.0, 56.0], "unit": "score", "name": "audio-fft", "value": 83.1}, {"lowerIsBetter": true, "replicates": [84.0, 79.0, 121.0, 77.0, 87.0, 80.0, 116.0, 76.0, 78.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 91.6}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 89.0, 87.0, 100.0, 117.0, 91.0, 88.0, 90.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.8}, {"lowerIsBetter": true, "replicates": [103.0, 126.0, 94.0, 131.0, 149.0, 94.0, 95.0, 94.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 107.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 111.0, 101.0, 102.0, 96.0, 103.0, 94.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 99.0}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 59.0, 60.0, 64.0, 69.0, 83.0, 88.0, 92.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 68.4}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 72.0, 72.0, 71.0, 71.0, 66.0, 65.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [80.0, 83.0, 82.0, 85.0, 82.0, 80.0, 84.0, 81.0, 82.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [118.0, 125.0, 136.0, 141.0, 135.0, 120.0, 129.0, 126.0, 126.0, 141.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.7}, {"lowerIsBetter": true, "replicates": [125.0, 135.0, 131.0, 112.0, 138.0, 159.0, 171.0, 114.0, 131.0, 158.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.4}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 67.0, 66.0, 65.0, 66.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1485.0000000000002}]} 14:42:21 INFO - Return code: 0 14:42:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:42:21 ERROR - # TBPL SUCCESS # 14:42:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:42:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:42:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:42:21 INFO - 2016-05-25 14:42:21.519 screenresolution[1990:21392] starting screenresolution argv=screenresolution get 14:42:21 INFO - 2016-05-25 14:42:21.522 screenresolution[1990:21392] Display 0: 1600x1200x32@60 14:42:21 INFO - 2016-05-25 14:42:21.528 screenresolution[1991:21395] starting screenresolution argv=screenresolution list 14:42:21 INFO - Available Modes on Display 0 14:42:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:42:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:42:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:42:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:42:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:42:21 INFO - Intel Iris: 14:42:21 INFO - Chipset Model: Intel Iris 14:42:21 INFO - Type: GPU 14:42:21 INFO - Bus: Built-In 14:42:21 INFO - VRAM (Dynamic, Max): 1536 MB 14:42:21 INFO - Vendor: Intel (0x8086) 14:42:21 INFO - Device ID: 0x0a2e 14:42:21 INFO - Revision ID: 0x0009 14:42:21 INFO - Displays: 14:42:21 INFO - Display: 14:42:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:42:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:42:21 INFO - Display Serial Number: 1600x1200 60 14:42:21 INFO - Main Display: Yes 14:42:21 INFO - Mirror: Off 14:42:21 INFO - Online: Yes 14:42:21 INFO - Rotation: Supported 14:42:21 INFO - Return code: 0 14:42:21 INFO - Running post-action listener: _resource_record_post_action 14:42:21 INFO - Running post-run listener: _resource_record_post_run 14:42:22 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 995328; Write bytes: 508729856; Read time: 8; Write time: 1574 14:42:22 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 194988544; Write bytes: 195761664; Read time: 18201; Write time: 407 14:42:22 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 995328; Write bytes: 301380608; Read time: 8; Write time: 1127 14:42:22 INFO - Running post-run listener: _upload_blobber_files 14:42:22 INFO - Blob upload gear active. 14:42:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:42:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:42:22 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'] 14:42:22 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 14:42:23 INFO - (blobuploader) - INFO - Open directory for files ... 14:42:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:42:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:42:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:24 INFO - (blobuploader) - INFO - Done attempting. 14:42:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:42:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:42:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:25 INFO - (blobuploader) - INFO - Done attempting. 14:42:25 INFO - (blobuploader) - INFO - Iteration through files over. 14:42:25 INFO - Return code: 0 14:42:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:42:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:42:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/601865d98431c0c5c4d0ea5a997ba41dfc290581745eaed828eed2ea49fbfbfeb7ce7cb0d5fe4087c6292ba806a6825f9ee62f7407ebb697ff3fbfa304971bf0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e1cc8fb5f08d952e797907583f708fd70772bd93895c5d7b9cee7f44b3e20da891302bab838c3a6685e9ad8ad6be484dc86d199bf8a6487b51f3bd0d8e51b078"} 14:42:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:42:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:42:25 INFO - Contents: 14:42:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/601865d98431c0c5c4d0ea5a997ba41dfc290581745eaed828eed2ea49fbfbfeb7ce7cb0d5fe4087c6292ba806a6825f9ee62f7407ebb697ff3fbfa304971bf0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e1cc8fb5f08d952e797907583f708fd70772bd93895c5d7b9cee7f44b3e20da891302bab838c3a6685e9ad8ad6be484dc86d199bf8a6487b51f3bd0d8e51b078"} 14:42:25 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:25 INFO - Copying logs to upload dir... 14:42:25 INFO - mkdir: /builds/slave/test/build/upload/logs 14:42:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.835829 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-25 14:42:25.577385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 14:42:25.581141) ========= 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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/601865d98431c0c5c4d0ea5a997ba41dfc290581745eaed828eed2ea49fbfbfeb7ce7cb0d5fe4087c6292ba806a6825f9ee62f7407ebb697ff3fbfa304971bf0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e1cc8fb5f08d952e797907583f708fd70772bd93895c5d7b9cee7f44b3e20da891302bab838c3a6685e9ad8ad6be484dc86d199bf8a6487b51f3bd0d8e51b078"} build_url:https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/eJiyHPjHRheM_fwYt3nWTg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/601865d98431c0c5c4d0ea5a997ba41dfc290581745eaed828eed2ea49fbfbfeb7ce7cb0d5fe4087c6292ba806a6825f9ee62f7407ebb697ff3fbfa304971bf0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e1cc8fb5f08d952e797907583f708fd70772bd93895c5d7b9cee7f44b3e20da891302bab838c3a6685e9ad8ad6be484dc86d199bf8a6487b51f3bd0d8e51b078"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 14:42:25.612431) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:42:25.612775) ========= 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.lDOyH5QTBG/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.w71t6Dn2SB/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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.005238 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:42:25.661655) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 14:42:25.662051) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 14:42:25.662389) ========= ========= Total master_lag: 0.17 =========