builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1506458959.14 results: success (0) revision: 058e8c2cba283dd5e9b301c7994a059f9a2677ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:19.139443) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:19.139794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:19.140063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:19.164902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:19.165167) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 13:49:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-09-26 13:49:19 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137078 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:19.326085) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:19.326424) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024126 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:19.384445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:19.384878) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 058e8c2cba283dd5e9b301c7994a059f9a2677ca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 058e8c2cba283dd5e9b301c7994a059f9a2677ca --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 13:49:19,440 truncating revision to first 12 chars 2017-09-26 13:49:19,440 Setting DEBUG logging. 2017-09-26 13:49:19,440 attempt 1/10 2017-09-26 13:49:19,440 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/058e8c2cba28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 13:49:19,852 unpacking tar archive at: mozilla-beta-058e8c2cba28/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693460 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:20.097763) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:20.098073) ========= script_repo_revision: 058e8c2cba283dd5e9b301c7994a059f9a2677ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:20.098468) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:20.098738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 13:49:20.117637) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-26 13:49:20.118016) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:49:20 INFO - MultiFileLogger online at 20170926 13:49:20 in /builds/slave/test 13:49:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 13:49:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:49:20 INFO - {'append_to_log': False, 13:49:20 INFO - 'base_work_dir': '/builds/slave/test', 13:49:20 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 13:49:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:49:20 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 13:49:20 INFO - 'buildbot_json_path': 'buildprops.json', 13:49:20 INFO - 'code_coverage': False, 13:49:20 INFO - 'config_files': ('talos/linux_config.py',), 13:49:20 INFO - 'default_actions': ('clobber', 13:49:20 INFO - 'read-buildbot-config', 13:49:20 INFO - 'download-and-extract', 13:49:20 INFO - 'populate-webroot', 13:49:20 INFO - 'create-virtualenv', 13:49:20 INFO - 'install', 13:49:20 INFO - 'setup-mitmproxy', 13:49:20 INFO - 'run-tests'), 13:49:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:49:20 INFO - 'disable_ccov_upload': False, 13:49:20 INFO - 'disable_stylo': False, 13:49:20 INFO - 'download_minidump_stackwalk': True, 13:49:20 INFO - 'download_symbols': 'ondemand', 13:49:20 INFO - 'enable_stylo': False, 13:49:20 INFO - 'enable_webrender': False, 13:49:20 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:49:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:49:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:49:20 INFO - 'gecko_profile': False, 13:49:20 INFO - 'gecko_profile_interval': 0, 13:49:20 INFO - 'installer_path': 'installer.exe', 13:49:20 INFO - 'log_level': 'info', 13:49:20 INFO - 'log_name': 'talos', 13:49:20 INFO - 'log_to_console': True, 13:49:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:49:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:49:20 INFO - 'opt_config_files': (), 13:49:20 INFO - 'pip_index': False, 13:49:20 INFO - 'suite': 'dromaeojs-e10s', 13:49:20 INFO - 'system_bits': '32', 13:49:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:49:20 INFO - 'title': 'talos-linux64-ix-029', 13:49:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:49:20 INFO - 'use_talos_json': True, 13:49:20 INFO - 'verify': 'False', 13:49:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:49:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:49:20 INFO - 'work_dir': 'build'} 13:49:20 INFO - [mozharness: 2017-09-26 20:49:20.319616Z] Running clobber step. 13:49:20 INFO - Running pre-action listener: _resource_record_pre_action 13:49:20 INFO - Running main action method: clobber 13:49:20 INFO - rmtree: /builds/slave/test/build 13:49:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:49:21 INFO - Running post-action listener: _resource_record_post_action 13:49:21 INFO - [mozharness: 2017-09-26 20:49:21.832238Z] Finished clobber step (success) 13:49:21 INFO - [mozharness: 2017-09-26 20:49:21.832334Z] Running read-buildbot-config step. 13:49:21 INFO - Running pre-action listener: _resource_record_pre_action 13:49:21 INFO - Running main action method: read_buildbot_config 13:49:21 INFO - Using buildbot properties: 13:49:21 INFO - { 13:49:21 INFO - "project": "", 13:49:21 INFO - "product": "firefox", 13:49:21 INFO - "who": "ryanvm@gmail.com", 13:49:21 INFO - "installer_path": "public/build/target.tar.bz2", 13:49:21 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 13:49:21 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 13:49:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 13:49:21 INFO - "stage_platform": "linux64", 13:49:21 INFO - "basedir": "/builds/slave/test", 13:49:21 INFO - "buildnumber": 130, 13:49:21 INFO - "platform": "ubuntu64_hw", 13:49:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:49:21 INFO - "slavebuilddir": "test", 13:49:21 INFO - "taskId": "RhN3l8_yQQS0uzM8pcysew", 13:49:21 INFO - "branch": "mozilla-beta", 13:49:21 INFO - "script_repo_revision": "production", 13:49:21 INFO - "revision": "058e8c2cba283dd5e9b301c7994a059f9a2677ca", 13:49:21 INFO - "slavename": "talos-linux64-ix-029", 13:49:21 INFO - "repo_path": "releases/mozilla-beta" 13:49:21 INFO - } 13:49:21 INFO - Finding installer, test and symbols from parent task. 13:49:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RhN3l8_yQQS0uzM8pcysew'}, attempt #1 13:49:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RhN3l8_yQQS0uzM8pcysew'}, attempt #1 13:49:23 INFO - Task dependencies: TQRHIg1RQGeiJPRjZXCmEA 13:49:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA'}, attempt #1 13:49:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.tar.bz2 13:49:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.test_packages.json 13:49:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.crashreporter-symbols.zip 13:49:23 INFO - Running post-action listener: _resource_record_post_action 13:49:23 INFO - [mozharness: 2017-09-26 20:49:23.608458Z] Finished read-buildbot-config step (success) 13:49:23 INFO - [mozharness: 2017-09-26 20:49:23.608674Z] Running download-and-extract step. 13:49:23 INFO - Running pre-action listener: _resource_record_pre_action 13:49:23 INFO - Running main action method: download_and_extract 13:49:23 INFO - mkdir: /builds/slave/test/build/tests 13:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:23 INFO - trying https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.test_packages.json 13:49:23 INFO - Downloading https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:49:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:49:24 INFO - Downloaded 989 bytes. 13:49:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:49:24 INFO - Using the following test package requirements: 13:49:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:49:24 INFO - u'common': [u'target.common.tests.zip'], 13:49:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:49:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:49:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:49:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:49:24 INFO - u'mozbase': [u'target.common.tests.zip'], 13:49:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:49:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:49:24 INFO - u'web-platform': [u'target.common.tests.zip', 13:49:24 INFO - u'target.web-platform.tests.tar.gz'], 13:49:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:49:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 13:49:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.common.tests.zip 13:49:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:49:24 INFO - Fetch https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.common.tests.zip into memory 13:49:25 INFO - Content-Length response header: 55177309 13:49:25 INFO - Bytes received: 55177309 13:49:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.talos.tests.zip 13:49:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:49:36 INFO - Fetch https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.talos.tests.zip into memory 13:49:36 INFO - Content-Length response header: 14509184 13:49:36 INFO - Bytes received: 14509184 13:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:37 INFO - trying https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.tar.bz2 13:49:37 INFO - Downloading https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:49:38 INFO - Downloaded 53524653 bytes. 13:49:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.tar.bz2 13:49:38 INFO - mkdir: /builds/slave/test/properties 13:49:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:49:38 INFO - Writing to file /builds/slave/test/properties/build_url 13:49:38 INFO - Contents: 13:49:38 INFO - build_url:https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.tar.bz2 13:49:38 INFO - Running post-action listener: _resource_record_post_action 13:49:38 INFO - Running post-action listener: find_tests_for_verification 13:49:38 INFO - Running post-action listener: set_extra_try_arguments 13:49:38 INFO - [mozharness: 2017-09-26 20:49:38.322799Z] Finished download-and-extract step (success) 13:49:38 INFO - [mozharness: 2017-09-26 20:49:38.322896Z] Running populate-webroot step. 13:49:38 INFO - Running pre-action listener: _resource_record_pre_action 13:49:38 INFO - Running main action method: populate_webroot 13:49:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:49:38 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:38 INFO - 'tests': ['tresize', 13:49:38 INFO - 'tcanvasmark']}, 13:49:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:49:38 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:38 INFO - 'tests': ['dromaeo_css', 13:49:38 INFO - 'kraken']}, 13:49:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:49:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:38 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:38 INFO - 'talos_options': ['--disable-stylo'], 13:49:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:49:38 INFO - 'tests': ['damp', 'tps']}, 13:49:38 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:38 INFO - 'talos_options': ['--disable-stylo'], 13:49:38 INFO - 'tests': ['damp', 'tps']}, 13:49:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:49:38 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:38 INFO - 'tests': ['dromaeo_dom']}, 13:49:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:49:38 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:38 INFO - 'tests': ['basic_compositor_video', 13:49:38 INFO - 'glvideo']}, 13:49:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:49:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:49:38 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:38 INFO - 'talos_options': ['--disable-stylo'], 13:49:38 INFO - 'tests': ['ts_paint_webext', 13:49:38 INFO - 'tp5o_webext']}, 13:49:38 INFO - 'other-e10s': {'tests': ['a11yr', 13:49:38 INFO - 'ts_paint', 13:49:38 INFO - 'tpaint', 13:49:38 INFO - 'sessionrestore', 13:49:38 INFO - 'sessionrestore_many_windows', 13:49:38 INFO - 'sessionrestore_no_auto_restore', 13:49:38 INFO - 'tabpaint']}, 13:49:38 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:38 INFO - 'tests': ['a11yr', 13:49:38 INFO - 'ts_paint', 13:49:38 INFO - 'tpaint', 13:49:38 INFO - 'sessionrestore', 13:49:38 INFO - 'sessionrestore_many_windows', 13:49:38 INFO - 'sessionrestore_no_auto_restore', 13:49:38 INFO - 'tabpaint']}, 13:49:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:49:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 13:49:38 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:38 INFO - 'tests': ['perf_reftest_singletons']}, 13:49:38 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:38 INFO - 'tests': ['bloom_basic']}, 13:49:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:49:38 INFO - 'tsvgr_opacity', 13:49:38 INFO - 'tart', 13:49:38 INFO - 'tscrollx', 13:49:38 INFO - 'tsvg_static']}, 13:49:38 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:38 INFO - 'tests': ['tsvgx', 13:49:38 INFO - 'tsvgr_opacity', 13:49:38 INFO - 'tart', 13:49:38 INFO - 'tscrollx', 13:49:38 INFO - 'tsvg_static']}, 13:49:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:49:38 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:38 INFO - 'talos_options': ['--disable-stylo'], 13:49:38 INFO - 'tests': ['tp5o']}, 13:49:38 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:49:38 INFO - 'talos_options': ['--mitmproxy', 13:49:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:49:38 INFO - '--firstNonBlankPaint'], 13:49:38 INFO - 'tests': ['tp6_google', 13:49:38 INFO - 'tp6_youtube', 13:49:38 INFO - 'tp6_amazon', 13:49:38 INFO - 'tp6_facebook']}, 13:49:38 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:49:38 INFO - 'talos_options': ['--disable-stylo', 13:49:38 INFO - '--mitmproxy', 13:49:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:49:38 INFO - '--firstNonBlankPaint'], 13:49:38 INFO - 'tests': ['tp6_google', 13:49:38 INFO - 'tp6_youtube', 13:49:38 INFO - 'tp6_amazon', 13:49:38 INFO - 'tp6_facebook']}, 13:49:38 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:49:38 INFO - 'talos_options': ['--stylo-threads=1', 13:49:38 INFO - '--mitmproxy', 13:49:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:49:38 INFO - '--firstNonBlankPaint'], 13:49:38 INFO - 'tests': ['tp6_google', 13:49:38 INFO - 'tp6_youtube', 13:49:38 INFO - 'tp6_amazon', 13:49:38 INFO - 'tp6_facebook']}, 13:49:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:49:38 INFO - 'talos_options': ['--xperf_path', 13:49:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:38 INFO - 'tests': ['tp5n']}, 13:49:38 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:38 INFO - 'talos_options': ['--disable-stylo', 13:49:38 INFO - '--xperf_path', 13:49:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:38 INFO - 'tests': ['tp5n']}}} 13:49:38 INFO - Running post-action listener: _resource_record_post_action 13:49:38 INFO - [mozharness: 2017-09-26 20:49:38.337674Z] Finished populate-webroot step (success) 13:49:38 INFO - [mozharness: 2017-09-26 20:49:38.337763Z] Running create-virtualenv step. 13:49:38 INFO - Running pre-action listener: _resource_record_pre_action 13:49:38 INFO - Running main action method: create_virtualenv 13:49:38 INFO - Creating virtualenv /builds/slave/test/build/venv 13:49:38 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:49:38 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:49:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:49:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:49:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:49:40 INFO - Installing distribute.............................................................................................................................................................................................done. 13:49:41 INFO - Installing pip...............done. 13:49:41 INFO - Return code: 0 13:49:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:49:41 INFO - Reading from file tmpfile_stdout 13:49:41 INFO - Output received: 13:49:41 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:49:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:41 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/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 0x12f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662090>, '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 0x1662d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:49:41 INFO - Using env: {'DISPLAY': ':0', 13:49:41 INFO - 'HOME': '/home/cltbld', 13:49:41 INFO - 'LANG': 'en_US.UTF-8', 13:49:41 INFO - 'LANGUAGE': 'en_US:en', 13:49:41 INFO - 'LOGNAME': 'cltbld', 13:49:41 INFO - 'MAIL': '/var/mail/cltbld', 13:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:41 INFO - 'MOZ_NO_REMOTE': '1', 13:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:41 INFO - 'NO_EM_RESTART': '1', 13:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:41 INFO - 'PWD': '/builds/slave/test', 13:49:41 INFO - 'SHELL': '/bin/bash', 13:49:41 INFO - 'SHLVL': '1', 13:49:41 INFO - 'TERM': 'linux', 13:49:41 INFO - 'TMOUT': '86400', 13:49:41 INFO - 'USER': 'cltbld', 13:49:41 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 13:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:41 INFO - '_': '/tools/buildbot/bin/python'} 13:49:42 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:49:42 INFO - Downloading/unpacking pip>=1.5 13:49:42 INFO - Running setup.py egg_info for package pip 13:49:42 INFO - warning: no files found matching 'pip/cacert.pem' 13:49:42 INFO - warning: no files found matching '*.html' under directory 'docs' 13:49:42 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:49:42 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:49:42 INFO - Installing collected packages: pip 13:49:42 INFO - Found existing installation: pip 1.1 13:49:42 INFO - Uninstalling pip: 13:49:42 INFO - Successfully uninstalled pip 13:49:42 INFO - Running setup.py install for pip 13:49:42 INFO - warning: no files found matching 'pip/cacert.pem' 13:49:42 INFO - warning: no files found matching '*.html' under directory 'docs' 13:49:42 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:49:42 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:49:42 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:49:42 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:49:42 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:49:42 INFO - Successfully installed pip 13:49:42 INFO - Cleaning up... 13:49:42 INFO - Return code: 0 13:49:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:42 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662090>, '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 0x1662d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:49:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:49:42 INFO - Using env: {'DISPLAY': ':0', 13:49:42 INFO - 'HOME': '/home/cltbld', 13:49:42 INFO - 'LANG': 'en_US.UTF-8', 13:49:42 INFO - 'LANGUAGE': 'en_US:en', 13:49:42 INFO - 'LOGNAME': 'cltbld', 13:49:42 INFO - 'MAIL': '/var/mail/cltbld', 13:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:42 INFO - 'MOZ_NO_REMOTE': '1', 13:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:42 INFO - 'NO_EM_RESTART': '1', 13:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:42 INFO - 'PWD': '/builds/slave/test', 13:49:42 INFO - 'SHELL': '/bin/bash', 13:49:42 INFO - 'SHLVL': '1', 13:49:42 INFO - 'TERM': 'linux', 13:49:42 INFO - 'TMOUT': '86400', 13:49:42 INFO - 'USER': 'cltbld', 13:49:42 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 13:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:42 INFO - '_': '/tools/buildbot/bin/python'} 13:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:43 INFO - Downloading/unpacking psutil>=3.1.1 13:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:49:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:44 INFO - Installing collected packages: psutil 13:49:44 INFO - Running setup.py install for psutil 13:49:44 INFO - building 'psutil._psutil_linux' extension 13:49:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:49:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:49:44 INFO - building 'psutil._psutil_posix' extension 13:49:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:49:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:49:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:46 INFO - Successfully installed psutil 13:49:46 INFO - Cleaning up... 13:49:47 INFO - Return code: 0 13:49:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:47 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662090>, '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 0x1662d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:49:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:49:47 INFO - Using env: {'DISPLAY': ':0', 13:49:47 INFO - 'HOME': '/home/cltbld', 13:49:47 INFO - 'LANG': 'en_US.UTF-8', 13:49:47 INFO - 'LANGUAGE': 'en_US:en', 13:49:47 INFO - 'LOGNAME': 'cltbld', 13:49:47 INFO - 'MAIL': '/var/mail/cltbld', 13:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:47 INFO - 'MOZ_NO_REMOTE': '1', 13:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:47 INFO - 'NO_EM_RESTART': '1', 13:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:47 INFO - 'PWD': '/builds/slave/test', 13:49:47 INFO - 'SHELL': '/bin/bash', 13:49:47 INFO - 'SHLVL': '1', 13:49:47 INFO - 'TERM': 'linux', 13:49:47 INFO - 'TMOUT': '86400', 13:49:47 INFO - 'USER': 'cltbld', 13:49:47 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 13:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:47 INFO - '_': '/tools/buildbot/bin/python'} 13:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:49:48 INFO - Installing collected packages: mozsystemmonitor 13:49:48 INFO - Running setup.py install for mozsystemmonitor 13:49:49 INFO - Successfully installed mozsystemmonitor 13:49:49 INFO - Cleaning up... 13:49:50 INFO - Return code: 0 13:49:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662090>, '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 0x1662d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:49:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:49:50 INFO - Using env: {'DISPLAY': ':0', 13:49:50 INFO - 'HOME': '/home/cltbld', 13:49:50 INFO - 'LANG': 'en_US.UTF-8', 13:49:50 INFO - 'LANGUAGE': 'en_US:en', 13:49:50 INFO - 'LOGNAME': 'cltbld', 13:49:50 INFO - 'MAIL': '/var/mail/cltbld', 13:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:50 INFO - 'MOZ_NO_REMOTE': '1', 13:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:50 INFO - 'NO_EM_RESTART': '1', 13:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:50 INFO - 'PWD': '/builds/slave/test', 13:49:50 INFO - 'SHELL': '/bin/bash', 13:49:50 INFO - 'SHLVL': '1', 13:49:50 INFO - 'TERM': 'linux', 13:49:50 INFO - 'TMOUT': '86400', 13:49:50 INFO - 'USER': 'cltbld', 13:49:50 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 13:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:50 INFO - '_': '/tools/buildbot/bin/python'} 13:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:51 INFO - Downloading/unpacking jsonschema==2.5.1 13:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:49:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:53 INFO - Downloading functools32-3.2.3-2.tar.gz 13:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:49:53 INFO - warning: no files found matching '*.txt' 13:49:53 INFO - no previously-included directories found matching 'build' 13:49:53 INFO - no previously-included directories found matching 'dist' 13:49:53 INFO - no previously-included directories found matching '.git*' 13:49:53 INFO - Installing collected packages: jsonschema, functools32 13:49:53 INFO - Running setup.py install for functools32 13:49:53 INFO - warning: no files found matching '*.txt' 13:49:53 INFO - no previously-included directories found matching 'build' 13:49:53 INFO - no previously-included directories found matching 'dist' 13:49:53 INFO - no previously-included directories found matching '.git*' 13:49:53 INFO - Successfully installed jsonschema functools32 13:49:53 INFO - Cleaning up... 13:49:53 INFO - Return code: 0 13:49:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662090>, '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 0x1662d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:49:53 INFO - Using env: {'DISPLAY': ':0', 13:49:53 INFO - 'HOME': '/home/cltbld', 13:49:53 INFO - 'LANG': 'en_US.UTF-8', 13:49:53 INFO - 'LANGUAGE': 'en_US:en', 13:49:53 INFO - 'LOGNAME': 'cltbld', 13:49:53 INFO - 'MAIL': '/var/mail/cltbld', 13:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:53 INFO - 'MOZ_NO_REMOTE': '1', 13:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:53 INFO - 'NO_EM_RESTART': '1', 13:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:53 INFO - 'PWD': '/builds/slave/test', 13:49:53 INFO - 'SHELL': '/bin/bash', 13:49:53 INFO - 'SHLVL': '1', 13:49:53 INFO - 'TERM': 'linux', 13:49:53 INFO - 'TMOUT': '86400', 13:49:53 INFO - 'USER': 'cltbld', 13:49:53 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 13:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:53 INFO - '_': '/tools/buildbot/bin/python'} 13:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:49:53 INFO - Cleaning up... 13:49:53 INFO - Return code: 0 13:49:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x12f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662090>, '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 0x1662d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:49:53 INFO - Using env: {'DISPLAY': ':0', 13:49:53 INFO - 'HOME': '/home/cltbld', 13:49:53 INFO - 'LANG': 'en_US.UTF-8', 13:49:53 INFO - 'LANGUAGE': 'en_US:en', 13:49:53 INFO - 'LOGNAME': 'cltbld', 13:49:53 INFO - 'MAIL': '/var/mail/cltbld', 13:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:53 INFO - 'MOZ_NO_REMOTE': '1', 13:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:53 INFO - 'NO_EM_RESTART': '1', 13:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:53 INFO - 'PWD': '/builds/slave/test', 13:49:53 INFO - 'SHELL': '/bin/bash', 13:49:53 INFO - 'SHLVL': '1', 13:49:53 INFO - 'TERM': 'linux', 13:49:53 INFO - 'TMOUT': '86400', 13:49:53 INFO - 'USER': 'cltbld', 13:49:53 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 13:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:53 INFO - '_': '/tools/buildbot/bin/python'} 13:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:53 INFO - Downloading/unpacking blobuploader==1.2.4 13:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:54 INFO - Downloading blobuploader-1.2.4.tar.gz 13:49:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:49:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:49:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:55 INFO - Downloading docopt-0.6.1.tar.gz 13:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:49:55 INFO - Installing collected packages: blobuploader, requests, docopt 13:49:55 INFO - Running setup.py install for blobuploader 13:49:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:49:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:49:55 INFO - Running setup.py install for requests 13:49:55 INFO - Running setup.py install for docopt 13:49:55 INFO - Successfully installed blobuploader requests docopt 13:49:55 INFO - Cleaning up... 13:49:55 INFO - Return code: 0 13:49:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:55 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/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 0x12f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662090>, '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 0x1662d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:49:55 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:49:55 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:49:55 INFO - Using env: {'DISPLAY': ':0', 13:49:55 INFO - 'HOME': '/home/cltbld', 13:49:55 INFO - 'LANG': 'en_US.UTF-8', 13:49:55 INFO - 'LANGUAGE': 'en_US:en', 13:49:55 INFO - 'LOGNAME': 'cltbld', 13:49:55 INFO - 'MAIL': '/var/mail/cltbld', 13:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:55 INFO - 'MOZ_NO_REMOTE': '1', 13:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:55 INFO - 'NO_EM_RESTART': '1', 13:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:55 INFO - 'PWD': '/builds/slave/test', 13:49:55 INFO - 'SHELL': '/bin/bash', 13:49:55 INFO - 'SHLVL': '1', 13:49:55 INFO - 'TERM': 'linux', 13:49:55 INFO - 'TMOUT': '86400', 13:49:55 INFO - 'USER': 'cltbld', 13:49:55 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 13:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:55 INFO - '_': '/tools/buildbot/bin/python'} 13:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:56 INFO - Running setup.py (path:/tmp/pip-l0LPhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:56 INFO - Running setup.py (path:/tmp/pip-m8WIqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:56 INFO - Running setup.py (path:/tmp/pip-2tx4Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:56 INFO - Running setup.py (path:/tmp/pip-XH6bJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:56 INFO - Running setup.py (path:/tmp/pip-y2IIgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:56 INFO - Running setup.py (path:/tmp/pip-ZRmBGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:56 INFO - Running setup.py (path:/tmp/pip-BESLYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:56 INFO - Running setup.py (path:/tmp/pip-XZVv0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:56 INFO - Running setup.py (path:/tmp/pip-EDdgFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:56 INFO - Running setup.py (path:/tmp/pip-DRBBjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:56 INFO - Running setup.py (path:/tmp/pip-yUyVK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:56 INFO - Running setup.py (path:/tmp/pip-dfb2ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:57 INFO - Running setup.py (path:/tmp/pip-26DaXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:57 INFO - Running setup.py (path:/tmp/pip-yPKucm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:57 INFO - Running setup.py (path:/tmp/pip-qVoVfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:57 INFO - Running setup.py (path:/tmp/pip-c3uGO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:57 INFO - Running setup.py (path:/tmp/pip-olp3cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:49:57 INFO - Running setup.py install for manifestparser 13:49:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:49:57 INFO - Running setup.py install for mozcrash 13:49:57 INFO - Running setup.py install for mozdebug 13:49:57 INFO - Running setup.py install for mozdevice 13:49:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:49:57 INFO - Running setup.py install for mozfile 13:49:57 INFO - Running setup.py install for mozhttpd 13:49:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:49:57 INFO - Running setup.py install for mozinfo 13:49:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:49:58 INFO - Running setup.py install for mozInstall 13:49:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:49:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:49:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:49:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:49:58 INFO - Running setup.py install for mozleak 13:49:58 INFO - Running setup.py install for mozlog 13:49:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:49:58 INFO - Running setup.py install for moznetwork 13:49:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:49:58 INFO - Running setup.py install for mozprocess 13:49:58 INFO - Running setup.py install for mozprofile 13:49:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:49:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:49:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:49:58 INFO - Running setup.py install for mozrunner 13:49:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:49:58 INFO - Running setup.py install for mozscreenshot 13:49:58 INFO - Running setup.py install for moztest 13:49:59 INFO - Running setup.py install for mozversion 13:49:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:49:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:49:59 INFO - Cleaning up... 13:49:59 INFO - Return code: 0 13:49:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:59 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/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 0x12f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662090>, '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 0x1662d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:49:59 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:49:59 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:49:59 INFO - Using env: {'DISPLAY': ':0', 13:49:59 INFO - 'HOME': '/home/cltbld', 13:49:59 INFO - 'LANG': 'en_US.UTF-8', 13:49:59 INFO - 'LANGUAGE': 'en_US:en', 13:49:59 INFO - 'LOGNAME': 'cltbld', 13:49:59 INFO - 'MAIL': '/var/mail/cltbld', 13:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:59 INFO - 'MOZ_NO_REMOTE': '1', 13:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:59 INFO - 'NO_EM_RESTART': '1', 13:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:59 INFO - 'PWD': '/builds/slave/test', 13:49:59 INFO - 'SHELL': '/bin/bash', 13:49:59 INFO - 'SHLVL': '1', 13:49:59 INFO - 'TERM': 'linux', 13:49:59 INFO - 'TMOUT': '86400', 13:49:59 INFO - 'USER': 'cltbld', 13:49:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 13:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:59 INFO - '_': '/tools/buildbot/bin/python'} 13:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:59 INFO - Running setup.py (path:/tmp/pip-mTtFjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:59 INFO - Running setup.py (path:/tmp/pip-tboOHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:59 INFO - Running setup.py (path:/tmp/pip-FBckzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:59 INFO - Running setup.py (path:/tmp/pip-807Ic4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:59 INFO - Running setup.py (path:/tmp/pip-Y4YEJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:59 INFO - Running setup.py (path:/tmp/pip-OrlVID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:59 INFO - Running setup.py (path:/tmp/pip-YFzAXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:59 INFO - Running setup.py (path:/tmp/pip-RjgDEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:59 INFO - Running setup.py (path:/tmp/pip-vQJ0kA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:59 INFO - Running setup.py (path:/tmp/pip-1JLQKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:50:00 INFO - Running setup.py (path:/tmp/pip-Fk9OCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:50:00 INFO - Running setup.py (path:/tmp/pip-DZqY2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:50:00 INFO - Running setup.py (path:/tmp/pip-YMNvTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:50:00 INFO - Running setup.py (path:/tmp/pip-cnjV9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:00 INFO - Running setup.py (path:/tmp/pip-FiFphM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:50:00 INFO - Running setup.py (path:/tmp/pip-CuDAai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:50:00 INFO - Running setup.py (path:/tmp/pip-Wly1sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:50:00 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:50:00 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:50:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:50: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 13:50: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 13:50: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 13:50: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 13:50:01 INFO - Downloading blessings-1.6.tar.gz 13:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:50:01 INFO - Installing collected packages: blessings 13:50:01 INFO - Running setup.py install for blessings 13:50:01 INFO - Successfully installed blessings 13:50:01 INFO - Cleaning up... 13:50:01 INFO - Return code: 0 13:50:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:50:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:50:02 INFO - Reading from file tmpfile_stdout 13:50:02 INFO - Current package versions: 13:50:02 INFO - argparse == 1.2.1 13:50:02 INFO - blessings == 1.6 13:50:02 INFO - blobuploader == 1.2.4 13:50:02 INFO - docopt == 0.6.1 13:50:02 INFO - functools32 == 3.2.3-2 13:50:02 INFO - jsonschema == 2.5.1 13:50:02 INFO - manifestparser == 1.1 13:50:02 INFO - mozInstall == 1.13 13:50:02 INFO - mozcrash == 1.0 13:50:02 INFO - mozdebug == 0.1 13:50:02 INFO - mozdevice == 0.51 13:50:02 INFO - mozfile == 1.2 13:50:02 INFO - mozhttpd == 0.7 13:50:02 INFO - mozinfo == 0.10 13:50:02 INFO - mozleak == 0.1 13:50:02 INFO - mozlog == 3.5 13:50:02 INFO - moznetwork == 0.27 13:50:02 INFO - mozprocess == 0.25 13:50:02 INFO - mozprofile == 0.28 13:50:02 INFO - mozrunner == 6.13 13:50:02 INFO - mozscreenshot == 0.1 13:50:02 INFO - mozsystemmonitor == 0.3 13:50:02 INFO - moztest == 0.8 13:50:02 INFO - mozversion == 1.4 13:50:02 INFO - psutil == 3.1.1 13:50:02 INFO - requests == 1.2.3 13:50:02 INFO - wsgiref == 0.1.2 13:50:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:02 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/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 0x12f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662090>, '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 0x1662d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:50:02 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:50:02 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:50:02 INFO - Using env: {'DISPLAY': ':0', 13:50:02 INFO - 'HOME': '/home/cltbld', 13:50:02 INFO - 'LANG': 'en_US.UTF-8', 13:50:02 INFO - 'LANGUAGE': 'en_US:en', 13:50:02 INFO - 'LOGNAME': 'cltbld', 13:50:02 INFO - 'MAIL': '/var/mail/cltbld', 13:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:02 INFO - 'MOZ_NO_REMOTE': '1', 13:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:02 INFO - 'NO_EM_RESTART': '1', 13:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:02 INFO - 'PWD': '/builds/slave/test', 13:50:02 INFO - 'SHELL': '/bin/bash', 13:50:02 INFO - 'SHLVL': '1', 13:50:02 INFO - 'TERM': 'linux', 13:50:02 INFO - 'TMOUT': '86400', 13:50:02 INFO - 'USER': 'cltbld', 13:50:02 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 13:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:02 INFO - '_': '/tools/buildbot/bin/python'} 13:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:50:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:50:03 INFO - Installing collected packages: simplejson 13:50:03 INFO - Running setup.py install for simplejson 13:50:03 INFO - building 'simplejson._speedups' extension 13:50:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 13:50:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 13:50:04 INFO - Successfully installed simplejson 13:50:04 INFO - Cleaning up... 13:50:04 INFO - Return code: 0 13:50:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:04 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/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 0x12f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662090>, '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 0x1662d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:50:04 INFO - Using env: {'DISPLAY': ':0', 13:50:04 INFO - 'HOME': '/home/cltbld', 13:50:04 INFO - 'LANG': 'en_US.UTF-8', 13:50:04 INFO - 'LANGUAGE': 'en_US:en', 13:50:04 INFO - 'LOGNAME': 'cltbld', 13:50:04 INFO - 'MAIL': '/var/mail/cltbld', 13:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:04 INFO - 'MOZ_NO_REMOTE': '1', 13:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:04 INFO - 'NO_EM_RESTART': '1', 13:50:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:04 INFO - 'PWD': '/builds/slave/test', 13:50:04 INFO - 'SHELL': '/bin/bash', 13:50:04 INFO - 'SHLVL': '1', 13:50:04 INFO - 'TERM': 'linux', 13:50:04 INFO - 'TMOUT': '86400', 13:50:04 INFO - 'USER': 'cltbld', 13:50:04 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 13:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:04 INFO - '_': '/tools/buildbot/bin/python'} 13:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:50:04 INFO - Cleaning up... 13:50:04 INFO - Return code: 0 13:50:04 INFO - Running post-action listener: _resource_record_post_action 13:50:04 INFO - Running post-action listener: _start_resource_monitoring 13:50:04 INFO - Starting resource monitoring. 13:50:04 INFO - [mozharness: 2017-09-26 20:50:04.841503Z] Finished create-virtualenv step (success) 13:50:04 INFO - [mozharness: 2017-09-26 20:50:04.842152Z] Running install step. 13:50:04 INFO - Running pre-action listener: _resource_record_pre_action 13:50:04 INFO - Running main action method: install 13:50:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:50:05 INFO - Reading from file tmpfile_stdout 13:50:05 INFO - Detecting whether we're running mozinstall >=1.0... 13:50:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:50:05 INFO - Reading from file tmpfile_stdout 13:50:05 INFO - Output received: 13:50:05 INFO - Usage: mozinstall [options] installer 13:50:05 INFO - Options: 13:50:05 INFO - -h, --help show this help message and exit 13:50:05 INFO - -d DEST, --destination=DEST 13:50:05 INFO - Directory to install application into. [default: 13:50:05 INFO - "/builds/slave/test"] 13:50:05 INFO - --app=APP Application being installed. [default: firefox] 13:50:05 INFO - mkdir: /builds/slave/test/build/application 13:50:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:50:19 INFO - Reading from file tmpfile_stdout 13:50:19 INFO - Output received: 13:50:19 INFO - /builds/slave/test/build/application/firefox/firefox 13:50:19 INFO - Running post-action listener: _resource_record_post_action 13:50:19 INFO - [mozharness: 2017-09-26 20:50:19.764952Z] Finished install step (success) 13:50:19 INFO - [mozharness: 2017-09-26 20:50:19.765098Z] Running setup-mitmproxy step. 13:50:19 INFO - Running pre-action listener: _resource_record_pre_action 13:50:19 INFO - Running main action method: setup_mitmproxy 13:50:19 INFO - Skipping: mitmproxy is not required 13:50:19 INFO - Running post-action listener: _resource_record_post_action 13:50:19 INFO - [mozharness: 2017-09-26 20:50:19.765759Z] Finished setup-mitmproxy step (success) 13:50:19 INFO - [mozharness: 2017-09-26 20:50:19.765980Z] Running run-tests step. 13:50:19 INFO - Running pre-action listener: _resource_record_pre_action 13:50:19 INFO - Running pre-action listener: _set_gcov_prefix 13:50:19 INFO - Running main action method: run_tests 13:50:19 WARNING - Try message not found. 13:50:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:50:19 INFO - Python 2.7.3 13:50:19 INFO - Return code: 0 13:50:19 INFO - grabbing minidump binary from tooltool 13:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1662090>, '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 0x1662d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:50:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:50:19 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:50:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:50:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:50:19 INFO - Return code: 0 13:50:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:50:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:50:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:50:19 INFO - ENV: RUST_BACKTRACE is now full 13:50:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:50:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:50:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 13:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 13:50:19 INFO - Using env: {'DISPLAY': ':0', 13:50:19 INFO - 'HOME': '/home/cltbld', 13:50:19 INFO - 'LANG': 'en_US.UTF-8', 13:50:19 INFO - 'LANGUAGE': 'en_US:en', 13:50:19 INFO - 'LOGNAME': 'cltbld', 13:50:19 INFO - 'MAIL': '/var/mail/cltbld', 13:50:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:50:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:50:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:19 INFO - 'MOZ_NO_REMOTE': '1', 13:50:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:50:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:19 INFO - 'NO_EM_RESTART': '1', 13:50:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:19 INFO - 'PWD': '/builds/slave/test', 13:50:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:50:19 INFO - 'RUST_BACKTRACE': 'full', 13:50:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:50:19 INFO - 'SHELL': '/bin/bash', 13:50:19 INFO - 'SHLVL': '1', 13:50:19 INFO - 'TERM': 'linux', 13:50:19 INFO - 'TMOUT': '86400', 13:50:19 INFO - 'USER': 'cltbld', 13:50:19 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 13:50:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:19 INFO - '_': '/tools/buildbot/bin/python'} 13:50:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 13:50:20 INFO - mozversion application_buildid: 20170926192802 13:50:20 INFO - mozversion application_changeset: 058e8c2cba283dd5e9b301c7994a059f9a2677ca 13:50:20 INFO - mozversion application_display_name: Firefox 13:50:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:50:20 INFO - mozversion application_name: Firefox 13:50:20 INFO - mozversion application_remotingname: firefox 13:50:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:50:20 INFO - mozversion application_vendor: Mozilla 13:50:20 INFO - mozversion application_version: 57.0 13:50:20 INFO - mozversion platform_buildid: 20170926192802 13:50:20 INFO - mozversion platform_changeset: 058e8c2cba283dd5e9b301c7994a059f9a2677ca 13:50:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:50:20 INFO - mozversion platform_version: 57.0 13:50:20 INFO - using testdate: 1506459020 13:50:20 INFO - actual date: 1506459020 13:50:20 INFO - starting webserver on 'localhost:38896' 13:50:20 INFO - SUITE-START | Running 2 tests 13:50:20 INFO - TEST-START | dromaeo_css 13:50:20 INFO - Initialising browser for dromaeo_css test... 13:50:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38896/getInfo.html -profile /tmp/tmpugCdEC/profile 13:50:20 INFO - TEST-INFO | started process 17159 (/builds/slave/test/build/application/firefox/firefox http://localhost:38896/getInfo.html) 13:50:26 INFO - TEST-INFO | 17159: exit 0 13:50:27 INFO - Browser initialized. 13:50:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:50:27 INFO - Using env: {'DISPLAY': ':0', 13:50:27 INFO - 'HOME': '/home/cltbld', 13:50:27 INFO - 'JSGC_DISABLE_POISONING': '1', 13:50:27 INFO - 'LANG': 'en_US.UTF-8', 13:50:27 INFO - 'LANGUAGE': 'en_US:en', 13:50:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:50:27 INFO - 'LOGNAME': 'cltbld', 13:50:27 INFO - 'MAIL': '/var/mail/cltbld', 13:50:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:50:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:50:27 INFO - 'MOZ_CRASHREPORTER': '1', 13:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:50:27 INFO - 'MOZ_NO_REMOTE': '1', 13:50:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:27 INFO - 'NO_EM_RESTART': '1', 13:50:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:27 INFO - 'PWD': '/builds/slave/test', 13:50:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:50:27 INFO - 'RUST_BACKTRACE': 'full', 13:50:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:50:27 INFO - 'SHELL': '/bin/bash', 13:50:27 INFO - 'SHLVL': '1', 13:50:27 INFO - 'TERM': 'linux', 13:50:27 INFO - 'TMOUT': '86400', 13:50:27 INFO - 'USER': 'cltbld', 13:50:27 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 13:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:27 INFO - '_': '/tools/buildbot/bin/python'} 13:50:27 INFO - TEST-INFO | started process 17351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpugCdEC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:50:27 INFO - PID 17351 | 13:50:27 INFO - PID 17351 | (/builds/slave/test/build/application/firefox/firefox:17400): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:50:27 INFO - PID 17351 | 13:50:38 INFO - PID 17351 | RSS: Main: 141029376 13:50:38 INFO - PID 17351 | 13:53:35 INFO - PID 17351 | Cycle 1(1): loaded http://localhost:38896/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38896/tests/dromaeo/cssquery-ext.html) 13:53:36 INFO - PID 17351 | RSS: Main: 144711680 13:53:36 INFO - PID 17351 | 13:56:38 INFO - PID 17351 | Cycle 1(1): loaded http://localhost:38896/tests/dromaeo/cssquery-ext.html (next: http://localhost:38896/tests/dromaeo/cssquery-jquery.html) 13:56:38 INFO - PID 17351 | RSS: Main: 143933440 13:56:38 INFO - PID 17351 | 13:59:40 INFO - PID 17351 | Cycle 1(1): loaded http://localhost:38896/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38896/tests/dromaeo/cssquery-mootools.html) 13:59:40 INFO - PID 17351 | RSS: Main: 145014784 13:59:40 INFO - PID 17351 | 14:02:42 INFO - PID 17351 | Cycle 1(1): loaded http://localhost:38896/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38896/tests/dromaeo/cssquery-prototype.html) 14:02:42 INFO - PID 17351 | RSS: Main: 144863232 14:02:42 INFO - PID 17351 | 14:05:45 INFO - PID 17351 | Cycle 1(1): loaded http://localhost:38896/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38896/tests/dromaeo/cssquery-yui.html) 14:05:46 INFO - PID 17351 | RSS: Main: 146694144 14:05:46 INFO - PID 17351 | 14:08:47 INFO - PID 17351 | Cycle 1(1): loaded http://localhost:38896/tests/dromaeo/cssquery-yui.html (next: http://localhost:38896/tests/dromaeo/cssquery-dojo.html) 14:08:47 INFO - PID 17351 | RSS: Main: 148799488 14:08:47 INFO - PID 17351 | 14:08:47 INFO - PID 17351 | __start_tp_report 14:08:47 INFO - PID 17351 | _x_x_mozilla_page_load 14:08:47 INFO - PID 17351 | _x_x_mozilla_page_load_details 14:08:47 INFO - PID 17351 | |i|pagename|runs| 14:08:47 INFO - PID 17351 | |0;dojo.html;4032.9395059074113;4038.899027524313;4049.858254961075;4071.2468193384207;4111.958880411195;6515.478761699064;6548.803535893919;6610.933890661092;6674.332566743323;6675.86648267035;6597.406233438989;6603.8349041274;6610.537262391635;6666.433353164987;6685.164354455693;5922.88154236915;5945.316288626798;5953.821385358436;5958.225430694026;6007.339192688801;5901.645901245939;5940.287165540141;5960.642361458326;5981.85045373867;5982.760689572412;5896.351401345849;5918.437748413894;5934.495567876736;5948.643081415129;5954.821355359324;5957.106434034886;5966.2840459144745;5976.820695379146;6039.214902062726;6045.848853778669;5778.913316300259;5870.706464676792;5923.052311630118;5935;6068.605540639845;6482.448991835699;6487.448566871822;6496.7726129585235;6553.9344606553805;6560.507961902828;7112.395446387063;7198.856022879513;7214.711411543584;7215.747448839265;7216.494845360827;7171.533850299714;7178.784636460915;7194.38847697941;7256.709731610729;7285.307895749896;6530.118434011395;6650.900236496456;6674.666266686646;6681.231658359302;6688.799336019927;7347.63261836906;7352.228016058344;7363;7395.2235015323695;7428.554286742813;7063.328983746535;7064.646767661597;7146.106736657918;7146.499745017903;7168.17565979919;7201.675924583406;7204.207537170907;7249.093863267091;7250.782476525713;7255.782326530212;6979.860402792017;7090.964545177241;7095.254998225215;7114.537555058904;7151.60666163366;6985.965070174617;7104.6447677615915;7115.217326094125;7186.964065179641;7210.278972102853;5340.839774806762;5352.277442545284;5352.678839269578;5355.892882142413;5365.839024829262;4776.259679749644;4807.855764327076;4876.878078048077;4880.877978050577;4881.633877459205;6567.605943643397;6643.136392268974;6645.568038077509;6735.696893639798;6736.090627765189;7037.964810175917;7056.188538318056;7061;7074.080369551925;7127.857442851114;6629.337066293332;6690.565113267622;6712.12742343502;6726.764563240263;6733.494987875929;5990.970045149834;6005.789797357072;6074.271087469532;6091.02543593023;6093.268807743099;7339.449541284425;7406.07424071991;7452.441066920002;7455.0681164854395;7505.662245198979;7097.503174777819;7151.713931442684;7152.606606636685;7152.964235178791;7195.532290401107;7299.008837944405;7312.378447831994;7318.377937875341;7411;7551.622418879144;7081.157388668956;7082.787516374517;7159.105111861018;7161.248068952685;7181.174164971095;7041.964790176016;7090.290970902868;7094.9290507094265;7173.10336207974;7215.60314182725;6805.115335006418;6920.9307906920285;6955.304469553004;6970.651467426507;6972.442204623517;6719.764808231688;6825.078614386995;6875.243723190345;6929.861402772017;6992.79021629352;6871.622060786704;6926.896096558455;6964.0598519201285;6964.26875178099;6965.44276457872;6941.34057264559;6958.06066181059;6961.37347638715;7021.368076873106;7066.7173313066905;6669.233038200475;6725.092112564741;6763.898541521783;6815.591064536144;6826.624535650587 14:08:47 INFO - PID 17351 | |1;ext.html;968.9127978481936;973.3235401396029;1004.7638804880852;1026.5791025679473;1032.2258306270292;45528.31707524386;46088.308675369815;46550.3017454738;46654.76672616637;46934.530654693444;49100.50899491004;49433.75283123579;49479.752601237036;49615.50384496154;49658.751706241506;8925.999999999984;9094.77263068422;9096.317776166781;9101.95449022754;9105.135012173865;8947.150020748019;9049.638014479413;9050.366474346798;9055.728328150133;9056.728298151065;8991.730248092568;9074.682386116487;9076.36465447419;9090.13643703847;9096.681616143436;8952.328575356874;8953.731388058368;8971.372003959725;9002.459852408843;9035.41269817463;8790.780230494225;8846.424982376126;8854.247388971946;8917.42036767608;8923.41997770143;41919.37120943188;42158.367624485654;43128.78435607833;43461.56538434607;43478.56521434777;3840.577536470986;3886.9222615547533;3898.8440462381755;3932.075962148893;3935.232629637222;34727.6527234727;34787.82606086979;34820.303593928234;34955;35182.120446988774;5718.456746609066;5743.310802703661;5749.511291540224;5753.424657534255;5788.82633520995;239071;239799;239891;240469;240913;53578.464215357344;53704.73147634315;53726.731366342916;54148.729256353465;56781.99999999917;59757.70121149453;60164.69917650384;60187.398126019056;60206.397936020956;60432.69783651141;18980;19042.238310467703;19049.238030478624;19201.231950721816;19216.61566768657;15815.920920395325;15909.443169489012;15944.2825072872;15973.760393594106;15975.920120399556;15746.448874289345;15946.521604351889;16007.919960400357;16090.75863862043;16102.677946441005;6005.129256257818;6230.6573138476915;6240.7503699851495;6242.250929888442;6257.530685198628;1126.8366086917351;1130.6268931252666;1134.9262297950606;1143.9428028598536;1145.7593905279984;26454.470910582066;26465.603015954777;27052.72947270502;27235.319117022234;27318;1238.2322959764824;1238.4736486992992;1239.6528971887885;1240.8076748104058;1248.1574936917543;14010.75601408864;14133.15201087938;14238.85761142396;14261.286935653176;14294;327117;330538;335714;337185;338022;67027.32972670211;67383.32616673868;67463.66268168726;67744.66127669429;67842.66078669575;1537.9154146521826;1559.173637971854;1567.8902476826513;1571.5835303644544;1592.562045437514;30745.53881691821;30910.227244318172;30949.381012379177;31047.53428698526;31081.533776993816;44578.3313250295;44746.552534475544;44898.551014490746;44899.551004489535;44914.55085449234;284912;285340;285360;287304;287382;39399.80300098481;39509.604903950596;39649.80175099106;39803;39882;49826;49828;49946.500534994186;50277.497225027284;50277.49722502875;35954.28091438209;36406.9077927652;36780.81609591935;36965.260694785415;37251.813740931124;35501.64498355087;35811.64188358187;36145.81927090348;36245.45631815472;36793.26413471769;42134.15731685411;42671;42858;42919.141617168105;43133.784331078146;34928.82535587306;35024.824875875456;35256.11859703528;35387;35414.64585354216;26060.856450255465;26165.215043548724;26196.48609223352;26460.8676956614;26879.731202687723 14:08:47 INFO - PID 17351 | |2;jquery.html;642.9045999921835;643.2857661975427;651.375235825638;652.5236875037247;656.6099398190586;23782.286531404043;24399.512009759794;24463.75536244639;24470.14354497593;24488.265352039423;26783.062592809256;26950.46099078017;27053;27124.32189195271;27185.320366990836;6783.864322713543;7033.1911830139425;7073.221945585981;7073.469489788261;7073.504854660176;7038.788836334918;7046.541974771623;7090.964545177293;7095.43236541078;7096.5387249828855;7005.614691191982;7026.789196324118;7034.824129396755;7035.894461583081;7049.083619129532;6957;7024.754133605325;7045.084139061914;7045.154581450233;7054.788356349318;6178.969105154445;6355.205599300088;6372.904406433907;6420.133282006916;6448.709808058648;31114.844425777952;31657.841710791297;31711.20721981946;31749.20626984321;31810.840945795124;2345.0854166874933;2369.1352656280505;2384.701912260967;2385.0579021286494;2385.272491889973;19480.220791168478;19758.11088501021;20127.29554465601;21612.135514579397;21780.564388712297;2656.628072069912;2666.4933662604044;2737.712540183272;2748.6839013513304;2751.697313295536;140934;145710;157172;161833;162548.9999999988;15981.002374703163;16996.385343392358;17186.74219886703;17552.736708949375;17860.464186074438;27382.315442114108;27435.45129097407;27437.58843617347;27481.31296717558;27513.44973100527;11070.723231919106;11159.609413670483;11303.434828258718;11372.203945723886;11435.942820285845;10239.539220735085;10242.129418999319;10279.383237005653;10334.75982882059;10437.425941573134;10243.539040743184;10279.280450368551;10309.484525773682;10565.947170264253;10714.89285107139;3091.1190310761326;3109.4558452271212;3126.8592913318957;3188.660762479764;3191.574403453346;1061.9787604247872;1066.6213494209599;1087.423665457309;1088.580896354909;1094.7482079121687;22209.777902220772;22354.888225558767;22502.324930252118;22588.209412670476;22892.542149157256;1112.4604566785104;1114.2924243105524;1127.413744852672;1130.4404319861558;1159.211736019498;12009;12295.139340246276;12362.258264504158;12392.75214495723;12517.812232816515;605096;628553;631229;647590;657599;136463;136537.3173134128;138368.30815845856;139302.3034884819;142511;1264.7027948432112;1270.8474983001913;1297.344840855362;1307.6469353274563;1309.8952083833271;19262.32581859684;19305.710414344077;19462.94328629219;19665.901670491556;20033.29883454072;61472.69263653653;61489.69255153875;61577.69211153915;62002;63226.68386658037;80924.59537702274;81049.78425323743;82298;82378.17621823704;82446.58776706079;15753.527394178192;16139.596510086873;16214.10822404779;16247.593810154367;16276.918615406847;24993.87503062473;25211.873940630914;25309.493810123327;25410.237692869243;25528;20338.796612034283;20572.69140962857;20612.587748244652;20720.48198795042;20736.481587959817;17705.822941770417;18009.909950450165;18150.364737234133;18369.81630183681;18696.34562790296;20693.689594655792;21036.368908932756;21092.261770837948;21286.467838304165;21300.573988520453;16114.597135071717;16182;16196.838031619533;16238.918805405898;16246;18744.812551874307;18770.96759678176;18981;19068.141933612744;19140.8085919139 14:08:47 INFO - PID 17351 | |3;mootools.html;1519.2935285092433;1555.5255647027652;1579.976300355495;1586.508182463436;1589.3642542982805;17548;18259;18259;18264.269429222848;18293.634127317444;17662.293508259656;17749.20128594213;17776.200070996805;17811.109444527785;17825.37611183609;3140.8762325253724;3154.9211269718267;3218.291975765328;3220.4847224444093;3227.8386080695986;3110.2846345340586;3125.9062228133193;3132.6867313268604;3136.827474488902;3159;3108.891188808392;3110.0203435917615;3130.467820470514;3213.7589680773917;3218.5011323244935;3208;3218.9356212875846;3238.9676103238903;3243.4323993301077;3247.253131779692;3108.626964764243;3115.8909438169553;3116.2209447638093;3138.529220616903;3141.8271995040263;17166.570835729082;17230.569235769206;17272;17304.653906921918;17322.740158897628;9266.768330791716;9607.279454040974;9610.6636267731;9612;9647.3729207602;5734.397888221718;5915.467607915309;6003.549733769941;6045.78839740607;6077.301110372276;2088.0812442525394;2107.072887929306;2146.3560931720576;2157.5792720419527;2185.278857976864;33186.83406582951;33347.16632084193;33489.497657535154;33507.49738753921;33549;7820.843583128306;7865.685372585032;7906.458240643135;8132.6746930122135;8186.877196842052;21030.263940762;21037.368878933656;21042.47393815167;21070.262540811;21071.26250581222;8942;9028.232600228923;9093.590788414405;9094.86357704635;9105.362624616213;8233.053198882086;8334.291585215324;8363.16368363171;8365.498070115813;8431.40980131385;6176.197094377702;6208.410201030895;6214.720337584819;6225.750969961241;6261.405166509266;1631.7552367145024;1649.5958490169746;1795.9281628734705;1811.1035037656445;1813.2475022865626;968.2931460034215;1004.7036124343336;1020.9591616335412;1024.1704219582161;1027.6095083868083;9965.302428829913;10117.140043096419;10323.84514232287;10417.270791044706;10451.790964180826;848.4442690038035;849.8172892828071;884.3765145572356;957.5164541906292;1111.4220605285207;5530.474604912527;6024.698765061729;6029;6088.117223002729;6163.876722465615;26012.349691257492;27048.1885543434;27410.177694669193;27436;27917.581236281472;26497.735022649525;27185;27189.04838330649;27258.863705681346;27360.315992100357;13369.66575835612;13411.128276661986;13558.593242202553;13582.320883955763;13603.523876664269;9946.403215807075;10021.09810117093;10115.949420252851;10140.645077422254;10166.440845753554;22848.428789280402;22875;22999.65500517527;23016.194433194756;23557.175498857458;23314;23772.881135594904;23960.28119156428;24173.274801755975;24719.752802471747;12500.124991250888;12669.746605067663;12792.424340904496;12817.359132043173;12845.935770321088;16154.67690646204;16456.917715411346;16489.422870199487;16510.42213522521;16512.66974660524;13401.731965360834;13437.865621344052;13504.122232054886;13550.322483875963;13551.32243387807;12627.558035468715;13016.788772882242;13257;13359.866401335863;13435.19388836673;10069.144122749649;10158.593656253666;10207.948960255151;10344.431056291976;10380.844287335545;8701.695440659547;8823.911760882309;8843.867341989746;8864.556772161237;8880.600372983103;8703.521306328214;8740.863687720555;8777.122287771172;8823.558822059;8827 14:08:47 INFO - PID 17351 | |4;prototype.html;563.8308507447765;587.3949831673376;612.6569121292074;613.0834402568158;613.6870196199939;6512.088307636935;6534.738610455576;6548.86902261955;6623.668816559177;6679;6456.451201647866;6479.125318082058;6485.411074286794;6532.216134063919;6577.2436169840485;5275.419703832576;5348.144296912495;5366.356037275513;5389.272448219499;5391.110466772978;5323.855371095214;5342.305500284958;5346.251524786533;5351.464853514656;5355.919661205085;5053.620978426614;5187.974060129694;5202.179237266945;5203.2975548301065;5218.712970786605;5155.32980712505;5194.77922688168;5212.817551385702;5232.895342093175;5234.214867769827;4645.814167433298;4670.789814458358;4673.532646735333;4691.601213896823;4699.953000469985;6288.339724328971;6322.873542529123;6332.33510481402;6421;6447.580907241061;6062.696865156725;6089.878202435926;6139.324674285825;6171.938280617182;6216.191895053659;6750.565794535397;6833.180018397824;6974.302569743036;6996.475264355143;7010.123734533184;5211.973940130275;5215.478452154792;5217.660852044605;5240.34495688039;5300.2314664373835;6912.4815638826785;7112.751053713096;7176.533525320838;7176.856462870765;7256.040868965402;5430.8913821723345;5438.592105592096;5443.455654434604;5465.836024919259;5500.762328476141;5484.451554844483;5491.105568578834;5491.148871924858;5526.839363733661;5558.276444542226;6041.818745437644;6102.298235702951;6105.48103411215;6123.510119190454;6177.505799536027;6962;7035.261297563785;7044.87282034872;7045.577265364094;7050;1896.2035944903173;1902.7526421565385;1913.2347061175642;1923.1826473748881;1930.7200455933812;1323.808047833078;1352.864713528659;1360.4694718441754;1368.2132773655187;1369.2400717601827;6391.808245752635;6425.453836423956;6463.479243095197;6477.514186436036;6508.707108180143;6824.249332573413;6903.482238832007;6924.792256232321;6982.1970473395195;7000.769315309379;6320.71556779946;6417;6473.449756770633;6485.7405703772265;6534.934650653433;3679.105260790695;3759.8496060157836;3760.1539653577724;3763.7553559018575;3774.7923864187183;7345.485815992829;7377.778666639902;7385.929040289128;7403.333699967029;7471.252874712485;7067.893981590178;7093.787186384417;7112.502124851314;7117.786466406016;7212.783616491513;7274.27257274279;7275.927240727525;7379.963100184465;7395.6671949762385;7407.777766667009;7078.504504684623;7113.110861142357;7133.964330178316;7162.89255661176;7203.271214908489;6967.686454109476;6996.720131194898;7028.789136325919;7084.716611335489;7117.1459424869345;7309.561426314225;7400.259974002557;7435.962820185864;7444.367228785614;7468.92531074704;5462.453754624506;5463.9180412294645;5480.232767412485;5481.177823326533;5497.807576734955;6762.729490820312;6994.545354552141;7113.430925525842;7178.5692858428665;7213.639318034182;6657.700403481758;6864.141982252218;6924.238333783179;6933.647938652116;6940.861182776215;6774.525783195129;6787.355201255873;6909.654517274217;6935.583864968118;6941.930580694128;6450.7097180627925;6687.966560167168;6761.560498567577;6805.761798337233;6834.043233947152;6799.456043516408;6825.283345248876;6871.4159296458365;6916.412104971134;6924.234320248304;6701.631410272482;6739.123913891162;6750.084950728664;6773.762918297836;6802.3537763912345 14:08:47 INFO - PID 17351 | |5;yui.html;978.3298440568216;998.986029180382;1022.4018948914885;1032.7934413117373;1039.5633833789807;18761.061946902668;18954;19164.712529312037;19198.616027679436;19306.131224094916;18132.728009079874;18209.635807283845;18318;19502.512437189078;19821.70267445986;1061.7557961668801;1091.732525531246;1092.7650555130645;1094.2285688589566;1094.6934858239665;1073.8389241613781;1112.2881355932209;1115.2249186815168;1116.5366372955255;1117.6423544465774;1162.5349860056003;1170.1750266062447;1175.294823106138;1175.4710380328843;1175.6943194769378;1170.631251155883;1171.7656468706207;1176.0944073063736;1177.540759103946;1179.2158214787157;860.8192279621287;867.4014929698487;868.2663149638545;868.9217970382633;869.2133619074748;21224.151033958624;21404.571908561742;21557.784422155735;21577.244796432205;21664.35006949794;24166.879165604234;24224.273271801874;24538.754612454002;24566.140185093616;24631.522108673536;18355.541111472186;18875;18987.620247594972;19080.427587172406;19126.521836954187;4049.898752531181;4104.938425923614;4106.096658735073;4110.794460277004;4112.670986321087;172264;175307;176399.11800441044;176900;179240;17014.57463563421;17193.914030430016;17222.741658875126;17392.82607173912;17418.216180271917;34820.477692834625;35359.29281414357;35961.100972475375;35978;35990;9477.099675530813;9642.951785241028;9666.130048295687;9698.272629552812;9715.222782177409;4847.612191024709;4878.341423907727;4935.062338155739;4947.604191664658;4948.257761335828;6334.809955701337;6459.709313080923;6531.444827189647;6538.738450462023;6557.377049180321;1112.516055515837;1126.183516950221;1144.199060657543;1149.454009345571;1151.654503648902;733.8568979049141;755.0637209859734;760.7793739815392;765.7128576783706;776.5030380556449;13394.397252123677;13448.93275533616;13885.930570347084;14184.716305673828;14404.711905761826;760.228368206271;762.527233115472;764.8929149919015;772.5982489105634;783.8275579372529;6311.779087731908;6394.360563943662;6442.420182183626;6459.806205813833;6481.027845823164;146094;150505;157351;158551;158821;140518;140726;141289.29355353158;142668;143093.28453357666;120614;121933.39033304776;122541;122578.3871080639;127193;11884.46519906589;11918.52325906954;12105.970992465738;12401.689957751129;12512.499500019898;59433.40566594279;59706.70146649239;59944.100838486585;60021.69989150026;60269.397306028135;76152;76492.23507764851;77251.61374193092;77400.61299693465;78602.6069869647;16892.493225203263;17172.828271717124;17292.913535432242;17399.391021314193;17697.115144242478;18752.15615297342;19428.320008799623;19772.80227197767;19797.40607781769;19875.900620496806;17041.23314450828;17246.310147593955;17393.391231306843;17758.556036099202;18598.81401186025;14746.11523308605;14846.703065938837;14847.480338188112;15040.849591503946;15042.32309546095;17294;17296.135193240538;17375;17449.912750436168;17495.125243738017;12221;12365.319907405179;12492.687682808002;12724.300163490727;12811.103222774316;12445.191062580903;12491.125621206429;12493.93753031229;12641.620751377473;12825.743485130432 14:08:47 INFO - PID 17351 | __end_tp_report 14:08:47 INFO - PID 17351 | __start_cc_report 14:08:47 INFO - PID 17351 | _x_x_mozilla_cycle_collect,254 14:08:47 INFO - PID 17351 | __end_cc_report 14:08:47 INFO - PID 17351 | __startTimestamp1506460127860__endTimestamp 14:08:47 INFO - PID 17351 | 14:08:47 INFO - PID 17351 | ------- Summary: start ------- 14:08:47 INFO - PID 17351 | Number of tests: 6 14:08:47 INFO - PID 17351 | 14:08:47 INFO - PID 17351 | [#0] dojo.html Cycles:165 Average:6604.26 Median:6826.62 stddev:760.45 (11.1%) stddev-sans-first:735.54 14:08:47 INFO - PID 17351 | Values: 4032.9 4038.9 4049.9 4071.2 4112.0 6515.5 6548.8 6610.9 6674.3 6675.9 6597.4 6603.8 6610.5 6666.4 6685.2 5922.9 5945.3 5953.8 5958.2 6007.3 5901.6 5940.3 5960.6 5981.9 5982.8 5896.4 5918.4 5934.5 5948.6 5954.8 5957.1 5966.3 5976.8 6039.2 6045.8 5778.9 5870.7 5923.1 5935.0 6068.6 6482.4 6487.4 6496.8 6553.9 6560.5 7112.4 7198.9 7214.7 7215.7 7216.5 7171.5 7178.8 7194.4 7256.7 7285.3 6530.1 6650.9 6674.7 6681.2 6688.8 7347.6 7352.2 7363.0 7395.2 7428.6 7063.3 7064.6 7146.1 7146.5 7168.2 7201.7 7204.2 7249.1 7250.8 7255.8 6979.9 7091.0 7095.3 7114.5 7151.6 6986.0 7104.6 7115.2 7187.0 7210.3 5340.8 5352.3 5352.7 5355.9 5365.8 4776.3 4807.9 4876.9 4880.9 4881.6 6567.6 6643.1 6645.6 6735.7 6736.1 7038.0 7056.2 7061.0 7074.1 7127.9 6629.3 6690.6 6712.1 6726.8 6733.5 5991.0 6005.8 6074.3 6091.0 6093.3 7339.4 7406.1 7452.4 7455.1 7505.7 7097.5 7151.7 7152.6 7153.0 7195.5 7299.0 7312.4 7318.4 7411.0 7551.6 7081.2 7082.8 7159.1 7161.2 7181.2 7042.0 7090.3 7094.9 7173.1 7215.6 6805.1 6920.9 6955.3 6970.7 6972.4 6719.8 6825.1 6875.2 6929.9 6992.8 6871.6 6926.9 6964.1 6964.3 6965.4 6941.3 6958.1 6961.4 7021.4 7066.7 6669.2 6725.1 6763.9 6815.6 6826.6 14:08:47 INFO - PID 17351 | 14:08:47 INFO - PID 17351 | [#1] ext.html Cycles:180 Average:47660.14 Median:3915.46 stddev:75409.95 (1926.0%) stddev-sans-first:75540.00 14:08:47 INFO - PID 17351 | Values: 968.9 973.3 1004.8 1026.6 1032.2 45528.3 46088.3 46550.3 46654.8 46934.5 49100.5 49433.8 49479.8 49615.5 49658.8 8926.0 9094.8 9096.3 9102.0 9105.1 8947.2 9049.6 9050.4 9055.7 9056.7 8991.7 9074.7 9076.4 9090.1 9096.7 8952.3 8953.7 8971.4 9002.5 9035.4 8790.8 8846.4 8854.2 8917.4 8923.4 41919.4 42158.4 43128.8 43461.6 43478.6 3840.6 3886.9 3898.8 3932.1 3935.2 34727.7 34787.8 34820.3 34955.0 35182.1 5718.5 5743.3 5749.5 5753.4 5788.8 239071.0 239799.0 239891.0 240469.0 240913.0 53578.5 53704.7 53726.7 54148.7 56782.0 59757.7 60164.7 60187.4 60206.4 60432.7 18980.0 19042.2 19049.2 19201.2 19216.6 15815.9 15909.4 15944.3 15973.8 15975.9 15746.4 15946.5 16007.9 16090.8 16102.7 6005.1 6230.7 6240.8 6242.3 6257.5 1126.8 1130.6 1134.9 1143.9 1145.8 26454.5 26465.6 27052.7 27235.3 27318.0 1238.2 1238.5 1239.7 1240.8 1248.2 14010.8 14133.2 14238.9 14261.3 14294.0 327117.0 330538.0 335714.0 337185.0 338022.0 67027.3 67383.3 67463.7 67744.7 67842.7 1537.9 1559.2 1567.9 1571.6 1592.6 30745.5 30910.2 30949.4 31047.5 31081.5 44578.3 44746.6 44898.6 44899.6 44914.6 284912.0 285340.0 285360.0 287304.0 287382.0 39399.8 39509.6 39649.8 39803.0 39882.0 49826.0 49828.0 49946.5 50277.5 50277.5 35954.3 36406.9 36780.8 36965.3 37251.8 35501.6 35811.6 36145.8 36245.5 36793.3 42134.2 42671.0 42858.0 42919.1 43133.8 34928.8 35024.8 35256.1 35387.0 35414.6 26060.9 26165.2 26196.5 26460.9 26879.7 14:08:47 INFO - PID 17351 | 14:08:47 INFO - PID 17351 | [#2] jquery.html Cycles:180 Average:41327.32 Median:22282.33 stddev:106021.20 (475.8%) stddev-sans-first:106274.61 14:08:47 INFO - PID 17351 | Values: 642.9 643.3 651.4 652.5 656.6 23782.3 24399.5 24463.8 24470.1 24488.3 26783.1 26950.5 27053.0 27124.3 27185.3 6783.9 7033.2 7073.2 7073.5 7073.5 7038.8 7046.5 7091.0 7095.4 7096.5 7005.6 7026.8 7034.8 7035.9 7049.1 6957.0 7024.8 7045.1 7045.2 7054.8 6179.0 6355.2 6372.9 6420.1 6448.7 31114.8 31657.8 31711.2 31749.2 31810.8 2345.1 2369.1 2384.7 2385.1 2385.3 19480.2 19758.1 20127.3 21612.1 21780.6 2656.6 2666.5 2737.7 2748.7 2751.7 140934.0 145710.0 157172.0 161833.0 162549.0 15981.0 16996.4 17186.7 17552.7 17860.5 27382.3 27435.5 27437.6 27481.3 27513.4 11070.7 11159.6 11303.4 11372.2 11435.9 10239.5 10242.1 10279.4 10334.8 10437.4 10243.5 10279.3 10309.5 10565.9 10714.9 3091.1 3109.5 3126.9 3188.7 3191.6 1062.0 1066.6 1087.4 1088.6 1094.7 22209.8 22354.9 22502.3 22588.2 22892.5 1112.5 1114.3 1127.4 1130.4 1159.2 12009.0 12295.1 12362.3 12392.8 12517.8 605096.0 628553.0 631229.0 647590.0 657599.0 136463.0 136537.3 138368.3 139302.3 142511.0 1264.7 1270.8 1297.3 1307.6 1309.9 19262.3 19305.7 19462.9 19665.9 20033.3 61472.7 61489.7 61577.7 62002.0 63226.7 80924.6 81049.8 82298.0 82378.2 82446.6 15753.5 16139.6 16214.1 16247.6 16276.9 24993.9 25211.9 25309.5 25410.2 25528.0 20338.8 20572.7 20612.6 20720.5 20736.5 17705.8 18009.9 18150.4 18369.8 18696.3 20693.7 21036.4 21092.3 21286.5 21300.6 16114.6 16182.0 16196.8 16238.9 16246.0 18744.8 18771.0 18981.0 19068.1 19140.8 14:08:47 INFO - PID 17351 | 14:08:47 INFO - PID 17351 | [#3] mootools.html Cycles:180 Average:11185.03 Median:27116.59 stddev:8342.95 (30.8%) stddev-sans-first:8334.75 14:08:47 INFO - PID 17351 | Values: 1519.3 1555.5 1580.0 1586.5 1589.4 17548.0 18259.0 18259.0 18264.3 18293.6 17662.3 17749.2 17776.2 17811.1 17825.4 3140.9 3154.9 3218.3 3220.5 3227.8 3110.3 3125.9 3132.7 3136.8 3159.0 3108.9 3110.0 3130.5 3213.8 3218.5 3208.0 3218.9 3239.0 3243.4 3247.3 3108.6 3115.9 3116.2 3138.5 3141.8 17166.6 17230.6 17272.0 17304.7 17322.7 9266.8 9607.3 9610.7 9612.0 9647.4 5734.4 5915.5 6003.5 6045.8 6077.3 2088.1 2107.1 2146.4 2157.6 2185.3 33186.8 33347.2 33489.5 33507.5 33549.0 7820.8 7865.7 7906.5 8132.7 8186.9 21030.3 21037.4 21042.5 21070.3 21071.3 8942.0 9028.2 9093.6 9094.9 9105.4 8233.1 8334.3 8363.2 8365.5 8431.4 6176.2 6208.4 6214.7 6225.8 6261.4 1631.8 1649.6 1795.9 1811.1 1813.2 968.3 1004.7 1021.0 1024.2 1027.6 9965.3 10117.1 10323.8 10417.3 10451.8 848.4 849.8 884.4 957.5 1111.4 5530.5 6024.7 6029.0 6088.1 6163.9 26012.3 27048.2 27410.2 27436.0 27917.6 26497.7 27185.0 27189.0 27258.9 27360.3 13369.7 13411.1 13558.6 13582.3 13603.5 9946.4 10021.1 10115.9 10140.6 10166.4 22848.4 22875.0 22999.7 23016.2 23557.2 23314.0 23772.9 23960.3 24173.3 24719.8 12500.1 12669.7 12792.4 12817.4 12845.9 16154.7 16456.9 16489.4 16510.4 16512.7 13401.7 13437.9 13504.1 13550.3 13551.3 12627.6 13016.8 13257.0 13359.9 13435.2 10069.1 10158.6 10207.9 10344.4 10380.8 8701.7 8823.9 8843.9 8864.6 8880.6 8703.5 8740.9 8777.1 8823.6 8827.0 14:08:47 INFO - PID 17351 | 14:08:47 INFO - PID 17351 | [#4] prototype.html Cycles:180 Average:5894.59 Median:6485.58 stddev:1642.49 (25.3%) stddev-sans-first:1597.62 14:08:47 INFO - PID 17351 | Values: 563.8 587.4 612.7 613.1 613.7 6512.1 6534.7 6548.9 6623.7 6679.0 6456.5 6479.1 6485.4 6532.2 6577.2 5275.4 5348.1 5366.4 5389.3 5391.1 5323.9 5342.3 5346.3 5351.5 5355.9 5053.6 5188.0 5202.2 5203.3 5218.7 5155.3 5194.8 5212.8 5232.9 5234.2 4645.8 4670.8 4673.5 4691.6 4700.0 6288.3 6322.9 6332.3 6421.0 6447.6 6062.7 6089.9 6139.3 6171.9 6216.2 6750.6 6833.2 6974.3 6996.5 7010.1 5212.0 5215.5 5217.7 5240.3 5300.2 6912.5 7112.8 7176.5 7176.9 7256.0 5430.9 5438.6 5443.5 5465.8 5500.8 5484.5 5491.1 5491.1 5526.8 5558.3 6041.8 6102.3 6105.5 6123.5 6177.5 6962.0 7035.3 7044.9 7045.6 7050.0 1896.2 1902.8 1913.2 1923.2 1930.7 1323.8 1352.9 1360.5 1368.2 1369.2 6391.8 6425.5 6463.5 6477.5 6508.7 6824.2 6903.5 6924.8 6982.2 7000.8 6320.7 6417.0 6473.4 6485.7 6534.9 3679.1 3759.8 3760.2 3763.8 3774.8 7345.5 7377.8 7385.9 7403.3 7471.3 7067.9 7093.8 7112.5 7117.8 7212.8 7274.3 7275.9 7380.0 7395.7 7407.8 7078.5 7113.1 7134.0 7162.9 7203.3 6967.7 6996.7 7028.8 7084.7 7117.1 7309.6 7400.3 7436.0 7444.4 7468.9 5462.5 5463.9 5480.2 5481.2 5497.8 6762.7 6994.5 7113.4 7178.6 7213.6 6657.7 6864.1 6924.2 6933.6 6940.9 6774.5 6787.4 6909.7 6935.6 6941.9 6450.7 6688.0 6761.6 6805.8 6834.0 6799.5 6825.3 6871.4 6916.4 6924.2 6701.6 6739.1 6750.1 6773.8 6802.4 14:08:47 INFO - PID 17351 | 14:08:47 INFO - PID 17351 | [#5] yui.html Cycles:180 Average:29610.85 Median:98499.28 stddev:45489.88 (46.2%) stddev-sans-first:45566.69 14:08:47 INFO - PID 17351 | Values: 978.3 999.0 1022.4 1032.8 1039.6 18761.1 18954.0 19164.7 19198.6 19306.1 18132.7 18209.6 18318.0 19502.5 19821.7 1061.8 1091.7 1092.8 1094.2 1094.7 1073.8 1112.3 1115.2 1116.5 1117.6 1162.5 1170.2 1175.3 1175.5 1175.7 1170.6 1171.8 1176.1 1177.5 1179.2 860.8 867.4 868.3 868.9 869.2 21224.2 21404.6 21557.8 21577.2 21664.4 24166.9 24224.3 24538.8 24566.1 24631.5 18355.5 18875.0 18987.6 19080.4 19126.5 4049.9 4104.9 4106.1 4110.8 4112.7 172264.0 175307.0 176399.1 176900.0 179240.0 17014.6 17193.9 17222.7 17392.8 17418.2 34820.5 35359.3 35961.1 35978.0 35990.0 9477.1 9643.0 9666.1 9698.3 9715.2 4847.6 4878.3 4935.1 4947.6 4948.3 6334.8 6459.7 6531.4 6538.7 6557.4 1112.5 1126.2 1144.2 1149.5 1151.7 733.9 755.1 760.8 765.7 776.5 13394.4 13448.9 13885.9 14184.7 14404.7 760.2 762.5 764.9 772.6 783.8 6311.8 6394.4 6442.4 6459.8 6481.0 146094.0 150505.0 157351.0 158551.0 158821.0 140518.0 140726.0 141289.3 142668.0 143093.3 120614.0 121933.4 122541.0 122578.4 127193.0 11884.5 11918.5 12106.0 12401.7 12512.5 59433.4 59706.7 59944.1 60021.7 60269.4 76152.0 76492.2 77251.6 77400.6 78602.6 16892.5 17172.8 17292.9 17399.4 17697.1 18752.2 19428.3 19772.8 19797.4 19875.9 17041.2 17246.3 17393.4 17758.6 18598.8 14746.1 14846.7 14847.5 15040.8 15042.3 17294.0 17296.1 17375.0 17449.9 17495.1 12221.0 12365.3 12492.7 12724.3 12811.1 12445.2 12491.1 12493.9 12641.6 12825.7 14:08:47 INFO - PID 17351 | -------- Summary: end -------- 14:08:47 INFO - PID 17351 | 14:08:48 INFO - TEST-INFO | 17351: exit 0 14:08:48 INFO - TEST-OK | dromaeo_css | took 1108416ms 14:08:48 INFO - TEST-START | kraken 14:08:48 INFO - Initialising browser for kraken test... 14:08:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38896/getInfo.html -profile /tmp/tmpzH4u6z/profile 14:08:48 INFO - TEST-INFO | started process 17719 (/builds/slave/test/build/application/firefox/firefox http://localhost:38896/getInfo.html) 14:08:54 INFO - TEST-INFO | 17719: exit 0 14:08:54 INFO - Browser initialized. 14:08:54 INFO - Running cycle 1/1 for kraken test... 14:08:54 INFO - Using env: {'DISPLAY': ':0', 14:08:54 INFO - 'HOME': '/home/cltbld', 14:08:54 INFO - 'JSGC_DISABLE_POISONING': '1', 14:08:54 INFO - 'LANG': 'en_US.UTF-8', 14:08:54 INFO - 'LANGUAGE': 'en_US:en', 14:08:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:08:54 INFO - 'LOGNAME': 'cltbld', 14:08:54 INFO - 'MAIL': '/var/mail/cltbld', 14:08:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:08:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:08:54 INFO - 'MOZ_CRASHREPORTER': '1', 14:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:08:54 INFO - 'MOZ_NO_REMOTE': '1', 14:08:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:54 INFO - 'NO_EM_RESTART': '1', 14:08:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:54 INFO - 'PWD': '/builds/slave/test', 14:08:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:08:54 INFO - 'RUST_BACKTRACE': 'full', 14:08:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:08:54 INFO - 'SHELL': '/bin/bash', 14:08:54 INFO - 'SHLVL': '1', 14:08:54 INFO - 'TERM': 'linux', 14:08:54 INFO - 'TMOUT': '86400', 14:08:54 INFO - 'USER': 'cltbld', 14:08:54 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061', 14:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:54 INFO - '_': '/tools/buildbot/bin/python'} 14:08:54 INFO - TEST-INFO | started process 17911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzH4u6z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:55 INFO - PID 17911 | 14:08:55 INFO - PID 17911 | (/builds/slave/test/build/application/firefox/firefox:17959): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:08:55 INFO - PID 17911 | 14:09:05 INFO - PID 17911 | RSS: Main: 141328384 14:09:05 INFO - PID 17911 | 14:09:08 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38896/tests/kraken/driver.html?testName=audio-beat-detection) 14:09:09 INFO - PID 17911 | RSS: Main: 148594688 14:09:09 INFO - PID 17911 | 14:09:11 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38896/tests/kraken/driver.html?testName=audio-dft) 14:09:12 INFO - PID 17911 | RSS: Main: 148946944 14:09:12 INFO - PID 17911 | 14:09:15 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38896/tests/kraken/driver.html?testName=audio-fft) 14:09:15 INFO - PID 17911 | RSS: Main: 150712320 14:09:15 INFO - PID 17911 | 14:09:17 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38896/tests/kraken/driver.html?testName=audio-oscillator) 14:09:18 INFO - PID 17911 | RSS: Main: 150798336 14:09:18 INFO - PID 17911 | 14:09:20 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38896/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:09:21 INFO - PID 17911 | RSS: Main: 150294528 14:09:21 INFO - PID 17911 | 14:09:24 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38896/tests/kraken/driver.html?testName=imaging-darkroom) 14:09:24 INFO - PID 17911 | RSS: Main: 150728704 14:09:24 INFO - PID 17911 | 14:09:28 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38896/tests/kraken/driver.html?testName=imaging-desaturate) 14:09:28 INFO - PID 17911 | RSS: Main: 152891392 14:09:28 INFO - PID 17911 | 14:09:31 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38896/tests/kraken/driver.html?testName=json-parse-financial) 14:09:32 INFO - PID 17911 | RSS: Main: 152956928 14:09:32 INFO - PID 17911 | 14:09:33 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38896/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:09:34 INFO - PID 17911 | RSS: Main: 153247744 14:09:34 INFO - PID 17911 | 14:09:35 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38896/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:09:36 INFO - PID 17911 | RSS: Main: 152948736 14:09:36 INFO - PID 17911 | 14:09:38 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38896/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:09:39 INFO - PID 17911 | RSS: Main: 149651456 14:09:39 INFO - PID 17911 | 14:09:41 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:09:42 INFO - PID 17911 | RSS: Main: 150294528 14:09:42 INFO - PID 17911 | 14:09:44 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:09:45 INFO - PID 17911 | RSS: Main: 150519808 14:09:45 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | Cycle 1(1): loaded http://localhost:38896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38896/tests/kraken/driver.html?testName=ai-astar) 14:09:47 INFO - PID 17911 | RSS: Main: 152428544 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | __start_tp_report 14:09:47 INFO - PID 17911 | _x_x_mozilla_page_load 14:09:47 INFO - PID 17911 | _x_x_mozilla_page_load_details 14:09:47 INFO - PID 17911 | |i|pagename|runs| 14:09:47 INFO - PID 17911 | |0;ai-astar;109;105;105;106;105;107;95;104;105;105 14:09:47 INFO - PID 17911 | |1;audio-beat-detection;114;117;116;113;111;110;147;116;114;112 14:09:47 INFO - PID 17911 | |2;audio-dft;161;162;162;161;161;161;163;161;163;161 14:09:47 INFO - PID 17911 | |3;audio-fft;74;72;77;72;73;72;72;72;74;76 14:09:47 INFO - PID 17911 | |4;audio-oscillator;78;77;77;78;77;77;78;79;77;78 14:09:47 INFO - PID 17911 | |5;imaging-gaussian-blur;110;114;110;114;113;113;113;114;114;115 14:09:47 INFO - PID 17911 | |6;imaging-darkroom;147;148;149;148;148;148;147;148;148;149 14:09:47 INFO - PID 17911 | |7;imaging-desaturate;94;94;94;94;94;95;95;95;94;93 14:09:47 INFO - PID 17911 | |8;json-parse-financial;43;44;43;44;45;44;43;44;42;43 14:09:47 INFO - PID 17911 | |9;json-stringify-tinderbox;38;37;37;37;37;37;37;37;37;38 14:09:47 INFO - PID 17911 | |10;stanford-crypto-aes;72;70;70;70;76;69;69;69;70;70 14:09:47 INFO - PID 17911 | |11;stanford-crypto-ccm;102;101;108;102;112;106;103;101;111;102 14:09:47 INFO - PID 17911 | |12;stanford-crypto-pbkdf2;157;152;149;150;147;144;149;147;151;148 14:09:47 INFO - PID 17911 | |13;stanford-crypto-sha256-iterative;57;59;57;57;59;57;58;58;60;58 14:09:47 INFO - PID 17911 | __end_tp_report 14:09:47 INFO - PID 17911 | __start_cc_report 14:09:47 INFO - PID 17911 | _x_x_mozilla_cycle_collect,691 14:09:47 INFO - PID 17911 | __end_cc_report 14:09:47 INFO - PID 17911 | __startTimestamp1506460187303__endTimestamp 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | ------- Summary: start ------- 14:09:47 INFO - PID 17911 | Number of tests: 14 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#0] ai-astar Cycles:10 Average:104.60 Median:105.50 stddev:3.66 (3.5%) stddev-sans-first:3.52 14:09:47 INFO - PID 17911 | Values: 109.0 105.0 105.0 106.0 105.0 107.0 95.0 104.0 105.0 105.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#1] audio-beat-detection Cycles:10 Average:117.00 Median:115.00 stddev:10.78 (9.4%) stddev-sans-first:11.38 14:09:47 INFO - PID 17911 | Values: 114.0 117.0 116.0 113.0 111.0 110.0 147.0 116.0 114.0 112.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 14:09:47 INFO - PID 17911 | Values: 161.0 162.0 162.0 161.0 161.0 161.0 163.0 161.0 163.0 161.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.50 stddev:1.84 (2.5%) stddev-sans-first:1.94 14:09:47 INFO - PID 17911 | Values: 74.0 72.0 77.0 72.0 73.0 72.0 72.0 72.0 74.0 76.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.00 stddev:0.70 (0.9%) stddev-sans-first:0.73 14:09:47 INFO - PID 17911 | Values: 78.0 77.0 77.0 78.0 77.0 77.0 78.0 79.0 77.0 78.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:114.00 stddev:1.70 (1.5%) stddev-sans-first:1.41 14:09:47 INFO - PID 17911 | Values: 110.0 114.0 110.0 114.0 113.0 113.0 113.0 114.0 114.0 115.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 14:09:47 INFO - PID 17911 | Values: 147.0 148.0 149.0 148.0 148.0 148.0 147.0 148.0 148.0 149.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:09:47 INFO - PID 17911 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 93.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#8] json-parse-financial Cycles:10 Average:43.50 Median:44.00 stddev:0.85 (1.9%) stddev-sans-first:0.88 14:09:47 INFO - PID 17911 | Values: 43.0 44.0 43.0 44.0 45.0 44.0 43.0 44.0 42.0 43.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#9] json-stringify-tinderbox Cycles:10 Average:37.20 Median:37.00 stddev:0.42 (1.1%) stddev-sans-first:0.33 14:09:47 INFO - PID 17911 | Values: 38.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 38.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#10] stanford-crypto-aes Cycles:10 Average:70.50 Median:70.00 stddev:2.12 (3.0%) stddev-sans-first:2.18 14:09:47 INFO - PID 17911 | Values: 72.0 70.0 70.0 70.0 76.0 69.0 69.0 69.0 70.0 70.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#11] stanford-crypto-ccm Cycles:10 Average:104.80 Median:104.50 stddev:4.18 (4.0%) stddev-sans-first:4.31 14:09:47 INFO - PID 17911 | Values: 102.0 101.0 108.0 102.0 112.0 106.0 103.0 101.0 111.0 102.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:149.50 stddev:3.50 (2.3%) stddev-sans-first:2.40 14:09:47 INFO - PID 17911 | Values: 157.0 152.0 149.0 150.0 147.0 144.0 149.0 147.0 151.0 148.0 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.00 Median:58.00 stddev:1.05 (1.8%) stddev-sans-first:1.05 14:09:47 INFO - PID 17911 | Values: 57.0 59.0 57.0 57.0 59.0 57.0 58.0 58.0 60.0 58.0 14:09:47 INFO - PID 17911 | -------- Summary: end -------- 14:09:47 INFO - PID 17911 | 14:09:47 INFO - PID 17911 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:09:48 INFO - TEST-INFO | 17911: exit 0 14:09:48 INFO - TEST-OK | kraken | took 59709ms 14:09:48 INFO - SUITE-END | took 1168s 14:09:48 INFO - Completed test suite (00:19:28) 14:09:48 INFO - javascript benchmark 14:09:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9538.367307672492, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4032.9395059074113, 4038.899027524313, 4049.858254961075, 4071.2468193384207, 4111.958880411195, 6515.478761699064, 6548.803535893919, 6610.933890661092, 6674.332566743323, 6675.86648267035, 6597.406233438989, 6603.8349041274, 6610.537262391635, 6666.433353164987, 6685.164354455693, 5922.88154236915, 5945.316288626798, 5953.821385358436, 5958.225430694026, 6007.339192688801, 5901.645901245939, 5940.287165540141, 5960.642361458326, 5981.85045373867, 5982.760689572412, 5896.351401345849, 5918.437748413894, 5934.495567876736, 5948.643081415129, 5954.821355359324, 5957.106434034886, 5966.2840459144745, 5976.820695379146, 6039.214902062726, 6045.848853778669, 5778.913316300259, 5870.706464676792, 5923.052311630118, 5935.0, 6068.605540639845, 6482.448991835699, 6487.448566871822, 6496.7726129585235, 6553.9344606553805, 6560.507961902828, 7112.395446387063, 7198.856022879513, 7214.711411543584, 7215.747448839265, 7216.494845360827, 7171.533850299714, 7178.784636460915, 7194.38847697941, 7256.709731610729, 7285.307895749896, 6530.118434011395, 6650.900236496456, 6674.666266686646, 6681.231658359302, 6688.799336019927, 7347.63261836906, 7352.228016058344, 7363.0, 7395.2235015323695, 7428.554286742813, 7063.328983746535, 7064.646767661597, 7146.106736657918, 7146.499745017903, 7168.17565979919, 7201.675924583406, 7204.207537170907, 7249.093863267091, 7250.782476525713, 7255.782326530212, 6979.860402792017, 7090.964545177241, 7095.254998225215, 7114.537555058904, 7151.60666163366, 6985.965070174617, 7104.6447677615915, 7115.217326094125, 7186.964065179641, 7210.278972102853, 5340.839774806762, 5352.277442545284, 5352.678839269578, 5355.892882142413, 5365.839024829262, 4776.259679749644, 4807.855764327076, 4876.878078048077, 4880.877978050577, 4881.633877459205, 6567.605943643397, 6643.136392268974, 6645.568038077509, 6735.696893639798, 6736.090627765189, 7037.964810175917, 7056.188538318056, 7061.0, 7074.080369551925, 7127.857442851114, 6629.337066293332, 6690.565113267622, 6712.12742343502, 6726.764563240263, 6733.494987875929, 5990.970045149834, 6005.789797357072, 6074.271087469532, 6091.02543593023, 6093.268807743099, 7339.449541284425, 7406.07424071991, 7452.441066920002, 7455.0681164854395, 7505.662245198979, 7097.503174777819, 7151.713931442684, 7152.606606636685, 7152.964235178791, 7195.532290401107, 7299.008837944405, 7312.378447831994, 7318.377937875341, 7411.0, 7551.622418879144, 7081.157388668956, 7082.787516374517, 7159.105111861018, 7161.248068952685, 7181.174164971095, 7041.964790176016, 7090.290970902868, 7094.9290507094265, 7173.10336207974, 7215.60314182725, 6805.115335006418, 6920.9307906920285, 6955.304469553004, 6970.651467426507, 6972.442204623517, 6719.764808231688, 6825.078614386995, 6875.243723190345, 6929.861402772017, 6992.79021629352, 6871.622060786704, 6926.896096558455, 6964.0598519201285, 6964.26875178099, 6965.44276457872, 6941.34057264559, 6958.06066181059, 6961.37347638715, 7021.368076873106, 7066.7173313066905, 6669.233038200475, 6725.092112564741, 6763.898541521783, 6815.591064536144, 6826.624535650587], "value": 6553.931057681396, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [968.9127978481936, 973.3235401396029, 1004.7638804880852, 1026.5791025679473, 1032.2258306270292, 45528.31707524386, 46088.308675369815, 46550.3017454738, 46654.76672616637, 46934.530654693444, 49100.50899491004, 49433.75283123579, 49479.752601237036, 49615.50384496154, 49658.751706241506, 8925.999999999984, 9094.77263068422, 9096.317776166781, 9101.95449022754, 9105.135012173865, 8947.150020748019, 9049.638014479413, 9050.366474346798, 9055.728328150133, 9056.728298151065, 8991.730248092568, 9074.682386116487, 9076.36465447419, 9090.13643703847, 9096.681616143436, 8952.328575356874, 8953.731388058368, 8971.372003959725, 9002.459852408843, 9035.41269817463, 8790.780230494225, 8846.424982376126, 8854.247388971946, 8917.42036767608, 8923.41997770143, 41919.37120943188, 42158.367624485654, 43128.78435607833, 43461.56538434607, 43478.56521434777, 3840.577536470986, 3886.9222615547533, 3898.8440462381755, 3932.075962148893, 3935.232629637222, 34727.6527234727, 34787.82606086979, 34820.303593928234, 34955.0, 35182.120446988774, 5718.456746609066, 5743.310802703661, 5749.511291540224, 5753.424657534255, 5788.82633520995, 239071.0, 239799.0, 239891.0, 240469.0, 240913.0, 53578.464215357344, 53704.73147634315, 53726.731366342916, 54148.729256353465, 56781.99999999917, 59757.70121149453, 60164.69917650384, 60187.398126019056, 60206.397936020956, 60432.69783651141, 18980.0, 19042.238310467703, 19049.238030478624, 19201.231950721816, 19216.61566768657, 15815.920920395325, 15909.443169489012, 15944.2825072872, 15973.760393594106, 15975.920120399556, 15746.448874289345, 15946.521604351889, 16007.919960400357, 16090.75863862043, 16102.677946441005, 6005.129256257818, 6230.6573138476915, 6240.7503699851495, 6242.250929888442, 6257.530685198628, 1126.8366086917351, 1130.6268931252666, 1134.9262297950606, 1143.9428028598536, 1145.7593905279984, 26454.470910582066, 26465.603015954777, 27052.72947270502, 27235.319117022234, 27318.0, 1238.2322959764824, 1238.4736486992992, 1239.6528971887885, 1240.8076748104058, 1248.1574936917543, 14010.75601408864, 14133.15201087938, 14238.85761142396, 14261.286935653176, 14294.0, 327117.0, 330538.0, 335714.0, 337185.0, 338022.0, 67027.32972670211, 67383.32616673868, 67463.66268168726, 67744.66127669429, 67842.66078669575, 1537.9154146521826, 1559.173637971854, 1567.8902476826513, 1571.5835303644544, 1592.562045437514, 30745.53881691821, 30910.227244318172, 30949.381012379177, 31047.53428698526, 31081.533776993816, 44578.3313250295, 44746.552534475544, 44898.551014490746, 44899.551004489535, 44914.55085449234, 284912.0, 285340.0, 285360.0, 287304.0, 287382.0, 39399.80300098481, 39509.604903950596, 39649.80175099106, 39803.0, 39882.0, 49826.0, 49828.0, 49946.500534994186, 50277.497225027284, 50277.49722502875, 35954.28091438209, 36406.9077927652, 36780.81609591935, 36965.260694785415, 37251.813740931124, 35501.64498355087, 35811.64188358187, 36145.81927090348, 36245.45631815472, 36793.26413471769, 42134.15731685411, 42671.0, 42858.0, 42919.141617168105, 43133.784331078146, 34928.82535587306, 35024.824875875456, 35256.11859703528, 35387.0, 35414.64585354216, 26060.856450255465, 26165.215043548724, 26196.48609223352, 26460.8676956614, 26879.731202687723], "value": 20115.632343445035, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.9045999921835, 643.2857661975427, 651.375235825638, 652.5236875037247, 656.6099398190586, 23782.286531404043, 24399.512009759794, 24463.75536244639, 24470.14354497593, 24488.265352039423, 26783.062592809256, 26950.46099078017, 27053.0, 27124.32189195271, 27185.320366990836, 6783.864322713543, 7033.1911830139425, 7073.221945585981, 7073.469489788261, 7073.504854660176, 7038.788836334918, 7046.541974771623, 7090.964545177293, 7095.43236541078, 7096.5387249828855, 7005.614691191982, 7026.789196324118, 7034.824129396755, 7035.894461583081, 7049.083619129532, 6957.0, 7024.754133605325, 7045.084139061914, 7045.154581450233, 7054.788356349318, 6178.969105154445, 6355.205599300088, 6372.904406433907, 6420.133282006916, 6448.709808058648, 31114.844425777952, 31657.841710791297, 31711.20721981946, 31749.20626984321, 31810.840945795124, 2345.0854166874933, 2369.1352656280505, 2384.701912260967, 2385.0579021286494, 2385.272491889973, 19480.220791168478, 19758.11088501021, 20127.29554465601, 21612.135514579397, 21780.564388712297, 2656.628072069912, 2666.4933662604044, 2737.712540183272, 2748.6839013513304, 2751.697313295536, 140934.0, 145710.0, 157172.0, 161833.0, 162548.9999999988, 15981.002374703163, 16996.385343392358, 17186.74219886703, 17552.736708949375, 17860.464186074438, 27382.315442114108, 27435.45129097407, 27437.58843617347, 27481.31296717558, 27513.44973100527, 11070.723231919106, 11159.609413670483, 11303.434828258718, 11372.203945723886, 11435.942820285845, 10239.539220735085, 10242.129418999319, 10279.383237005653, 10334.75982882059, 10437.425941573134, 10243.539040743184, 10279.280450368551, 10309.484525773682, 10565.947170264253, 10714.89285107139, 3091.1190310761326, 3109.4558452271212, 3126.8592913318957, 3188.660762479764, 3191.574403453346, 1061.9787604247872, 1066.6213494209599, 1087.423665457309, 1088.580896354909, 1094.7482079121687, 22209.777902220772, 22354.888225558767, 22502.324930252118, 22588.209412670476, 22892.542149157256, 1112.4604566785104, 1114.2924243105524, 1127.413744852672, 1130.4404319861558, 1159.211736019498, 12009.0, 12295.139340246276, 12362.258264504158, 12392.75214495723, 12517.812232816515, 605096.0, 628553.0, 631229.0, 647590.0, 657599.0, 136463.0, 136537.3173134128, 138368.30815845856, 139302.3034884819, 142511.0, 1264.7027948432112, 1270.8474983001913, 1297.344840855362, 1307.6469353274563, 1309.8952083833271, 19262.32581859684, 19305.710414344077, 19462.94328629219, 19665.901670491556, 20033.29883454072, 61472.69263653653, 61489.69255153875, 61577.69211153915, 62002.0, 63226.68386658037, 80924.59537702274, 81049.78425323743, 82298.0, 82378.17621823704, 82446.58776706079, 15753.527394178192, 16139.596510086873, 16214.10822404779, 16247.593810154367, 16276.918615406847, 24993.87503062473, 25211.873940630914, 25309.493810123327, 25410.237692869243, 25528.0, 20338.796612034283, 20572.69140962857, 20612.587748244652, 20720.48198795042, 20736.481587959817, 17705.822941770417, 18009.909950450165, 18150.364737234133, 18369.81630183681, 18696.34562790296, 20693.689594655792, 21036.368908932756, 21092.261770837948, 21286.467838304165, 21300.573988520453, 16114.597135071717, 16182.0, 16196.838031619533, 16238.918805405898, 16246.0, 18744.812551874307, 18770.96759678176, 18981.0, 19068.141933612744, 19140.8085919139], "value": 13299.51494498219, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.2935285092433, 1555.5255647027652, 1579.976300355495, 1586.508182463436, 1589.3642542982805, 17548.0, 18259.0, 18259.0, 18264.269429222848, 18293.634127317444, 17662.293508259656, 17749.20128594213, 17776.200070996805, 17811.109444527785, 17825.37611183609, 3140.8762325253724, 3154.9211269718267, 3218.291975765328, 3220.4847224444093, 3227.8386080695986, 3110.2846345340586, 3125.9062228133193, 3132.6867313268604, 3136.827474488902, 3159.0, 3108.891188808392, 3110.0203435917615, 3130.467820470514, 3213.7589680773917, 3218.5011323244935, 3208.0, 3218.9356212875846, 3238.9676103238903, 3243.4323993301077, 3247.253131779692, 3108.626964764243, 3115.8909438169553, 3116.2209447638093, 3138.529220616903, 3141.8271995040263, 17166.570835729082, 17230.569235769206, 17272.0, 17304.653906921918, 17322.740158897628, 9266.768330791716, 9607.279454040974, 9610.6636267731, 9612.0, 9647.3729207602, 5734.397888221718, 5915.467607915309, 6003.549733769941, 6045.78839740607, 6077.301110372276, 2088.0812442525394, 2107.072887929306, 2146.3560931720576, 2157.5792720419527, 2185.278857976864, 33186.83406582951, 33347.16632084193, 33489.497657535154, 33507.49738753921, 33549.0, 7820.843583128306, 7865.685372585032, 7906.458240643135, 8132.6746930122135, 8186.877196842052, 21030.263940762, 21037.368878933656, 21042.47393815167, 21070.262540811, 21071.26250581222, 8942.0, 9028.232600228923, 9093.590788414405, 9094.86357704635, 9105.362624616213, 8233.053198882086, 8334.291585215324, 8363.16368363171, 8365.498070115813, 8431.40980131385, 6176.197094377702, 6208.410201030895, 6214.720337584819, 6225.750969961241, 6261.405166509266, 1631.7552367145024, 1649.5958490169746, 1795.9281628734705, 1811.1035037656445, 1813.2475022865626, 968.2931460034215, 1004.7036124343336, 1020.9591616335412, 1024.1704219582161, 1027.6095083868083, 9965.302428829913, 10117.140043096419, 10323.84514232287, 10417.270791044706, 10451.790964180826, 848.4442690038035, 849.8172892828071, 884.3765145572356, 957.5164541906292, 1111.4220605285207, 5530.474604912527, 6024.698765061729, 6029.0, 6088.117223002729, 6163.876722465615, 26012.349691257492, 27048.1885543434, 27410.177694669193, 27436.0, 27917.581236281472, 26497.735022649525, 27185.0, 27189.04838330649, 27258.863705681346, 27360.315992100357, 13369.66575835612, 13411.128276661986, 13558.593242202553, 13582.320883955763, 13603.523876664269, 9946.403215807075, 10021.09810117093, 10115.949420252851, 10140.645077422254, 10166.440845753554, 22848.428789280402, 22875.0, 22999.65500517527, 23016.194433194756, 23557.175498857458, 23314.0, 23772.881135594904, 23960.28119156428, 24173.274801755975, 24719.752802471747, 12500.124991250888, 12669.746605067663, 12792.424340904496, 12817.359132043173, 12845.935770321088, 16154.67690646204, 16456.917715411346, 16489.422870199487, 16510.42213522521, 16512.66974660524, 13401.731965360834, 13437.865621344052, 13504.122232054886, 13550.322483875963, 13551.32243387807, 12627.558035468715, 13016.788772882242, 13257.0, 13359.866401335863, 13435.19388836673, 10069.144122749649, 10158.593656253666, 10207.948960255151, 10344.431056291976, 10380.844287335545, 8701.695440659547, 8823.911760882309, 8843.867341989746, 8864.556772161237, 8880.600372983103, 8703.521306328214, 8740.863687720555, 8777.122287771172, 8823.558822059, 8827.0], "value": 7822.923675330383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.8308507447765, 587.3949831673376, 612.6569121292074, 613.0834402568158, 613.6870196199939, 6512.088307636935, 6534.738610455576, 6548.86902261955, 6623.668816559177, 6679.0, 6456.451201647866, 6479.125318082058, 6485.411074286794, 6532.216134063919, 6577.2436169840485, 5275.419703832576, 5348.144296912495, 5366.356037275513, 5389.272448219499, 5391.110466772978, 5323.855371095214, 5342.305500284958, 5346.251524786533, 5351.464853514656, 5355.919661205085, 5053.620978426614, 5187.974060129694, 5202.179237266945, 5203.2975548301065, 5218.712970786605, 5155.32980712505, 5194.77922688168, 5212.817551385702, 5232.895342093175, 5234.214867769827, 4645.814167433298, 4670.789814458358, 4673.532646735333, 4691.601213896823, 4699.953000469985, 6288.339724328971, 6322.873542529123, 6332.33510481402, 6421.0, 6447.580907241061, 6062.696865156725, 6089.878202435926, 6139.324674285825, 6171.938280617182, 6216.191895053659, 6750.565794535397, 6833.180018397824, 6974.302569743036, 6996.475264355143, 7010.123734533184, 5211.973940130275, 5215.478452154792, 5217.660852044605, 5240.34495688039, 5300.2314664373835, 6912.4815638826785, 7112.751053713096, 7176.533525320838, 7176.856462870765, 7256.040868965402, 5430.8913821723345, 5438.592105592096, 5443.455654434604, 5465.836024919259, 5500.762328476141, 5484.451554844483, 5491.105568578834, 5491.148871924858, 5526.839363733661, 5558.276444542226, 6041.818745437644, 6102.298235702951, 6105.48103411215, 6123.510119190454, 6177.505799536027, 6962.0, 7035.261297563785, 7044.87282034872, 7045.577265364094, 7050.0, 1896.2035944903173, 1902.7526421565385, 1913.2347061175642, 1923.1826473748881, 1930.7200455933812, 1323.808047833078, 1352.864713528659, 1360.4694718441754, 1368.2132773655187, 1369.2400717601827, 6391.808245752635, 6425.453836423956, 6463.479243095197, 6477.514186436036, 6508.707108180143, 6824.249332573413, 6903.482238832007, 6924.792256232321, 6982.1970473395195, 7000.769315309379, 6320.71556779946, 6417.0, 6473.449756770633, 6485.7405703772265, 6534.934650653433, 3679.105260790695, 3759.8496060157836, 3760.1539653577724, 3763.7553559018575, 3774.7923864187183, 7345.485815992829, 7377.778666639902, 7385.929040289128, 7403.333699967029, 7471.252874712485, 7067.893981590178, 7093.787186384417, 7112.502124851314, 7117.786466406016, 7212.783616491513, 7274.27257274279, 7275.927240727525, 7379.963100184465, 7395.6671949762385, 7407.777766667009, 7078.504504684623, 7113.110861142357, 7133.964330178316, 7162.89255661176, 7203.271214908489, 6967.686454109476, 6996.720131194898, 7028.789136325919, 7084.716611335489, 7117.1459424869345, 7309.561426314225, 7400.259974002557, 7435.962820185864, 7444.367228785614, 7468.92531074704, 5462.453754624506, 5463.9180412294645, 5480.232767412485, 5481.177823326533, 5497.807576734955, 6762.729490820312, 6994.545354552141, 7113.430925525842, 7178.5692858428665, 7213.639318034182, 6657.700403481758, 6864.141982252218, 6924.238333783179, 6933.647938652116, 6940.861182776215, 6774.525783195129, 6787.355201255873, 6909.654517274217, 6935.583864968118, 6941.930580694128, 6450.7097180627925, 6687.966560167168, 6761.560498567577, 6805.761798337233, 6834.043233947152, 6799.456043516408, 6825.283345248876, 6871.4159296458365, 6916.412104971134, 6924.234320248304, 6701.631410272482, 6739.123913891162, 6750.084950728664, 6773.762918297836, 6802.3537763912345], "value": 5425.189644007436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [978.3298440568216, 998.986029180382, 1022.4018948914885, 1032.7934413117373, 1039.5633833789807, 18761.061946902668, 18954.0, 19164.712529312037, 19198.616027679436, 19306.131224094916, 18132.728009079874, 18209.635807283845, 18318.0, 19502.512437189078, 19821.70267445986, 1061.7557961668801, 1091.732525531246, 1092.7650555130645, 1094.2285688589566, 1094.6934858239665, 1073.8389241613781, 1112.2881355932209, 1115.2249186815168, 1116.5366372955255, 1117.6423544465774, 1162.5349860056003, 1170.1750266062447, 1175.294823106138, 1175.4710380328843, 1175.6943194769378, 1170.631251155883, 1171.7656468706207, 1176.0944073063736, 1177.540759103946, 1179.2158214787157, 860.8192279621287, 867.4014929698487, 868.2663149638545, 868.9217970382633, 869.2133619074748, 21224.151033958624, 21404.571908561742, 21557.784422155735, 21577.244796432205, 21664.35006949794, 24166.879165604234, 24224.273271801874, 24538.754612454002, 24566.140185093616, 24631.522108673536, 18355.541111472186, 18875.0, 18987.620247594972, 19080.427587172406, 19126.521836954187, 4049.898752531181, 4104.938425923614, 4106.096658735073, 4110.794460277004, 4112.670986321087, 172264.0, 175307.0, 176399.11800441044, 176900.0, 179240.0, 17014.57463563421, 17193.914030430016, 17222.741658875126, 17392.82607173912, 17418.216180271917, 34820.477692834625, 35359.29281414357, 35961.100972475375, 35978.0, 35990.0, 9477.099675530813, 9642.951785241028, 9666.130048295687, 9698.272629552812, 9715.222782177409, 4847.612191024709, 4878.341423907727, 4935.062338155739, 4947.604191664658, 4948.257761335828, 6334.809955701337, 6459.709313080923, 6531.444827189647, 6538.738450462023, 6557.377049180321, 1112.516055515837, 1126.183516950221, 1144.199060657543, 1149.454009345571, 1151.654503648902, 733.8568979049141, 755.0637209859734, 760.7793739815392, 765.7128576783706, 776.5030380556449, 13394.397252123677, 13448.93275533616, 13885.930570347084, 14184.716305673828, 14404.711905761826, 760.228368206271, 762.527233115472, 764.8929149919015, 772.5982489105634, 783.8275579372529, 6311.779087731908, 6394.360563943662, 6442.420182183626, 6459.806205813833, 6481.027845823164, 146094.0, 150505.0, 157351.0, 158551.0, 158821.0, 140518.0, 140726.0, 141289.29355353158, 142668.0, 143093.28453357666, 120614.0, 121933.39033304776, 122541.0, 122578.3871080639, 127193.0, 11884.46519906589, 11918.52325906954, 12105.970992465738, 12401.689957751129, 12512.499500019898, 59433.40566594279, 59706.70146649239, 59944.100838486585, 60021.69989150026, 60269.397306028135, 76152.0, 76492.23507764851, 77251.61374193092, 77400.61299693465, 78602.6069869647, 16892.493225203263, 17172.828271717124, 17292.913535432242, 17399.391021314193, 17697.115144242478, 18752.15615297342, 19428.320008799623, 19772.80227197767, 19797.40607781769, 19875.900620496806, 17041.23314450828, 17246.310147593955, 17393.391231306843, 17758.556036099202, 18598.81401186025, 14746.11523308605, 14846.703065938837, 14847.480338188112, 15040.849591503946, 15042.32309546095, 17294.0, 17296.135193240538, 17375.0, 17449.912750436168, 17495.125243738017, 12221.0, 12365.319907405179, 12492.687682808002, 12724.300163490727, 12811.103222774316, 12445.191062580903, 12491.125621206429, 12493.93753031229, 12641.620751377473, 12825.743485130432], "value": 10119.593752316756, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1352.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 105.0, 106.0, 105.0, 107.0, 95.0, 104.0, 105.0, 105.0], "value": 104.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 116.0, 113.0, 111.0, 110.0, 147.0, 116.0, 114.0, 112.0], "value": 117.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 161.0, 161.0, 163.0, 161.0, 163.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 77.0, 72.0, 73.0, 72.0, 72.0, 72.0, 74.0, 76.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 78.0, 77.0, 77.0, 78.0, 79.0, 77.0, 78.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 110.0, 114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 149.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 43.0, 44.0, 45.0, 44.0, 43.0, 44.0, 42.0, 43.0], "value": 43.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 38.0], "value": 37.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 70.0, 70.0, 76.0, 69.0, 69.0, 69.0, 70.0, 70.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 108.0, 102.0, 112.0, 106.0, 103.0, 101.0, 111.0, 102.0], "value": 104.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 152.0, 149.0, 150.0, 147.0, 144.0, 149.0, 147.0, 151.0, 148.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 57.0, 57.0, 59.0, 57.0, 58.0, 58.0, 60.0, 58.0], "value": 58.0, "unit": "score"}]}]} 14:09:48 INFO - Return code: 0 14:09:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:09:48 INFO - # TBPL SUCCESS # 14:09:48 INFO - Running post-action listener: _package_coverage_data 14:09:48 INFO - Running post-action listener: _resource_record_post_action 14:09:48 INFO - [mozharness: 2017-09-26 21:09:48.595662Z] Finished run-tests step (success) 14:09:48 INFO - Running post-run listener: _resource_record_post_run 14:09:48 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293392384; Read time: 476; Write time: 424852 14:09:48 INFO - TinderboxPrint: CPU usage
13.1% 14:09:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 476 14:09:48 INFO - TinderboxPrint: I/O write bytes / time
293,392,384 / 424,852 14:09:48 INFO - TinderboxPrint: CPU idle
8,198.3 (86.9%) 14:09:48 INFO - TinderboxPrint: CPU user
1,179.3 (12.5%) 14:09:48 INFO - TinderboxPrint: Swap in / out
0 / 0 14:09:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9945088; Read time: 0; Write time: 4308 14:09:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:09:48 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283447296; Read time: 476; Write time: 420544 14:09:49 INFO - Running post-run listener: _upload_blobber_files 14:09:49 INFO - Blob upload gear active. 14:09:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:09:49 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:09:49 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:09:49 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:09:49 INFO - (blobuploader) - INFO - Open directory for files ... 14:09:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:09:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:09:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:50 INFO - (blobuploader) - INFO - Done attempting. 14:09:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:09:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:09:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:51 INFO - (blobuploader) - INFO - Done attempting. 14:09:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:09:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:09:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:52 INFO - (blobuploader) - INFO - Done attempting. 14:09:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:09:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:10:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:00 INFO - (blobuploader) - INFO - Done attempting. 14:10:00 INFO - (blobuploader) - INFO - Iteration through files over. 14:10:00 INFO - Return code: 0 14:10:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:10:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:10:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4a4f65168080b6b8a24c0e4e98022be175ca935322be320d94f811fd8df42156ff058c951f2ad0a414659efd9805a2511907cbf48e91dcb75c340484c5856ff8", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8ae6aeac53d2ef0a0c7db10a90a96523d2fb1876d557374047d8ab1d2875b074a0f2a107f3cb64252feedef50b99dd34f861f5ed19d8b1d480bdfdba12d47488", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1d527e80b7ef0b9343656ca3b8af52094edef86907ea6bee3dd4ab28d77e86131bdcb57e9cf939a6aff4907a9c7a09935d91f3ba34996dd17ef0629ddabff205", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fdb7b86e2726cf3665b2cfc16b529f43cb7619516ae4f0349f8277b5b23bbbbefb65ab40db044e0efce050e5e7d67dfad186cd6c455236aa6c3e91b5445707b6"} 14:10:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:10:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:10:00 INFO - Contents: 14:10:00 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4a4f65168080b6b8a24c0e4e98022be175ca935322be320d94f811fd8df42156ff058c951f2ad0a414659efd9805a2511907cbf48e91dcb75c340484c5856ff8", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8ae6aeac53d2ef0a0c7db10a90a96523d2fb1876d557374047d8ab1d2875b074a0f2a107f3cb64252feedef50b99dd34f861f5ed19d8b1d480bdfdba12d47488", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1d527e80b7ef0b9343656ca3b8af52094edef86907ea6bee3dd4ab28d77e86131bdcb57e9cf939a6aff4907a9c7a09935d91f3ba34996dd17ef0629ddabff205", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fdb7b86e2726cf3665b2cfc16b529f43cb7619516ae4f0349f8277b5b23bbbbefb65ab40db044e0efce050e5e7d67dfad186cd6c455236aa6c3e91b5445707b6"} 14:10:00 INFO - Running post-run listener: copy_logs_to_upload_dir 14:10:00 INFO - Copying logs to upload dir... 14:10:00 INFO - mkdir: /builds/slave/test/build/upload/logs 14:10:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.511929 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-26 14:10:00.673008) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 14:10:00.678030) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4a4f65168080b6b8a24c0e4e98022be175ca935322be320d94f811fd8df42156ff058c951f2ad0a414659efd9805a2511907cbf48e91dcb75c340484c5856ff8", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8ae6aeac53d2ef0a0c7db10a90a96523d2fb1876d557374047d8ab1d2875b074a0f2a107f3cb64252feedef50b99dd34f861f5ed19d8b1d480bdfdba12d47488", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1d527e80b7ef0b9343656ca3b8af52094edef86907ea6bee3dd4ab28d77e86131bdcb57e9cf939a6aff4907a9c7a09935d91f3ba34996dd17ef0629ddabff205", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fdb7b86e2726cf3665b2cfc16b529f43cb7619516ae4f0349f8277b5b23bbbbefb65ab40db044e0efce050e5e7d67dfad186cd6c455236aa6c3e91b5445707b6"} build_url:https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/TQRHIg1RQGeiJPRjZXCmEA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4a4f65168080b6b8a24c0e4e98022be175ca935322be320d94f811fd8df42156ff058c951f2ad0a414659efd9805a2511907cbf48e91dcb75c340484c5856ff8", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8ae6aeac53d2ef0a0c7db10a90a96523d2fb1876d557374047d8ab1d2875b074a0f2a107f3cb64252feedef50b99dd34f861f5ed19d8b1d480bdfdba12d47488", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1d527e80b7ef0b9343656ca3b8af52094edef86907ea6bee3dd4ab28d77e86131bdcb57e9cf939a6aff4907a9c7a09935d91f3ba34996dd17ef0629ddabff205", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fdb7b86e2726cf3665b2cfc16b529f43cb7619516ae4f0349f8277b5b23bbbbefb65ab40db044e0efce050e5e7d67dfad186cd6c455236aa6c3e91b5445707b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 14:10:00.714280) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:10:00.714670) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1506458319.710019-1558542061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:10:00.795476) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 14:10:00.795785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 14:10:00.796099) ========= ========= Total master_lag: 0.22 =========