builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1501419271.11 results: success (0) revision: 6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:31.107929) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:31.108313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:31.108581) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:31.299322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:31.303441) ========= 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=9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-30 05:54:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.1M=0s 2017-07-30 05:54:31 (26.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116084 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:31.471868) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:31.472171) ========= 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=9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017892 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:31.534754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:31.535074) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1 --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 6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1 --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=9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-30 05:54:32,074 truncating revision to first 12 chars 2017-07-30 05:54:32,074 Setting DEBUG logging. 2017-07-30 05:54:32,074 attempt 1/10 2017-07-30 05:54:32,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6d1b50a370b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-30 05:54:32,529 unpacking tar archive at: mozilla-central-6d1b50a370b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.793892 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.363653) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.363935) ========= script_repo_revision: 6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.364282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.364556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.379135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-07-30 05:54:32.379420) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:32 INFO - MultiFileLogger online at 20170730 05:54:32 in /builds/slave/test 05:54:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:54:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:33 INFO - {'append_to_log': False, 05:54:33 INFO - 'base_work_dir': '/builds/slave/test', 05:54:33 INFO - 'blob_upload_branch': 'Firefox', 05:54:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:33 INFO - 'branch': 'Firefox', 05:54:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:33 INFO - 'code_coverage': False, 05:54:33 INFO - 'config_files': ('talos/linux_config.py',), 05:54:33 INFO - 'default_actions': ('clobber', 05:54:33 INFO - 'read-buildbot-config', 05:54:33 INFO - 'download-and-extract', 05:54:33 INFO - 'populate-webroot', 05:54:33 INFO - 'create-virtualenv', 05:54:33 INFO - 'install', 05:54:33 INFO - 'setup-mitmproxy', 05:54:33 INFO - 'run-tests'), 05:54:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:33 INFO - 'disable_ccov_upload': False, 05:54:33 INFO - 'download_minidump_stackwalk': True, 05:54:33 INFO - 'download_symbols': 'ondemand', 05:54:33 INFO - 'enable_stylo': False, 05:54:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:33 INFO - 'gecko_profile': False, 05:54:33 INFO - 'gecko_profile_interval': 0, 05:54:33 INFO - 'installer_path': 'installer.exe', 05:54:33 INFO - 'log_level': 'info', 05:54:33 INFO - 'log_name': 'talos', 05:54:33 INFO - 'log_to_console': True, 05:54:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:33 INFO - 'opt_config_files': (), 05:54:33 INFO - 'pip_index': False, 05:54:33 INFO - 'suite': 'dromaeojs-e10s', 05:54:33 INFO - 'system_bits': '32', 05:54:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:33 INFO - 'title': 'talos-linux64-ix-076', 05:54:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:33 INFO - 'use_talos_json': True, 05:54:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:33 INFO - 'work_dir': 'build'} 05:54:33 INFO - [mozharness: 2017-07-30 12:54:33.010970Z] Running clobber step. 05:54:33 INFO - Running pre-action listener: _resource_record_pre_action 05:54:33 INFO - Running main action method: clobber 05:54:33 INFO - rmtree: /builds/slave/test/build 05:54:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:34 INFO - Running post-action listener: _resource_record_post_action 05:54:34 INFO - [mozharness: 2017-07-30 12:54:34.569941Z] Finished clobber step (success) 05:54:34 INFO - [mozharness: 2017-07-30 12:54:34.570043Z] Running read-buildbot-config step. 05:54:34 INFO - Running pre-action listener: _resource_record_pre_action 05:54:34 INFO - Running main action method: read_buildbot_config 05:54:34 INFO - Using buildbot properties: 05:54:34 INFO - { 05:54:34 INFO - "project": "", 05:54:34 INFO - "product": "firefox", 05:54:34 INFO - "who": "archaeopteryx@coole-files.de", 05:54:34 INFO - "installer_path": "public/build/target.tar.bz2", 05:54:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 05:54:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:54:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 05:54:34 INFO - "stage_platform": "linux64-stylo", 05:54:34 INFO - "basedir": "/builds/slave/test", 05:54:34 INFO - "buildnumber": 56, 05:54:34 INFO - "platform": "ubuntu64_hw_stylo", 05:54:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:54:34 INFO - "slavebuilddir": "test", 05:54:34 INFO - "taskId": "Jwdt69_5S-yyUMOeXcG_Ag", 05:54:34 INFO - "branch": "mozilla-central", 05:54:34 INFO - "script_repo_revision": "production", 05:54:34 INFO - "revision": "6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1", 05:54:34 INFO - "slavename": "talos-linux64-ix-076", 05:54:34 INFO - "repo_path": "mozilla-central" 05:54:34 INFO - } 05:54:34 INFO - Finding installer, test and symbols from parent task. 05:54:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jwdt69_5S-yyUMOeXcG_Ag'}, attempt #1 05:54:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jwdt69_5S-yyUMOeXcG_Ag'}, attempt #1 05:54:35 INFO - Task dependencies: B8fC0UWOT0Oorcf49xoIZw 05:54:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw'}, attempt #1 05:54:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2 05:54:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.test_packages.json 05:54:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.crashreporter-symbols.zip 05:54:35 INFO - Running post-action listener: _resource_record_post_action 05:54:35 INFO - [mozharness: 2017-07-30 12:54:35.958683Z] Finished read-buildbot-config step (success) 05:54:35 INFO - [mozharness: 2017-07-30 12:54:35.958905Z] Running download-and-extract step. 05:54:35 INFO - Running pre-action listener: _resource_record_pre_action 05:54:35 INFO - Running main action method: download_and_extract 05:54:35 INFO - mkdir: /builds/slave/test/build/tests 05:54: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')]} 05:54:35 INFO - trying https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.test_packages.json 05:54:35 INFO - Downloading https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:54:36 INFO - Downloaded 989 bytes. 05:54:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:54:36 INFO - Using the following test package requirements: 05:54:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:54:36 INFO - u'common': [u'target.common.tests.zip'], 05:54:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:54:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:54:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:54:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:54:36 INFO - u'mozbase': [u'target.common.tests.zip'], 05:54:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:54:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:54:36 INFO - u'web-platform': [u'target.common.tests.zip', 05:54:36 INFO - u'target.web-platform.tests.tar.gz'], 05:54:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:54:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:54:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.common.tests.zip 05:54:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:54:36 INFO - Fetch https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.common.tests.zip into memory 05:54:39 INFO - Content-Length response header: 72567071 05:54:39 INFO - Bytes received: 72567071 05:54:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:54:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.common.tests.zip 05:54:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:54:50 INFO - Fetch https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.common.tests.zip into memory 05:54:53 INFO - Content-Length response header: 72567071 05:54:53 INFO - Bytes received: 72567071 05:55:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.talos.tests.zip 05:55:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:55:05 INFO - Fetch https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.talos.tests.zip into memory 05:55:06 INFO - Content-Length response header: 14496686 05:55:06 INFO - Bytes received: 14496686 05:55:06 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')]} 05:55:06 INFO - trying https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2 05:55:06 INFO - Downloading https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:55:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:55:10 INFO - Downloaded 62352183 bytes. 05:55:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2 05:55:10 INFO - mkdir: /builds/slave/test/properties 05:55:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:55:10 INFO - Writing to file /builds/slave/test/properties/build_url 05:55:10 INFO - Contents: 05:55:10 INFO - build_url:https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2 05:55:10 INFO - Running post-action listener: _resource_record_post_action 05:55:10 INFO - Running post-action listener: set_extra_try_arguments 05:55:10 INFO - [mozharness: 2017-07-30 12:55:10.322596Z] Finished download-and-extract step (success) 05:55:10 INFO - [mozharness: 2017-07-30 12:55:10.322825Z] Running populate-webroot step. 05:55:10 INFO - Running pre-action listener: _resource_record_pre_action 05:55:10 INFO - Running main action method: populate_webroot 05:55:10 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:55:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:55:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:55:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:55:10 INFO - 'tests': ['damp', 'tps']}, 05:55:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:55:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:55:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:55:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:55:10 INFO - 'other-e10s': {'tests': ['a11yr', 05:55:10 INFO - 'ts_paint', 05:55:10 INFO - 'tpaint', 05:55:10 INFO - 'sessionrestore', 05:55:10 INFO - 'sessionrestore_many_windows', 05:55:10 INFO - 'sessionrestore_no_auto_restore', 05:55:10 INFO - 'tabpaint']}, 05:55:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:55:10 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:55:10 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:55:10 INFO - 'talos_options': ['--mitmproxy', 05:55:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:55:10 INFO - '--firstNonBlankPaint'], 05:55:10 INFO - 'tests': ['quantum_pageload_google', 05:55:10 INFO - 'quantum_pageload_youtube', 05:55:10 INFO - 'quantum_pageload_amazon', 05:55:10 INFO - 'quantum_pageload_facebook']}, 05:55:10 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:55:10 INFO - 'talos_options': ['--stylo', 05:55:10 INFO - '--mitmproxy', 05:55:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:55:10 INFO - '--firstNonBlankPaint'], 05:55:10 INFO - 'tests': ['quantum_pageload_google', 05:55:10 INFO - 'quantum_pageload_youtube', 05:55:10 INFO - 'quantum_pageload_amazon', 05:55:10 INFO - 'quantum_pageload_facebook']}, 05:55:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:55:10 INFO - 'tsvgr_opacity', 05:55:10 INFO - 'tart', 05:55:10 INFO - 'tscrollx', 05:55:10 INFO - 'cart', 05:55:10 INFO - 'tsvg_static']}, 05:55:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:55:10 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:55:10 INFO - 'talos_options': ['--stylo', 05:55:10 INFO - '--stylo-threads=1', 05:55:10 INFO - '--mitmproxy', 05:55:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:55:10 INFO - '--firstNonBlankPaint'], 05:55:10 INFO - 'tests': ['tp6_google', 05:55:10 INFO - 'tp6_youtube', 05:55:10 INFO - 'tp6_amazon', 05:55:10 INFO - 'tp6_facebook']}, 05:55:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:55:10 INFO - 'talos_options': ['--xperf_path', 05:55:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:10 INFO - 'tests': ['tp5n']}}} 05:55:10 INFO - Running post-action listener: _resource_record_post_action 05:55:10 INFO - [mozharness: 2017-07-30 12:55:10.335778Z] Finished populate-webroot step (success) 05:55:10 INFO - [mozharness: 2017-07-30 12:55:10.335869Z] Running create-virtualenv step. 05:55:10 INFO - Running pre-action listener: _resource_record_pre_action 05:55:10 INFO - Running main action method: create_virtualenv 05:55:10 INFO - Creating virtualenv /builds/slave/test/build/venv 05:55:10 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 05:55:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:55:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:55:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:55:10 INFO - Using real prefix '/usr' 05:55:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:55:10 INFO - Installing distribute.............................................................................................................................................................................................done. 05:55:12 INFO - Installing pip.................done. 05:55:12 INFO - Return code: 0 05:55:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:55:13 INFO - Reading from file tmpfile_stdout 05:55:13 INFO - Output received: 05:55:13 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) 05:55:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:55:13 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')]} 05:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:13 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')]} 05:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:13 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 0x29771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3eb0>, '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 0x2ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5240>, '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': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', '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 05:55:13 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 05:55:13 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 05:55:13 INFO - Using env: {'DISPLAY': ':0', 05:55:13 INFO - 'HOME': '/home/cltbld', 05:55:13 INFO - 'LANG': 'en_US.UTF-8', 05:55:13 INFO - 'LANGUAGE': 'en_US:en', 05:55:13 INFO - 'LOGNAME': 'cltbld', 05:55:13 INFO - 'MAIL': '/var/mail/cltbld', 05:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:13 INFO - 'MOZ_NO_REMOTE': '1', 05:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:13 INFO - 'NO_EM_RESTART': '1', 05:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:13 INFO - 'PWD': '/builds/slave/test', 05:55:13 INFO - 'SHELL': '/bin/bash', 05:55:13 INFO - 'SHLVL': '1', 05:55:13 INFO - 'TERM': 'linux', 05:55:13 INFO - 'TMOUT': '86400', 05:55:13 INFO - 'USER': 'cltbld', 05:55:13 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', 05:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:13 INFO - '_': '/tools/buildbot/bin/python'} 05:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:13 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 05:55:13 INFO - Cleaning up... 05:55:13 INFO - Return code: 0 05:55:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:55:13 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')]} 05:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:13 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')]} 05:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:13 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 0x29771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3eb0>, '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 0x2ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5240>, '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': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', '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 05:55:13 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 05:55:13 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 05:55:13 INFO - Using env: {'DISPLAY': ':0', 05:55:13 INFO - 'HOME': '/home/cltbld', 05:55:13 INFO - 'LANG': 'en_US.UTF-8', 05:55:13 INFO - 'LANGUAGE': 'en_US:en', 05:55:13 INFO - 'LOGNAME': 'cltbld', 05:55:13 INFO - 'MAIL': '/var/mail/cltbld', 05:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:13 INFO - 'MOZ_NO_REMOTE': '1', 05:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:13 INFO - 'NO_EM_RESTART': '1', 05:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:13 INFO - 'PWD': '/builds/slave/test', 05:55:13 INFO - 'SHELL': '/bin/bash', 05:55:13 INFO - 'SHLVL': '1', 05:55:13 INFO - 'TERM': 'linux', 05:55:13 INFO - 'TMOUT': '86400', 05:55:13 INFO - 'USER': 'cltbld', 05:55:13 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', 05:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:13 INFO - '_': '/tools/buildbot/bin/python'} 05:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:13 INFO - Downloading/unpacking psutil>=3.1.1 05:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:55:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:14 INFO - Installing collected packages: psutil 05:55:14 INFO - Running setup.py install for psutil 05:55:14 INFO - building 'psutil._psutil_linux' extension 05:55:14 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 05:55:15 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 05:55:15 INFO - building 'psutil._psutil_posix' extension 05:55:15 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 05:55:15 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 05:55:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:15 INFO - Successfully installed psutil 05:55:15 INFO - Cleaning up... 05:55:15 INFO - Return code: 0 05:55:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:55:15 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')]} 05:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:15 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')]} 05:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:15 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 0x29771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3eb0>, '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 0x2ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5240>, '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': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', '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 05:55:15 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 05:55:15 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 05:55:15 INFO - Using env: {'DISPLAY': ':0', 05:55:15 INFO - 'HOME': '/home/cltbld', 05:55:15 INFO - 'LANG': 'en_US.UTF-8', 05:55:15 INFO - 'LANGUAGE': 'en_US:en', 05:55:15 INFO - 'LOGNAME': 'cltbld', 05:55:15 INFO - 'MAIL': '/var/mail/cltbld', 05:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:15 INFO - 'MOZ_NO_REMOTE': '1', 05:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:15 INFO - 'NO_EM_RESTART': '1', 05:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:15 INFO - 'PWD': '/builds/slave/test', 05:55:15 INFO - 'SHELL': '/bin/bash', 05:55:15 INFO - 'SHLVL': '1', 05:55:15 INFO - 'TERM': 'linux', 05:55:15 INFO - 'TMOUT': '86400', 05:55:15 INFO - 'USER': 'cltbld', 05:55:15 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', 05:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:15 INFO - '_': '/tools/buildbot/bin/python'} 05:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:55:15 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 05:55:15 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 05:55:15 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 05:55:15 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 05:55:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:55:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:55:16 INFO - Installing collected packages: mozsystemmonitor 05:55:16 INFO - Running setup.py install for mozsystemmonitor 05:55:16 INFO - Successfully installed mozsystemmonitor 05:55:16 INFO - Cleaning up... 05:55:16 INFO - Return code: 0 05:55:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:55:16 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')]} 05:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:16 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')]} 05:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:16 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 0x29771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3eb0>, '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 0x2ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5240>, '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': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', '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 05:55:16 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 05:55:16 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 05:55:16 INFO - Using env: {'DISPLAY': ':0', 05:55:16 INFO - 'HOME': '/home/cltbld', 05:55:16 INFO - 'LANG': 'en_US.UTF-8', 05:55:16 INFO - 'LANGUAGE': 'en_US:en', 05:55:16 INFO - 'LOGNAME': 'cltbld', 05:55:16 INFO - 'MAIL': '/var/mail/cltbld', 05:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:16 INFO - 'MOZ_NO_REMOTE': '1', 05:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:16 INFO - 'NO_EM_RESTART': '1', 05:55:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:16 INFO - 'PWD': '/builds/slave/test', 05:55:16 INFO - 'SHELL': '/bin/bash', 05:55:16 INFO - 'SHLVL': '1', 05:55:16 INFO - 'TERM': 'linux', 05:55:16 INFO - 'TMOUT': '86400', 05:55:16 INFO - 'USER': 'cltbld', 05:55:16 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', 05:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:16 INFO - '_': '/tools/buildbot/bin/python'} 05:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:17 INFO - Downloading/unpacking jsonschema==2.5.1 05:55:17 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 05:55:17 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 05:55:17 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 05:55:17 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 05:55:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:55:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:18 INFO - Downloading functools32-3.2.3-2.tar.gz 05:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:55:18 INFO - warning: no files found matching '*.txt' 05:55:18 INFO - no previously-included directories found matching 'build' 05:55:18 INFO - no previously-included directories found matching 'dist' 05:55:18 INFO - no previously-included directories found matching '.git*' 05:55:18 INFO - Installing collected packages: jsonschema, functools32 05:55:18 INFO - Running setup.py install for functools32 05:55:18 INFO - warning: no files found matching '*.txt' 05:55:18 INFO - no previously-included directories found matching 'build' 05:55:18 INFO - no previously-included directories found matching 'dist' 05:55:18 INFO - no previously-included directories found matching '.git*' 05:55:18 INFO - Successfully installed jsonschema functools32 05:55:18 INFO - Cleaning up... 05:55:18 INFO - Return code: 0 05:55:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:55:18 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')]} 05:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:18 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')]} 05:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:18 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 0x29771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3eb0>, '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 0x2ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5240>, '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': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', '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 05:55:18 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 05:55:18 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 05:55:18 INFO - Using env: {'DISPLAY': ':0', 05:55:18 INFO - 'HOME': '/home/cltbld', 05:55:18 INFO - 'LANG': 'en_US.UTF-8', 05:55:18 INFO - 'LANGUAGE': 'en_US:en', 05:55:18 INFO - 'LOGNAME': 'cltbld', 05:55:18 INFO - 'MAIL': '/var/mail/cltbld', 05:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:18 INFO - 'MOZ_NO_REMOTE': '1', 05:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:18 INFO - 'NO_EM_RESTART': '1', 05:55:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:18 INFO - 'PWD': '/builds/slave/test', 05:55:18 INFO - 'SHELL': '/bin/bash', 05:55:18 INFO - 'SHLVL': '1', 05:55:18 INFO - 'TERM': 'linux', 05:55:18 INFO - 'TMOUT': '86400', 05:55:18 INFO - 'USER': 'cltbld', 05:55:18 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', 05:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:18 INFO - '_': '/tools/buildbot/bin/python'} 05:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:55:18 INFO - Cleaning up... 05:55:18 INFO - Return code: 0 05:55:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:55:18 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')]} 05:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:18 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')]} 05:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:18 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 0x29771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3eb0>, '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 0x2ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5240>, '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': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', '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 05:55:18 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 05:55:18 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 05:55:18 INFO - Using env: {'DISPLAY': ':0', 05:55:18 INFO - 'HOME': '/home/cltbld', 05:55:18 INFO - 'LANG': 'en_US.UTF-8', 05:55:18 INFO - 'LANGUAGE': 'en_US:en', 05:55:18 INFO - 'LOGNAME': 'cltbld', 05:55:18 INFO - 'MAIL': '/var/mail/cltbld', 05:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:18 INFO - 'MOZ_NO_REMOTE': '1', 05:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:18 INFO - 'NO_EM_RESTART': '1', 05:55:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:18 INFO - 'PWD': '/builds/slave/test', 05:55:18 INFO - 'SHELL': '/bin/bash', 05:55:18 INFO - 'SHLVL': '1', 05:55:18 INFO - 'TERM': 'linux', 05:55:18 INFO - 'TMOUT': '86400', 05:55:18 INFO - 'USER': 'cltbld', 05:55:18 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', 05:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:18 INFO - '_': '/tools/buildbot/bin/python'} 05:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:18 INFO - Downloading/unpacking blobuploader==1.2.4 05:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:19 INFO - Downloading blobuploader-1.2.4.tar.gz 05:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:55:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:55:20 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 05:55:20 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 05:55:20 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 05:55:20 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 05:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:55:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:55:20 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 05:55:20 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 05:55:20 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 05:55:20 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 05:55:20 INFO - Downloading docopt-0.6.1.tar.gz 05:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:55:20 INFO - Installing collected packages: blobuploader, requests, docopt 05:55:20 INFO - Running setup.py install for blobuploader 05:55:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:55:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:55:20 INFO - Running setup.py install for requests 05:55:21 INFO - Running setup.py install for docopt 05:55:21 INFO - Successfully installed blobuploader requests docopt 05:55:21 INFO - Cleaning up... 05:55:21 INFO - Return code: 0 05:55:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:21 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')]} 05:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:21 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')]} 05:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:21 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 0x29771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3eb0>, '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 0x2ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5240>, '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': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', '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 05:55:21 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 05:55:21 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 05:55:21 INFO - Using env: {'DISPLAY': ':0', 05:55:21 INFO - 'HOME': '/home/cltbld', 05:55:21 INFO - 'LANG': 'en_US.UTF-8', 05:55:21 INFO - 'LANGUAGE': 'en_US:en', 05:55:21 INFO - 'LOGNAME': 'cltbld', 05:55:21 INFO - 'MAIL': '/var/mail/cltbld', 05:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:21 INFO - 'MOZ_NO_REMOTE': '1', 05:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:21 INFO - 'NO_EM_RESTART': '1', 05:55:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:21 INFO - 'PWD': '/builds/slave/test', 05:55:21 INFO - 'SHELL': '/bin/bash', 05:55:21 INFO - 'SHLVL': '1', 05:55:21 INFO - 'TERM': 'linux', 05:55:21 INFO - 'TMOUT': '86400', 05:55:21 INFO - 'USER': 'cltbld', 05:55:21 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', 05:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:21 INFO - '_': '/tools/buildbot/bin/python'} 05:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:21 INFO - Running setup.py (path:/tmp/pip-KGlIEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:21 INFO - Running setup.py (path:/tmp/pip-EjkjfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:21 INFO - Running setup.py (path:/tmp/pip-OnT7rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:21 INFO - Running setup.py (path:/tmp/pip-BrBrRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:21 INFO - Running setup.py (path:/tmp/pip-f7GPBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:21 INFO - Running setup.py (path:/tmp/pip-BkHRK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:21 INFO - Running setup.py (path:/tmp/pip-guMInc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:21 INFO - Running setup.py (path:/tmp/pip-lMrpdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:21 INFO - Running setup.py (path:/tmp/pip-pyLRVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:22 INFO - Running setup.py (path:/tmp/pip-G1H7V6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:22 INFO - Running setup.py (path:/tmp/pip-VPDEOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:22 INFO - Running setup.py (path:/tmp/pip-dm2TAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:22 INFO - Running setup.py (path:/tmp/pip-7xx8NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:22 INFO - Running setup.py (path:/tmp/pip-vZJsAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:22 INFO - Running setup.py (path:/tmp/pip-LbmfWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:22 INFO - Running setup.py (path:/tmp/pip-xpMUEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:22 INFO - Running setup.py (path:/tmp/pip-GiqWXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:55:22 INFO - Running setup.py install for manifestparser 05:55:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:55:22 INFO - Running setup.py install for mozcrash 05:55:22 INFO - Running setup.py install for mozdebug 05:55:22 INFO - Running setup.py install for mozdevice 05:55:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Running setup.py install for mozfile 05:55:23 INFO - Running setup.py install for mozhttpd 05:55:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Running setup.py install for mozinfo 05:55:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Running setup.py install for mozInstall 05:55:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Running setup.py install for mozleak 05:55:23 INFO - Running setup.py install for mozlog 05:55:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Running setup.py install for moznetwork 05:55:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Running setup.py install for mozprocess 05:55:23 INFO - Running setup.py install for mozprofile 05:55:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Running setup.py install for mozrunner 05:55:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Running setup.py install for mozscreenshot 05:55:24 INFO - Running setup.py install for moztest 05:55:24 INFO - Running setup.py install for mozversion 05:55:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:55:24 INFO - Cleaning up... 05:55:24 INFO - Return code: 0 05:55:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:24 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')]} 05:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:24 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')]} 05:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:24 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 0x29771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3eb0>, '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 0x2ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5240>, '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': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', '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 05:55:24 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 05:55:24 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 05:55:24 INFO - Using env: {'DISPLAY': ':0', 05:55:24 INFO - 'HOME': '/home/cltbld', 05:55:24 INFO - 'LANG': 'en_US.UTF-8', 05:55:24 INFO - 'LANGUAGE': 'en_US:en', 05:55:24 INFO - 'LOGNAME': 'cltbld', 05:55:24 INFO - 'MAIL': '/var/mail/cltbld', 05:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:24 INFO - 'MOZ_NO_REMOTE': '1', 05:55:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:24 INFO - 'NO_EM_RESTART': '1', 05:55:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:24 INFO - 'PWD': '/builds/slave/test', 05:55:24 INFO - 'SHELL': '/bin/bash', 05:55:24 INFO - 'SHLVL': '1', 05:55:24 INFO - 'TERM': 'linux', 05:55:24 INFO - 'TMOUT': '86400', 05:55:24 INFO - 'USER': 'cltbld', 05:55:24 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', 05:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:24 INFO - '_': '/tools/buildbot/bin/python'} 05:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:24 INFO - Running setup.py (path:/tmp/pip-3imlpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:24 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)) 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:24 INFO - Running setup.py (path:/tmp/pip-UsCXEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:24 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)) 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:24 INFO - Running setup.py (path:/tmp/pip-0KEZP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:24 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)) 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:24 INFO - Running setup.py (path:/tmp/pip-SY7gR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:24 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)) 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:24 INFO - Running setup.py (path:/tmp/pip-P0P_qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:24 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)) 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:24 INFO - Running setup.py (path:/tmp/pip-o7BtEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:25 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)) 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:25 INFO - Running setup.py (path:/tmp/pip-MVmj42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:25 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)) 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:25 INFO - Running setup.py (path:/tmp/pip-vzdUtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:25 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)) 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:25 INFO - Running setup.py (path:/tmp/pip-WibOD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:25 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)) 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:25 INFO - Running setup.py (path:/tmp/pip-t2zWGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:25 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)) 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:25 INFO - Running setup.py (path:/tmp/pip-Ipdh24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:25 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)) 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:25 INFO - Running setup.py (path:/tmp/pip-GDEquq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:25 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)) 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:25 INFO - Running setup.py (path:/tmp/pip-Hnoih3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:25 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)) 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:25 INFO - Running setup.py (path:/tmp/pip-1rtMNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:25 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)) 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:25 INFO - Running setup.py (path:/tmp/pip-V4rtBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:25 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)) 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:25 INFO - Running setup.py (path:/tmp/pip-OanhLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:25 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)) 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:25 INFO - Running setup.py (path:/tmp/pip-zcCE08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 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)) 05:55:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:27 INFO - Downloading blessings-1.6.tar.gz 05:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:27 INFO - Installing collected packages: blessings 05:55:27 INFO - Running setup.py install for blessings 05:55:27 INFO - Successfully installed blessings 05:55:27 INFO - Cleaning up... 05:55:27 INFO - Return code: 0 05:55:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:27 INFO - Reading from file tmpfile_stdout 05:55:27 INFO - Current package versions: 05:55:27 INFO - argparse == 1.2.1 05:55:27 INFO - blessings == 1.6 05:55:27 INFO - blobuploader == 1.2.4 05:55:27 INFO - docopt == 0.6.1 05:55:27 INFO - functools32 == 3.2.3-2 05:55:27 INFO - jsonschema == 2.5.1 05:55:27 INFO - manifestparser == 1.1 05:55:27 INFO - mozInstall == 1.13 05:55:27 INFO - mozcrash == 1.0 05:55:27 INFO - mozdebug == 0.1 05:55:27 INFO - mozdevice == 0.51 05:55:27 INFO - mozfile == 1.2 05:55:27 INFO - mozhttpd == 0.7 05:55:27 INFO - mozinfo == 0.10 05:55:27 INFO - mozleak == 0.1 05:55:27 INFO - mozlog == 3.5 05:55:27 INFO - moznetwork == 0.27 05:55:27 INFO - mozprocess == 0.25 05:55:27 INFO - mozprofile == 0.28 05:55:27 INFO - mozrunner == 6.13 05:55:27 INFO - mozscreenshot == 0.1 05:55:27 INFO - mozsystemmonitor == 0.3 05:55:27 INFO - moztest == 0.8 05:55:27 INFO - mozversion == 1.4 05:55:27 INFO - psutil == 3.1.1 05:55:27 INFO - requests == 1.2.3 05:55:27 INFO - wsgiref == 0.1.2 05:55:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55: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')]} 05:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:27 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 0x29771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3eb0>, '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 0x2ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5240>, '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': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', '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 05:55:27 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 05:55:27 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 05:55:27 INFO - Using env: {'DISPLAY': ':0', 05:55:27 INFO - 'HOME': '/home/cltbld', 05:55:27 INFO - 'LANG': 'en_US.UTF-8', 05:55:27 INFO - 'LANGUAGE': 'en_US:en', 05:55:27 INFO - 'LOGNAME': 'cltbld', 05:55:27 INFO - 'MAIL': '/var/mail/cltbld', 05:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:27 INFO - 'MOZ_NO_REMOTE': '1', 05:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:27 INFO - 'NO_EM_RESTART': '1', 05:55:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:27 INFO - 'PWD': '/builds/slave/test', 05:55:27 INFO - 'SHELL': '/bin/bash', 05:55:27 INFO - 'SHLVL': '1', 05:55:27 INFO - 'TERM': 'linux', 05:55:27 INFO - 'TMOUT': '86400', 05:55:27 INFO - 'USER': 'cltbld', 05:55:27 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', 05:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:27 INFO - '_': '/tools/buildbot/bin/python'} 05:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:27 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)) 05:55:27 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)) 05:55:27 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)) 05:55:27 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)) 05:55:27 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)) 05:55:27 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)) 05:55:27 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)) 05:55:27 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)) 05:55:27 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)) 05:55:27 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:28 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:55:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:55:28 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 05:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:55:29 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)) 05:55:29 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)) 05:55:29 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)) 05:55:29 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)) 05:55:29 INFO - Installing collected packages: marionette-driver, simplejson 05:55:29 INFO - Running setup.py install for marionette-driver 05:55:29 INFO - Running setup.py install for simplejson 05:55:29 INFO - building 'simplejson._speedups' extension 05:55:29 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 05:55:30 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 05:55:30 INFO - Successfully installed marionette-driver simplejson 05:55:30 INFO - Cleaning up... 05:55:30 INFO - Return code: 0 05:55:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:55:30 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')]} 05:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:30 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')]} 05:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:30 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 0x29771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b43a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3eb0>, '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 0x2ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5240>, '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': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', '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 05:55:30 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 05:55:30 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 05:55:30 INFO - Using env: {'DISPLAY': ':0', 05:55:30 INFO - 'HOME': '/home/cltbld', 05:55:30 INFO - 'LANG': 'en_US.UTF-8', 05:55:30 INFO - 'LANGUAGE': 'en_US:en', 05:55:30 INFO - 'LOGNAME': 'cltbld', 05:55:30 INFO - 'MAIL': '/var/mail/cltbld', 05:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:30 INFO - 'MOZ_NO_REMOTE': '1', 05:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:30 INFO - 'NO_EM_RESTART': '1', 05:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:30 INFO - 'PWD': '/builds/slave/test', 05:55:30 INFO - 'SHELL': '/bin/bash', 05:55:30 INFO - 'SHLVL': '1', 05:55:30 INFO - 'TERM': 'linux', 05:55:30 INFO - 'TMOUT': '86400', 05:55:30 INFO - 'USER': 'cltbld', 05:55:30 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', 05:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:30 INFO - '_': '/tools/buildbot/bin/python'} 05:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:55:30 INFO - Cleaning up... 05:55:30 INFO - Return code: 0 05:55:30 INFO - Running post-action listener: _resource_record_post_action 05:55:30 INFO - Running post-action listener: _start_resource_monitoring 05:55:30 INFO - Starting resource monitoring. 05:55:30 INFO - [mozharness: 2017-07-30 12:55:30.530899Z] Finished create-virtualenv step (success) 05:55:30 INFO - [mozharness: 2017-07-30 12:55:30.531411Z] Running install step. 05:55:30 INFO - Running pre-action listener: _resource_record_pre_action 05:55:30 INFO - Running main action method: install 05:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:30 INFO - Reading from file tmpfile_stdout 05:55:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:30 INFO - Reading from file tmpfile_stdout 05:55:30 INFO - Output received: 05:55:30 INFO - Usage: mozinstall [options] installer 05:55:30 INFO - Options: 05:55:30 INFO - -h, --help show this help message and exit 05:55:30 INFO - -d DEST, --destination=DEST 05:55:30 INFO - Directory to install application into. [default: 05:55:30 INFO - "/builds/slave/test"] 05:55:30 INFO - --app=APP Application being installed. [default: firefox] 05:55:30 INFO - mkdir: /builds/slave/test/build/application 05:55:30 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'] 05:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:55:48 INFO - Reading from file tmpfile_stdout 05:55:48 INFO - Output received: 05:55:48 INFO - /builds/slave/test/build/application/firefox/firefox 05:55:48 INFO - Running post-action listener: _resource_record_post_action 05:55:48 INFO - [mozharness: 2017-07-30 12:55:48.961028Z] Finished install step (success) 05:55:48 INFO - [mozharness: 2017-07-30 12:55:48.961178Z] Running setup-mitmproxy step. 05:55:48 INFO - Running pre-action listener: _resource_record_pre_action 05:55:48 INFO - Running main action method: setup_mitmproxy 05:55:48 INFO - Skipping: mitmproxy is not required 05:55:48 INFO - Running post-action listener: _resource_record_post_action 05:55:48 INFO - [mozharness: 2017-07-30 12:55:48.961985Z] Finished setup-mitmproxy step (success) 05:55:48 INFO - [mozharness: 2017-07-30 12:55:48.962210Z] Running run-tests step. 05:55:48 INFO - Running pre-action listener: _resource_record_pre_action 05:55:48 INFO - Running pre-action listener: _set_gcov_prefix 05:55:48 INFO - Running main action method: run_tests 05:55:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:48 INFO - Python 2.7.3 05:55:48 INFO - Return code: 0 05:55:48 INFO - grabbing minidump binary from tooltool 05:55:48 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')]} 05:55:48 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 0x2ce3eb0>, '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 0x2ce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:48 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 05:55:48 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 05:55:48 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 05:55:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:49 INFO - Return code: 0 05:55:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:55:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:49 INFO - ENV: RUST_BACKTRACE is now 1 05:55:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:55:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 05:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 05:55:49 INFO - Using env: {'DISPLAY': ':0', 05:55:49 INFO - 'HOME': '/home/cltbld', 05:55:49 INFO - 'LANG': 'en_US.UTF-8', 05:55:49 INFO - 'LANGUAGE': 'en_US:en', 05:55:49 INFO - 'LOGNAME': 'cltbld', 05:55:49 INFO - 'MAIL': '/var/mail/cltbld', 05:55:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:49 INFO - 'MOZ_NO_REMOTE': '1', 05:55:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:49 INFO - 'NO_EM_RESTART': '1', 05:55:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:49 INFO - 'PWD': '/builds/slave/test', 05:55:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:49 INFO - 'RUST_BACKTRACE': '1', 05:55:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:55:49 INFO - 'SHELL': '/bin/bash', 05:55:49 INFO - 'SHLVL': '1', 05:55:49 INFO - 'STYLO_FORCE_ENABLED': '1', 05:55:49 INFO - 'TERM': 'linux', 05:55:49 INFO - 'TMOUT': '86400', 05:55:49 INFO - 'USER': 'cltbld', 05:55:49 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549', 05:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:49 INFO - '_': '/tools/buildbot/bin/python'} 05:55:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 05:55:49 INFO - mozversion application_buildid: 20170730120914 05:55:49 INFO - mozversion application_changeset: 6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1 05:55:49 INFO - mozversion application_display_name: Nightly 05:55:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:49 INFO - mozversion application_name: Firefox 05:55:49 INFO - mozversion application_remotingname: firefox 05:55:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:55:49 INFO - mozversion application_vendor: Mozilla 05:55:49 INFO - mozversion application_version: 56.0a1 05:55:49 INFO - mozversion platform_buildid: 20170730120914 05:55:49 INFO - mozversion platform_changeset: 6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1 05:55:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:55:49 INFO - mozversion platform_version: 56.0a1 05:55:49 INFO - using testdate: 1501419349 05:55:49 INFO - actual date: 1501419349 05:55:49 INFO - starting webserver on 'localhost:52254' 05:55:49 INFO - SUITE-START | Running 2 tests 05:55:49 INFO - TEST-START | dromaeo_css 05:55:49 INFO - Initialising browser for dromaeo_css test... 05:55:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52254/getInfo.html -profile /tmp/tmp7Iar65/profile 05:55:49 INFO - TEST-INFO | started process 19203 (/builds/slave/test/build/application/firefox/firefox http://localhost:52254/getInfo.html) 05:55:55 INFO - TEST-INFO | 19203: exit 0 05:55:55 INFO - Browser initialized. 05:55:55 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:55 INFO - TEST-INFO | started process 19428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Iar65/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:56 INFO - PID 19428 | 05:55:56 INFO - PID 19428 | (/builds/slave/test/build/application/firefox/firefox:19483): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:55:56 INFO - PID 19428 | 05:56:07 INFO - PID 19428 | RSS: Main: 173404160 05:56:07 INFO - PID 19428 | 05:59:06 INFO - PID 19428 | Cycle 1(1): loaded http://localhost:52254/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52254/tests/dromaeo/cssquery-ext.html) 05:59:07 INFO - PID 19428 | RSS: Main: 173924352 05:59:07 INFO - PID 19428 | 06:02:09 INFO - PID 19428 | Cycle 1(1): loaded http://localhost:52254/tests/dromaeo/cssquery-ext.html (next: http://localhost:52254/tests/dromaeo/cssquery-jquery.html) 06:02:10 INFO - PID 19428 | RSS: Main: 172662784 06:02:10 INFO - PID 19428 | 06:05:12 INFO - PID 19428 | Cycle 1(1): loaded http://localhost:52254/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52254/tests/dromaeo/cssquery-mootools.html) 06:05:12 INFO - PID 19428 | RSS: Main: 175259648 06:05:12 INFO - PID 19428 | 06:08:14 INFO - PID 19428 | Cycle 1(1): loaded http://localhost:52254/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52254/tests/dromaeo/cssquery-prototype.html) 06:08:15 INFO - PID 19428 | RSS: Main: 173879296 06:08:15 INFO - PID 19428 | 06:11:19 INFO - PID 19428 | Cycle 1(1): loaded http://localhost:52254/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52254/tests/dromaeo/cssquery-yui.html) 06:11:20 INFO - PID 19428 | RSS: Main: 176939008 06:11:20 INFO - PID 19428 | 06:14:21 INFO - PID 19428 | Cycle 1(1): loaded http://localhost:52254/tests/dromaeo/cssquery-yui.html (next: http://localhost:52254/tests/dromaeo/cssquery-dojo.html) 06:14:22 INFO - PID 19428 | RSS: Main: 177491968 06:14:22 INFO - PID 19428 | 06:14:22 INFO - PID 19428 | __start_tp_report 06:14:22 INFO - PID 19428 | _x_x_mozilla_page_load 06:14:22 INFO - PID 19428 | _x_x_mozilla_page_load_details 06:14:22 INFO - PID 19428 | |i|pagename|runs| 06:14:22 INFO - PID 19428 | |0;dojo.html;3127.37452509498;3163.3040731039164;3173.603299587551;3194.6645602211765;3203.4233837909183;6127.601705889114;6165.722542485588;6200.348963358844;6239.6256224626495;6293.653849038301;6225.3463386344465;6292.811215663526;6304.936950630492;6328.493720502361;6334.461570766479;5678.829635110943;5688.658680479164;5743.253377060976;5770.451807078321;5826.766929322822;5598.748056337475;5682.659040457565;5821.952048631245;5823.56323275756;5841.123831425278;5710.428957104298;5712.742926568273;5780.5664575156825;5788.363280039192;5795.101759227306;5646.068398714207;5691;5721.056025755745;5777.393373695785;5786.305643322786;5656.490915817555;5707.6575405475805;5718.685472299022;5719.19931209631;5735.996200664908;6204.47261982732;6224.657643829588;6235.96882015587;6248.5313601480075;6274.654893980829;6730.360615741497;6735.461163106988;6746.359095885883;6819.24988251297;6828.317168283182;6627.834304142387;6766.69549870257;6769.05233267343;6793.388595026422;6882.242953275136;6175.59858609189;6192.102145188923;6192.442680158807;6235.844103897393;6241.34465881085;6748.696308666122;6848.6918088686125;6849.212340580797;6894.13823272091;6912.619805910623;6658.700358483879;6666.400023997863;6672.666366681744;6674.199096108498;6677.131972843499;6727.865442691119;6735.494837887178;6738.124043874265;6738.7304507819135;6742.089817874622;6694.297098804653;6696.531242812956;6709.463242940553;6739.663016849138;6777.627230502271;6725.8654826903185;6725.932740672629;6828.385445309946;6828.487863410264;6829.69266383004;5290.127129023745;5427.294451721251;5469.371022332403;5478.58910581708;5482.780688772485;4638.768061596974;4644.883877903079;4658;4658.720476771405;4761.714297142183;5763.971180144073;5801.332846722681;5808.709564521757;5811.244538210006;5814.476697097197;6412;6771.119754431892;6844.828879278058;6857.348551887562;6861.622610756456;5718.456746609066;5730.74211660468;5817.796377126865;5826.563007774434;5831.4168583141345;5787.479126878601;5887.646741195542;5893.027650437715;5901.7639294427745;5989.2812862456785;6477.481801455872;6478.740850365933;6496.805095847132;6508.088867558546;6508.869822603616;6774.898376524455;6777.085093512313;6810.9318906810295;6858.451323893977;6886.965565172142;6499.382558657109;6524;6528.21661400635;6621.370969757865;6629.569078009914;6474.5791523550815;6586.341365863375;6622.801315960529;6706.497012724163;6715.3620406061345;6722.932770672231;6798.388145066968;6801.557898736566;6808.353206445379;6832.965835170792;6486.708098135689;6573.408393244631;6605.57063790852;6621.039949207434;6621.867562648624;6520.152380190545;6542.771003014872;6601.471882249504;6620.3710647488415;6634.104395906491;6337.556371054166;6456.451201647913;6465.094886715958;6541.803745887631;6558.409743123142;6500.869982600416;6501.772437964649;6667.933320666732;6672.065910772399;6677.198736151693;6399.104125422352;6435.549511534147;6458.677066146768;6486.935130648633;6511.446527045254 06:14:22 INFO - PID 19428 | |1;ext.html;809.9028116626006;873.0570983337996;899.7435730816717;1170.1399471388522;1190.0776897904118;29018;39490;40047.199056018864;40137;40190.799046004766;39624.20751584967;39947.80026099866;40008.19983600326;40034.599654003454;40064.799676001654;7602.467827252094;7727.343175830061;7748.651310691032;7753.961230193841;7754.651040703154;7508.662110205027;7657.923420765776;7659.885101723478;7666.156722760492;7669.961650191769;7529.1341495727875;7686.538807671557;7693.961530192341;7729.381649468029;7736.303732664059;7591.27882851131;7653.923460765404;7654.808629784245;7696.615169241515;7698;7393.815154621124;7497.962510187469;7558.244175582453;7592.468527203098;7681.961590192013;37061.62938370609;37445.25109497822;37543.81228093842;37565.060873478105;37622.623773762185;3491.1970246843366;3538.150843797496;3546.592141903688;3560.2167523144867;3562.323158599858;29900.8504957476;29961.550576741367;29979.70020299791;30037.549436758247;30110.397792044037;4835.05716385305;4848.781804818792;4858.975705121487;4860.222364421711;4903.4606193318705;175686;176398;176498;176789;177109.1144544269;46310.768446158225;47002.294965575544;47018.52981470142;47323.5267647326;47897.76051119722;49707.50292497101;49915;50022;50033.999320014125;50048.74975625099;16299.918500407422;16343.101129437995;16413.83586164147;16485.670286594202;16514.917425413038;13497.460101595827;13520.526781562598;13576.321183940763;13592.11651242666;13602.115862468909;12499.687507812378;13630.659233519242;13698.726025479635;13770;13920.58238252854;4886.003201654468;5571.693556854331;5704.914426283609;5784;5824.504917082011;981.7643765496372;989.3964681544252;1008.7629407089328;1012.0233974214918;1035.984460233097;22600.434989125075;22661.660075098887;23059.538809224057;23185.075770009273;23487;1087.423665457293;1109.290054365207;1118.3737107219983;1120.445379537118;1130.9547618095348;11845.822312665317;12117.515299388102;12130.272183668832;12376.690582735324;12523.499060037679;237974;238364;238704;239026;239951;51680;51793.22310165351;55260.17109743357;56401.71799140978;56487;1467.3250304859885;1468.992655036718;1485.7325681377456;1499.3429174465557;1508.3363320139104;26524.336891577866;27907.302317442227;28207.294817629725;28309;28451.573226401208;48123.75938120287;49736.502634973185;49833.50166498288;49888.501114989835;49967;205945;207566;207975;208650;208685;34933.12667183341;35224.82387588046;35287;35382.646173537934;35408.82295588506;36929.44605830861;42867;43478.347824782024;43545.78227108844;43840.780796095816;30710.232244194074;30915.381692365576;31121.8443907779;31163.37673246477;31587.84206078955;28754.424911502072;30650.233744156576;30840;30887;31179.84410077935;33459.1635209112;34571.13572160716;34636;34648;34711.652883470844;28590.42819143647;30349.393012140074;30402.84798575993;30977.69022309748;31411.57846902123;23315.883420582788;23413;23529.764702352757;23569.646455303526;25450.363740906625 06:14:22 INFO - PID 19428 | |2;jquery.html;575.8502789274789;580.3645008715455;589.9174115623811;593.973271202796;595.583091835715;21958.45103872404;22707;22707.432314192152;22768.203112891053;22777.31668049957;24410.511789764194;26011.739882601167;26041.609375859378;26105.21684349468;26113.999999999953;6393.232812062536;6618.271990081087;6620.6358650274215;6621.470282377399;6623.03965924943;5885.7351419186025;6383;6393.456556192729;6475.611463312216;6559.245686746014;6391.776287829927;6392.968035159818;6396.456301214403;6397.1363865877975;6398.360163983611;6331.968340158316;6370.140031095789;6377.585456945307;6378.202724659441;6381.585196962205;5972.880542389128;5978.790742324041;5980.372060933583;5981.551383646244;5987.191729116557;29655.25861853449;29978.25054373636;30058.098257052105;30620.856540041983;31166.844165779254;1902.3817259390753;1928.7974762650001;1929.53691114133;1930.362980216525;1939.5732938753451;18855.622887542173;19407.51481212967;19550.31573894921;19565.315213967442;19581.902090489457;2288.9542209155725;2354.176038386568;2421.067888862783;2433.2821817563863;2439.865807380593;135709;140886;143729;144911.3772155694;145314;14746.18895960711;14793.704125917422;14931.477398291008;15251.313690883937;15681.451149209723;23899.28302150938;23910.88044559766;23912;24043.51912961766;24063.157789477285;10485;10605.25763196569;10704;10746.462676866126;10839.403832789272;9952.601895924226;9985.1512621428;10050.246231532665;10171.440570768678;10189.23580731448;7775.950246716621;8943.150400711922;9109.681161159328;9155;9352.953235233781;2634.288742039677;2642.3262068172494;2784.2320126719274;2801.677807052174;2852.7860410469298;933.071593764209;934.2572654739498;936.438137117724;956.2541217850088;973.9659111931048;18777;19040.52398690044;19113.90443047776;19634;24336.513269734507;997.7755005123789;999.8300288950895;1006.5923301063082;1034.8913364096811;1038.6883934819675;10734.248602597743;11369.602063927723;11490.195686301879;13234.536791212262;13702.38339274735;491897;493067;503509;510877;519332;128161.35919320343;128333;129527;132356;134116.32941835228;1252.9122961392798;1278.1755767530076;1310.4365122997203;1315.8881495072835;1320.9207447552985;20359.389218323475;21506.569868602226;22210;22226.110955561595;22339.329820105424;54402;56826.43173568211;56992.430075698714;58562.12156817736;59990;74901;75746;76478.23521764712;76560;76832;19690.409287720817;20504.692429613868;21044.579108417438;21280.148794048066;21286.254981075588;23545.764542354358;23599.764002359756;23676.289711308687;23757.881210593838;23853;17804.91097544504;18030.639387212446;18113.275468981094;18216.81783182204;18522.351717689817;13520.188788672318;14219.431222750974;14302.57092287233;14373.281335932952;14976.101433914;18600.627987440446;18705.81294187041;19027.33404330842;19244.23023079117;19321.227150913805;20156.496087597927;20364;20373.471989601137;20491.69262461094;20603.4849128773;16262.268197930885;16445;16727.330906763593;16798.58003549921;16994.66010679804 06:14:22 INFO - PID 19428 | |3;mootools.html;1368.4321006782186;1425.387083554072;1437.6549628089263;1444.8193975753031;1446.6455718349007;13516.797248041275;13870.791938120936;14225.719685228327;14238.92880535596;14249.287535623229;14482.637934051654;14708.117512949204;14726.26368681567;14729.558113256593;14778.408863645469;2710.105665130502;2769.141566114511;2769.9446011079867;2771.210205091549;2773.459175460786;2514.5599520084;2640.749128832758;2664.2540088775077;2670.4792565449743;2731.590261460777;2691.5020721166547;2711.4848178845955;2716.2530304166316;2724.196362073183;2724.6866610339766;2585.5733803922426;2638.4723055388904;2642.8810703518197;2648.523265812153;2654.0976068136733;2586.456844062749;2607.8304910180777;2616.2674451153516;2620.9475810483873;2624.094687332867;13901.930490347584;13936.930315348358;14023.088499247619;14024.298785060706;14046.595340465974;7234.49358544902;7433.888491672629;7499.100107987022;7502.062242219723;7514.887276690854;5065.594752419797;5188.570418767215;5209.114450543417;5262.894742105174;5289;1735.8003829559636;1741.3295881085746;1751.95620109497;1775.1834156288123;1776.3427531813184;22430.102795888146;22783.54432911349;22825.885870570542;22826.429339266484;22866.657000145013;6293.685315734195;6461.0616814956265;6466.644334561644;6577.868442631217;6608.801735947929;15584.220788960507;15666.13836238995;15698.215089245721;15701.450449234222;15713.450029248921;7412.555246685216;7562.848743025219;7568.962155189299;7575.810604734926;7577.5453472791805;6300;6965.756198533027;6979.267176946449;7105.396041336544;7116.181639111568;4903.950960490421;5039.193729003415;5044.672096313728;5073.365829271341;5159.329287192716;1335.8797708206307;1366.41244264967;1422.8932830037788;1458.8176477940258;1510.5015344936144;758.5638258001671;763.9221318014991;769.0655853138463;798.876174193001;799.3085980626716;7114.253003434668;7189.59082146329;7241.8551628967125;7330.5968171751065;7376.299251571092;884.6019291318933;925.7037747920735;927.9907200928039;947.3605316411532;956.7034219391871;4280.828766849353;4750.714957102585;4788.497207793132;4803.975980120077;4851.393575803025;17320;17956.730649040273;18054.638907221783;18126.456206313833;18298.45104646863;18497.907510462363;18917.43247702571;18994.335198267996;19367.418977430698;19418.417447476597;10111.443870587042;10341.37951722899;10397.168226541708;10470.16238700902;10476.63331783384;6793.898091528532;7473.215312392338;7708.344790692854;7788.610569471391;7839.137694853447;16160.838391615933;16515.91742041282;16799.748003780198;16856.410025649042;16944.74582881233;15825.446109386578;16592.83407165913;16714.080725560212;16962.406315778888;17206.483805485856;11313.377764223047;11406.14453915943;11553.826692599785;11586.942065289619;11589.82615260755;12526.87473125257;12575.43410546546;12660.303683297507;12674.619761407173;12694.365281735692;9209.125133112344;9215.677451289173;9247;9700.75748106303;10062.798744024933;8908.163163810379;9384.812303754023;9481.952590237004;9482.715518534455;9646.324757266924;8876.733697989072;8965.641374344954;8972.461652300883;8979.685711000346;8990.190882820578;6106.572539922163;6347.587406818727;6407.807765767035;6409.102725618511;6410.0705397718;6252.906206406817;6331.683415829098;6354.205724284465;6461.418472337512;6500.187476565429 06:14:22 INFO - PID 19428 | |4;prototype.html;476.5687053216838;494.4832649880874;510.41557416757837;512.9640925135242;520.7396301849076;6214.502839772818;6216.595921265114;6258.655773932438;6285.905711414321;6360.300366959631;5954.642721436717;6116.510679145669;6122.326544080159;6123.632582045069;6171.531387445024;4934.728589927553;4966.379202599675;4971.900561988758;5026.120428924933;5051.873703157414;4932.778024988884;4944.082991035289;4944.700714167911;4982.850514484553;4993.800247990094;4807.639427042968;4867.756612169395;4902.3872015998;4956.107900577895;4957.4298955620025;4894.632902532288;4896.971635956454;4940.3330550375595;4958.8512344629535;4996.4254110777;4407.537208593084;4417.955820441786;4448.377227188196;4486.55134486552;4505.571970662814;6023.939760602426;6047.425494578008;6074.665893375863;6083.148359229667;6114.755409783604;5644.6330988486025;5730.025895597759;5735.741891614887;5760.308762948431;5785.016547186946;6437.485001199892;6466.224053113609;6466.6766661666725;6495.350464953467;6579.407853293226;4811.855644330676;4812.831550895737;4832.516748325174;4839.975800120977;4863.975680121612;6776.220734615533;6793.932060679429;6931.861362772716;6937.826554336131;6963.721451141898;4914.262860570871;4959.851204463872;4966.726830024383;4978.377702787152;5002.899942001212;5021.447640759514;5092.2361645753435;5094.5160209780015;5099.745012749348;5105.361829771278;5669.149627555899;5726.284214473191;5739.655620662774;5739.942600573941;5750.769969201185;6511.772087976993;6629.9337006630285;6641.302663220389;6645.501587380966;6698.363655452724;1637.9262933168036;1640.5816516788143;1709.9230534625972;1725.7066298729246;1742.7298768690873;1184.4492311075392;1204.5723768062387;1204.674737820801;1214.481897627965;1214.690253985228;5672.376038635747;5675.574331925122;5712.200291959129;5743.310802703619;5762.9135562966585;6545.697984632463;6638.336166383323;6660.367265109807;6670.199576050905;6673.3993940544615;5561.221428999943;5676.962824888665;5686.601937864392;5704.0588302929555;5724.284464441945;3578.248567800791;3597.3165098631175;3602.0454579536445;3603.85584576614;3604.6395360464267;6386.936130638727;6469.838254043687;6491.837704057436;6533.314002029813;6584.6378449184795;6742.39318461331;6774.966125169342;6813;6819.181698196248;6902.758403455855;6392.520560957947;6426.389492998158;6476.773312934025;6492.220933488012;6497.350264973465;6578.638174900427;6602.207735071822;6709.597424154566;6740.528163028737;6742.258351581224;6544.149260596282;6570.29172415166;6589.17635295588;6600.306967768315;6617.2721000688925;6479.2224933006455;6530.91010876515;6533.771318003847;6572.934270657423;6581.868362632625;4938.419705694287;4964.0071985603745;4966.900661986812;4978.253262010582;5004.549590536869;6611.471082313499;6673.399394054559;6680.899786503303;6709.630970296681;6714.462842972648;6369.235691716838;6423.678816059271;6471.870562588816;6488.870222595616;6507.674616269073;6375.649339286384;6401.231852177769;6444.871102578016;6459.321771214143;6491.4806815455595;5824.970875145597;6408.61548307103;6419.614823110628;6477.77327793525;6502.154719886385;6510.414062734377;6519.967400162969;6562.179727534059;6578.80263592093;6580.440662543546;6173.9073913892225;6274.937250627435;6305.211848518935;6378.681065946591;6383.616982981036 06:14:22 INFO - PID 19428 | |5;yui.html;894.6063731957938;918.4902379179555;919.3748251189189;923.0031565908819;935.2517985611511;17718.734218986727;18758.62482750344;18807.811921880777;18853.340133095346;21401.57196856062;20767.68848467274;21680.2411915583;21778.237761678345;21880.23419180325;21896.671549926763;972.1153750087421;1041.1722680469045;1048.9213309001818;1050.448514529874;1051.747580580659;1015.4668798880573;1044.639599338227;1064.473085822519;1064.8775390830076;1066.610687099207;1096.7477480179564;1100.8018556659797;1104.2491106047885;1104.304288298371;1104.9834252486219;1082.4209048159237;1094.8357746338033;1098.1599076706325;1099.0493223361814;1099.6151347028556;796.8246985663145;807.8424707182102;807.8788181772723;807.9515229086273;809.6761295481796;18398.632027359512;18489.630207395778;18579.72130418045;18639.254429822926;19683;20487.38537843867;20517.5896482071;20770.688439673417;21058.684119738216;21126.577468450545;15762.133082680448;15912.840871591252;15945.681086378323;15951.441699540577;16396.508104756875;3590.0845284452557;3591.120175556979;3595.3708101082207;3610.855565777366;3616.1682812952904;113518;114972;116844;118036;118550.40724796407;16000.75998860018;16521.504354869372;16575.585610359838;16593.6681266374;16610.169491525376;29769.40461190764;30361.392772144434;30399.848000760296;30405.847970760005;30432;7750.573718445539;8075.555844428495;8083.757487275391;8124.959375203086;8181.631826567819;3912.5304963404005;3959.6634286085427;3959.821808018646;3960.0495880988933;3967.7024223183375;5181.4300426953005;5184.533391994663;5225.425203227642;5291.788328466895;5299.205119232069;926.3376685669779;932.7947851472666;934.8644446555347;936.3352020065829;939.7086903060073;664.8105289992329;669.1267895396456;679.8980152977093;685.5783693028851;701.8631366883511;10932;11519.827202591969;11545.884541154648;11673.357965311989;11707.648770536898;640.1230314469207;668.6122049211446;677.989830152548;679.2629996453903;685.8285428642839;4979;5174.09453345663;5193.37679478465;5239.1355426354985;5391.191321301836;98439.50780246053;102349;105174;105479;107856.46071769591;86151;87388.56305718557;89627;89810.10189898148;90514;77515.2248477508;79323.60338198271;79332.20667793248;79660.99999999884;84610.57694711487;10104.89895101069;10135.391876487434;10207;10578.471076445992;10623.256372053882;32810.343793124484;34165.658343416246;34248.65751342455;34670.95987120391;36830.263394732494;64905.35094648993;65433.34566654272;66181.45202680521;68096.6595167021;69118.96321555281;18723.531911702317;19119.90440047791;19182.616347673247;19500.31748888782;19536.21855125836;21417.89291053535;21503.677444838027;22052.88973555122;22155.33533993983;22661.773382265965;18176.545586360447;19066.52333691669;19220.423387298404;19321.806781932562;19911.303104391278;19210.615787683888;19353.032348382807;19356.70964935499;19425.51436214106;19768;18172;18640.533986650444;18853.15160817739;18905;18952.43142705721;12885.806712899126;12983.285919274153;13084.803727943898;14084.929575352058;14468.927655361656;12117;12967.351632418153;13163.276019819003;13401.329933503092;13467.191968481922 06:14:22 INFO - PID 19428 | __end_tp_report 06:14:22 INFO - PID 19428 | __start_cc_report 06:14:22 INFO - PID 19428 | _x_x_mozilla_cycle_collect,386 06:14:22 INFO - PID 19428 | __end_cc_report 06:14:22 INFO - PID 19428 | __startTimestamp1501420462160__endTimestamp 06:14:22 INFO - PID 19428 | 06:14:22 INFO - PID 19428 | ------- Summary: start ------- 06:14:22 INFO - PID 19428 | Number of tests: 6 06:14:22 INFO - PID 19428 | 06:14:22 INFO - PID 19428 | [#0] dojo.html Cycles:165 Average:6194.87 Median:6474.58 stddev:739.81 (11.4%) stddev-sans-first:701.85 06:14:22 INFO - PID 19428 | Values: 3127.4 3163.3 3173.6 3194.7 3203.4 6127.6 6165.7 6200.3 6239.6 6293.7 6225.3 6292.8 6304.9 6328.5 6334.5 5678.8 5688.7 5743.3 5770.5 5826.8 5598.7 5682.7 5822.0 5823.6 5841.1 5710.4 5712.7 5780.6 5788.4 5795.1 5646.1 5691.0 5721.1 5777.4 5786.3 5656.5 5707.7 5718.7 5719.2 5736.0 6204.5 6224.7 6236.0 6248.5 6274.7 6730.4 6735.5 6746.4 6819.2 6828.3 6627.8 6766.7 6769.1 6793.4 6882.2 6175.6 6192.1 6192.4 6235.8 6241.3 6748.7 6848.7 6849.2 6894.1 6912.6 6658.7 6666.4 6672.7 6674.2 6677.1 6727.9 6735.5 6738.1 6738.7 6742.1 6694.3 6696.5 6709.5 6739.7 6777.6 6725.9 6725.9 6828.4 6828.5 6829.7 5290.1 5427.3 5469.4 5478.6 5482.8 4638.8 4644.9 4658.0 4658.7 4761.7 5764.0 5801.3 5808.7 5811.2 5814.5 6412.0 6771.1 6844.8 6857.3 6861.6 5718.5 5730.7 5817.8 5826.6 5831.4 5787.5 5887.6 5893.0 5901.8 5989.3 6477.5 6478.7 6496.8 6508.1 6508.9 6774.9 6777.1 6810.9 6858.5 6887.0 6499.4 6524.0 6528.2 6621.4 6629.6 6474.6 6586.3 6622.8 6706.5 6715.4 6722.9 6798.4 6801.6 6808.4 6833.0 6486.7 6573.4 6605.6 6621.0 6621.9 6520.2 6542.8 6601.5 6620.4 6634.1 6337.6 6456.5 6465.1 6541.8 6558.4 6500.9 6501.8 6667.9 6672.1 6677.2 6399.1 6435.5 6458.7 6486.9 6511.4 06:14:22 INFO - PID 19428 | 06:14:22 INFO - PID 19428 | [#1] ext.html Cycles:180 Average:37777.48 Median:19101.42 stddev:54282.08 (284.2%) stddev-sans-first:54363.38 06:14:22 INFO - PID 19428 | Values: 809.9 873.1 899.7 1170.1 1190.1 29018.0 39490.0 40047.2 40137.0 40190.8 39624.2 39947.8 40008.2 40034.6 40064.8 7602.5 7727.3 7748.7 7754.0 7754.7 7508.7 7657.9 7659.9 7666.2 7670.0 7529.1 7686.5 7694.0 7729.4 7736.3 7591.3 7653.9 7654.8 7696.6 7698.0 7393.8 7498.0 7558.2 7592.5 7682.0 37061.6 37445.3 37543.8 37565.1 37622.6 3491.2 3538.2 3546.6 3560.2 3562.3 29900.9 29961.6 29979.7 30037.5 30110.4 4835.1 4848.8 4859.0 4860.2 4903.5 175686.0 176398.0 176498.0 176789.0 177109.1 46310.8 47002.3 47018.5 47323.5 47897.8 49707.5 49915.0 50022.0 50034.0 50048.7 16299.9 16343.1 16413.8 16485.7 16514.9 13497.5 13520.5 13576.3 13592.1 13602.1 12499.7 13630.7 13698.7 13770.0 13920.6 4886.0 5571.7 5704.9 5784.0 5824.5 981.8 989.4 1008.8 1012.0 1036.0 22600.4 22661.7 23059.5 23185.1 23487.0 1087.4 1109.3 1118.4 1120.4 1131.0 11845.8 12117.5 12130.3 12376.7 12523.5 237974.0 238364.0 238704.0 239026.0 239951.0 51680.0 51793.2 55260.2 56401.7 56487.0 1467.3 1469.0 1485.7 1499.3 1508.3 26524.3 27907.3 28207.3 28309.0 28451.6 48123.8 49736.5 49833.5 49888.5 49967.0 205945.0 207566.0 207975.0 208650.0 208685.0 34933.1 35224.8 35287.0 35382.6 35408.8 36929.4 42867.0 43478.3 43545.8 43840.8 30710.2 30915.4 31121.8 31163.4 31587.8 28754.4 30650.2 30840.0 30887.0 31179.8 33459.2 34571.1 34636.0 34648.0 34711.7 28590.4 30349.4 30402.8 30977.7 31411.6 23315.9 23413.0 23529.8 23569.6 25450.4 06:14:22 INFO - PID 19428 | 06:14:22 INFO - PID 19428 | [#2] jquery.html Cycles:180 Average:36275.91 Median:2321.57 stddev:85255.30 (3672.3%) stddev-sans-first:85452.33 06:14:22 INFO - PID 19428 | Values: 575.9 580.4 589.9 594.0 595.6 21958.5 22707.0 22707.4 22768.2 22777.3 24410.5 26011.7 26041.6 26105.2 26114.0 6393.2 6618.3 6620.6 6621.5 6623.0 5885.7 6383.0 6393.5 6475.6 6559.2 6391.8 6393.0 6396.5 6397.1 6398.4 6332.0 6370.1 6377.6 6378.2 6381.6 5972.9 5978.8 5980.4 5981.6 5987.2 29655.3 29978.3 30058.1 30620.9 31166.8 1902.4 1928.8 1929.5 1930.4 1939.6 18855.6 19407.5 19550.3 19565.3 19581.9 2289.0 2354.2 2421.1 2433.3 2439.9 135709.0 140886.0 143729.0 144911.4 145314.0 14746.2 14793.7 14931.5 15251.3 15681.5 23899.3 23910.9 23912.0 24043.5 24063.2 10485.0 10605.3 10704.0 10746.5 10839.4 9952.6 9985.2 10050.2 10171.4 10189.2 7776.0 8943.2 9109.7 9155.0 9353.0 2634.3 2642.3 2784.2 2801.7 2852.8 933.1 934.3 936.4 956.3 974.0 18777.0 19040.5 19113.9 19634.0 24336.5 997.8 999.8 1006.6 1034.9 1038.7 10734.2 11369.6 11490.2 13234.5 13702.4 491897.0 493067.0 503509.0 510877.0 519332.0 128161.4 128333.0 129527.0 132356.0 134116.3 1252.9 1278.2 1310.4 1315.9 1320.9 20359.4 21506.6 22210.0 22226.1 22339.3 54402.0 56826.4 56992.4 58562.1 59990.0 74901.0 75746.0 76478.2 76560.0 76832.0 19690.4 20504.7 21044.6 21280.1 21286.3 23545.8 23599.8 23676.3 23757.9 23853.0 17804.9 18030.6 18113.3 18216.8 18522.4 13520.2 14219.4 14302.6 14373.3 14976.1 18600.6 18705.8 19027.3 19244.2 19321.2 20156.5 20364.0 20373.5 20491.7 20603.5 16262.3 16445.0 16727.3 16798.6 16994.7 06:14:22 INFO - PID 19428 | 06:14:22 INFO - PID 19428 | [#3] mootools.html Cycles:180 Average:8449.07 Median:2700.80 stddev:5812.30 (215.2%) stddev-sans-first:5804.25 06:14:22 INFO - PID 19428 | Values: 1368.4 1425.4 1437.7 1444.8 1446.6 13516.8 13870.8 14225.7 14238.9 14249.3 14482.6 14708.1 14726.3 14729.6 14778.4 2710.1 2769.1 2769.9 2771.2 2773.5 2514.6 2640.7 2664.3 2670.5 2731.6 2691.5 2711.5 2716.3 2724.2 2724.7 2585.6 2638.5 2642.9 2648.5 2654.1 2586.5 2607.8 2616.3 2620.9 2624.1 13901.9 13936.9 14023.1 14024.3 14046.6 7234.5 7433.9 7499.1 7502.1 7514.9 5065.6 5188.6 5209.1 5262.9 5289.0 1735.8 1741.3 1752.0 1775.2 1776.3 22430.1 22783.5 22825.9 22826.4 22866.7 6293.7 6461.1 6466.6 6577.9 6608.8 15584.2 15666.1 15698.2 15701.5 15713.5 7412.6 7562.8 7569.0 7575.8 7577.5 6300.0 6965.8 6979.3 7105.4 7116.2 4904.0 5039.2 5044.7 5073.4 5159.3 1335.9 1366.4 1422.9 1458.8 1510.5 758.6 763.9 769.1 798.9 799.3 7114.3 7189.6 7241.9 7330.6 7376.3 884.6 925.7 928.0 947.4 956.7 4280.8 4750.7 4788.5 4804.0 4851.4 17320.0 17956.7 18054.6 18126.5 18298.5 18497.9 18917.4 18994.3 19367.4 19418.4 10111.4 10341.4 10397.2 10470.2 10476.6 6793.9 7473.2 7708.3 7788.6 7839.1 16160.8 16515.9 16799.7 16856.4 16944.7 15825.4 16592.8 16714.1 16962.4 17206.5 11313.4 11406.1 11553.8 11586.9 11589.8 12526.9 12575.4 12660.3 12674.6 12694.4 9209.1 9215.7 9247.0 9700.8 10062.8 8908.2 9384.8 9482.0 9482.7 9646.3 8876.7 8965.6 8972.5 8979.7 8990.2 6106.6 6347.6 6407.8 6409.1 6410.1 6252.9 6331.7 6354.2 6461.4 6500.2 06:14:22 INFO - PID 19428 | 06:14:22 INFO - PID 19428 | [#4] prototype.html Cycles:180 Average:5480.44 Median:6098.95 stddev:1540.27 (25.3%) stddev-sans-first:1498.10 06:14:22 INFO - PID 19428 | Values: 476.6 494.5 510.4 513.0 520.7 6214.5 6216.6 6258.7 6285.9 6360.3 5954.6 6116.5 6122.3 6123.6 6171.5 4934.7 4966.4 4971.9 5026.1 5051.9 4932.8 4944.1 4944.7 4982.9 4993.8 4807.6 4867.8 4902.4 4956.1 4957.4 4894.6 4897.0 4940.3 4958.9 4996.4 4407.5 4418.0 4448.4 4486.6 4505.6 6023.9 6047.4 6074.7 6083.1 6114.8 5644.6 5730.0 5735.7 5760.3 5785.0 6437.5 6466.2 6466.7 6495.4 6579.4 4811.9 4812.8 4832.5 4840.0 4864.0 6776.2 6793.9 6931.9 6937.8 6963.7 4914.3 4959.9 4966.7 4978.4 5002.9 5021.4 5092.2 5094.5 5099.7 5105.4 5669.1 5726.3 5739.7 5739.9 5750.8 6511.8 6629.9 6641.3 6645.5 6698.4 1637.9 1640.6 1709.9 1725.7 1742.7 1184.4 1204.6 1204.7 1214.5 1214.7 5672.4 5675.6 5712.2 5743.3 5762.9 6545.7 6638.3 6660.4 6670.2 6673.4 5561.2 5677.0 5686.6 5704.1 5724.3 3578.2 3597.3 3602.0 3603.9 3604.6 6386.9 6469.8 6491.8 6533.3 6584.6 6742.4 6775.0 6813.0 6819.2 6902.8 6392.5 6426.4 6476.8 6492.2 6497.4 6578.6 6602.2 6709.6 6740.5 6742.3 6544.1 6570.3 6589.2 6600.3 6617.3 6479.2 6530.9 6533.8 6572.9 6581.9 4938.4 4964.0 4966.9 4978.3 5004.5 6611.5 6673.4 6680.9 6709.6 6714.5 6369.2 6423.7 6471.9 6488.9 6507.7 6375.6 6401.2 6444.9 6459.3 6491.5 5825.0 6408.6 6419.6 6477.8 6502.2 6510.4 6520.0 6562.2 6578.8 6580.4 6173.9 6274.9 6305.2 6378.7 6383.6 06:14:22 INFO - PID 19428 | 06:14:22 INFO - PID 19428 | [#5] yui.html Cycles:180 Average:22622.08 Median:20914.69 stddev:29718.82 (142.1%) stddev-sans-first:29757.40 06:14:22 INFO - PID 19428 | Values: 894.6 918.5 919.4 923.0 935.3 17718.7 18758.6 18807.8 18853.3 21401.6 20767.7 21680.2 21778.2 21880.2 21896.7 972.1 1041.2 1048.9 1050.4 1051.7 1015.5 1044.6 1064.5 1064.9 1066.6 1096.7 1100.8 1104.2 1104.3 1105.0 1082.4 1094.8 1098.2 1099.0 1099.6 796.8 807.8 807.9 808.0 809.7 18398.6 18489.6 18579.7 18639.3 19683.0 20487.4 20517.6 20770.7 21058.7 21126.6 15762.1 15912.8 15945.7 15951.4 16396.5 3590.1 3591.1 3595.4 3610.9 3616.2 113518.0 114972.0 116844.0 118036.0 118550.4 16000.8 16521.5 16575.6 16593.7 16610.2 29769.4 30361.4 30399.8 30405.8 30432.0 7750.6 8075.6 8083.8 8125.0 8181.6 3912.5 3959.7 3959.8 3960.0 3967.7 5181.4 5184.5 5225.4 5291.8 5299.2 926.3 932.8 934.9 936.3 939.7 664.8 669.1 679.9 685.6 701.9 10932.0 11519.8 11545.9 11673.4 11707.6 640.1 668.6 678.0 679.3 685.8 4979.0 5174.1 5193.4 5239.1 5391.2 98439.5 102349.0 105174.0 105479.0 107856.5 86151.0 87388.6 89627.0 89810.1 90514.0 77515.2 79323.6 79332.2 79661.0 84610.6 10104.9 10135.4 10207.0 10578.5 10623.3 32810.3 34165.7 34248.7 34671.0 36830.3 64905.4 65433.3 66181.5 68096.7 69119.0 18723.5 19119.9 19182.6 19500.3 19536.2 21417.9 21503.7 22052.9 22155.3 22661.8 18176.5 19066.5 19220.4 19321.8 19911.3 19210.6 19353.0 19356.7 19425.5 19768.0 18172.0 18640.5 18853.2 18905.0 18952.4 12885.8 12983.3 13084.8 14084.9 14468.9 12117.0 12967.4 13163.3 13401.3 13467.2 06:14:22 INFO - PID 19428 | -------- Summary: end -------- 06:14:22 INFO - PID 19428 | 06:14:22 INFO - TEST-INFO | 19428: exit 0 06:14:22 INFO - TEST-OK | dromaeo_css | took 1113527ms 06:14:22 INFO - TEST-START | kraken 06:14:22 INFO - Initialising browser for kraken test... 06:14:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52254/getInfo.html -profile /tmp/tmpVhv5Sv/profile 06:14:22 INFO - TEST-INFO | started process 19802 (/builds/slave/test/build/application/firefox/firefox http://localhost:52254/getInfo.html) 06:14:28 INFO - TEST-INFO | 19802: exit 0 06:14:28 INFO - Browser initialized. 06:14:28 INFO - Running cycle 1/1 for kraken test... 06:14:28 INFO - TEST-INFO | started process 20027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVhv5Sv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:29 INFO - PID 20027 | 06:14:29 INFO - PID 20027 | (/builds/slave/test/build/application/firefox/firefox:20081): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:14:29 INFO - PID 20027 | 06:14:40 INFO - PID 20027 | RSS: Main: 174096384 06:14:40 INFO - PID 20027 | 06:14:43 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52254/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:43 INFO - PID 20027 | RSS: Main: 179572736 06:14:43 INFO - PID 20027 | 06:14:46 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52254/tests/kraken/driver.html?testName=audio-dft) 06:14:47 INFO - PID 20027 | RSS: Main: 179458048 06:14:47 INFO - PID 20027 | 06:14:50 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52254/tests/kraken/driver.html?testName=audio-fft) 06:14:51 INFO - PID 20027 | RSS: Main: 174063616 06:14:51 INFO - PID 20027 | 06:14:53 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52254/tests/kraken/driver.html?testName=audio-oscillator) 06:14:53 INFO - PID 20027 | RSS: Main: 175235072 06:14:53 INFO - PID 20027 | 06:14:56 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52254/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:56 INFO - PID 20027 | RSS: Main: 174845952 06:14:56 INFO - PID 20027 | 06:14:59 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52254/tests/kraken/driver.html?testName=imaging-darkroom) 06:15:00 INFO - PID 20027 | RSS: Main: 177205248 06:15:00 INFO - PID 20027 | 06:15:04 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52254/tests/kraken/driver.html?testName=imaging-desaturate) 06:15:04 INFO - PID 20027 | RSS: Main: 176832512 06:15:04 INFO - PID 20027 | 06:15:07 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52254/tests/kraken/driver.html?testName=json-parse-financial) 06:15:08 INFO - PID 20027 | RSS: Main: 177967104 06:15:08 INFO - PID 20027 | 06:15:10 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52254/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:15:10 INFO - PID 20027 | RSS: Main: 177430528 06:15:10 INFO - PID 20027 | 06:15:12 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52254/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:15:13 INFO - PID 20027 | RSS: Main: 174907392 06:15:13 INFO - PID 20027 | 06:15:15 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52254/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:15:16 INFO - PID 20027 | RSS: Main: 174825472 06:15:16 INFO - PID 20027 | 06:15:18 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:15:19 INFO - PID 20027 | RSS: Main: 175214592 06:15:19 INFO - PID 20027 | 06:15:22 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:23 INFO - PID 20027 | RSS: Main: 175132672 06:15:23 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | Cycle 1(1): loaded http://localhost:52254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52254/tests/kraken/driver.html?testName=ai-astar) 06:15:25 INFO - PID 20027 | RSS: Main: 177090560 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | __start_tp_report 06:15:25 INFO - PID 20027 | _x_x_mozilla_page_load 06:15:25 INFO - PID 20027 | _x_x_mozilla_page_load_details 06:15:25 INFO - PID 20027 | |i|pagename|runs| 06:15:25 INFO - PID 20027 | |0;ai-astar;98;115;102;107;109;110;109;99;111;110 06:15:25 INFO - PID 20027 | |1;audio-beat-detection;147;126;154;181;134;146;145;119;188;122 06:15:25 INFO - PID 20027 | |2;audio-dft;172;166;164;163;162;172;170;161;165;164 06:15:25 INFO - PID 20027 | |3;audio-fft;76;78;78;179;78;75;76;74;160;76 06:15:25 INFO - PID 20027 | |4;audio-oscillator;78;80;131;83;83;87;125;80;79;131 06:15:25 INFO - PID 20027 | |5;imaging-gaussian-blur;114;114;114;113;114;114;114;114;114;114 06:15:25 INFO - PID 20027 | |6;imaging-darkroom;152;150;151;151;150;150;150;151;150;150 06:15:25 INFO - PID 20027 | |7;imaging-desaturate;94;95;94;94;93;94;93;95;94;94 06:15:25 INFO - PID 20027 | |8;json-parse-financial;60;63;58;57;62;57;61;57;58;59 06:15:25 INFO - PID 20027 | |9;json-stringify-tinderbox;55;54;53;55;55;54;54;54;54;56 06:15:25 INFO - PID 20027 | |10;stanford-crypto-aes;88;85;85;82;86;79;81;91;92;79 06:15:25 INFO - PID 20027 | |11;stanford-crypto-ccm;133;130;135;131;130;128;144;129;137;178 06:15:25 INFO - PID 20027 | |12;stanford-crypto-pbkdf2;190;184;187;180;194;202;185;178;179;194 06:15:25 INFO - PID 20027 | |13;stanford-crypto-sha256-iterative;70;72;69;69;72;70;85;73;70;68 06:15:25 INFO - PID 20027 | __end_tp_report 06:15:25 INFO - PID 20027 | __start_cc_report 06:15:25 INFO - PID 20027 | _x_x_mozilla_cycle_collect,992 06:15:25 INFO - PID 20027 | __end_cc_report 06:15:25 INFO - PID 20027 | __startTimestamp1501420525574__endTimestamp 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | ------- Summary: start ------- 06:15:25 INFO - PID 20027 | Number of tests: 14 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#0] ai-astar Cycles:10 Average:107.00 Median:110.50 stddev:5.54 (5.0%) stddev-sans-first:4.82 06:15:25 INFO - PID 20027 | Values: 98.0 115.0 102.0 107.0 109.0 110.0 109.0 99.0 111.0 110.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:146.50 stddev:23.34 (15.9%) stddev-sans-first:24.76 06:15:25 INFO - PID 20027 | Values: 147.0 126.0 154.0 181.0 134.0 146.0 145.0 119.0 188.0 122.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.50 stddev:4.04 (2.4%) stddev-sans-first:3.63 06:15:25 INFO - PID 20027 | Values: 172.0 166.0 164.0 163.0 162.0 172.0 170.0 161.0 165.0 164.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:39.54 (52.0%) stddev-sans-first:41.34 06:15:25 INFO - PID 20027 | Values: 76.0 78.0 78.0 179.0 78.0 75.0 76.0 74.0 160.0 76.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:80.00 stddev:23.18 (29.0%) stddev-sans-first:23.68 06:15:25 INFO - PID 20027 | Values: 78.0 80.0 131.0 83.0 83.0 87.0 125.0 80.0 79.0 131.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:15:25 INFO - PID 20027 | Values: 114.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 06:15:25 INFO - PID 20027 | Values: 152.0 150.0 151.0 151.0 150.0 150.0 150.0 151.0 150.0 150.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:15:25 INFO - PID 20027 | Values: 94.0 95.0 94.0 94.0 93.0 94.0 93.0 95.0 94.0 94.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.50 stddev:2.20 (3.7%) stddev-sans-first:2.32 06:15:25 INFO - PID 20027 | Values: 60.0 63.0 58.0 57.0 62.0 57.0 61.0 57.0 58.0 59.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.84 (1.5%) stddev-sans-first:0.87 06:15:25 INFO - PID 20027 | Values: 55.0 54.0 53.0 55.0 55.0 54.0 54.0 54.0 54.0 56.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.50 stddev:4.61 (5.4%) stddev-sans-first:4.75 06:15:25 INFO - PID 20027 | Values: 88.0 85.0 85.0 82.0 86.0 79.0 81.0 91.0 92.0 79.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:134.00 stddev:15.01 (11.2%) stddev-sans-first:15.83 06:15:25 INFO - PID 20027 | Values: 133.0 130.0 135.0 131.0 130.0 128.0 144.0 129.0 137.0 178.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.30 Median:188.50 stddev:7.73 (4.1%) stddev-sans-first:8.14 06:15:25 INFO - PID 20027 | Values: 190.0 184.0 187.0 180.0 194.0 202.0 185.0 178.0 179.0 194.0 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:71.00 stddev:4.89 (6.9%) stddev-sans-first:5.15 06:15:25 INFO - PID 20027 | Values: 70.0 72.0 69.0 69.0 72.0 70.0 85.0 73.0 70.0 68.0 06:15:25 INFO - PID 20027 | -------- Summary: end -------- 06:15:25 INFO - PID 20027 | 06:15:25 INFO - PID 20027 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:15:26 INFO - TEST-INFO | 20027: exit 0 06:15:26 INFO - TEST-OK | kraken | took 63466ms 06:15:26 INFO - SUITE-END | took 1176s 06:15:26 INFO - Completed test suite (00:19:37) 06:15:26 INFO - javascript benchmark 06:15:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8445.618301362103, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3127.37452509498, 3163.3040731039164, 3173.603299587551, 3194.6645602211765, 3203.4233837909183, 6127.601705889114, 6165.722542485588, 6200.348963358844, 6239.6256224626495, 6293.653849038301, 6225.3463386344465, 6292.811215663526, 6304.936950630492, 6328.493720502361, 6334.461570766479, 5678.829635110943, 5688.658680479164, 5743.253377060976, 5770.451807078321, 5826.766929322822, 5598.748056337475, 5682.659040457565, 5821.952048631245, 5823.56323275756, 5841.123831425278, 5710.428957104298, 5712.742926568273, 5780.5664575156825, 5788.363280039192, 5795.101759227306, 5646.068398714207, 5691.0, 5721.056025755745, 5777.393373695785, 5786.305643322786, 5656.490915817555, 5707.6575405475805, 5718.685472299022, 5719.19931209631, 5735.996200664908, 6204.47261982732, 6224.657643829588, 6235.96882015587, 6248.5313601480075, 6274.654893980829, 6730.360615741497, 6735.461163106988, 6746.359095885883, 6819.24988251297, 6828.317168283182, 6627.834304142387, 6766.69549870257, 6769.05233267343, 6793.388595026422, 6882.242953275136, 6175.59858609189, 6192.102145188923, 6192.442680158807, 6235.844103897393, 6241.34465881085, 6748.696308666122, 6848.6918088686125, 6849.212340580797, 6894.13823272091, 6912.619805910623, 6658.700358483879, 6666.400023997863, 6672.666366681744, 6674.199096108498, 6677.131972843499, 6727.865442691119, 6735.494837887178, 6738.124043874265, 6738.7304507819135, 6742.089817874622, 6694.297098804653, 6696.531242812956, 6709.463242940553, 6739.663016849138, 6777.627230502271, 6725.8654826903185, 6725.932740672629, 6828.385445309946, 6828.487863410264, 6829.69266383004, 5290.127129023745, 5427.294451721251, 5469.371022332403, 5478.58910581708, 5482.780688772485, 4638.768061596974, 4644.883877903079, 4658.0, 4658.720476771405, 4761.714297142183, 5763.971180144073, 5801.332846722681, 5808.709564521757, 5811.244538210006, 5814.476697097197, 6412.0, 6771.119754431892, 6844.828879278058, 6857.348551887562, 6861.622610756456, 5718.456746609066, 5730.74211660468, 5817.796377126865, 5826.563007774434, 5831.4168583141345, 5787.479126878601, 5887.646741195542, 5893.027650437715, 5901.7639294427745, 5989.2812862456785, 6477.481801455872, 6478.740850365933, 6496.805095847132, 6508.088867558546, 6508.869822603616, 6774.898376524455, 6777.085093512313, 6810.9318906810295, 6858.451323893977, 6886.965565172142, 6499.382558657109, 6524.0, 6528.21661400635, 6621.370969757865, 6629.569078009914, 6474.5791523550815, 6586.341365863375, 6622.801315960529, 6706.497012724163, 6715.3620406061345, 6722.932770672231, 6798.388145066968, 6801.557898736566, 6808.353206445379, 6832.965835170792, 6486.708098135689, 6573.408393244631, 6605.57063790852, 6621.039949207434, 6621.867562648624, 6520.152380190545, 6542.771003014872, 6601.471882249504, 6620.3710647488415, 6634.104395906491, 6337.556371054166, 6456.451201647913, 6465.094886715958, 6541.803745887631, 6558.409743123142, 6500.869982600416, 6501.772437964649, 6667.933320666732, 6672.065910772399, 6677.198736151693, 6399.104125422352, 6435.549511534147, 6458.677066146768, 6486.935130648633, 6511.446527045254], "value": 6138.934897812098, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.9028116626006, 873.0570983337996, 899.7435730816717, 1170.1399471388522, 1190.0776897904118, 29018.0, 39490.0, 40047.199056018864, 40137.0, 40190.799046004766, 39624.20751584967, 39947.80026099866, 40008.19983600326, 40034.599654003454, 40064.799676001654, 7602.467827252094, 7727.343175830061, 7748.651310691032, 7753.961230193841, 7754.651040703154, 7508.662110205027, 7657.923420765776, 7659.885101723478, 7666.156722760492, 7669.961650191769, 7529.1341495727875, 7686.538807671557, 7693.961530192341, 7729.381649468029, 7736.303732664059, 7591.27882851131, 7653.923460765404, 7654.808629784245, 7696.615169241515, 7698.0, 7393.815154621124, 7497.962510187469, 7558.244175582453, 7592.468527203098, 7681.961590192013, 37061.62938370609, 37445.25109497822, 37543.81228093842, 37565.060873478105, 37622.623773762185, 3491.1970246843366, 3538.150843797496, 3546.592141903688, 3560.2167523144867, 3562.323158599858, 29900.8504957476, 29961.550576741367, 29979.70020299791, 30037.549436758247, 30110.397792044037, 4835.05716385305, 4848.781804818792, 4858.975705121487, 4860.222364421711, 4903.4606193318705, 175686.0, 176398.0, 176498.0, 176789.0, 177109.1144544269, 46310.768446158225, 47002.294965575544, 47018.52981470142, 47323.5267647326, 47897.76051119722, 49707.50292497101, 49915.0, 50022.0, 50033.999320014125, 50048.74975625099, 16299.918500407422, 16343.101129437995, 16413.83586164147, 16485.670286594202, 16514.917425413038, 13497.460101595827, 13520.526781562598, 13576.321183940763, 13592.11651242666, 13602.115862468909, 12499.687507812378, 13630.659233519242, 13698.726025479635, 13770.0, 13920.58238252854, 4886.003201654468, 5571.693556854331, 5704.914426283609, 5784.0, 5824.504917082011, 981.7643765496372, 989.3964681544252, 1008.7629407089328, 1012.0233974214918, 1035.984460233097, 22600.434989125075, 22661.660075098887, 23059.538809224057, 23185.075770009273, 23487.0, 1087.423665457293, 1109.290054365207, 1118.3737107219983, 1120.445379537118, 1130.9547618095348, 11845.822312665317, 12117.515299388102, 12130.272183668832, 12376.690582735324, 12523.499060037679, 237974.0, 238364.0, 238704.0, 239026.0, 239951.0, 51680.0, 51793.22310165351, 55260.17109743357, 56401.71799140978, 56487.0, 1467.3250304859885, 1468.992655036718, 1485.7325681377456, 1499.3429174465557, 1508.3363320139104, 26524.336891577866, 27907.302317442227, 28207.294817629725, 28309.0, 28451.573226401208, 48123.75938120287, 49736.502634973185, 49833.50166498288, 49888.501114989835, 49967.0, 205945.0, 207566.0, 207975.0, 208650.0, 208685.0, 34933.12667183341, 35224.82387588046, 35287.0, 35382.646173537934, 35408.82295588506, 36929.44605830861, 42867.0, 43478.347824782024, 43545.78227108844, 43840.780796095816, 30710.232244194074, 30915.381692365576, 31121.8443907779, 31163.37673246477, 31587.84206078955, 28754.424911502072, 30650.233744156576, 30840.0, 30887.0, 31179.84410077935, 33459.1635209112, 34571.13572160716, 34636.0, 34648.0, 34711.652883470844, 28590.42819143647, 30349.393012140074, 30402.84798575993, 30977.69022309748, 31411.57846902123, 23315.883420582788, 23413.0, 23529.764702352757, 23569.646455303526, 25450.363740906625], "value": 17226.879348853, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.8502789274789, 580.3645008715455, 589.9174115623811, 593.973271202796, 595.583091835715, 21958.45103872404, 22707.0, 22707.432314192152, 22768.203112891053, 22777.31668049957, 24410.511789764194, 26011.739882601167, 26041.609375859378, 26105.21684349468, 26113.999999999953, 6393.232812062536, 6618.271990081087, 6620.6358650274215, 6621.470282377399, 6623.03965924943, 5885.7351419186025, 6383.0, 6393.456556192729, 6475.611463312216, 6559.245686746014, 6391.776287829927, 6392.968035159818, 6396.456301214403, 6397.1363865877975, 6398.360163983611, 6331.968340158316, 6370.140031095789, 6377.585456945307, 6378.202724659441, 6381.585196962205, 5972.880542389128, 5978.790742324041, 5980.372060933583, 5981.551383646244, 5987.191729116557, 29655.25861853449, 29978.25054373636, 30058.098257052105, 30620.856540041983, 31166.844165779254, 1902.3817259390753, 1928.7974762650001, 1929.53691114133, 1930.362980216525, 1939.5732938753451, 18855.622887542173, 19407.51481212967, 19550.31573894921, 19565.315213967442, 19581.902090489457, 2288.9542209155725, 2354.176038386568, 2421.067888862783, 2433.2821817563863, 2439.865807380593, 135709.0, 140886.0, 143729.0, 144911.3772155694, 145314.0, 14746.18895960711, 14793.704125917422, 14931.477398291008, 15251.313690883937, 15681.451149209723, 23899.28302150938, 23910.88044559766, 23912.0, 24043.51912961766, 24063.157789477285, 10485.0, 10605.25763196569, 10704.0, 10746.462676866126, 10839.403832789272, 9952.601895924226, 9985.1512621428, 10050.246231532665, 10171.440570768678, 10189.23580731448, 7775.950246716621, 8943.150400711922, 9109.681161159328, 9155.0, 9352.953235233781, 2634.288742039677, 2642.3262068172494, 2784.2320126719274, 2801.677807052174, 2852.7860410469298, 933.071593764209, 934.2572654739498, 936.438137117724, 956.2541217850088, 973.9659111931048, 18777.0, 19040.52398690044, 19113.90443047776, 19634.0, 24336.513269734507, 997.7755005123789, 999.8300288950895, 1006.5923301063082, 1034.8913364096811, 1038.6883934819675, 10734.248602597743, 11369.602063927723, 11490.195686301879, 13234.536791212262, 13702.38339274735, 491897.0, 493067.0, 503509.0, 510877.0, 519332.0, 128161.35919320343, 128333.0, 129527.0, 132356.0, 134116.32941835228, 1252.9122961392798, 1278.1755767530076, 1310.4365122997203, 1315.8881495072835, 1320.9207447552985, 20359.389218323475, 21506.569868602226, 22210.0, 22226.110955561595, 22339.329820105424, 54402.0, 56826.43173568211, 56992.430075698714, 58562.12156817736, 59990.0, 74901.0, 75746.0, 76478.23521764712, 76560.0, 76832.0, 19690.409287720817, 20504.692429613868, 21044.579108417438, 21280.148794048066, 21286.254981075588, 23545.764542354358, 23599.764002359756, 23676.289711308687, 23757.881210593838, 23853.0, 17804.91097544504, 18030.639387212446, 18113.275468981094, 18216.81783182204, 18522.351717689817, 13520.188788672318, 14219.431222750974, 14302.57092287233, 14373.281335932952, 14976.101433914, 18600.627987440446, 18705.81294187041, 19027.33404330842, 19244.23023079117, 19321.227150913805, 20156.496087597927, 20364.0, 20373.471989601137, 20491.69262461094, 20603.4849128773, 16262.268197930885, 16445.0, 16727.330906763593, 16798.58003549921, 16994.66010679804], "value": 12345.140025202778, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.4321006782186, 1425.387083554072, 1437.6549628089263, 1444.8193975753031, 1446.6455718349007, 13516.797248041275, 13870.791938120936, 14225.719685228327, 14238.92880535596, 14249.287535623229, 14482.637934051654, 14708.117512949204, 14726.26368681567, 14729.558113256593, 14778.408863645469, 2710.105665130502, 2769.141566114511, 2769.9446011079867, 2771.210205091549, 2773.459175460786, 2514.5599520084, 2640.749128832758, 2664.2540088775077, 2670.4792565449743, 2731.590261460777, 2691.5020721166547, 2711.4848178845955, 2716.2530304166316, 2724.196362073183, 2724.6866610339766, 2585.5733803922426, 2638.4723055388904, 2642.8810703518197, 2648.523265812153, 2654.0976068136733, 2586.456844062749, 2607.8304910180777, 2616.2674451153516, 2620.9475810483873, 2624.094687332867, 13901.930490347584, 13936.930315348358, 14023.088499247619, 14024.298785060706, 14046.595340465974, 7234.49358544902, 7433.888491672629, 7499.100107987022, 7502.062242219723, 7514.887276690854, 5065.594752419797, 5188.570418767215, 5209.114450543417, 5262.894742105174, 5289.0, 1735.8003829559636, 1741.3295881085746, 1751.95620109497, 1775.1834156288123, 1776.3427531813184, 22430.102795888146, 22783.54432911349, 22825.885870570542, 22826.429339266484, 22866.657000145013, 6293.685315734195, 6461.0616814956265, 6466.644334561644, 6577.868442631217, 6608.801735947929, 15584.220788960507, 15666.13836238995, 15698.215089245721, 15701.450449234222, 15713.450029248921, 7412.555246685216, 7562.848743025219, 7568.962155189299, 7575.810604734926, 7577.5453472791805, 6300.0, 6965.756198533027, 6979.267176946449, 7105.396041336544, 7116.181639111568, 4903.950960490421, 5039.193729003415, 5044.672096313728, 5073.365829271341, 5159.329287192716, 1335.8797708206307, 1366.41244264967, 1422.8932830037788, 1458.8176477940258, 1510.5015344936144, 758.5638258001671, 763.9221318014991, 769.0655853138463, 798.876174193001, 799.3085980626716, 7114.253003434668, 7189.59082146329, 7241.8551628967125, 7330.5968171751065, 7376.299251571092, 884.6019291318933, 925.7037747920735, 927.9907200928039, 947.3605316411532, 956.7034219391871, 4280.828766849353, 4750.714957102585, 4788.497207793132, 4803.975980120077, 4851.393575803025, 17320.0, 17956.730649040273, 18054.638907221783, 18126.456206313833, 18298.45104646863, 18497.907510462363, 18917.43247702571, 18994.335198267996, 19367.418977430698, 19418.417447476597, 10111.443870587042, 10341.37951722899, 10397.168226541708, 10470.16238700902, 10476.63331783384, 6793.898091528532, 7473.215312392338, 7708.344790692854, 7788.610569471391, 7839.137694853447, 16160.838391615933, 16515.91742041282, 16799.748003780198, 16856.410025649042, 16944.74582881233, 15825.446109386578, 16592.83407165913, 16714.080725560212, 16962.406315778888, 17206.483805485856, 11313.377764223047, 11406.14453915943, 11553.826692599785, 11586.942065289619, 11589.82615260755, 12526.87473125257, 12575.43410546546, 12660.303683297507, 12674.619761407173, 12694.365281735692, 9209.125133112344, 9215.677451289173, 9247.0, 9700.75748106303, 10062.798744024933, 8908.163163810379, 9384.812303754023, 9481.952590237004, 9482.715518534455, 9646.324757266924, 8876.733697989072, 8965.641374344954, 8972.461652300883, 8979.685711000346, 8990.190882820578, 6106.572539922163, 6347.587406818727, 6407.807765767035, 6409.102725618511, 6410.0705397718, 6252.906206406817, 6331.683415829098, 6354.205724284465, 6461.418472337512, 6500.187476565429], "value": 6167.526278725893, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.5687053216838, 494.4832649880874, 510.41557416757837, 512.9640925135242, 520.7396301849076, 6214.502839772818, 6216.595921265114, 6258.655773932438, 6285.905711414321, 6360.300366959631, 5954.642721436717, 6116.510679145669, 6122.326544080159, 6123.632582045069, 6171.531387445024, 4934.728589927553, 4966.379202599675, 4971.900561988758, 5026.120428924933, 5051.873703157414, 4932.778024988884, 4944.082991035289, 4944.700714167911, 4982.850514484553, 4993.800247990094, 4807.639427042968, 4867.756612169395, 4902.3872015998, 4956.107900577895, 4957.4298955620025, 4894.632902532288, 4896.971635956454, 4940.3330550375595, 4958.8512344629535, 4996.4254110777, 4407.537208593084, 4417.955820441786, 4448.377227188196, 4486.55134486552, 4505.571970662814, 6023.939760602426, 6047.425494578008, 6074.665893375863, 6083.148359229667, 6114.755409783604, 5644.6330988486025, 5730.025895597759, 5735.741891614887, 5760.308762948431, 5785.016547186946, 6437.485001199892, 6466.224053113609, 6466.6766661666725, 6495.350464953467, 6579.407853293226, 4811.855644330676, 4812.831550895737, 4832.516748325174, 4839.975800120977, 4863.975680121612, 6776.220734615533, 6793.932060679429, 6931.861362772716, 6937.826554336131, 6963.721451141898, 4914.262860570871, 4959.851204463872, 4966.726830024383, 4978.377702787152, 5002.899942001212, 5021.447640759514, 5092.2361645753435, 5094.5160209780015, 5099.745012749348, 5105.361829771278, 5669.149627555899, 5726.284214473191, 5739.655620662774, 5739.942600573941, 5750.769969201185, 6511.772087976993, 6629.9337006630285, 6641.302663220389, 6645.501587380966, 6698.363655452724, 1637.9262933168036, 1640.5816516788143, 1709.9230534625972, 1725.7066298729246, 1742.7298768690873, 1184.4492311075392, 1204.5723768062387, 1204.674737820801, 1214.481897627965, 1214.690253985228, 5672.376038635747, 5675.574331925122, 5712.200291959129, 5743.310802703619, 5762.9135562966585, 6545.697984632463, 6638.336166383323, 6660.367265109807, 6670.199576050905, 6673.3993940544615, 5561.221428999943, 5676.962824888665, 5686.601937864392, 5704.0588302929555, 5724.284464441945, 3578.248567800791, 3597.3165098631175, 3602.0454579536445, 3603.85584576614, 3604.6395360464267, 6386.936130638727, 6469.838254043687, 6491.837704057436, 6533.314002029813, 6584.6378449184795, 6742.39318461331, 6774.966125169342, 6813.0, 6819.181698196248, 6902.758403455855, 6392.520560957947, 6426.389492998158, 6476.773312934025, 6492.220933488012, 6497.350264973465, 6578.638174900427, 6602.207735071822, 6709.597424154566, 6740.528163028737, 6742.258351581224, 6544.149260596282, 6570.29172415166, 6589.17635295588, 6600.306967768315, 6617.2721000688925, 6479.2224933006455, 6530.91010876515, 6533.771318003847, 6572.934270657423, 6581.868362632625, 4938.419705694287, 4964.0071985603745, 4966.900661986812, 4978.253262010582, 5004.549590536869, 6611.471082313499, 6673.399394054559, 6680.899786503303, 6709.630970296681, 6714.462842972648, 6369.235691716838, 6423.678816059271, 6471.870562588816, 6488.870222595616, 6507.674616269073, 6375.649339286384, 6401.231852177769, 6444.871102578016, 6459.321771214143, 6491.4806815455595, 5824.970875145597, 6408.61548307103, 6419.614823110628, 6477.77327793525, 6502.154719886385, 6510.414062734377, 6519.967400162969, 6562.179727534059, 6578.80263592093, 6580.440662543546, 6173.9073913892225, 6274.937250627435, 6305.211848518935, 6378.681065946591, 6383.616982981036], "value": 5023.02646567317, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [894.6063731957938, 918.4902379179555, 919.3748251189189, 923.0031565908819, 935.2517985611511, 17718.734218986727, 18758.62482750344, 18807.811921880777, 18853.340133095346, 21401.57196856062, 20767.68848467274, 21680.2411915583, 21778.237761678345, 21880.23419180325, 21896.671549926763, 972.1153750087421, 1041.1722680469045, 1048.9213309001818, 1050.448514529874, 1051.747580580659, 1015.4668798880573, 1044.639599338227, 1064.473085822519, 1064.8775390830076, 1066.610687099207, 1096.7477480179564, 1100.8018556659797, 1104.2491106047885, 1104.304288298371, 1104.9834252486219, 1082.4209048159237, 1094.8357746338033, 1098.1599076706325, 1099.0493223361814, 1099.6151347028556, 796.8246985663145, 807.8424707182102, 807.8788181772723, 807.9515229086273, 809.6761295481796, 18398.632027359512, 18489.630207395778, 18579.72130418045, 18639.254429822926, 19683.0, 20487.38537843867, 20517.5896482071, 20770.688439673417, 21058.684119738216, 21126.577468450545, 15762.133082680448, 15912.840871591252, 15945.681086378323, 15951.441699540577, 16396.508104756875, 3590.0845284452557, 3591.120175556979, 3595.3708101082207, 3610.855565777366, 3616.1682812952904, 113518.0, 114972.0, 116844.0, 118036.0, 118550.40724796407, 16000.75998860018, 16521.504354869372, 16575.585610359838, 16593.6681266374, 16610.169491525376, 29769.40461190764, 30361.392772144434, 30399.848000760296, 30405.847970760005, 30432.0, 7750.573718445539, 8075.555844428495, 8083.757487275391, 8124.959375203086, 8181.631826567819, 3912.5304963404005, 3959.6634286085427, 3959.821808018646, 3960.0495880988933, 3967.7024223183375, 5181.4300426953005, 5184.533391994663, 5225.425203227642, 5291.788328466895, 5299.205119232069, 926.3376685669779, 932.7947851472666, 934.8644446555347, 936.3352020065829, 939.7086903060073, 664.8105289992329, 669.1267895396456, 679.8980152977093, 685.5783693028851, 701.8631366883511, 10932.0, 11519.827202591969, 11545.884541154648, 11673.357965311989, 11707.648770536898, 640.1230314469207, 668.6122049211446, 677.989830152548, 679.2629996453903, 685.8285428642839, 4979.0, 5174.09453345663, 5193.37679478465, 5239.1355426354985, 5391.191321301836, 98439.50780246053, 102349.0, 105174.0, 105479.0, 107856.46071769591, 86151.0, 87388.56305718557, 89627.0, 89810.10189898148, 90514.0, 77515.2248477508, 79323.60338198271, 79332.20667793248, 79660.99999999884, 84610.57694711487, 10104.89895101069, 10135.391876487434, 10207.0, 10578.471076445992, 10623.256372053882, 32810.343793124484, 34165.658343416246, 34248.65751342455, 34670.95987120391, 36830.263394732494, 64905.35094648993, 65433.34566654272, 66181.45202680521, 68096.6595167021, 69118.96321555281, 18723.531911702317, 19119.90440047791, 19182.616347673247, 19500.31748888782, 19536.21855125836, 21417.89291053535, 21503.677444838027, 22052.88973555122, 22155.33533993983, 22661.773382265965, 18176.545586360447, 19066.52333691669, 19220.423387298404, 19321.806781932562, 19911.303104391278, 19210.615787683888, 19353.032348382807, 19356.70964935499, 19425.51436214106, 19768.0, 18172.0, 18640.533986650444, 18853.15160817739, 18905.0, 18952.43142705721, 12885.806712899126, 12983.285919274153, 13084.803727943898, 14084.929575352058, 14468.927655361656, 12117.0, 12967.351632418153, 13163.276019819003, 13401.329933503092, 13467.191968481922], "value": 8971.988072411552, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 115.0, 102.0, 107.0, 109.0, 110.0, 109.0, 99.0, 111.0, 110.0], "value": 107.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 154.0, 181.0, 134.0, 146.0, 145.0, 119.0, 188.0, 122.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 166.0, 164.0, 163.0, 162.0, 172.0, 170.0, 161.0, 165.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 78.0, 179.0, 78.0, 75.0, 76.0, 74.0, 160.0, 76.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 131.0, 83.0, 83.0, 87.0, 125.0, 80.0, 79.0, 131.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 151.0, 151.0, 150.0, 150.0, 150.0, 151.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 93.0, 95.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 58.0, 57.0, 62.0, 57.0, 61.0, 57.0, 58.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 56.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 85.0, 82.0, 86.0, 79.0, 81.0, 91.0, 92.0, 79.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 135.0, 131.0, 130.0, 128.0, 144.0, 129.0, 137.0, 178.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 184.0, 187.0, 180.0, 194.0, 202.0, 185.0, 178.0, 179.0, 194.0], "value": 187.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 69.0, 69.0, 72.0, 70.0, 85.0, 73.0, 70.0, 68.0], "value": 71.8, "unit": "score"}]}]} 06:15:26 INFO - Return code: 0 06:15:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:15:26 INFO - # TBPL SUCCESS # 06:15:26 INFO - Running post-action listener: _package_coverage_data 06:15:26 INFO - Running post-action listener: _resource_record_post_action 06:15:26 INFO - [mozharness: 2017-07-30 13:15:26.825253Z] Finished run-tests step (success) 06:15:26 INFO - Running post-run listener: _resource_record_post_run 06:15:26 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 16384; Write bytes: 432807936; Read time: 408; Write time: 321764 06:15:26 INFO - TinderboxPrint: CPU usage
13.2% 06:15:26 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 408 06:15:26 INFO - TinderboxPrint: I/O write bytes / time
432,807,936 / 321,764 06:15:26 INFO - TinderboxPrint: CPU idle
8,279.0 (86.8%) 06:15:26 INFO - TinderboxPrint: CPU user
1,205.1 (12.6%) 06:15:26 INFO - TinderboxPrint: Swap in / out
0 / 0 06:15:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109342720; Read time: 88; Write time: 95480 06:15:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:15:26 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 323465216; Read time: 304; Write time: 226284 06:15:27 INFO - Running post-run listener: _upload_blobber_files 06:15:27 INFO - Blob upload gear active. 06:15:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:27 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 06:15:27 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:15:27 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:15:27 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:15:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:15:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:28 INFO - (blobuploader) - INFO - Done attempting. 06:15:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:15:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:15:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:35 INFO - (blobuploader) - INFO - Done attempting. 06:15:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:15:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:15:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:38 INFO - (blobuploader) - INFO - Done attempting. 06:15:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:15:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:15:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:39 INFO - (blobuploader) - INFO - Done attempting. 06:15:39 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:39 INFO - Return code: 0 06:15:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:39 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f577fa6b428aade13ec083a0276825752d17cd354a581f59dd4ca08c188393e160b0c3d3319bcc23b784d234703342b4d1ac2c51abd4a42080865b2f7bdf4b4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d74037657f6140c712492682b6d80578dd50882370a81b46273062465cb0d73d11aaa5ef7c6319f6859576806b52722435c5d2c58a0e86af371235dee749ca4f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7220c1b00611e582c12e20fdc9b7480b9d49ca2f3553c74925bd31f194ebed29dd39e8ccb3636554ae53944e265707073feffa6ed1069e1543aaea4d7f8575eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a4a93fb76b9473f1bdb55c8d38370892830f11f2dcc551161c0c50211e972cb063a0520f13cae67858c26e9fa92de91b8e0b5d42e354eeef6a7b8c1cef93c87"} 06:15:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:39 INFO - Contents: 06:15:39 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f577fa6b428aade13ec083a0276825752d17cd354a581f59dd4ca08c188393e160b0c3d3319bcc23b784d234703342b4d1ac2c51abd4a42080865b2f7bdf4b4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d74037657f6140c712492682b6d80578dd50882370a81b46273062465cb0d73d11aaa5ef7c6319f6859576806b52722435c5d2c58a0e86af371235dee749ca4f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7220c1b00611e582c12e20fdc9b7480b9d49ca2f3553c74925bd31f194ebed29dd39e8ccb3636554ae53944e265707073feffa6ed1069e1543aaea4d7f8575eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a4a93fb76b9473f1bdb55c8d38370892830f11f2dcc551161c0c50211e972cb063a0520f13cae67858c26e9fa92de91b8e0b5d42e354eeef6a7b8c1cef93c87"} 06:15:39 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:39 INFO - Copying logs to upload dir... 06:15:39 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.387573 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-07-30 06:15:38.845798) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 06:15:38.850159) ========= 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=9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549 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/sha512/f577fa6b428aade13ec083a0276825752d17cd354a581f59dd4ca08c188393e160b0c3d3319bcc23b784d234703342b4d1ac2c51abd4a42080865b2f7bdf4b4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d74037657f6140c712492682b6d80578dd50882370a81b46273062465cb0d73d11aaa5ef7c6319f6859576806b52722435c5d2c58a0e86af371235dee749ca4f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7220c1b00611e582c12e20fdc9b7480b9d49ca2f3553c74925bd31f194ebed29dd39e8ccb3636554ae53944e265707073feffa6ed1069e1543aaea4d7f8575eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a4a93fb76b9473f1bdb55c8d38370892830f11f2dcc551161c0c50211e972cb063a0520f13cae67858c26e9fa92de91b8e0b5d42e354eeef6a7b8c1cef93c87"} build_url:https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f577fa6b428aade13ec083a0276825752d17cd354a581f59dd4ca08c188393e160b0c3d3319bcc23b784d234703342b4d1ac2c51abd4a42080865b2f7bdf4b4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d74037657f6140c712492682b6d80578dd50882370a81b46273062465cb0d73d11aaa5ef7c6319f6859576806b52722435c5d2c58a0e86af371235dee749ca4f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7220c1b00611e582c12e20fdc9b7480b9d49ca2f3553c74925bd31f194ebed29dd39e8ccb3636554ae53944e265707073feffa6ed1069e1543aaea4d7f8575eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a4a93fb76b9473f1bdb55c8d38370892830f11f2dcc551161c0c50211e972cb063a0520f13cae67858c26e9fa92de91b8e0b5d42e354eeef6a7b8c1cef93c87"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 06:15:38.877778) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 06:15:38.878155) ========= 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=9bfb7e13875ed353a705960e000001c0-1501412877.728974-161047549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 06:15:38.959801) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 06:15:38.960224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 06:15:38.960600) ========= ========= Total master_lag: 0.30 =========