builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1500804355.37 results: success (0) revision: c023ce417c98641c0dfacaaf236dcfdcb7794f88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:55.365522) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:55.365969) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:55.366309) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:55.408178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:55.408438) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-23 03:05:55-- 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% 41.0M=0s 2017-07-23 03:05:55 (41.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.181157 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:55.627886) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:55.628284) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020308 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:55.678067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-23 03:05:55.678420) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c023ce417c98641c0dfacaaf236dcfdcb7794f88 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev c023ce417c98641c0dfacaaf236dcfdcb7794f88 --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=769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-23 03:05:55,634 truncating revision to first 12 chars 2017-07-23 03:05:55,634 Setting DEBUG logging. 2017-07-23 03:05:55,634 attempt 1/10 2017-07-23 03:05:55,634 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c023ce417c98?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-23 03:05:56,537 unpacking tar archive at: mozilla-central-c023ce417c98/testing/mozharness/ program finished with exit code 0 elapsedTime=1.236562 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-23 03:05:56.928018) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:56.928343) ========= script_repo_revision: c023ce417c98641c0dfacaaf236dcfdcb7794f88 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:56.928733) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:56.929003) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-23 03:05:56.937616) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-23 03:05:56.937911) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:05:57 INFO - MultiFileLogger online at 20170723 03:05:57 in /builds/slave/test 03:05:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:05:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:05:57 INFO - {'append_to_log': False, 03:05:57 INFO - 'base_work_dir': '/builds/slave/test', 03:05:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:05:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:05:57 INFO - 'branch': 'Firefox-Non-PGO', 03:05:57 INFO - 'buildbot_json_path': 'buildprops.json', 03:05:57 INFO - 'code_coverage': False, 03:05:57 INFO - 'config_files': ('talos/linux_config.py',), 03:05:57 INFO - 'default_actions': ('clobber', 03:05:57 INFO - 'read-buildbot-config', 03:05:57 INFO - 'download-and-extract', 03:05:57 INFO - 'populate-webroot', 03:05:57 INFO - 'create-virtualenv', 03:05:57 INFO - 'install', 03:05:57 INFO - 'setup-mitmproxy', 03:05:57 INFO - 'run-tests'), 03:05:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:05:57 INFO - 'disable_ccov_upload': False, 03:05:57 INFO - 'download_minidump_stackwalk': True, 03:05:57 INFO - 'download_symbols': 'ondemand', 03:05:57 INFO - 'enable_stylo': False, 03:05:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:05:57 INFO - 'tooltool.py': '/tools/tooltool.py', 03:05:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:05:57 INFO - '/tools/misc-python/virtualenv.py')}, 03:05:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:05:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:05:57 INFO - 'gecko_profile': False, 03:05:57 INFO - 'gecko_profile_interval': 0, 03:05:57 INFO - 'installer_path': 'installer.exe', 03:05:57 INFO - 'log_level': 'info', 03:05:57 INFO - 'log_name': 'talos', 03:05:57 INFO - 'log_to_console': True, 03:05:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:05:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:05:57 INFO - 'opt_config_files': (), 03:05:57 INFO - 'pip_index': False, 03:05:57 INFO - 'suite': 'dromaeojs-e10s', 03:05:57 INFO - 'system_bits': '32', 03:05:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:05:57 INFO - 'title': 'talos-linux64-ix-063', 03:05:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:05:57 INFO - 'use_talos_json': True, 03:05:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:05:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:05:57 INFO - 'work_dir': 'build'} 03:05:57 INFO - [mozharness: 2017-07-23 10:05:57.115766Z] Running clobber step. 03:05:57 INFO - Running pre-action listener: _resource_record_pre_action 03:05:57 INFO - Running main action method: clobber 03:05:57 INFO - rmtree: /builds/slave/test/build 03:05:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:05:58 INFO - Running post-action listener: _resource_record_post_action 03:05:58 INFO - [mozharness: 2017-07-23 10:05:58.100376Z] Finished clobber step (success) 03:05:58 INFO - [mozharness: 2017-07-23 10:05:58.100479Z] Running read-buildbot-config step. 03:05:58 INFO - Running pre-action listener: _resource_record_pre_action 03:05:58 INFO - Running main action method: read_buildbot_config 03:05:58 INFO - Using buildbot properties: 03:05:58 INFO - { 03:05:58 INFO - "project": "", 03:05:58 INFO - "product": "firefox", 03:05:58 INFO - "who": "archaeopteryx@coole-files.de", 03:05:58 INFO - "installer_path": "public/build/target.tar.bz2", 03:05:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:05:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:05:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:05:58 INFO - "stage_platform": "linux64", 03:05:58 INFO - "basedir": "/builds/slave/test", 03:05:58 INFO - "buildnumber": 1030, 03:05:58 INFO - "platform": "ubuntu64_hw", 03:05:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:05:58 INFO - "slavebuilddir": "test", 03:05:58 INFO - "taskId": "XNnu8g_ERSS-f_EbDUiKtQ", 03:05:58 INFO - "branch": "mozilla-central", 03:05:58 INFO - "script_repo_revision": "production", 03:05:58 INFO - "revision": "c023ce417c98641c0dfacaaf236dcfdcb7794f88", 03:05:58 INFO - "slavename": "talos-linux64-ix-063", 03:05:58 INFO - "repo_path": "mozilla-central" 03:05:58 INFO - } 03:05:58 INFO - Finding installer, test and symbols from parent task. 03:05:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNnu8g_ERSS-f_EbDUiKtQ'}, attempt #1 03:05:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNnu8g_ERSS-f_EbDUiKtQ'}, attempt #1 03:05:59 INFO - Task dependencies: ZesVv5jtR_WeV4mZcPNddA 03:05:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA'}, attempt #1 03:05:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2 03:05:59 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/test_packages.json 03:05:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.crashreporter-symbols.zip 03:05:59 INFO - Running post-action listener: _resource_record_post_action 03:05:59 INFO - [mozharness: 2017-07-23 10:05:59.447276Z] Finished read-buildbot-config step (success) 03:05:59 INFO - [mozharness: 2017-07-23 10:05:59.447498Z] Running download-and-extract step. 03:05:59 INFO - Running pre-action listener: _resource_record_pre_action 03:05:59 INFO - Running main action method: download_and_extract 03:05:59 INFO - mkdir: /builds/slave/test/build/tests 03:05: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')]} 03:05:59 INFO - trying https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.test_packages.json 03:05:59 INFO - Downloading https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:05:59 INFO - Downloaded 989 bytes. 03:05:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:05:59 INFO - Using the following test package requirements: 03:05:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:05:59 INFO - u'common': [u'target.common.tests.zip'], 03:05:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:05:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:05:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:05:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:05:59 INFO - u'mozbase': [u'target.common.tests.zip'], 03:05:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:05:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:05:59 INFO - u'web-platform': [u'target.common.tests.zip', 03:05:59 INFO - u'target.web-platform.tests.tar.gz'], 03:05:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:05:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:05:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.common.tests.zip 03:05:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:05:59 INFO - Fetch https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.common.tests.zip into memory 03:06:01 INFO - Content-Length response header: 72766777 03:06:01 INFO - Bytes received: 72766777 03:06:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:06:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.common.tests.zip 03:06:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:06:12 INFO - Fetch https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.common.tests.zip into memory 03:06:13 INFO - Content-Length response header: 72766777 03:06:13 INFO - Bytes received: 72766777 03:06:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.talos.tests.zip 03:06:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:06:26 INFO - Fetch https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.talos.tests.zip into memory 03:06:27 INFO - Content-Length response header: 14498826 03:06:27 INFO - Bytes received: 14498826 03:06:27 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')]} 03:06:27 INFO - trying https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2 03:06:27 INFO - Downloading https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:06:29 INFO - Downloaded 62011074 bytes. 03:06:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2 03:06:29 INFO - mkdir: /builds/slave/test/properties 03:06:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:06:29 INFO - Writing to file /builds/slave/test/properties/build_url 03:06:29 INFO - Contents: 03:06:29 INFO - build_url:https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2 03:06:29 INFO - Running post-action listener: _resource_record_post_action 03:06:29 INFO - Running post-action listener: set_extra_try_arguments 03:06:29 INFO - [mozharness: 2017-07-23 10:06:29.004514Z] Finished download-and-extract step (success) 03:06:29 INFO - [mozharness: 2017-07-23 10:06:29.004612Z] Running populate-webroot step. 03:06:29 INFO - Running pre-action listener: _resource_record_pre_action 03:06:29 INFO - Running main action method: populate_webroot 03:06:29 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:06:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:06:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:06:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:06:29 INFO - 'tests': ['damp', 'tps']}, 03:06:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:06:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:06:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:06:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:06:29 INFO - 'other-e10s': {'tests': ['a11yr', 03:06:29 INFO - 'ts_paint', 03:06:29 INFO - 'tpaint', 03:06:29 INFO - 'sessionrestore', 03:06:29 INFO - 'sessionrestore_many_windows', 03:06:29 INFO - 'sessionrestore_no_auto_restore', 03:06:29 INFO - 'tabpaint']}, 03:06:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:06:29 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:06:29 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:06:29 INFO - 'talos_options': ['--mitmproxy', 03:06:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:06:29 INFO - '--firstNonBlankPaint'], 03:06:29 INFO - 'tests': ['quantum_pageload_google', 03:06:29 INFO - 'quantum_pageload_youtube', 03:06:29 INFO - 'quantum_pageload_amazon', 03:06:29 INFO - 'quantum_pageload_facebook']}, 03:06:29 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:06:29 INFO - 'talos_options': ['--stylo', 03:06:29 INFO - '--mitmproxy', 03:06:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:06:29 INFO - '--firstNonBlankPaint'], 03:06:29 INFO - 'tests': ['quantum_pageload_google', 03:06:29 INFO - 'quantum_pageload_youtube', 03:06:29 INFO - 'quantum_pageload_amazon', 03:06:29 INFO - 'quantum_pageload_facebook']}, 03:06:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:06:29 INFO - 'tsvgr_opacity', 03:06:29 INFO - 'tart', 03:06:29 INFO - 'tscrollx', 03:06:29 INFO - 'cart', 03:06:29 INFO - 'tsvg_static']}, 03:06:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:06:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:06:29 INFO - 'talos_options': ['--xperf_path', 03:06:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:29 INFO - 'tests': ['tp5n']}}} 03:06:29 INFO - Running post-action listener: _resource_record_post_action 03:06:29 INFO - [mozharness: 2017-07-23 10:06:29.011945Z] Finished populate-webroot step (success) 03:06:29 INFO - [mozharness: 2017-07-23 10:06:29.012035Z] Running create-virtualenv step. 03:06:29 INFO - Running pre-action listener: _resource_record_pre_action 03:06:29 INFO - Running main action method: create_virtualenv 03:06:29 INFO - Creating virtualenv /builds/slave/test/build/venv 03:06:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:06:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:06:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:06:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:06:29 INFO - Using real prefix '/usr' 03:06:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:06:29 INFO - Installing distribute.............................................................................................................................................................................................done. 03:06:31 INFO - Installing pip.................done. 03:06:31 INFO - Return code: 0 03:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:06:32 INFO - Reading from file tmpfile_stdout 03:06:32 INFO - Output received: 03:06:32 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:06:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:06:32 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')]} 03:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:32 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')]} 03:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:32 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 0x240f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277ceb0>, '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 0x277ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277e240>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', '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 03:06:32 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 03:06:32 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 03:06:32 INFO - Using env: {'DISPLAY': ':0', 03:06:32 INFO - 'HOME': '/home/cltbld', 03:06:32 INFO - 'LANG': 'en_US.UTF-8', 03:06:32 INFO - 'LANGUAGE': 'en_US:en', 03:06:32 INFO - 'LOGNAME': 'cltbld', 03:06:32 INFO - 'MAIL': '/var/mail/cltbld', 03:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:32 INFO - 'MOZ_NO_REMOTE': '1', 03:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:32 INFO - 'NO_EM_RESTART': '1', 03:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:32 INFO - 'PWD': '/builds/slave/test', 03:06:32 INFO - 'SHELL': '/bin/bash', 03:06:32 INFO - 'SHLVL': '1', 03:06:32 INFO - 'TERM': 'linux', 03:06:32 INFO - 'TMOUT': '86400', 03:06:32 INFO - 'USER': 'cltbld', 03:06:32 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', 03:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:32 INFO - '_': '/tools/buildbot/bin/python'} 03:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:06:32 INFO - Cleaning up... 03:06:32 INFO - Return code: 0 03:06:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:06:32 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')]} 03:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:32 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')]} 03:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:32 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 0x240f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277ceb0>, '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 0x277ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277e240>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', '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 03:06:32 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 03:06:32 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 03:06:32 INFO - Using env: {'DISPLAY': ':0', 03:06:32 INFO - 'HOME': '/home/cltbld', 03:06:32 INFO - 'LANG': 'en_US.UTF-8', 03:06:32 INFO - 'LANGUAGE': 'en_US:en', 03:06:32 INFO - 'LOGNAME': 'cltbld', 03:06:32 INFO - 'MAIL': '/var/mail/cltbld', 03:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:32 INFO - 'MOZ_NO_REMOTE': '1', 03:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:32 INFO - 'NO_EM_RESTART': '1', 03:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:32 INFO - 'PWD': '/builds/slave/test', 03:06:32 INFO - 'SHELL': '/bin/bash', 03:06:32 INFO - 'SHLVL': '1', 03:06:32 INFO - 'TERM': 'linux', 03:06:32 INFO - 'TMOUT': '86400', 03:06:32 INFO - 'USER': 'cltbld', 03:06:32 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', 03:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:32 INFO - '_': '/tools/buildbot/bin/python'} 03:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:32 INFO - Downloading/unpacking psutil>=3.1.1 03:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:06:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:33 INFO - Installing collected packages: psutil 03:06:33 INFO - Running setup.py install for psutil 03:06:33 INFO - building 'psutil._psutil_linux' extension 03:06:33 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 03:06:34 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 03:06:34 INFO - building 'psutil._psutil_posix' extension 03:06:34 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 03:06:34 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 03:06:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:35 INFO - Successfully installed psutil 03:06:35 INFO - Cleaning up... 03:06:35 INFO - Return code: 0 03:06:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:06:35 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')]} 03:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:35 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')]} 03:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:35 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 0x240f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277ceb0>, '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 0x277ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277e240>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', '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 03:06:35 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 03:06:35 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 03:06:35 INFO - Using env: {'DISPLAY': ':0', 03:06:35 INFO - 'HOME': '/home/cltbld', 03:06:35 INFO - 'LANG': 'en_US.UTF-8', 03:06:35 INFO - 'LANGUAGE': 'en_US:en', 03:06:35 INFO - 'LOGNAME': 'cltbld', 03:06:35 INFO - 'MAIL': '/var/mail/cltbld', 03:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:35 INFO - 'MOZ_NO_REMOTE': '1', 03:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:35 INFO - 'NO_EM_RESTART': '1', 03:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:35 INFO - 'PWD': '/builds/slave/test', 03:06:35 INFO - 'SHELL': '/bin/bash', 03:06:35 INFO - 'SHLVL': '1', 03:06:35 INFO - 'TERM': 'linux', 03:06:35 INFO - 'TMOUT': '86400', 03:06:35 INFO - 'USER': 'cltbld', 03:06:35 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', 03:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:35 INFO - '_': '/tools/buildbot/bin/python'} 03:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:06:35 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 03:06:35 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 03:06:35 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 03:06:35 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 03:06:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:06:36 INFO - Installing collected packages: mozsystemmonitor 03:06:36 INFO - Running setup.py install for mozsystemmonitor 03:06:36 INFO - Successfully installed mozsystemmonitor 03:06:36 INFO - Cleaning up... 03:06:36 INFO - Return code: 0 03:06:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:06:36 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')]} 03:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:36 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')]} 03:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:36 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 0x240f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277ceb0>, '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 0x277ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277e240>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', '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 03:06:36 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 03:06:36 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 03:06:36 INFO - Using env: {'DISPLAY': ':0', 03:06:36 INFO - 'HOME': '/home/cltbld', 03:06:36 INFO - 'LANG': 'en_US.UTF-8', 03:06:36 INFO - 'LANGUAGE': 'en_US:en', 03:06:36 INFO - 'LOGNAME': 'cltbld', 03:06:36 INFO - 'MAIL': '/var/mail/cltbld', 03:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:36 INFO - 'MOZ_NO_REMOTE': '1', 03:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:36 INFO - 'NO_EM_RESTART': '1', 03:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:36 INFO - 'PWD': '/builds/slave/test', 03:06:36 INFO - 'SHELL': '/bin/bash', 03:06:36 INFO - 'SHLVL': '1', 03:06:36 INFO - 'TERM': 'linux', 03:06:36 INFO - 'TMOUT': '86400', 03:06:36 INFO - 'USER': 'cltbld', 03:06:36 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', 03:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:36 INFO - '_': '/tools/buildbot/bin/python'} 03:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:36 INFO - Downloading/unpacking jsonschema==2.5.1 03:06:36 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 03:06:36 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 03:06:36 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 03:06:36 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 03:06:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:06:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:06:37 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 03:06:37 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 03:06:37 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 03:06:37 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 03:06:38 INFO - Downloading functools32-3.2.3-2.tar.gz 03:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:06:38 INFO - warning: no files found matching '*.txt' 03:06:38 INFO - no previously-included directories found matching 'build' 03:06:38 INFO - no previously-included directories found matching 'dist' 03:06:38 INFO - no previously-included directories found matching '.git*' 03:06:38 INFO - Installing collected packages: jsonschema, functools32 03:06:38 INFO - Running setup.py install for functools32 03:06:38 INFO - warning: no files found matching '*.txt' 03:06:38 INFO - no previously-included directories found matching 'build' 03:06:38 INFO - no previously-included directories found matching 'dist' 03:06:38 INFO - no previously-included directories found matching '.git*' 03:06:38 INFO - Successfully installed jsonschema functools32 03:06:38 INFO - Cleaning up... 03:06:38 INFO - Return code: 0 03:06:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:06:38 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')]} 03:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:38 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')]} 03:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:38 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 0x240f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277ceb0>, '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 0x277ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277e240>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', '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 03:06:38 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 03:06:38 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 03:06:38 INFO - Using env: {'DISPLAY': ':0', 03:06:38 INFO - 'HOME': '/home/cltbld', 03:06:38 INFO - 'LANG': 'en_US.UTF-8', 03:06:38 INFO - 'LANGUAGE': 'en_US:en', 03:06:38 INFO - 'LOGNAME': 'cltbld', 03:06:38 INFO - 'MAIL': '/var/mail/cltbld', 03:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:38 INFO - 'MOZ_NO_REMOTE': '1', 03:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:38 INFO - 'NO_EM_RESTART': '1', 03:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:38 INFO - 'PWD': '/builds/slave/test', 03:06:38 INFO - 'SHELL': '/bin/bash', 03:06:38 INFO - 'SHLVL': '1', 03:06:38 INFO - 'TERM': 'linux', 03:06:38 INFO - 'TMOUT': '86400', 03:06:38 INFO - 'USER': 'cltbld', 03:06:38 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', 03:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:38 INFO - '_': '/tools/buildbot/bin/python'} 03:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:06:38 INFO - Cleaning up... 03:06:38 INFO - Return code: 0 03:06:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:06:38 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')]} 03:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:38 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')]} 03:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:38 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 0x240f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277ceb0>, '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 0x277ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277e240>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', '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 03:06:38 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 03:06:38 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 03:06:38 INFO - Using env: {'DISPLAY': ':0', 03:06:38 INFO - 'HOME': '/home/cltbld', 03:06:38 INFO - 'LANG': 'en_US.UTF-8', 03:06:38 INFO - 'LANGUAGE': 'en_US:en', 03:06:38 INFO - 'LOGNAME': 'cltbld', 03:06:38 INFO - 'MAIL': '/var/mail/cltbld', 03:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:38 INFO - 'MOZ_NO_REMOTE': '1', 03:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:38 INFO - 'NO_EM_RESTART': '1', 03:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:38 INFO - 'PWD': '/builds/slave/test', 03:06:38 INFO - 'SHELL': '/bin/bash', 03:06:38 INFO - 'SHLVL': '1', 03:06:38 INFO - 'TERM': 'linux', 03:06:38 INFO - 'TMOUT': '86400', 03:06:38 INFO - 'USER': 'cltbld', 03:06:38 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', 03:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:38 INFO - '_': '/tools/buildbot/bin/python'} 03:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:38 INFO - Downloading/unpacking blobuploader==1.2.4 03:06:38 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 03:06:38 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 03:06:38 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 03:06:38 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 03:06:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:06:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:06:39 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 03:06:39 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 03:06:39 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 03:06:39 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 03:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:06:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:06:40 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 03:06:40 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 03:06:40 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 03:06:40 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 03:06:40 INFO - Downloading docopt-0.6.1.tar.gz 03:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:06:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:06:40 INFO - Running setup.py install for blobuploader 03:06:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:06:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:06:40 INFO - Running setup.py install for requests 03:06:40 INFO - Running setup.py install for docopt 03:06:40 INFO - Successfully installed blobuploader requests docopt 03:06:40 INFO - Cleaning up... 03:06:40 INFO - Return code: 0 03:06:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:40 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')]} 03:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:40 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')]} 03:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:41 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 0x240f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277ceb0>, '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 0x277ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277e240>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', '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 03:06:41 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 03:06:41 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 03:06:41 INFO - Using env: {'DISPLAY': ':0', 03:06:41 INFO - 'HOME': '/home/cltbld', 03:06:41 INFO - 'LANG': 'en_US.UTF-8', 03:06:41 INFO - 'LANGUAGE': 'en_US:en', 03:06:41 INFO - 'LOGNAME': 'cltbld', 03:06:41 INFO - 'MAIL': '/var/mail/cltbld', 03:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:41 INFO - 'MOZ_NO_REMOTE': '1', 03:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:41 INFO - 'NO_EM_RESTART': '1', 03:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:41 INFO - 'PWD': '/builds/slave/test', 03:06:41 INFO - 'SHELL': '/bin/bash', 03:06:41 INFO - 'SHLVL': '1', 03:06:41 INFO - 'TERM': 'linux', 03:06:41 INFO - 'TMOUT': '86400', 03:06:41 INFO - 'USER': 'cltbld', 03:06:41 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', 03:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:41 INFO - '_': '/tools/buildbot/bin/python'} 03:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:06:41 INFO - Running setup.py (path:/tmp/pip-tEgleZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:06:41 INFO - Running setup.py (path:/tmp/pip-t0bYn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:06:41 INFO - Running setup.py (path:/tmp/pip-sQHthY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:06:41 INFO - Running setup.py (path:/tmp/pip-xEpbgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:06:41 INFO - Running setup.py (path:/tmp/pip-sbEgoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:06:41 INFO - Running setup.py (path:/tmp/pip-cG2nlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:06:41 INFO - Running setup.py (path:/tmp/pip-3PdAJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:06:41 INFO - Running setup.py (path:/tmp/pip-EyTgZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:06:41 INFO - Running setup.py (path:/tmp/pip-BlTFRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:06:41 INFO - Running setup.py (path:/tmp/pip-FVhOEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:06:41 INFO - Running setup.py (path:/tmp/pip-8qxZ54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:06:41 INFO - Running setup.py (path:/tmp/pip-gOE_us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:06:42 INFO - Running setup.py (path:/tmp/pip-2SlUif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:06:42 INFO - Running setup.py (path:/tmp/pip-a99t6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:42 INFO - Running setup.py (path:/tmp/pip-g8m9ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:06:42 INFO - Running setup.py (path:/tmp/pip-Du8WuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:06:42 INFO - Running setup.py (path:/tmp/pip-Tdk3Mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:06:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:06:42 INFO - Running setup.py install for manifestparser 03:06:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:06:42 INFO - Running setup.py install for mozcrash 03:06:42 INFO - Running setup.py install for mozdebug 03:06:42 INFO - Running setup.py install for mozdevice 03:06:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:06:42 INFO - Running setup.py install for mozfile 03:06:42 INFO - Running setup.py install for mozhttpd 03:06:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:06:43 INFO - Running setup.py install for mozinfo 03:06:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:06:43 INFO - Running setup.py install for mozInstall 03:06:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:06:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:06:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:06:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:06:43 INFO - Running setup.py install for mozleak 03:06:43 INFO - Running setup.py install for mozlog 03:06:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:06:43 INFO - Running setup.py install for moznetwork 03:06:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:06:43 INFO - Running setup.py install for mozprocess 03:06:43 INFO - Running setup.py install for mozprofile 03:06:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:06:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:06:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:06:43 INFO - Running setup.py install for mozrunner 03:06:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:06:43 INFO - Running setup.py install for mozscreenshot 03:06:43 INFO - Running setup.py install for moztest 03:06:44 INFO - Running setup.py install for mozversion 03:06:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:06:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:06:44 INFO - Cleaning up... 03:06:44 INFO - Return code: 0 03:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:44 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')]} 03:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:44 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')]} 03:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:44 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 0x240f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277ceb0>, '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 0x277ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277e240>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', '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 03:06:44 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 03:06:44 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 03:06:44 INFO - Using env: {'DISPLAY': ':0', 03:06:44 INFO - 'HOME': '/home/cltbld', 03:06:44 INFO - 'LANG': 'en_US.UTF-8', 03:06:44 INFO - 'LANGUAGE': 'en_US:en', 03:06:44 INFO - 'LOGNAME': 'cltbld', 03:06:44 INFO - 'MAIL': '/var/mail/cltbld', 03:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:44 INFO - 'MOZ_NO_REMOTE': '1', 03:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:44 INFO - 'NO_EM_RESTART': '1', 03:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:44 INFO - 'PWD': '/builds/slave/test', 03:06:44 INFO - 'SHELL': '/bin/bash', 03:06:44 INFO - 'SHLVL': '1', 03:06:44 INFO - 'TERM': 'linux', 03:06:44 INFO - 'TMOUT': '86400', 03:06:44 INFO - 'USER': 'cltbld', 03:06:44 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', 03:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:44 INFO - '_': '/tools/buildbot/bin/python'} 03:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:06:44 INFO - Running setup.py (path:/tmp/pip-fXTmpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:06:44 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)) 03:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:06:44 INFO - Running setup.py (path:/tmp/pip-xjIGBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:06:44 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)) 03:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:06:44 INFO - Running setup.py (path:/tmp/pip-028ZQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:06:44 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)) 03:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:06:44 INFO - Running setup.py (path:/tmp/pip-pQQpyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:06:44 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)) 03:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:06:44 INFO - Running setup.py (path:/tmp/pip-MMkCuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:06:44 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)) 03:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:06:44 INFO - Running setup.py (path:/tmp/pip-rWlLBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:06:44 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)) 03:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:06:44 INFO - Running setup.py (path:/tmp/pip-CsxXyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:06:44 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)) 03:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:06:44 INFO - Running setup.py (path:/tmp/pip-3qIZzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:06:45 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)) 03:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:06:45 INFO - Running setup.py (path:/tmp/pip-nTBAk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:06:45 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)) 03:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:06:45 INFO - Running setup.py (path:/tmp/pip-AGY3Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:06:45 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)) 03:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:06:45 INFO - Running setup.py (path:/tmp/pip-vPCVLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:06:45 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)) 03:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:06:45 INFO - Running setup.py (path:/tmp/pip-8W8x0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:06:45 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)) 03:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:06:45 INFO - Running setup.py (path:/tmp/pip-OWnJCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:06:45 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)) 03:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:06:45 INFO - Running setup.py (path:/tmp/pip-m01IXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:06:45 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)) 03:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:45 INFO - Running setup.py (path:/tmp/pip-IxfX_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:45 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)) 03:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:06:45 INFO - Running setup.py (path:/tmp/pip-ffxwaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:06:45 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)) 03:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:06:45 INFO - Running setup.py (path:/tmp/pip-Vsvd3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:06:45 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)) 03:06:45 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)) 03:06:45 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)) 03:06:45 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)) 03:06:45 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)) 03:06:45 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)) 03:06:45 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)) 03:06:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:06:45 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 03:06:45 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 03:06:45 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 03:06:45 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 03:06:46 INFO - Downloading blessings-1.6.tar.gz 03:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:06:46 INFO - Installing collected packages: blessings 03:06:46 INFO - Running setup.py install for blessings 03:06:46 INFO - Successfully installed blessings 03:06:46 INFO - Cleaning up... 03:06:47 INFO - Return code: 0 03:06:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:06:47 INFO - Reading from file tmpfile_stdout 03:06:47 INFO - Current package versions: 03:06:47 INFO - argparse == 1.2.1 03:06:47 INFO - blessings == 1.6 03:06:47 INFO - blobuploader == 1.2.4 03:06:47 INFO - docopt == 0.6.1 03:06:47 INFO - functools32 == 3.2.3-2 03:06:47 INFO - jsonschema == 2.5.1 03:06:47 INFO - manifestparser == 1.1 03:06:47 INFO - mozInstall == 1.13 03:06:47 INFO - mozcrash == 1.0 03:06:47 INFO - mozdebug == 0.1 03:06:47 INFO - mozdevice == 0.51 03:06:47 INFO - mozfile == 1.2 03:06:47 INFO - mozhttpd == 0.7 03:06:47 INFO - mozinfo == 0.10 03:06:47 INFO - mozleak == 0.1 03:06:47 INFO - mozlog == 3.5 03:06:47 INFO - moznetwork == 0.27 03:06:47 INFO - mozprocess == 0.25 03:06:47 INFO - mozprofile == 0.28 03:06:47 INFO - mozrunner == 6.13 03:06:47 INFO - mozscreenshot == 0.1 03:06:47 INFO - mozsystemmonitor == 0.3 03:06:47 INFO - moztest == 0.8 03:06:47 INFO - mozversion == 1.4 03:06:47 INFO - psutil == 3.1.1 03:06:47 INFO - requests == 1.2.3 03:06:47 INFO - wsgiref == 0.1.2 03:06:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06: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')]} 03:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06: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')]} 03:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:47 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 0x240f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277ceb0>, '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 0x277ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277e240>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', '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 03:06:47 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 03:06:47 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 03:06:47 INFO - Using env: {'DISPLAY': ':0', 03:06:47 INFO - 'HOME': '/home/cltbld', 03:06:47 INFO - 'LANG': 'en_US.UTF-8', 03:06:47 INFO - 'LANGUAGE': 'en_US:en', 03:06:47 INFO - 'LOGNAME': 'cltbld', 03:06:47 INFO - 'MAIL': '/var/mail/cltbld', 03:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:47 INFO - 'MOZ_NO_REMOTE': '1', 03:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:47 INFO - 'NO_EM_RESTART': '1', 03:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:47 INFO - 'PWD': '/builds/slave/test', 03:06:47 INFO - 'SHELL': '/bin/bash', 03:06:47 INFO - 'SHLVL': '1', 03:06:47 INFO - 'TERM': 'linux', 03:06:47 INFO - 'TMOUT': '86400', 03:06:47 INFO - 'USER': 'cltbld', 03:06:47 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', 03:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:47 INFO - '_': '/tools/buildbot/bin/python'} 03:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:47 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)) 03:06:47 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)) 03:06:47 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)) 03:06:47 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)) 03:06:47 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)) 03:06:47 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)) 03:06:47 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)) 03:06:47 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)) 03:06:47 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)) 03:06:47 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:06: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 03:06: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 03:06: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 03:06: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 03:06:48 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:06:48 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:06:48 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)) 03:06:48 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)) 03:06:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:06:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:06:48 INFO - Installing collected packages: marionette-driver, simplejson 03:06:48 INFO - Running setup.py install for marionette-driver 03:06:48 INFO - Running setup.py install for simplejson 03:06:49 INFO - building 'simplejson._speedups' extension 03:06:49 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 03:06:49 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 03:06:49 INFO - Successfully installed marionette-driver simplejson 03:06:49 INFO - Cleaning up... 03:06:50 INFO - Return code: 0 03:06:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:06: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')]} 03:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06: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')]} 03:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277ceb0>, '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 0x277ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277e240>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', '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 03:06: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'] in /builds/slave/test/build 03:06: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 03:06:50 INFO - Using env: {'DISPLAY': ':0', 03:06:50 INFO - 'HOME': '/home/cltbld', 03:06:50 INFO - 'LANG': 'en_US.UTF-8', 03:06:50 INFO - 'LANGUAGE': 'en_US:en', 03:06:50 INFO - 'LOGNAME': 'cltbld', 03:06:50 INFO - 'MAIL': '/var/mail/cltbld', 03:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:50 INFO - 'MOZ_NO_REMOTE': '1', 03:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:50 INFO - 'NO_EM_RESTART': '1', 03:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:50 INFO - 'PWD': '/builds/slave/test', 03:06:50 INFO - 'SHELL': '/bin/bash', 03:06:50 INFO - 'SHLVL': '1', 03:06:50 INFO - 'TERM': 'linux', 03:06:50 INFO - 'TMOUT': '86400', 03:06:50 INFO - 'USER': 'cltbld', 03:06:50 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', 03:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:50 INFO - '_': '/tools/buildbot/bin/python'} 03:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:06:50 INFO - Cleaning up... 03:06:50 INFO - Return code: 0 03:06:50 INFO - Running post-action listener: _resource_record_post_action 03:06:50 INFO - Running post-action listener: _start_resource_monitoring 03:06:50 INFO - Starting resource monitoring. 03:06:50 INFO - [mozharness: 2017-07-23 10:06:50.326747Z] Finished create-virtualenv step (success) 03:06:50 INFO - [mozharness: 2017-07-23 10:06:50.327734Z] Running install step. 03:06:50 INFO - Running pre-action listener: _resource_record_pre_action 03:06:50 INFO - Running main action method: install 03:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:06:50 INFO - Reading from file tmpfile_stdout 03:06:50 INFO - Detecting whether we're running mozinstall >=1.0... 03:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:06:50 INFO - Reading from file tmpfile_stdout 03:06:50 INFO - Output received: 03:06:50 INFO - Usage: mozinstall [options] installer 03:06:50 INFO - Options: 03:06:50 INFO - -h, --help show this help message and exit 03:06:50 INFO - -d DEST, --destination=DEST 03:06:50 INFO - Directory to install application into. [default: 03:06:50 INFO - "/builds/slave/test"] 03:06:50 INFO - --app=APP Application being installed. [default: firefox] 03:06:50 INFO - mkdir: /builds/slave/test/build/application 03:06:50 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'] 03:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:07:08 INFO - Reading from file tmpfile_stdout 03:07:08 INFO - Output received: 03:07:08 INFO - /builds/slave/test/build/application/firefox/firefox 03:07:08 INFO - Running post-action listener: _resource_record_post_action 03:07:08 INFO - [mozharness: 2017-07-23 10:07:08.682366Z] Finished install step (success) 03:07:08 INFO - [mozharness: 2017-07-23 10:07:08.682620Z] Running setup-mitmproxy step. 03:07:08 INFO - Running pre-action listener: _resource_record_pre_action 03:07:08 INFO - Running main action method: setup_mitmproxy 03:07:08 INFO - Skipping: mitmproxy is not required 03:07:08 INFO - Running post-action listener: _resource_record_post_action 03:07:08 INFO - [mozharness: 2017-07-23 10:07:08.683747Z] Finished setup-mitmproxy step (success) 03:07:08 INFO - [mozharness: 2017-07-23 10:07:08.683969Z] Running run-tests step. 03:07:08 INFO - Running pre-action listener: _resource_record_pre_action 03:07:08 INFO - Running pre-action listener: _set_gcov_prefix 03:07:08 INFO - Running main action method: run_tests 03:07:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:07:08 INFO - Python 2.7.3 03:07:08 INFO - Return code: 0 03:07:08 INFO - grabbing minidump binary from tooltool 03:07:08 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')]} 03:07:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/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 0x277ceb0>, '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 0x277ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277e240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:07:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:07:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:07:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:07:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:07:08 INFO - Return code: 0 03:07:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:07:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:07:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:07:08 INFO - ENV: RUST_BACKTRACE is now 1 03:07:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:07:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:07:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 03:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 03:07:08 INFO - Using env: {'DISPLAY': ':0', 03:07:08 INFO - 'HOME': '/home/cltbld', 03:07:08 INFO - 'LANG': 'en_US.UTF-8', 03:07:08 INFO - 'LANGUAGE': 'en_US:en', 03:07:08 INFO - 'LOGNAME': 'cltbld', 03:07:08 INFO - 'MAIL': '/var/mail/cltbld', 03:07:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:07:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:08 INFO - 'MOZ_NO_REMOTE': '1', 03:07:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:08 INFO - 'NO_EM_RESTART': '1', 03:07:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:08 INFO - 'PWD': '/builds/slave/test', 03:07:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:07:08 INFO - 'RUST_BACKTRACE': '1', 03:07:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:07:08 INFO - 'SHELL': '/bin/bash', 03:07:08 INFO - 'SHLVL': '1', 03:07:08 INFO - 'TERM': 'linux', 03:07:08 INFO - 'TMOUT': '86400', 03:07:08 INFO - 'USER': 'cltbld', 03:07:08 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267', 03:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:08 INFO - '_': '/tools/buildbot/bin/python'} 03:07:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 03:07:09 INFO - mozversion application_buildid: 20170723092615 03:07:09 INFO - mozversion application_changeset: c023ce417c98641c0dfacaaf236dcfdcb7794f88 03:07:09 INFO - mozversion application_display_name: Nightly 03:07:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:07:09 INFO - mozversion application_name: Firefox 03:07:09 INFO - mozversion application_remotingname: firefox 03:07:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:07:09 INFO - mozversion application_vendor: Mozilla 03:07:09 INFO - mozversion application_version: 56.0a1 03:07:09 INFO - mozversion platform_buildid: 20170723092615 03:07:09 INFO - mozversion platform_changeset: c023ce417c98641c0dfacaaf236dcfdcb7794f88 03:07:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:07:09 INFO - mozversion platform_version: 56.0a1 03:07:09 INFO - using testdate: 1500804429 03:07:09 INFO - actual date: 1500804429 03:07:09 INFO - starting webserver on 'localhost:36488' 03:07:09 INFO - SUITE-START | Running 2 tests 03:07:09 INFO - TEST-START | dromaeo_css 03:07:09 INFO - Initialising browser for dromaeo_css test... 03:07:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36488/getInfo.html -profile /tmp/tmpoRZpY0/profile 03:07:09 INFO - TEST-INFO | started process 3442 (/builds/slave/test/build/application/firefox/firefox http://localhost:36488/getInfo.html) 03:07:16 INFO - TEST-INFO | 3442: exit 0 03:07:17 INFO - Browser initialized. 03:07:17 INFO - Running cycle 1/1 for dromaeo_css test... 03:07:17 INFO - TEST-INFO | started process 3651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoRZpY0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:07:28 INFO - PID 3651 | RSS: Main: 177750016 03:07:28 INFO - PID 3651 | 03:10:28 INFO - PID 3651 | Cycle 1(1): loaded http://localhost:36488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36488/tests/dromaeo/cssquery-ext.html) 03:10:29 INFO - PID 3651 | RSS: Main: 176869376 03:10:29 INFO - PID 3651 | 03:13:31 INFO - PID 3651 | Cycle 1(1): loaded http://localhost:36488/tests/dromaeo/cssquery-ext.html (next: http://localhost:36488/tests/dromaeo/cssquery-jquery.html) 03:13:31 INFO - PID 3651 | RSS: Main: 177213440 03:13:31 INFO - PID 3651 | 03:16:33 INFO - PID 3651 | Cycle 1(1): loaded http://localhost:36488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36488/tests/dromaeo/cssquery-mootools.html) 03:16:34 INFO - PID 3651 | RSS: Main: 177434624 03:16:34 INFO - PID 3651 | 03:19:35 INFO - PID 3651 | Cycle 1(1): loaded http://localhost:36488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36488/tests/dromaeo/cssquery-prototype.html) 03:19:36 INFO - PID 3651 | RSS: Main: 175800320 03:19:36 INFO - PID 3651 | 03:22:40 INFO - PID 3651 | Cycle 1(1): loaded http://localhost:36488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36488/tests/dromaeo/cssquery-yui.html) 03:22:40 INFO - PID 3651 | RSS: Main: 177872896 03:22:41 INFO - PID 3651 | 03:25:42 INFO - PID 3651 | Cycle 1(1): loaded http://localhost:36488/tests/dromaeo/cssquery-yui.html (next: http://localhost:36488/tests/dromaeo/cssquery-dojo.html) 03:25:42 INFO - PID 3651 | RSS: Main: 181727232 03:25:42 INFO - PID 3651 | 03:25:42 INFO - PID 3651 | __start_tp_report 03:25:42 INFO - PID 3651 | _x_x_mozilla_page_load 03:25:42 INFO - PID 3651 | _x_x_mozilla_page_load_details 03:25:42 INFO - PID 3651 | |i|pagename|runs| 03:25:42 INFO - PID 3651 | |0;dojo.html;3093.73703235225;3131.9686803131967;3178.046586024192;3192.425363434581;3202.1674364665196;6029.909551356728;6041.184440100591;6176.907346389808;6218.191635087438;6232.5013998880095;6156.507479401648;6170.228721409824;6198.72105755241;6272;6280.120783090371;5429.321334833146;5605.159226116095;5678.26182596264;5719.857003574913;5736.541076713874;5588.832335029955;5602.355729091146;5626.099824028156;5710.371859095496;5725.083986562151;5637.408072152406;5701.0308247598;5701.857453563653;5702.971485142589;5728;5569.8607534811545;5638.492535671769;5660.971695141539;5726.599138060295;5729.28383952006;5564.970480461087;5581.776728930838;5651.237082993825;5660.179274005287;5683.232763576905;6101.328853826076;6101.877962440771;6176.197094377747;6182.969085154546;6239.095331176999;6407.903881441782;6663.9333606663795;6671.366220209121;6684.933150668479;6689.765858194988;6606.735730570771;6611.239707433659;6701.564398314094;6744.426723728489;6770.492213084039;6144.569880108439;6154.476869466101;6199.814005579839;6219.569499015207;6254.155688981929;6706;6798.76204332846;6817.01153332764;6875.48433867462;6910.378065974087;6424.036394540856;6426.485881129498;6427.807165785034;6464.579802312929;6548.083268342436;6660.333966603301;6680;6682.164729408824;6686.632235227012;6691.1636045494315;6541.934580654228;6550.377714117151;6570.244421891448;6582.96708516464;6633.170853643294;6503.479721622259;6576.76981305652;6596.175478065242;6688.966555167291;6692.196936367667;5267.789288428497;5269.762860671279;5278.049951008778;5287.2597836302175;5354.705491197944;4562.201614717411;4586.289125185602;4683.297505374221;4685.953140468551;4719.197736384823;5718.7426565804635;5738.11059285803;5801.622894511843;5805.042168042311;5817.825465236049;6508.934910650928;6607.867842643216;6689.264180940093;6760.830979225559;6768.323167683291;5607.186957891083;5693.4021927696995;5696.23100881384;5698.686572238566;5706.514946229534;5796.942030579725;5871.55963302754;5878.882422351529;5887.411258874164;5896.528277737771;6400.935990640034;6412.647304398303;6416;6434.774782882577;6506.837329066717;6517.576357536745;6612.933870661232;6646.368594983469;6732.3267673232285;6743.763968261087;6388.1376014237485;6470.288268290578;6480.287168411565;6485.221773387035;6504.934950650622;6472.385123413268;6475.902861456988;6572.047053177167;6577.6053436793945;6583.374579414948;6576.375244351779;6669.833254168685;6672.232693240339;6683.598984060972;6761.797146085625;6488.480921526361;6536.117624120873;6556.770513032021;6563.638999855054;6566;6464.191976003;6485.902711459237;6514.902276465951;6557;6592.868142637025;6314.84212894663;6378.840528986812;6387.776427825004;6401.231852177769;6407.0709747085475;6376.713047912763;6435.03474478832;6538;6541.378569035934;6541.378569035934;6264.154339164154;6282.246130464374;6294.213223347082;6395.232572091379;6407.199100112486 03:25:42 INFO - PID 3651 | |1;ext.html;795.339867909635;849.2908421468073;864.948103113813;888.0542222533004;899.3210126354601;41248.79375603121;41764;41988.160236795244;42001.57998420015;42002;37613.43579846305;37981.43027854584;37995.810020949924;38084;38175;6786.694598743068;6879.89680154798;6900.20647625522;6902.482313826458;6913.585184888898;6766;6848.965755171242;6859.519833611649;6862.210845752727;6866.690998905036;6801.251862295168;7247.7100915963565;7498.212687667771;7498.325150736433;7503.174650788409;7410.073740782403;7437.442191835634;7440.851182976365;7444.36722878556;7470.626468676572;7228.8554228915655;7330.780076597711;7426.925730742678;7429.07136607924;7430.665620047111;38483.615163848284;38620;38641.806790965864;38827.22345553073;38859.22281554381;3472.791632502058;3486.564179477565;3540.6990405815277;3544.113971507123;3544.167120726627;30429.087127386214;30443.847780761174;30718.84640576805;30723.231919201975;30824.691753082632;4747.7626118693925;4868.902621947541;4871.634627402959;4909.361782968192;4977.776000079969;184253;184519;184908;187184;195941.02029489903;47504.28743568849;47532.52467475281;47881.281780773315;48058.519414806105;48110.759446202544;50479.49520504822;50549;50713.49286507162;51049.74475127675;51097;14686.92656536732;14741.92629036848;14752.40990360395;14839.480618178311;14934.775978360334;11842.28946263227;12013.099017573542;12059.095567832272;12075.09436792244;12288;14153.726164645026;14210.147391156564;14211.005229633827;14215.507371726027;14356.712865742627;5659.377468478464;5717.599768016282;5724.484796368263;5818.4763371296785;5837.620554663933;963.349738926222;978.2907392140784;983.537737263485;1007.1942446043137;1013.8834034086175;22325.888370558045;22356.888215558818;22622;22875.885620572124;23184.18855340055;1061.129658915632;1090.1224514265934;1101.9504122314515;1111.4387234446554;1118.0887576625187;11378.260413073123;11968.940155299168;12327.93836030832;16007.199640017952;16230.431934882223;214325;230478;230758;230782;230881;56576.717116414155;56671.433285666615;56942.7152864233;57415;57553.42446575564;1431.2485944879022;1455.9344829482698;1461.817272840895;1466.4720700547794;1471.9852801471848;26086.478270434105;26883.462330753668;27144.72855271501;27337;27488.976212616995;50979.49020509747;51181.7440912793;51506.22740658968;51553;51701.48298516967;210051;210073;211205;212107;213012;35095.29809403849;37493;37923;38123.618763813116;38125.80937095297;46874.296885546064;47258.76370618125;47278.52721472879;47311.29033064438;47375.28937065878;28554.14337569793;28744.13767586976;28778.856105719336;29202.70797292085;29290.56064159082;33435.33129337448;33466.33067338688;33543.496847547794;33687;33787.15532111717;36866;37472.81263593664;37503.249935001695;37782.2443551133;38081.238375231784;31245.531317030716;32135.51796723098;32508.349833002736;33341.666583333856;33581;23693.881530592236;23725.762742372357;23736.762632373455;24266.393340166636;24661 03:25:43 INFO - PID 3651 | |2;jquery.html;570.3640440908389;570.4295704295704;576.3544829790635;577.7082573300482;586.7858231745414;22140;22473;22917.885410572966;22939.311820645366;22970.08119675213;25853.224403267934;26655.20034398966;26678.733212667867;26787.86606066967;26844.865775671144;6478.416942475164;6567.901481477782;6609.173853268341;6622.1722284714415;6662.333766623323;5828.358880523139;6368.4905207583515;6386.10594516768;6417.8395540111405;6541.247756507991;6335.841603959915;6338.30278669346;6344.968275158641;6348.111264422984;6348.206474190726;6242.375762423767;6254.093156492306;6268.811935641916;6308.116863639094;6308.621482711052;5793.362730099686;5800.477956983892;5848.239728835267;5887.528997680175;5930.169776231331;29256.70743292561;29538;30046.84976575125;30256.09231723052;30630;1822.7448157257995;1868.841148502379;1870.1958157992058;1870.7568016157948;1874.2784028149124;18259.726104108315;18847.81152188488;18860.434186974413;18879.716804247946;18882.433526994075;2316.6061769499056;2367.597508423572;2418.9516209675885;2420.7579242075826;2421.055788242587;131870.3406482971;134652;134698.32650836682;134833;135235;14107.435702571987;15064.548063558112;15215.467458638894;15270.694586108215;15501.922490387477;22611.547769044526;24100.51798964011;24101.276961691176;24122.51754964891;24157.033718651408;9534.761630959281;9541.52292385378;9660.855087173557;9741.9025809741;9829.655962041294;8562;8572.828543429096;8589.398742087993;8702.869456958151;8754.387192896436;9225.769355766026;9529.237660987243;9611.855822162674;9645.9035409645;9688.07632908673;2846.2599724071893;2870.7559857411934;2887.422515496909;2898.8985385511405;2930.794844360917;937.1706040154512;943.3726571829657;965.3435663748578;996.5017491254373;1006.6828948881079;19572.804271957382;19596.412107636792;23702.88148559246;25087.74912250854;25271;1003.5684655598017;1019.8572199892021;1020.8009438159488;1049.3441599000626;1055.767731099157;10790.89209107899;11044.613438529774;11077.11383089351;11468.4839182237;11533.769324613628;497916;501802;506133;508594;530787;117405;118751;119608.40195798966;122809;123415.38292308661;1231.2673958994385;1261.2306493039239;1289.9032572557096;1296.857345691973;1298.1691717300935;16901.408450704166;17355.7396639048;17840.55398615045;17846.553836153682;18354.90822545879;56778.716106420856;57105.428945711676;57115.714421429286;57269.14096288642;59813.70093149506;68340.65829670819;68794;68979.65510172417;69406.65296673484;69617.3038269631;14619.342129604405;15020;15040.17279049619;15094.54716358511;15112.697746045238;23008.309750707507;23261.651075234222;23382.883085584464;23492.295231143093;23685.64471532963;18311.908440458246;18520.60363596468;18946.242150314385;18982.240710371432;19047;14825.550396013286;16020.67958640844;16468.505944821674;16618.086005269826;16958.576035598715;18048.187831547875;18877.622447551246;19018.42944711661;19067;19170.424887253404;14435.35040923182;14804.703905921606;14837.109773413198;15257.465988690787;15350.692986140439;19160.71258931145;19172.616547669248;19208.327708530134;19232.903835480734;19370.4188874334 03:25:43 INFO - PID 3651 | |3;mootools.html;1367.8905687544998;1398;1406.2406300597677;1415.299426783742;1430.670945682493;13062.93468532656;13257.867421325784;13824.308784560782;13837.792433113498;13889.791653125187;14199.574012779607;14367.928160359184;14442.927785361058;14452.421903123888;14477.493287734931;2619.9869000655017;2673.4786716590274;2674.398260391416;2679.303381120903;2679.745424184709;2515.408878913454;2541.7966562675033;2605.671107735059;2662.3876508403077;2691.0581296546247;2629.355807827085;2644.93387665308;2661.853598052116;2664.134156399168;2666.0535509894;2491.0533997081084;2508.8996440142373;2509.1970569417795;2518.8362756420865;2574.407886186169;2402.123225022854;2522.848629082261;2536.5053814506177;2552.1705445730026;2557.5268575313626;13716.65708357289;13790.448382064706;13840.238786866717;13855.930720346334;13868.514601988882;7100.502964792415;7490.775276741707;7519.172890981988;7530.359919406857;7551.056117985252;5005.57452616528;5056.064628043824;5128.692278463267;5228.241904923765;5238.947610523884;1867.6638205123209;1878.6806242938733;1914.2725764209652;1948.3278268997315;1958.8237058664647;21895.562088758295;22135.225267115733;22160.335189944326;22195.11219551216;22229.22197723088;6254.906176407358;6486.740530378826;6491.350864913566;6630.569013014138;6647.66761661915;14327.713445731235;14353.92823035878;14381.712365752626;14419.711605767827;14420.351084201237;7060.152781666233;7289.380402665833;7368.778936631909;7421.8144546386775;7424.368928641126;6103;6760.42536384403;6760.932390676128;6795.38841504267;6847.657617119125;4772.880677983078;4832.178529649968;4872.317875497433;4959.132151873408;4966.91389616362;1267.353649638691;1331.7203387288585;1381.88944884409;1385.1965859801292;1407.7785731328884;886.0740526150189;894.338189739601;904.9909500904906;911.2436677557612;929.2380248196414;8526.147385261549;8606.741797746077;8674.913250867537;8680.56597170139;8741.256993155654;996.3822430093388;1020.5560581147224;1022.4325499347784;1029.1098200057047;1032.230987914009;4506.211413002777;4641.698289611165;4927.211646136672;5183.0670479314085;5235.377462034354;17775.644487110185;19408.417747467316;19542.218311267676;19565.608687826163;19588.020598969993;17434.215460304316;19050.142743576573;19322.32371866978;19720.70418943717;19739.309124180872;10559.630412935665;10688.358698478116;10726.302790318605;10752.677419677422;10756.838647420294;7313.341799238094;8128.268455839003;8264.917350826414;8284.917150828414;8286.04710458305;16159;16322.347106115622;16816.747748784022;16834.326626934784;17088.57278568046;17149.57126071858;17403.30386784565;17451.912740436215;17468.563285917953;17506.649867002845;10695.786084278427;10994.065504432212;11056.11551075928;11059.557617695202;11077.667669969915;11830.940845295718;12766.744665106831;12847.550335738204;12953.481860725466;12956.28740419286;10302.433366164933;10412.27114102036;10527.368357898551;10563.52464139131;10731.087857532197;9944.105030547285;10419.687409377731;10543.89456105429;10697.358158510515;10775.299605525615;9092.59083341238;9309.022552632146;9316.767080823034;9336.533173341442;9353.251739860658;6878.965605171942;7273.636318184175;7321.890171647536;7407.370373518312;7459.142198647008;6999.580025198505;7064.32888875556;7164.068671072727;7224.277572242734;7285.7814265572115 03:25:43 INFO - PID 3651 | |4;prototype.html;492.556698970926;494.68093079963427;495.13351634639383;523.6727045596502;525.1387724132421;6045.607035542686;6186.536009799261;6187.350328215534;6219.693864288499;6295.45034261125;5977.52179825614;6013.579049466539;6038.124471951564;6091;6138.447539721425;4767.451743049559;4853.053654537367;4857.562819346258;4871.293662418947;4876.244182151772;4790.976045119787;4793.544613261734;4808.302796094564;4812.350332705092;4883.682560633548;4787.40157480315;4805.51029180955;4810.663253572251;4850.733209673466;4897.779599917994;4758.643101767347;4797.712137271775;4823.469418363977;4839.395075615548;4856.247281671346;4365.781710914442;4366.257736184856;4409.470863496369;4413.984783499781;4421.358902959085;6009.939900600982;6018.548608854353;6032.728527216286;6060.2424696912885;6067.302260240085;5487.149491828773;5544.3346798384455;5590.748416321276;5597.74810133545;5664.54683625309;6418.326075762071;6448;6470.288268290485;6473.385028422293;6505.739770409178;4759.309900064472;4761.952380476186;4800.423949126127;4802.711837289774;4840.346553215341;6796.728130874809;6844.931550684529;6874.772015210659;6899.655017249067;6900.171979362509;4822.903541929142;4928.162212423897;4957.652964292537;4959.7272150032095;4967.801287948514;4974.552290293891;5006.624503162205;5008.17365134756;5049.419316778617;5054.115529782273;5414.891702166014;5496.1755736639825;5545.805896793593;5550.47270509301;5607.214989901417;6455.095746754719;6496.967515162394;6497.512686548528;6549.181352330958;6578.868422631521;1614.1041721844254;1664.3758590528553;1666.3251383189586;1671.5319710480842;1728;1179.2511755035614;1182.9467673954694;1213.9028877689764;1219.7804395208948;1221.3465795799204;5516.668999860021;5547.306586676666;5629.943700563023;5633.3240011198095;5652.576056795757;6382.7129028550335;6484.967575162094;6520.967395163088;6555.344465553407;6668.299828517936;5656.434356564393;5662.2639056922335;5690.174924635905;5714.228659008402;5742.684152371659;3482.495038219444;3518.9120271993406;3531.3820081485637;3566.251087271702;3586.569611646567;6409.230892292955;6429.453496452854;6519.478441724651;6527.510436717265;6592.9340706593275;6812.591244525344;6823.249442561314;6870.484713646497;6916.515843890879;6932.688029038705;6461.386168314003;6499.415052645285;6508.047585724264;6533.934660653427;6535.215774106948;6717.395434410926;6730.40879261478;6733.074894093166;6745.224299205458;6784.084148640068;6578.736850525926;6590.912499437731;6652.467802575879;6670.299618540177;6706.8993965089585;6361.187061687397;6403.807885763435;6429.8392540185;6488.545801793829;6513.250976137805;4783.330333753208;4815.374001379798;4819.590334821439;4826.251930950708;4863.708177509361;6385.29761726219;6626.701798418986;6632.270450250372;6669.866602668017;6717.395434410926;6224.688765561795;6244.875102497834;6366.331535188739;6387.968060159669;6430.131932189094;6365;6402.1357116790505;6464.4828413725845;6464.806055818333;6466.997615369625;6267.435930766253;6340.797897061954;6352.872942541031;6398.328175541501;6428.4214420702365;6438.871222575616;6446.7098980546925;6503.358119453122;6534.346565343428;6554.737810487527;6279.623222606659;6308.873822523616;6356.141920840627;6379.74481020754;6390.968045159744 03:25:43 INFO - PID 3651 | |5;yui.html;901.4140808474491;909.9317551183663;910.9043550427205;911.325619041909;932.4871320773573;17810.46568602941;18709.251629934803;18729.71905421418;18741.15664795084;20013.299534516296;19557.902210488926;19589.51026224345;19713.605727885435;19846;20187.899060504715;969.6315400147934;1045.242199405429;1052.2686732720763;1052.41590917041;1053.9209559283047;985.5860538573817;1060.01948197917;1061.1245722279111;1068.2255364860453;1069.6577095329499;1085.4138765066855;1097.4841824342545;1099.0657940750377;1099.0987390339924;1100.6697990602827;1078.8705355357329;1092.153580974743;1095.052779345864;1095.3209010413516;1096.8793432722393;793.131520984521;798.3652995868299;798.5208874675207;800.0479429478902;802.1176705623767;15718;17238.569035774206;17923.3726819562;18136.365227217117;18153.7276940846;19666.311679091163;19937.30219442327;20398.082086306153;20406.795932040786;20577.176912923464;16154.676906461806;16302.429414970418;16603.584910377336;16607.252673629715;16635.750463743054;3516.4901089342156;3565.5721313442295;3565.732570057256;3568.946465803015;3579.713622910161;121206.39396803048;121274.39362803218;125289;126845;128502;15125.54623361301;15278.694426111639;15310.311036003406;15385.307661155275;15426.228688565527;30328.696713033027;30908.072757817303;31037.224069398446;31058.689413106033;31107.68892311048;7179.389751871149;7548.131964824115;8035.276825085653;8382.036065852382;8495.447795893248;3502.194495266103;3796.240751849641;3938.054866831997;3943.6056394360335;3955;5178.249153872667;5205.45342739007;5310.946890531122;5321.122014867504;5326.6537675050995;1038.948052597367;1041.598984391015;1043.3948309980344;1052.8526006359116;1054.8259537176434;649.7465988264486;667.4927055437902;695.5166159519085;701.4633805139073;707.7027648387586;10776.010157592022;11309.660710178709;11474.378812231178;11658.53365865356;11693.824592631117;646.890028695123;678.8811957907445;690.2890023276034;696.4289282788167;699.0667458942369;4650.837220697327;4818.156822556039;4887.413510378707;4909.582685471703;4997.150484417658;104398;105652.47173764082;107377.4631126855;108809;111673.44163279132;86512;91912.54043729739;92439.5378023119;93125.60311595332;97012;73627.63186184142;78339.21660783433;80552.59723701462;82127.58936205281;82190;11008.834867476835;11034.337939723642;11179.714332851501;11651.592194273499;11673;35512.644873551966;35964.10089747777;35972.82013589915;37187.25625487529;38603.61396386113;44286;45182;45279.32081018853;45867.77066114648;46388.76805616085;17550.73673894867;17689.646207076043;17993.920364778154;18028.54928626795;18138.365157219436;19271.22915083381;19707;19768.604627907647;19807.306744264457;19828.40514784501;17551.122443878012;17914.372996945043;17954.281828726704;18183.18175682071;18218.544536386697;17489.212985415434;17496.125193740518;17685.64628707393;17869.73195402044;17902.731459028386;17082.743758843877;17139.228734707216;17379.131043447524;17418.30326786914;17503.562410939827;12075.879241207827;12816.935915320364;13364.198148111145;13791.724165516433;13915.58253252404;13884.236366999912;14324.355404007054;14395.85604143987;14442.277886105863;14727.55817325482 03:25:43 INFO - PID 3651 | __end_tp_report 03:25:43 INFO - PID 3651 | __start_cc_report 03:25:43 INFO - PID 3651 | _x_x_mozilla_cycle_collect,406 03:25:43 INFO - PID 3651 | __end_cc_report 03:25:43 INFO - PID 3651 | __startTimestamp1500805542985__endTimestamp 03:25:43 INFO - PID 3651 | 03:25:43 INFO - PID 3651 | ------- Summary: start ------- 03:25:43 INFO - PID 3651 | Number of tests: 6 03:25:43 INFO - PID 3651 | 03:25:43 INFO - PID 3651 | [#0] dojo.html Cycles:165 Average:6107.45 Median:6388.14 stddev:720.25 (11.3%) stddev-sans-first:682.56 03:25:43 INFO - PID 3651 | Values: 3093.7 3132.0 3178.0 3192.4 3202.2 6029.9 6041.2 6176.9 6218.2 6232.5 6156.5 6170.2 6198.7 6272.0 6280.1 5429.3 5605.2 5678.3 5719.9 5736.5 5588.8 5602.4 5626.1 5710.4 5725.1 5637.4 5701.0 5701.9 5703.0 5728.0 5569.9 5638.5 5661.0 5726.6 5729.3 5565.0 5581.8 5651.2 5660.2 5683.2 6101.3 6101.9 6176.2 6183.0 6239.1 6407.9 6663.9 6671.4 6684.9 6689.8 6606.7 6611.2 6701.6 6744.4 6770.5 6144.6 6154.5 6199.8 6219.6 6254.2 6706.0 6798.8 6817.0 6875.5 6910.4 6424.0 6426.5 6427.8 6464.6 6548.1 6660.3 6680.0 6682.2 6686.6 6691.2 6541.9 6550.4 6570.2 6583.0 6633.2 6503.5 6576.8 6596.2 6689.0 6692.2 5267.8 5269.8 5278.0 5287.3 5354.7 4562.2 4586.3 4683.3 4686.0 4719.2 5718.7 5738.1 5801.6 5805.0 5817.8 6508.9 6607.9 6689.3 6760.8 6768.3 5607.2 5693.4 5696.2 5698.7 5706.5 5796.9 5871.6 5878.9 5887.4 5896.5 6400.9 6412.6 6416.0 6434.8 6506.8 6517.6 6612.9 6646.4 6732.3 6743.8 6388.1 6470.3 6480.3 6485.2 6504.9 6472.4 6475.9 6572.0 6577.6 6583.4 6576.4 6669.8 6672.2 6683.6 6761.8 6488.5 6536.1 6556.8 6563.6 6566.0 6464.2 6485.9 6514.9 6557.0 6592.9 6314.8 6378.8 6387.8 6401.2 6407.1 6376.7 6435.0 6538.0 6541.4 6541.4 6264.2 6282.2 6294.2 6395.2 6407.2 03:25:43 INFO - PID 3651 | 03:25:43 INFO - PID 3651 | [#1] ext.html Cycles:180 Average:38391.27 Median:37498.12 stddev:54370.98 (145.0%) stddev-sans-first:54450.22 03:25:43 INFO - PID 3651 | Values: 795.3 849.3 864.9 888.1 899.3 41248.8 41764.0 41988.2 42001.6 42002.0 37613.4 37981.4 37995.8 38084.0 38175.0 6786.7 6879.9 6900.2 6902.5 6913.6 6766.0 6849.0 6859.5 6862.2 6866.7 6801.3 7247.7 7498.2 7498.3 7503.2 7410.1 7437.4 7440.9 7444.4 7470.6 7228.9 7330.8 7426.9 7429.1 7430.7 38483.6 38620.0 38641.8 38827.2 38859.2 3472.8 3486.6 3540.7 3544.1 3544.2 30429.1 30443.8 30718.8 30723.2 30824.7 4747.8 4868.9 4871.6 4909.4 4977.8 184253.0 184519.0 184908.0 187184.0 195941.0 47504.3 47532.5 47881.3 48058.5 48110.8 50479.5 50549.0 50713.5 51049.7 51097.0 14686.9 14741.9 14752.4 14839.5 14934.8 11842.3 12013.1 12059.1 12075.1 12288.0 14153.7 14210.1 14211.0 14215.5 14356.7 5659.4 5717.6 5724.5 5818.5 5837.6 963.3 978.3 983.5 1007.2 1013.9 22325.9 22356.9 22622.0 22875.9 23184.2 1061.1 1090.1 1102.0 1111.4 1118.1 11378.3 11968.9 12327.9 16007.2 16230.4 214325.0 230478.0 230758.0 230782.0 230881.0 56576.7 56671.4 56942.7 57415.0 57553.4 1431.2 1455.9 1461.8 1466.5 1472.0 26086.5 26883.5 27144.7 27337.0 27489.0 50979.5 51181.7 51506.2 51553.0 51701.5 210051.0 210073.0 211205.0 212107.0 213012.0 35095.3 37493.0 37923.0 38123.6 38125.8 46874.3 47258.8 47278.5 47311.3 47375.3 28554.1 28744.1 28778.9 29202.7 29290.6 33435.3 33466.3 33543.5 33687.0 33787.2 36866.0 37472.8 37503.2 37782.2 38081.2 31245.5 32135.5 32508.3 33341.7 33581.0 23693.9 23725.8 23736.8 24266.4 24661.0 03:25:43 INFO - PID 3651 | 03:25:43 INFO - PID 3651 | [#2] jquery.html Cycles:180 Average:35419.72 Median:23694.26 stddev:85505.28 (360.9%) stddev-sans-first:85705.11 03:25:43 INFO - PID 3651 | Values: 570.4 570.4 576.4 577.7 586.8 22140.0 22473.0 22917.9 22939.3 22970.1 25853.2 26655.2 26678.7 26787.9 26844.9 6478.4 6567.9 6609.2 6622.2 6662.3 5828.4 6368.5 6386.1 6417.8 6541.2 6335.8 6338.3 6345.0 6348.1 6348.2 6242.4 6254.1 6268.8 6308.1 6308.6 5793.4 5800.5 5848.2 5887.5 5930.2 29256.7 29538.0 30046.8 30256.1 30630.0 1822.7 1868.8 1870.2 1870.8 1874.3 18259.7 18847.8 18860.4 18879.7 18882.4 2316.6 2367.6 2419.0 2420.8 2421.1 131870.3 134652.0 134698.3 134833.0 135235.0 14107.4 15064.5 15215.5 15270.7 15501.9 22611.5 24100.5 24101.3 24122.5 24157.0 9534.8 9541.5 9660.9 9741.9 9829.7 8562.0 8572.8 8589.4 8702.9 8754.4 9225.8 9529.2 9611.9 9645.9 9688.1 2846.3 2870.8 2887.4 2898.9 2930.8 937.2 943.4 965.3 996.5 1006.7 19572.8 19596.4 23702.9 25087.7 25271.0 1003.6 1019.9 1020.8 1049.3 1055.8 10790.9 11044.6 11077.1 11468.5 11533.8 497916.0 501802.0 506133.0 508594.0 530787.0 117405.0 118751.0 119608.4 122809.0 123415.4 1231.3 1261.2 1289.9 1296.9 1298.2 16901.4 17355.7 17840.6 17846.6 18354.9 56778.7 57105.4 57115.7 57269.1 59813.7 68340.7 68794.0 68979.7 69406.7 69617.3 14619.3 15020.0 15040.2 15094.5 15112.7 23008.3 23261.7 23382.9 23492.3 23685.6 18311.9 18520.6 18946.2 18982.2 19047.0 14825.6 16020.7 16468.5 16618.1 16958.6 18048.2 18877.6 19018.4 19067.0 19170.4 14435.4 14804.7 14837.1 15257.5 15350.7 19160.7 19172.6 19208.3 19232.9 19370.4 03:25:43 INFO - PID 3651 | 03:25:43 INFO - PID 3651 | [#3] mootools.html Cycles:180 Average:8573.58 Median:2509.05 stddev:5795.78 (231.0%) stddev-sans-first:5786.74 03:25:43 INFO - PID 3651 | Values: 1367.9 1398.0 1406.2 1415.3 1430.7 13062.9 13257.9 13824.3 13837.8 13889.8 14199.6 14367.9 14442.9 14452.4 14477.5 2620.0 2673.5 2674.4 2679.3 2679.7 2515.4 2541.8 2605.7 2662.4 2691.1 2629.4 2644.9 2661.9 2664.1 2666.1 2491.1 2508.9 2509.2 2518.8 2574.4 2402.1 2522.8 2536.5 2552.2 2557.5 13716.7 13790.4 13840.2 13855.9 13868.5 7100.5 7490.8 7519.2 7530.4 7551.1 5005.6 5056.1 5128.7 5228.2 5238.9 1867.7 1878.7 1914.3 1948.3 1958.8 21895.6 22135.2 22160.3 22195.1 22229.2 6254.9 6486.7 6491.4 6630.6 6647.7 14327.7 14353.9 14381.7 14419.7 14420.4 7060.2 7289.4 7368.8 7421.8 7424.4 6103.0 6760.4 6760.9 6795.4 6847.7 4772.9 4832.2 4872.3 4959.1 4966.9 1267.4 1331.7 1381.9 1385.2 1407.8 886.1 894.3 905.0 911.2 929.2 8526.1 8606.7 8674.9 8680.6 8741.3 996.4 1020.6 1022.4 1029.1 1032.2 4506.2 4641.7 4927.2 5183.1 5235.4 17775.6 19408.4 19542.2 19565.6 19588.0 17434.2 19050.1 19322.3 19720.7 19739.3 10559.6 10688.4 10726.3 10752.7 10756.8 7313.3 8128.3 8264.9 8284.9 8286.0 16159.0 16322.3 16816.7 16834.3 17088.6 17149.6 17403.3 17451.9 17468.6 17506.6 10695.8 10994.1 11056.1 11059.6 11077.7 11830.9 12766.7 12847.6 12953.5 12956.3 10302.4 10412.3 10527.4 10563.5 10731.1 9944.1 10419.7 10543.9 10697.4 10775.3 9092.6 9309.0 9316.8 9336.5 9353.3 6879.0 7273.6 7321.9 7407.4 7459.1 6999.6 7064.3 7164.1 7224.3 7285.8 03:25:43 INFO - PID 3651 | 03:25:43 INFO - PID 3651 | [#4] prototype.html Cycles:180 Average:5429.76 Median:6041.87 stddev:1542.76 (25.5%) stddev-sans-first:1501.92 03:25:43 INFO - PID 3651 | Values: 492.6 494.7 495.1 523.7 525.1 6045.6 6186.5 6187.4 6219.7 6295.5 5977.5 6013.6 6038.1 6091.0 6138.4 4767.5 4853.1 4857.6 4871.3 4876.2 4791.0 4793.5 4808.3 4812.4 4883.7 4787.4 4805.5 4810.7 4850.7 4897.8 4758.6 4797.7 4823.5 4839.4 4856.2 4365.8 4366.3 4409.5 4414.0 4421.4 6009.9 6018.5 6032.7 6060.2 6067.3 5487.1 5544.3 5590.7 5597.7 5664.5 6418.3 6448.0 6470.3 6473.4 6505.7 4759.3 4762.0 4800.4 4802.7 4840.3 6796.7 6844.9 6874.8 6899.7 6900.2 4822.9 4928.2 4957.7 4959.7 4967.8 4974.6 5006.6 5008.2 5049.4 5054.1 5414.9 5496.2 5545.8 5550.5 5607.2 6455.1 6497.0 6497.5 6549.2 6578.9 1614.1 1664.4 1666.3 1671.5 1728.0 1179.3 1182.9 1213.9 1219.8 1221.3 5516.7 5547.3 5629.9 5633.3 5652.6 6382.7 6485.0 6521.0 6555.3 6668.3 5656.4 5662.3 5690.2 5714.2 5742.7 3482.5 3518.9 3531.4 3566.3 3586.6 6409.2 6429.5 6519.5 6527.5 6592.9 6812.6 6823.2 6870.5 6916.5 6932.7 6461.4 6499.4 6508.0 6533.9 6535.2 6717.4 6730.4 6733.1 6745.2 6784.1 6578.7 6590.9 6652.5 6670.3 6706.9 6361.2 6403.8 6429.8 6488.5 6513.3 4783.3 4815.4 4819.6 4826.3 4863.7 6385.3 6626.7 6632.3 6669.9 6717.4 6224.7 6244.9 6366.3 6388.0 6430.1 6365.0 6402.1 6464.5 6464.8 6467.0 6267.4 6340.8 6352.9 6398.3 6428.4 6438.9 6446.7 6503.4 6534.3 6554.7 6279.6 6308.9 6356.1 6379.7 6391.0 03:25:43 INFO - PID 3651 | 03:25:43 INFO - PID 3651 | [#5] yui.html Cycles:180 Average:22202.02 Median:18735.44 stddev:30337.91 (161.9%) stddev-sans-first:30380.85 03:25:43 INFO - PID 3651 | Values: 901.4 909.9 910.9 911.3 932.5 17810.5 18709.3 18729.7 18741.2 20013.3 19557.9 19589.5 19713.6 19846.0 20187.9 969.6 1045.2 1052.3 1052.4 1053.9 985.6 1060.0 1061.1 1068.2 1069.7 1085.4 1097.5 1099.1 1099.1 1100.7 1078.9 1092.2 1095.1 1095.3 1096.9 793.1 798.4 798.5 800.0 802.1 15718.0 17238.6 17923.4 18136.4 18153.7 19666.3 19937.3 20398.1 20406.8 20577.2 16154.7 16302.4 16603.6 16607.3 16635.8 3516.5 3565.6 3565.7 3568.9 3579.7 121206.4 121274.4 125289.0 126845.0 128502.0 15125.5 15278.7 15310.3 15385.3 15426.2 30328.7 30908.1 31037.2 31058.7 31107.7 7179.4 7548.1 8035.3 8382.0 8495.4 3502.2 3796.2 3938.1 3943.6 3955.0 5178.2 5205.5 5310.9 5321.1 5326.7 1038.9 1041.6 1043.4 1052.9 1054.8 649.7 667.5 695.5 701.5 707.7 10776.0 11309.7 11474.4 11658.5 11693.8 646.9 678.9 690.3 696.4 699.1 4650.8 4818.2 4887.4 4909.6 4997.2 104398.0 105652.5 107377.5 108809.0 111673.4 86512.0 91912.5 92439.5 93125.6 97012.0 73627.6 78339.2 80552.6 82127.6 82190.0 11008.8 11034.3 11179.7 11651.6 11673.0 35512.6 35964.1 35972.8 37187.3 38603.6 44286.0 45182.0 45279.3 45867.8 46388.8 17550.7 17689.6 17993.9 18028.5 18138.4 19271.2 19707.0 19768.6 19807.3 19828.4 17551.1 17914.4 17954.3 18183.2 18218.5 17489.2 17496.1 17685.6 17869.7 17902.7 17082.7 17139.2 17379.1 17418.3 17503.6 12075.9 12816.9 13364.2 13791.7 13915.6 13884.2 14324.4 14395.9 14442.3 14727.6 03:25:43 INFO - PID 3651 | -------- Summary: end -------- 03:25:43 INFO - PID 3651 | 03:25:43 INFO - TEST-INFO | 3651: exit 0 03:25:43 INFO - TEST-OK | dromaeo_css | took 1114524ms 03:25:43 INFO - TEST-START | kraken 03:25:43 INFO - Initialising browser for kraken test... 03:25:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36488/getInfo.html -profile /tmp/tmpLOdFXo/profile 03:25:43 INFO - TEST-INFO | started process 4009 (/builds/slave/test/build/application/firefox/firefox http://localhost:36488/getInfo.html) 03:25:50 INFO - TEST-INFO | 4009: exit 0 03:25:50 INFO - Browser initialized. 03:25:50 INFO - Running cycle 1/1 for kraken test... 03:25:50 INFO - TEST-INFO | started process 4219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLOdFXo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:01 INFO - PID 4219 | RSS: Main: 174960640 03:26:01 INFO - PID 4219 | 03:26:04 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36488/tests/kraken/driver.html?testName=audio-beat-detection) 03:26:05 INFO - PID 4219 | RSS: Main: 179322880 03:26:05 INFO - PID 4219 | 03:26:07 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36488/tests/kraken/driver.html?testName=audio-dft) 03:26:08 INFO - PID 4219 | RSS: Main: 179621888 03:26:08 INFO - PID 4219 | 03:26:11 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36488/tests/kraken/driver.html?testName=audio-fft) 03:26:12 INFO - PID 4219 | RSS: Main: 173662208 03:26:12 INFO - PID 4219 | 03:26:14 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36488/tests/kraken/driver.html?testName=audio-oscillator) 03:26:14 INFO - PID 4219 | RSS: Main: 174489600 03:26:14 INFO - PID 4219 | 03:26:16 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:26:17 INFO - PID 4219 | RSS: Main: 174436352 03:26:17 INFO - PID 4219 | 03:26:20 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36488/tests/kraken/driver.html?testName=imaging-darkroom) 03:26:21 INFO - PID 4219 | RSS: Main: 176672768 03:26:21 INFO - PID 4219 | 03:26:24 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36488/tests/kraken/driver.html?testName=imaging-desaturate) 03:26:25 INFO - PID 4219 | RSS: Main: 177401856 03:26:25 INFO - PID 4219 | 03:26:28 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36488/tests/kraken/driver.html?testName=json-parse-financial) 03:26:28 INFO - PID 4219 | RSS: Main: 177930240 03:26:28 INFO - PID 4219 | 03:26:30 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:26:31 INFO - PID 4219 | RSS: Main: 177729536 03:26:31 INFO - PID 4219 | 03:26:32 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36488/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:26:33 INFO - PID 4219 | RSS: Main: 177639424 03:26:33 INFO - PID 4219 | 03:26:35 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:26:36 INFO - PID 4219 | RSS: Main: 177967104 03:26:36 INFO - PID 4219 | 03:26:38 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:26:39 INFO - PID 4219 | RSS: Main: 178302976 03:26:39 INFO - PID 4219 | 03:26:42 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:26:43 INFO - PID 4219 | RSS: Main: 178417664 03:26:43 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:36488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36488/tests/kraken/driver.html?testName=ai-astar) 03:26:45 INFO - PID 4219 | RSS: Main: 179847168 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | __start_tp_report 03:26:45 INFO - PID 4219 | _x_x_mozilla_page_load 03:26:45 INFO - PID 4219 | _x_x_mozilla_page_load_details 03:26:45 INFO - PID 4219 | |i|pagename|runs| 03:26:45 INFO - PID 4219 | |0;ai-astar;101;109;101;111;110;111;113;102;111;111 03:26:45 INFO - PID 4219 | |1;audio-beat-detection;151;120;149;180;120;146;153;129;179;121 03:26:45 INFO - PID 4219 | |2;audio-dft;163;162;162;164;165;162;167;165;162;163 03:26:45 INFO - PID 4219 | |3;audio-fft;77;75;78;182;78;75;75;76;165;77 03:26:45 INFO - PID 4219 | |4;audio-oscillator;81;81;131;81;81;80;133;81;81;128 03:26:45 INFO - PID 4219 | |5;imaging-gaussian-blur;115;114;114;115;114;115;114;114;114;114 03:26:45 INFO - PID 4219 | |6;imaging-darkroom;152;151;152;153;151;151;152;153;152;151 03:26:45 INFO - PID 4219 | |7;imaging-desaturate;94;95;94;94;95;95;94;100;93;94 03:26:45 INFO - PID 4219 | |8;json-parse-financial;65;53;54;55;54;54;54;54;53;54 03:26:45 INFO - PID 4219 | |9;json-stringify-tinderbox;55;54;55;55;54;55;54;55;55;56 03:26:45 INFO - PID 4219 | |10;stanford-crypto-aes;79;80;85;78;77;77;77;78;79;78 03:26:45 INFO - PID 4219 | |11;stanford-crypto-ccm;134;129;137;126;128;124;126;126;123;163 03:26:45 INFO - PID 4219 | |12;stanford-crypto-pbkdf2;177;182;187;178;178;181;180;180;181;181 03:26:45 INFO - PID 4219 | |13;stanford-crypto-sha256-iterative;69;70;72;71;71;67;67;75;70;67 03:26:45 INFO - PID 4219 | __end_tp_report 03:26:45 INFO - PID 4219 | __start_cc_report 03:26:45 INFO - PID 4219 | _x_x_mozilla_cycle_collect,992 03:26:45 INFO - PID 4219 | __end_cc_report 03:26:45 INFO - PID 4219 | __startTimestamp1500805605541__endTimestamp 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | ------- Summary: start ------- 03:26:45 INFO - PID 4219 | Number of tests: 14 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#0] ai-astar Cycles:10 Average:108.00 Median:111.00 stddev:4.71 (4.2%) stddev-sans-first:4.27 03:26:45 INFO - PID 4219 | Values: 101.0 109.0 101.0 111.0 110.0 111.0 113.0 102.0 111.0 111.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:150.00 stddev:22.56 (15.0%) stddev-sans-first:23.81 03:26:45 INFO - PID 4219 | Values: 151.0 120.0 149.0 180.0 120.0 146.0 153.0 129.0 179.0 121.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:1.72 (1.0%) stddev-sans-first:1.81 03:26:45 INFO - PID 4219 | Values: 163.0 162.0 162.0 164.0 165.0 162.0 167.0 165.0 162.0 163.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#3] audio-fft Cycles:10 Average:95.80 Median:76.50 stddev:41.16 (53.8%) stddev-sans-first:43.09 03:26:45 INFO - PID 4219 | Values: 77.0 75.0 78.0 182.0 78.0 75.0 75.0 76.0 165.0 77.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:81.00 stddev:24.09 (29.7%) stddev-sans-first:24.95 03:26:45 INFO - PID 4219 | Values: 81.0 81.0 131.0 81.0 81.0 80.0 133.0 81.0 81.0 128.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 03:26:45 INFO - PID 4219 | Values: 115.0 114.0 114.0 115.0 114.0 115.0 114.0 114.0 114.0 114.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:152.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:26:45 INFO - PID 4219 | Values: 152.0 151.0 152.0 153.0 151.0 151.0 152.0 153.0 152.0 151.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:1.93 (2.1%) stddev-sans-first:2.03 03:26:45 INFO - PID 4219 | Values: 94.0 95.0 94.0 94.0 95.0 95.0 94.0 100.0 93.0 94.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.00 stddev:3.56 (6.6%) stddev-sans-first:0.60 03:26:45 INFO - PID 4219 | Values: 65.0 53.0 54.0 55.0 54.0 54.0 54.0 54.0 53.0 54.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 03:26:45 INFO - PID 4219 | Values: 55.0 54.0 55.0 55.0 54.0 55.0 54.0 55.0 55.0 56.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.50 stddev:2.39 (3.1%) stddev-sans-first:2.54 03:26:45 INFO - PID 4219 | Values: 79.0 80.0 85.0 78.0 77.0 77.0 77.0 78.0 79.0 78.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:128.50 stddev:11.86 (9.2%) stddev-sans-first:12.55 03:26:45 INFO - PID 4219 | Values: 134.0 129.0 137.0 126.0 128.0 124.0 126.0 126.0 123.0 163.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:181.00 stddev:2.80 (1.5%) stddev-sans-first:2.67 03:26:45 INFO - PID 4219 | Values: 177.0 182.0 187.0 178.0 178.0 181.0 180.0 180.0 181.0 181.0 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.50 stddev:2.56 (3.6%) stddev-sans-first:2.69 03:26:45 INFO - PID 4219 | Values: 69.0 70.0 72.0 71.0 71.0 67.0 67.0 75.0 70.0 67.0 03:26:45 INFO - PID 4219 | -------- Summary: end -------- 03:26:45 INFO - PID 4219 | 03:26:45 INFO - PID 4219 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:26:46 INFO - TEST-INFO | 4219: exit 0 03:26:46 INFO - TEST-OK | kraken | took 62625ms 03:26:46 INFO - SUITE-END | took 1177s 03:26:46 INFO - Completed test suite (00:19:37) 03:26:46 INFO - javascript benchmark 03:26:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8376.179177132304, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.73703235225, 3131.9686803131967, 3178.046586024192, 3192.425363434581, 3202.1674364665196, 6029.909551356728, 6041.184440100591, 6176.907346389808, 6218.191635087438, 6232.5013998880095, 6156.507479401648, 6170.228721409824, 6198.72105755241, 6272.0, 6280.120783090371, 5429.321334833146, 5605.159226116095, 5678.26182596264, 5719.857003574913, 5736.541076713874, 5588.832335029955, 5602.355729091146, 5626.099824028156, 5710.371859095496, 5725.083986562151, 5637.408072152406, 5701.0308247598, 5701.857453563653, 5702.971485142589, 5728.0, 5569.8607534811545, 5638.492535671769, 5660.971695141539, 5726.599138060295, 5729.28383952006, 5564.970480461087, 5581.776728930838, 5651.237082993825, 5660.179274005287, 5683.232763576905, 6101.328853826076, 6101.877962440771, 6176.197094377747, 6182.969085154546, 6239.095331176999, 6407.903881441782, 6663.9333606663795, 6671.366220209121, 6684.933150668479, 6689.765858194988, 6606.735730570771, 6611.239707433659, 6701.564398314094, 6744.426723728489, 6770.492213084039, 6144.569880108439, 6154.476869466101, 6199.814005579839, 6219.569499015207, 6254.155688981929, 6706.0, 6798.76204332846, 6817.01153332764, 6875.48433867462, 6910.378065974087, 6424.036394540856, 6426.485881129498, 6427.807165785034, 6464.579802312929, 6548.083268342436, 6660.333966603301, 6680.0, 6682.164729408824, 6686.632235227012, 6691.1636045494315, 6541.934580654228, 6550.377714117151, 6570.244421891448, 6582.96708516464, 6633.170853643294, 6503.479721622259, 6576.76981305652, 6596.175478065242, 6688.966555167291, 6692.196936367667, 5267.789288428497, 5269.762860671279, 5278.049951008778, 5287.2597836302175, 5354.705491197944, 4562.201614717411, 4586.289125185602, 4683.297505374221, 4685.953140468551, 4719.197736384823, 5718.7426565804635, 5738.11059285803, 5801.622894511843, 5805.042168042311, 5817.825465236049, 6508.934910650928, 6607.867842643216, 6689.264180940093, 6760.830979225559, 6768.323167683291, 5607.186957891083, 5693.4021927696995, 5696.23100881384, 5698.686572238566, 5706.514946229534, 5796.942030579725, 5871.55963302754, 5878.882422351529, 5887.411258874164, 5896.528277737771, 6400.935990640034, 6412.647304398303, 6416.0, 6434.774782882577, 6506.837329066717, 6517.576357536745, 6612.933870661232, 6646.368594983469, 6732.3267673232285, 6743.763968261087, 6388.1376014237485, 6470.288268290578, 6480.287168411565, 6485.221773387035, 6504.934950650622, 6472.385123413268, 6475.902861456988, 6572.047053177167, 6577.6053436793945, 6583.374579414948, 6576.375244351779, 6669.833254168685, 6672.232693240339, 6683.598984060972, 6761.797146085625, 6488.480921526361, 6536.117624120873, 6556.770513032021, 6563.638999855054, 6566.0, 6464.191976003, 6485.902711459237, 6514.902276465951, 6557.0, 6592.868142637025, 6314.84212894663, 6378.840528986812, 6387.776427825004, 6401.231852177769, 6407.0709747085475, 6376.713047912763, 6435.03474478832, 6538.0, 6541.378569035934, 6541.378569035934, 6264.154339164154, 6282.246130464374, 6294.213223347082, 6395.232572091379, 6407.199100112486], "value": 6053.850163461313, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.339867909635, 849.2908421468073, 864.948103113813, 888.0542222533004, 899.3210126354601, 41248.79375603121, 41764.0, 41988.160236795244, 42001.57998420015, 42002.0, 37613.43579846305, 37981.43027854584, 37995.810020949924, 38084.0, 38175.0, 6786.694598743068, 6879.89680154798, 6900.20647625522, 6902.482313826458, 6913.585184888898, 6766.0, 6848.965755171242, 6859.519833611649, 6862.210845752727, 6866.690998905036, 6801.251862295168, 7247.7100915963565, 7498.212687667771, 7498.325150736433, 7503.174650788409, 7410.073740782403, 7437.442191835634, 7440.851182976365, 7444.36722878556, 7470.626468676572, 7228.8554228915655, 7330.780076597711, 7426.925730742678, 7429.07136607924, 7430.665620047111, 38483.615163848284, 38620.0, 38641.806790965864, 38827.22345553073, 38859.22281554381, 3472.791632502058, 3486.564179477565, 3540.6990405815277, 3544.113971507123, 3544.167120726627, 30429.087127386214, 30443.847780761174, 30718.84640576805, 30723.231919201975, 30824.691753082632, 4747.7626118693925, 4868.902621947541, 4871.634627402959, 4909.361782968192, 4977.776000079969, 184253.0, 184519.0, 184908.0, 187184.0, 195941.02029489903, 47504.28743568849, 47532.52467475281, 47881.281780773315, 48058.519414806105, 48110.759446202544, 50479.49520504822, 50549.0, 50713.49286507162, 51049.74475127675, 51097.0, 14686.92656536732, 14741.92629036848, 14752.40990360395, 14839.480618178311, 14934.775978360334, 11842.28946263227, 12013.099017573542, 12059.095567832272, 12075.09436792244, 12288.0, 14153.726164645026, 14210.147391156564, 14211.005229633827, 14215.507371726027, 14356.712865742627, 5659.377468478464, 5717.599768016282, 5724.484796368263, 5818.4763371296785, 5837.620554663933, 963.349738926222, 978.2907392140784, 983.537737263485, 1007.1942446043137, 1013.8834034086175, 22325.888370558045, 22356.888215558818, 22622.0, 22875.885620572124, 23184.18855340055, 1061.129658915632, 1090.1224514265934, 1101.9504122314515, 1111.4387234446554, 1118.0887576625187, 11378.260413073123, 11968.940155299168, 12327.93836030832, 16007.199640017952, 16230.431934882223, 214325.0, 230478.0, 230758.0, 230782.0, 230881.0, 56576.717116414155, 56671.433285666615, 56942.7152864233, 57415.0, 57553.42446575564, 1431.2485944879022, 1455.9344829482698, 1461.817272840895, 1466.4720700547794, 1471.9852801471848, 26086.478270434105, 26883.462330753668, 27144.72855271501, 27337.0, 27488.976212616995, 50979.49020509747, 51181.7440912793, 51506.22740658968, 51553.0, 51701.48298516967, 210051.0, 210073.0, 211205.0, 212107.0, 213012.0, 35095.29809403849, 37493.0, 37923.0, 38123.618763813116, 38125.80937095297, 46874.296885546064, 47258.76370618125, 47278.52721472879, 47311.29033064438, 47375.28937065878, 28554.14337569793, 28744.13767586976, 28778.856105719336, 29202.70797292085, 29290.56064159082, 33435.33129337448, 33466.33067338688, 33543.496847547794, 33687.0, 33787.15532111717, 36866.0, 37472.81263593664, 37503.249935001695, 37782.2443551133, 38081.238375231784, 31245.531317030716, 32135.51796723098, 32508.349833002736, 33341.666583333856, 33581.0, 23693.881530592236, 23725.762742372357, 23736.762632373455, 24266.393340166636, 24661.0], "value": 17234.792506615355, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.3640440908389, 570.4295704295704, 576.3544829790635, 577.7082573300482, 586.7858231745414, 22140.0, 22473.0, 22917.885410572966, 22939.311820645366, 22970.08119675213, 25853.224403267934, 26655.20034398966, 26678.733212667867, 26787.86606066967, 26844.865775671144, 6478.416942475164, 6567.901481477782, 6609.173853268341, 6622.1722284714415, 6662.333766623323, 5828.358880523139, 6368.4905207583515, 6386.10594516768, 6417.8395540111405, 6541.247756507991, 6335.841603959915, 6338.30278669346, 6344.968275158641, 6348.111264422984, 6348.206474190726, 6242.375762423767, 6254.093156492306, 6268.811935641916, 6308.116863639094, 6308.621482711052, 5793.362730099686, 5800.477956983892, 5848.239728835267, 5887.528997680175, 5930.169776231331, 29256.70743292561, 29538.0, 30046.84976575125, 30256.09231723052, 30630.0, 1822.7448157257995, 1868.841148502379, 1870.1958157992058, 1870.7568016157948, 1874.2784028149124, 18259.726104108315, 18847.81152188488, 18860.434186974413, 18879.716804247946, 18882.433526994075, 2316.6061769499056, 2367.597508423572, 2418.9516209675885, 2420.7579242075826, 2421.055788242587, 131870.3406482971, 134652.0, 134698.32650836682, 134833.0, 135235.0, 14107.435702571987, 15064.548063558112, 15215.467458638894, 15270.694586108215, 15501.922490387477, 22611.547769044526, 24100.51798964011, 24101.276961691176, 24122.51754964891, 24157.033718651408, 9534.761630959281, 9541.52292385378, 9660.855087173557, 9741.9025809741, 9829.655962041294, 8562.0, 8572.828543429096, 8589.398742087993, 8702.869456958151, 8754.387192896436, 9225.769355766026, 9529.237660987243, 9611.855822162674, 9645.9035409645, 9688.07632908673, 2846.2599724071893, 2870.7559857411934, 2887.422515496909, 2898.8985385511405, 2930.794844360917, 937.1706040154512, 943.3726571829657, 965.3435663748578, 996.5017491254373, 1006.6828948881079, 19572.804271957382, 19596.412107636792, 23702.88148559246, 25087.74912250854, 25271.0, 1003.5684655598017, 1019.8572199892021, 1020.8009438159488, 1049.3441599000626, 1055.767731099157, 10790.89209107899, 11044.613438529774, 11077.11383089351, 11468.4839182237, 11533.769324613628, 497916.0, 501802.0, 506133.0, 508594.0, 530787.0, 117405.0, 118751.0, 119608.40195798966, 122809.0, 123415.38292308661, 1231.2673958994385, 1261.2306493039239, 1289.9032572557096, 1296.857345691973, 1298.1691717300935, 16901.408450704166, 17355.7396639048, 17840.55398615045, 17846.553836153682, 18354.90822545879, 56778.716106420856, 57105.428945711676, 57115.714421429286, 57269.14096288642, 59813.70093149506, 68340.65829670819, 68794.0, 68979.65510172417, 69406.65296673484, 69617.3038269631, 14619.342129604405, 15020.0, 15040.17279049619, 15094.54716358511, 15112.697746045238, 23008.309750707507, 23261.651075234222, 23382.883085584464, 23492.295231143093, 23685.64471532963, 18311.908440458246, 18520.60363596468, 18946.242150314385, 18982.240710371432, 19047.0, 14825.550396013286, 16020.67958640844, 16468.505944821674, 16618.086005269826, 16958.576035598715, 18048.187831547875, 18877.622447551246, 19018.42944711661, 19067.0, 19170.424887253404, 14435.35040923182, 14804.703905921606, 14837.109773413198, 15257.465988690787, 15350.692986140439, 19160.71258931145, 19172.616547669248, 19208.327708530134, 19232.903835480734, 19370.4188874334], "value": 12016.070931835276, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.8905687544998, 1398.0, 1406.2406300597677, 1415.299426783742, 1430.670945682493, 13062.93468532656, 13257.867421325784, 13824.308784560782, 13837.792433113498, 13889.791653125187, 14199.574012779607, 14367.928160359184, 14442.927785361058, 14452.421903123888, 14477.493287734931, 2619.9869000655017, 2673.4786716590274, 2674.398260391416, 2679.303381120903, 2679.745424184709, 2515.408878913454, 2541.7966562675033, 2605.671107735059, 2662.3876508403077, 2691.0581296546247, 2629.355807827085, 2644.93387665308, 2661.853598052116, 2664.134156399168, 2666.0535509894, 2491.0533997081084, 2508.8996440142373, 2509.1970569417795, 2518.8362756420865, 2574.407886186169, 2402.123225022854, 2522.848629082261, 2536.5053814506177, 2552.1705445730026, 2557.5268575313626, 13716.65708357289, 13790.448382064706, 13840.238786866717, 13855.930720346334, 13868.514601988882, 7100.502964792415, 7490.775276741707, 7519.172890981988, 7530.359919406857, 7551.056117985252, 5005.57452616528, 5056.064628043824, 5128.692278463267, 5228.241904923765, 5238.947610523884, 1867.6638205123209, 1878.6806242938733, 1914.2725764209652, 1948.3278268997315, 1958.8237058664647, 21895.562088758295, 22135.225267115733, 22160.335189944326, 22195.11219551216, 22229.22197723088, 6254.906176407358, 6486.740530378826, 6491.350864913566, 6630.569013014138, 6647.66761661915, 14327.713445731235, 14353.92823035878, 14381.712365752626, 14419.711605767827, 14420.351084201237, 7060.152781666233, 7289.380402665833, 7368.778936631909, 7421.8144546386775, 7424.368928641126, 6103.0, 6760.42536384403, 6760.932390676128, 6795.38841504267, 6847.657617119125, 4772.880677983078, 4832.178529649968, 4872.317875497433, 4959.132151873408, 4966.91389616362, 1267.353649638691, 1331.7203387288585, 1381.88944884409, 1385.1965859801292, 1407.7785731328884, 886.0740526150189, 894.338189739601, 904.9909500904906, 911.2436677557612, 929.2380248196414, 8526.147385261549, 8606.741797746077, 8674.913250867537, 8680.56597170139, 8741.256993155654, 996.3822430093388, 1020.5560581147224, 1022.4325499347784, 1029.1098200057047, 1032.230987914009, 4506.211413002777, 4641.698289611165, 4927.211646136672, 5183.0670479314085, 5235.377462034354, 17775.644487110185, 19408.417747467316, 19542.218311267676, 19565.608687826163, 19588.020598969993, 17434.215460304316, 19050.142743576573, 19322.32371866978, 19720.70418943717, 19739.309124180872, 10559.630412935665, 10688.358698478116, 10726.302790318605, 10752.677419677422, 10756.838647420294, 7313.341799238094, 8128.268455839003, 8264.917350826414, 8284.917150828414, 8286.04710458305, 16159.0, 16322.347106115622, 16816.747748784022, 16834.326626934784, 17088.57278568046, 17149.57126071858, 17403.30386784565, 17451.912740436215, 17468.563285917953, 17506.649867002845, 10695.786084278427, 10994.065504432212, 11056.11551075928, 11059.557617695202, 11077.667669969915, 11830.940845295718, 12766.744665106831, 12847.550335738204, 12953.481860725466, 12956.28740419286, 10302.433366164933, 10412.27114102036, 10527.368357898551, 10563.52464139131, 10731.087857532197, 9944.105030547285, 10419.687409377731, 10543.89456105429, 10697.358158510515, 10775.299605525615, 9092.59083341238, 9309.022552632146, 9316.767080823034, 9336.533173341442, 9353.251739860658, 6878.965605171942, 7273.636318184175, 7321.890171647536, 7407.370373518312, 7459.142198647008, 6999.580025198505, 7064.32888875556, 7164.068671072727, 7224.277572242734, 7285.7814265572115], "value": 6290.871973096563, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.556698970926, 494.68093079963427, 495.13351634639383, 523.6727045596502, 525.1387724132421, 6045.607035542686, 6186.536009799261, 6187.350328215534, 6219.693864288499, 6295.45034261125, 5977.52179825614, 6013.579049466539, 6038.124471951564, 6091.0, 6138.447539721425, 4767.451743049559, 4853.053654537367, 4857.562819346258, 4871.293662418947, 4876.244182151772, 4790.976045119787, 4793.544613261734, 4808.302796094564, 4812.350332705092, 4883.682560633548, 4787.40157480315, 4805.51029180955, 4810.663253572251, 4850.733209673466, 4897.779599917994, 4758.643101767347, 4797.712137271775, 4823.469418363977, 4839.395075615548, 4856.247281671346, 4365.781710914442, 4366.257736184856, 4409.470863496369, 4413.984783499781, 4421.358902959085, 6009.939900600982, 6018.548608854353, 6032.728527216286, 6060.2424696912885, 6067.302260240085, 5487.149491828773, 5544.3346798384455, 5590.748416321276, 5597.74810133545, 5664.54683625309, 6418.326075762071, 6448.0, 6470.288268290485, 6473.385028422293, 6505.739770409178, 4759.309900064472, 4761.952380476186, 4800.423949126127, 4802.711837289774, 4840.346553215341, 6796.728130874809, 6844.931550684529, 6874.772015210659, 6899.655017249067, 6900.171979362509, 4822.903541929142, 4928.162212423897, 4957.652964292537, 4959.7272150032095, 4967.801287948514, 4974.552290293891, 5006.624503162205, 5008.17365134756, 5049.419316778617, 5054.115529782273, 5414.891702166014, 5496.1755736639825, 5545.805896793593, 5550.47270509301, 5607.214989901417, 6455.095746754719, 6496.967515162394, 6497.512686548528, 6549.181352330958, 6578.868422631521, 1614.1041721844254, 1664.3758590528553, 1666.3251383189586, 1671.5319710480842, 1728.0, 1179.2511755035614, 1182.9467673954694, 1213.9028877689764, 1219.7804395208948, 1221.3465795799204, 5516.668999860021, 5547.306586676666, 5629.943700563023, 5633.3240011198095, 5652.576056795757, 6382.7129028550335, 6484.967575162094, 6520.967395163088, 6555.344465553407, 6668.299828517936, 5656.434356564393, 5662.2639056922335, 5690.174924635905, 5714.228659008402, 5742.684152371659, 3482.495038219444, 3518.9120271993406, 3531.3820081485637, 3566.251087271702, 3586.569611646567, 6409.230892292955, 6429.453496452854, 6519.478441724651, 6527.510436717265, 6592.9340706593275, 6812.591244525344, 6823.249442561314, 6870.484713646497, 6916.515843890879, 6932.688029038705, 6461.386168314003, 6499.415052645285, 6508.047585724264, 6533.934660653427, 6535.215774106948, 6717.395434410926, 6730.40879261478, 6733.074894093166, 6745.224299205458, 6784.084148640068, 6578.736850525926, 6590.912499437731, 6652.467802575879, 6670.299618540177, 6706.8993965089585, 6361.187061687397, 6403.807885763435, 6429.8392540185, 6488.545801793829, 6513.250976137805, 4783.330333753208, 4815.374001379798, 4819.590334821439, 4826.251930950708, 4863.708177509361, 6385.29761726219, 6626.701798418986, 6632.270450250372, 6669.866602668017, 6717.395434410926, 6224.688765561795, 6244.875102497834, 6366.331535188739, 6387.968060159669, 6430.131932189094, 6365.0, 6402.1357116790505, 6464.4828413725845, 6464.806055818333, 6466.997615369625, 6267.435930766253, 6340.797897061954, 6352.872942541031, 6398.328175541501, 6428.4214420702365, 6438.871222575616, 6446.7098980546925, 6503.358119453122, 6534.346565343428, 6554.737810487527, 6279.623222606659, 6308.873822523616, 6356.141920840627, 6379.74481020754, 6390.968045159744], "value": 4974.719888659781, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.4140808474491, 909.9317551183663, 910.9043550427205, 911.325619041909, 932.4871320773573, 17810.46568602941, 18709.251629934803, 18729.71905421418, 18741.15664795084, 20013.299534516296, 19557.902210488926, 19589.51026224345, 19713.605727885435, 19846.0, 20187.899060504715, 969.6315400147934, 1045.242199405429, 1052.2686732720763, 1052.41590917041, 1053.9209559283047, 985.5860538573817, 1060.01948197917, 1061.1245722279111, 1068.2255364860453, 1069.6577095329499, 1085.4138765066855, 1097.4841824342545, 1099.0657940750377, 1099.0987390339924, 1100.6697990602827, 1078.8705355357329, 1092.153580974743, 1095.052779345864, 1095.3209010413516, 1096.8793432722393, 793.131520984521, 798.3652995868299, 798.5208874675207, 800.0479429478902, 802.1176705623767, 15718.0, 17238.569035774206, 17923.3726819562, 18136.365227217117, 18153.7276940846, 19666.311679091163, 19937.30219442327, 20398.082086306153, 20406.795932040786, 20577.176912923464, 16154.676906461806, 16302.429414970418, 16603.584910377336, 16607.252673629715, 16635.750463743054, 3516.4901089342156, 3565.5721313442295, 3565.732570057256, 3568.946465803015, 3579.713622910161, 121206.39396803048, 121274.39362803218, 125289.0, 126845.0, 128502.0, 15125.54623361301, 15278.694426111639, 15310.311036003406, 15385.307661155275, 15426.228688565527, 30328.696713033027, 30908.072757817303, 31037.224069398446, 31058.689413106033, 31107.68892311048, 7179.389751871149, 7548.131964824115, 8035.276825085653, 8382.036065852382, 8495.447795893248, 3502.194495266103, 3796.240751849641, 3938.054866831997, 3943.6056394360335, 3955.0, 5178.249153872667, 5205.45342739007, 5310.946890531122, 5321.122014867504, 5326.6537675050995, 1038.948052597367, 1041.598984391015, 1043.3948309980344, 1052.8526006359116, 1054.8259537176434, 649.7465988264486, 667.4927055437902, 695.5166159519085, 701.4633805139073, 707.7027648387586, 10776.010157592022, 11309.660710178709, 11474.378812231178, 11658.53365865356, 11693.824592631117, 646.890028695123, 678.8811957907445, 690.2890023276034, 696.4289282788167, 699.0667458942369, 4650.837220697327, 4818.156822556039, 4887.413510378707, 4909.582685471703, 4997.150484417658, 104398.0, 105652.47173764082, 107377.4631126855, 108809.0, 111673.44163279132, 86512.0, 91912.54043729739, 92439.5378023119, 93125.60311595332, 97012.0, 73627.63186184142, 78339.21660783433, 80552.59723701462, 82127.58936205281, 82190.0, 11008.834867476835, 11034.337939723642, 11179.714332851501, 11651.592194273499, 11673.0, 35512.644873551966, 35964.10089747777, 35972.82013589915, 37187.25625487529, 38603.61396386113, 44286.0, 45182.0, 45279.32081018853, 45867.77066114648, 46388.76805616085, 17550.73673894867, 17689.646207076043, 17993.920364778154, 18028.54928626795, 18138.365157219436, 19271.22915083381, 19707.0, 19768.604627907647, 19807.306744264457, 19828.40514784501, 17551.122443878012, 17914.372996945043, 17954.281828726704, 18183.18175682071, 18218.544536386697, 17489.212985415434, 17496.125193740518, 17685.64628707393, 17869.73195402044, 17902.731459028386, 17082.743758843877, 17139.228734707216, 17379.131043447524, 17418.30326786914, 17503.562410939827, 12075.879241207827, 12816.935915320364, 13364.198148111145, 13791.724165516433, 13915.58253252404, 13884.236366999912, 14324.355404007054, 14395.85604143987, 14442.277886105863, 14727.55817325482], "value": 8801.737364765791, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 101.0, 111.0, 110.0, 111.0, 113.0, 102.0, 111.0, 111.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 149.0, 180.0, 120.0, 146.0, 153.0, 129.0, 179.0, 121.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 164.0, 165.0, 162.0, 167.0, 165.0, 162.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 78.0, 182.0, 78.0, 75.0, 75.0, 76.0, 165.0, 77.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 131.0, 81.0, 81.0, 80.0, 133.0, 81.0, 81.0, 128.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 152.0, 153.0, 151.0, 151.0, 152.0, 153.0, 152.0, 151.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 100.0, 93.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 53.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 55.0, 54.0, 55.0, 54.0, 55.0, 55.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 85.0, 78.0, 77.0, 77.0, 77.0, 78.0, 79.0, 78.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 129.0, 137.0, 126.0, 128.0, 124.0, 126.0, 126.0, 123.0, 163.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 182.0, 187.0, 178.0, 178.0, 181.0, 180.0, 180.0, 181.0, 181.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 72.0, 71.0, 71.0, 67.0, 67.0, 75.0, 70.0, 67.0], "value": 69.9, "unit": "score"}]}]} 03:26:46 INFO - Return code: 0 03:26:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:26:46 INFO - # TBPL SUCCESS # 03:26:46 INFO - Running post-action listener: _package_coverage_data 03:26:46 INFO - Running post-action listener: _resource_record_post_action 03:26:46 INFO - [mozharness: 2017-07-23 10:26:46.835586Z] Finished run-tests step (success) 03:26:46 INFO - Running post-run listener: _resource_record_post_run 03:26:46 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 5357568; Write bytes: 447848448; Read time: 1940; Write time: 315728 03:26:46 INFO - TinderboxPrint: CPU usage
13.1% 03:26:46 INFO - TinderboxPrint: I/O read bytes / time
5,357,568 / 1,940 03:26:46 INFO - TinderboxPrint: I/O write bytes / time
447,848,448 / 315,728 03:26:46 INFO - TinderboxPrint: CPU idle
8,282.8 (86.9%) 03:26:46 INFO - TinderboxPrint: CPU user
1,202.1 (12.6%) 03:26:46 INFO - TinderboxPrint: Swap in / out
0 / 0 03:26:46 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 119181312; Read time: 60; Write time: 66504 03:26:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:26:46 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 2846720; Write bytes: 328667136; Read time: 1168; Write time: 249224 03:26:47 INFO - Running post-run listener: _upload_blobber_files 03:26:47 INFO - Blob upload gear active. 03:26:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:26:47 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 03:26:47 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:26:47 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:26:47 INFO - (blobuploader) - INFO - Open directory for files ... 03:26:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:26:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:26:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:49 INFO - (blobuploader) - INFO - Done attempting. 03:26:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:26:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:26:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:49 INFO - (blobuploader) - INFO - Done attempting. 03:26:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:26:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:26:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:50 INFO - (blobuploader) - INFO - Done attempting. 03:26:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:26:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:53 INFO - (blobuploader) - INFO - Done attempting. 03:26:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:26:53 INFO - Return code: 0 03:26:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:26:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:26:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00f90aa02c87dc928e5c53dc9abba3da617e16ef0d6ca50f3bafab5f0c9f61e1f16a7cbbc0baf684a83b10d7c23741877092b41a5092f89012d47ae4a9ed8391", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f5f6907f11e7ec52a442c269e8e5e1bacf3f6fa37f0bf27914bc1f4a1e4131397924035ba52317677294bda0b34f29289e2a263a82313bbeb42e34c2aef6639", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9171b3ab02a19e8be50f63e1cc53ab7a7e8c955a1afaf6ec193befd1f653bbd4874cebf1e2da1100eedae4d8ac800e21e594008cbbcd688afc5b7d24045275aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45421420de6c40419ee91ac40ae06a996febef5eb5701252d395018b95a6e9ee6a96ba887f155716f47ae9944b49956bf26e7d2b71811bacf031eb859bb57792"} 03:26:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:26:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:26:53 INFO - Contents: 03:26:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00f90aa02c87dc928e5c53dc9abba3da617e16ef0d6ca50f3bafab5f0c9f61e1f16a7cbbc0baf684a83b10d7c23741877092b41a5092f89012d47ae4a9ed8391", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f5f6907f11e7ec52a442c269e8e5e1bacf3f6fa37f0bf27914bc1f4a1e4131397924035ba52317677294bda0b34f29289e2a263a82313bbeb42e34c2aef6639", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9171b3ab02a19e8be50f63e1cc53ab7a7e8c955a1afaf6ec193befd1f653bbd4874cebf1e2da1100eedae4d8ac800e21e594008cbbcd688afc5b7d24045275aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45421420de6c40419ee91ac40ae06a996febef5eb5701252d395018b95a6e9ee6a96ba887f155716f47ae9944b49956bf26e7d2b71811bacf031eb859bb57792"} 03:26:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:26:53 INFO - Copying logs to upload dir... 03:26:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:26:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.425488 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-23 03:26:53.386548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-23 03:26:53.390575) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00f90aa02c87dc928e5c53dc9abba3da617e16ef0d6ca50f3bafab5f0c9f61e1f16a7cbbc0baf684a83b10d7c23741877092b41a5092f89012d47ae4a9ed8391", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f5f6907f11e7ec52a442c269e8e5e1bacf3f6fa37f0bf27914bc1f4a1e4131397924035ba52317677294bda0b34f29289e2a263a82313bbeb42e34c2aef6639", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9171b3ab02a19e8be50f63e1cc53ab7a7e8c955a1afaf6ec193befd1f653bbd4874cebf1e2da1100eedae4d8ac800e21e594008cbbcd688afc5b7d24045275aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45421420de6c40419ee91ac40ae06a996febef5eb5701252d395018b95a6e9ee6a96ba887f155716f47ae9944b49956bf26e7d2b71811bacf031eb859bb57792"} build_url:https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011178 build_url: 'https://queue.taskcluster.net/v1/task/ZesVv5jtR_WeV4mZcPNddA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00f90aa02c87dc928e5c53dc9abba3da617e16ef0d6ca50f3bafab5f0c9f61e1f16a7cbbc0baf684a83b10d7c23741877092b41a5092f89012d47ae4a9ed8391", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f5f6907f11e7ec52a442c269e8e5e1bacf3f6fa37f0bf27914bc1f4a1e4131397924035ba52317677294bda0b34f29289e2a263a82313bbeb42e34c2aef6639", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9171b3ab02a19e8be50f63e1cc53ab7a7e8c955a1afaf6ec193befd1f653bbd4874cebf1e2da1100eedae4d8ac800e21e594008cbbcd688afc5b7d24045275aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45421420de6c40419ee91ac40ae06a996febef5eb5701252d395018b95a6e9ee6a96ba887f155716f47ae9944b49956bf26e7d2b71811bacf031eb859bb57792"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-23 03:26:53.417916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:26:53.418230) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1500804024.618102-347681267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004306 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:26:53.499081) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-23 03:26:53.499404) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-23 03:26:53.499825) ========= ========= Total master_lag: 0.20 =========