builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1501291471.62 results: success (0) revision: ec666e910442ae55686160c1bd0c93b00a08dead ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.617124) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.617587) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.617899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.827285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.827590) ========= 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=232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-28 18:24:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 108M=0s 2017-07-28 18:24:32 (108 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103657 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:32.017210) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:32.017609) ========= 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=232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021450 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:32.113299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:32.113691) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ec666e910442ae55686160c1bd0c93b00a08dead --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 ec666e910442ae55686160c1bd0c93b00a08dead --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=232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-28 18:24:33,073 truncating revision to first 12 chars 2017-07-28 18:24:33,073 Setting DEBUG logging. 2017-07-28 18:24:33,073 attempt 1/10 2017-07-28 18:24:33,073 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ec666e910442?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-28 18:24:33,365 unpacking tar archive at: mozilla-central-ec666e910442/testing/mozharness/ program finished with exit code 0 elapsedTime=0.597905 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:32.729293) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:32.729624) ========= script_repo_revision: ec666e910442ae55686160c1bd0c93b00a08dead ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:32.730046) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:32.735384) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:32.745171) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-07-28 18:24:32.745501) ========= /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=232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:24:33 INFO - MultiFileLogger online at 20170728 18:24:33 in /builds/slave/test 18:24:33 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 18:24:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:24:33 INFO - {'append_to_log': False, 18:24:33 INFO - 'base_work_dir': '/builds/slave/test', 18:24:33 INFO - 'blob_upload_branch': 'Firefox', 18:24:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:24:33 INFO - 'branch': 'Firefox', 18:24:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:24:33 INFO - 'code_coverage': False, 18:24:33 INFO - 'config_files': ('talos/linux_config.py',), 18:24:33 INFO - 'default_actions': ('clobber', 18:24:33 INFO - 'read-buildbot-config', 18:24:33 INFO - 'download-and-extract', 18:24:33 INFO - 'populate-webroot', 18:24:33 INFO - 'create-virtualenv', 18:24:33 INFO - 'install', 18:24:33 INFO - 'setup-mitmproxy', 18:24:33 INFO - 'run-tests'), 18:24:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:24:33 INFO - 'disable_ccov_upload': False, 18:24:33 INFO - 'download_minidump_stackwalk': True, 18:24:33 INFO - 'download_symbols': 'ondemand', 18:24:33 INFO - 'enable_stylo': False, 18:24:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:24:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:24:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:24:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:24:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:24:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:24:33 INFO - 'gecko_profile': False, 18:24:33 INFO - 'gecko_profile_interval': 0, 18:24:33 INFO - 'installer_path': 'installer.exe', 18:24:33 INFO - 'log_level': 'info', 18:24:33 INFO - 'log_name': 'talos', 18:24:33 INFO - 'log_to_console': True, 18:24:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:24:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:24:33 INFO - 'opt_config_files': (), 18:24:33 INFO - 'pip_index': False, 18:24:33 INFO - 'suite': 'dromaeojs-e10s', 18:24:33 INFO - 'system_bits': '32', 18:24:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:24:33 INFO - 'title': 'talos-linux64-ix-025', 18:24:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:24:33 INFO - 'use_talos_json': True, 18:24:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:24:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:24:33 INFO - 'work_dir': 'build'} 18:24:33 INFO - [mozharness: 2017-07-29 01:24:33.801943Z] Running clobber step. 18:24:33 INFO - Running pre-action listener: _resource_record_pre_action 18:24:33 INFO - Running main action method: clobber 18:24:33 INFO - rmtree: /builds/slave/test/build 18:24:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:24:34 INFO - Running post-action listener: _resource_record_post_action 18:24:34 INFO - [mozharness: 2017-07-29 01:24:34.849729Z] Finished clobber step (success) 18:24:34 INFO - [mozharness: 2017-07-29 01:24:34.849831Z] Running read-buildbot-config step. 18:24:34 INFO - Running pre-action listener: _resource_record_pre_action 18:24:34 INFO - Running main action method: read_buildbot_config 18:24:34 INFO - Using buildbot properties: 18:24:34 INFO - { 18:24:34 INFO - "project": "", 18:24:34 INFO - "product": "firefox", 18:24:34 INFO - "who": "kwierso@gmail.com", 18:24:34 INFO - "installer_path": "public/build/target.tar.bz2", 18:24:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:24:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:24:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:24:34 INFO - "stage_platform": "linux64-stylo", 18:24:34 INFO - "basedir": "/builds/slave/test", 18:24:34 INFO - "buildnumber": 54, 18:24:34 INFO - "platform": "ubuntu64_hw_stylo", 18:24:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:24:34 INFO - "slavebuilddir": "test", 18:24:34 INFO - "taskId": "ZPs7TKdhQ3K55DI7-LTj3A", 18:24:34 INFO - "branch": "mozilla-central", 18:24:34 INFO - "script_repo_revision": "production", 18:24:34 INFO - "revision": "ec666e910442ae55686160c1bd0c93b00a08dead", 18:24:34 INFO - "slavename": "talos-linux64-ix-025", 18:24:34 INFO - "repo_path": "mozilla-central" 18:24:34 INFO - } 18:24:34 INFO - Finding installer, test and symbols from parent task. 18:24:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPs7TKdhQ3K55DI7-LTj3A'}, attempt #1 18:24:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPs7TKdhQ3K55DI7-LTj3A'}, attempt #1 18:24:35 INFO - Task dependencies: esOdlu_7SECy18fFonV7ig 18:24:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig'}, attempt #1 18:24:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2 18:24:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/test_packages.json 18:24:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.crashreporter-symbols.zip 18:24:36 INFO - Running post-action listener: _resource_record_post_action 18:24:36 INFO - [mozharness: 2017-07-29 01:24:36.309439Z] Finished read-buildbot-config step (success) 18:24:36 INFO - [mozharness: 2017-07-29 01:24:36.309661Z] Running download-and-extract step. 18:24:36 INFO - Running pre-action listener: _resource_record_pre_action 18:24:36 INFO - Running main action method: download_and_extract 18:24:36 INFO - mkdir: /builds/slave/test/build/tests 18:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:24:36 INFO - trying https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.test_packages.json 18:24:36 INFO - Downloading https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:24:36 INFO - Downloaded 989 bytes. 18:24:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:24:36 INFO - Using the following test package requirements: 18:24:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:24:36 INFO - u'common': [u'target.common.tests.zip'], 18:24:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:24:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:24:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:24:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:24:36 INFO - u'mozbase': [u'target.common.tests.zip'], 18:24:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:24:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:24:36 INFO - u'web-platform': [u'target.common.tests.zip', 18:24:36 INFO - u'target.web-platform.tests.tar.gz'], 18:24:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:24:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:24:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.common.tests.zip 18:24:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:24:36 INFO - Fetch https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.common.tests.zip into memory 18:24:39 INFO - Content-Length response header: 72565189 18:24:39 INFO - Bytes received: 72565189 18:24:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:24:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.common.tests.zip 18:24:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:24:51 INFO - Fetch https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.common.tests.zip into memory 18:24:54 INFO - Content-Length response header: 72565189 18:24:54 INFO - Bytes received: 72565189 18:25:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.talos.tests.zip 18:25:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:25:06 INFO - Fetch https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.talos.tests.zip into memory 18:25:07 INFO - Content-Length response header: 14496686 18:25:07 INFO - Bytes received: 14496686 18:25:07 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')]} 18:25:07 INFO - trying https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2 18:25:07 INFO - Downloading https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:25:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:25:12 INFO - Downloaded 62111661 bytes. 18:25:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2 18:25:12 INFO - mkdir: /builds/slave/test/properties 18:25:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:25:12 INFO - Writing to file /builds/slave/test/properties/build_url 18:25:12 INFO - Contents: 18:25:12 INFO - build_url:https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2 18:25:12 INFO - Running post-action listener: _resource_record_post_action 18:25:12 INFO - Running post-action listener: set_extra_try_arguments 18:25:12 INFO - [mozharness: 2017-07-29 01:25:12.106810Z] Finished download-and-extract step (success) 18:25:12 INFO - [mozharness: 2017-07-29 01:25:12.107038Z] Running populate-webroot step. 18:25:12 INFO - Running pre-action listener: _resource_record_pre_action 18:25:12 INFO - Running main action method: populate_webroot 18:25:12 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:25:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:25:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:25:12 INFO - 'tests': ['damp', 'tps']}, 18:25:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:25:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:25:12 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:25:12 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:25:12 INFO - 'other-e10s': {'tests': ['a11yr', 18:25:12 INFO - 'ts_paint', 18:25:12 INFO - 'tpaint', 18:25:12 INFO - 'sessionrestore', 18:25:12 INFO - 'sessionrestore_many_windows', 18:25:12 INFO - 'sessionrestore_no_auto_restore', 18:25:12 INFO - 'tabpaint']}, 18:25:12 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:25:12 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:25:12 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:25:12 INFO - 'talos_options': ['--mitmproxy', 18:25:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:25:12 INFO - '--firstNonBlankPaint'], 18:25:12 INFO - 'tests': ['quantum_pageload_google', 18:25:12 INFO - 'quantum_pageload_youtube', 18:25:12 INFO - 'quantum_pageload_amazon', 18:25:12 INFO - 'quantum_pageload_facebook']}, 18:25:12 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:25:12 INFO - 'talos_options': ['--stylo', 18:25:12 INFO - '--mitmproxy', 18:25:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:25:12 INFO - '--firstNonBlankPaint'], 18:25:12 INFO - 'tests': ['quantum_pageload_google', 18:25:12 INFO - 'quantum_pageload_youtube', 18:25:12 INFO - 'quantum_pageload_amazon', 18:25:12 INFO - 'quantum_pageload_facebook']}, 18:25:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:25:12 INFO - 'tsvgr_opacity', 18:25:12 INFO - 'tart', 18:25:12 INFO - 'tscrollx', 18:25:12 INFO - 'cart', 18:25:12 INFO - 'tsvg_static']}, 18:25:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:25:12 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:25:12 INFO - 'talos_options': ['--stylo', 18:25:12 INFO - '--stylo-threads=1', 18:25:12 INFO - '--mitmproxy', 18:25:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:25:12 INFO - '--firstNonBlankPaint'], 18:25:12 INFO - 'tests': ['tp6_google', 18:25:12 INFO - 'tp6_youtube', 18:25:12 INFO - 'tp6_amazon', 18:25:12 INFO - 'tp6_facebook']}, 18:25:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:25:12 INFO - 'talos_options': ['--xperf_path', 18:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:12 INFO - 'tests': ['tp5n']}}} 18:25:12 INFO - Running post-action listener: _resource_record_post_action 18:25:12 INFO - [mozharness: 2017-07-29 01:25:12.119537Z] Finished populate-webroot step (success) 18:25:12 INFO - [mozharness: 2017-07-29 01:25:12.119628Z] Running create-virtualenv step. 18:25:12 INFO - Running pre-action listener: _resource_record_pre_action 18:25:12 INFO - Running main action method: create_virtualenv 18:25:12 INFO - Creating virtualenv /builds/slave/test/build/venv 18:25:12 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 18:25:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:25:12 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:25:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:25:12 INFO - Using real prefix '/usr' 18:25:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:25:12 INFO - Installing distribute.............................................................................................................................................................................................done. 18:25:14 INFO - Installing pip.................done. 18:25:14 INFO - Return code: 0 18:25:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:25:14 INFO - Reading from file tmpfile_stdout 18:25:14 INFO - Output received: 18:25:14 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) 18:25:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:25:14 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')]} 18:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:14 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')]} 18:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:14 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 0xa671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc33a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3eb0>, '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 0xdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd5240>, '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': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', '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 18:25:14 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 18:25:14 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 18:25:14 INFO - Using env: {'DISPLAY': ':0', 18:25:14 INFO - 'HOME': '/home/cltbld', 18:25:14 INFO - 'LANG': 'en_US.UTF-8', 18:25:14 INFO - 'LANGUAGE': 'en_US:en', 18:25:14 INFO - 'LOGNAME': 'cltbld', 18:25:14 INFO - 'MAIL': '/var/mail/cltbld', 18:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:14 INFO - 'MOZ_NO_REMOTE': '1', 18:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:14 INFO - 'NO_EM_RESTART': '1', 18:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:14 INFO - 'PWD': '/builds/slave/test', 18:25:14 INFO - 'SHELL': '/bin/bash', 18:25:14 INFO - 'SHLVL': '1', 18:25:14 INFO - 'TERM': 'linux', 18:25:14 INFO - 'TMOUT': '86400', 18:25:14 INFO - 'USER': 'cltbld', 18:25:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', 18:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:14 INFO - '_': '/tools/buildbot/bin/python'} 18:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:15 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 18:25:15 INFO - Cleaning up... 18:25:15 INFO - Return code: 0 18:25:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25: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', '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 0xa671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc33a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3eb0>, '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 0xdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd5240>, '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': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', '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 18:25: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:25: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 psutil>=3.1.1 18:25:15 INFO - Using env: {'DISPLAY': ':0', 18:25:15 INFO - 'HOME': '/home/cltbld', 18:25:15 INFO - 'LANG': 'en_US.UTF-8', 18:25:15 INFO - 'LANGUAGE': 'en_US:en', 18:25:15 INFO - 'LOGNAME': 'cltbld', 18:25:15 INFO - 'MAIL': '/var/mail/cltbld', 18:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:15 INFO - 'MOZ_NO_REMOTE': '1', 18:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:15 INFO - 'NO_EM_RESTART': '1', 18:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:15 INFO - 'PWD': '/builds/slave/test', 18:25:15 INFO - 'SHELL': '/bin/bash', 18:25:15 INFO - 'SHLVL': '1', 18:25:15 INFO - 'TERM': 'linux', 18:25:15 INFO - 'TMOUT': '86400', 18:25:15 INFO - 'USER': 'cltbld', 18:25:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', 18:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:15 INFO - '_': '/tools/buildbot/bin/python'} 18:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:15 INFO - Downloading/unpacking psutil>=3.1.1 18:25: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 18:25: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 18:25: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 18:25: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 18:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:25:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:25:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:25:16 INFO - Installing collected packages: psutil 18:25:16 INFO - Running setup.py install for psutil 18:25:16 INFO - building 'psutil._psutil_linux' extension 18:25:16 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 18:25:16 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 18:25:16 INFO - building 'psutil._psutil_posix' extension 18:25:16 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 18:25:16 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 18:25:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:25:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:25:17 INFO - Successfully installed psutil 18:25:17 INFO - Cleaning up... 18:25:17 INFO - Return code: 0 18:25:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:25:17 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')]} 18:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:17 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')]} 18:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:17 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 0xa671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc33a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3eb0>, '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 0xdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd5240>, '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': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', '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 18:25:17 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 18:25:17 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 18:25:17 INFO - Using env: {'DISPLAY': ':0', 18:25:17 INFO - 'HOME': '/home/cltbld', 18:25:17 INFO - 'LANG': 'en_US.UTF-8', 18:25:17 INFO - 'LANGUAGE': 'en_US:en', 18:25:17 INFO - 'LOGNAME': 'cltbld', 18:25:17 INFO - 'MAIL': '/var/mail/cltbld', 18:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:17 INFO - 'MOZ_NO_REMOTE': '1', 18:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:17 INFO - 'NO_EM_RESTART': '1', 18:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:17 INFO - 'PWD': '/builds/slave/test', 18:25:17 INFO - 'SHELL': '/bin/bash', 18:25:17 INFO - 'SHLVL': '1', 18:25:17 INFO - 'TERM': 'linux', 18:25:17 INFO - 'TMOUT': '86400', 18:25:17 INFO - 'USER': 'cltbld', 18:25:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', 18:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:17 INFO - '_': '/tools/buildbot/bin/python'} 18:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:25: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 18:25: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 18:25: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 18:25: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 18:25:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:25:18 INFO - Installing collected packages: mozsystemmonitor 18:25:18 INFO - Running setup.py install for mozsystemmonitor 18:25:18 INFO - Successfully installed mozsystemmonitor 18:25:18 INFO - Cleaning up... 18:25:18 INFO - Return code: 0 18:25:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25: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', '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 0xa671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc33a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3eb0>, '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 0xdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd5240>, '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': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', '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 18:25: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:25: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 jsonschema==2.5.1 18:25:18 INFO - Using env: {'DISPLAY': ':0', 18:25:18 INFO - 'HOME': '/home/cltbld', 18:25:18 INFO - 'LANG': 'en_US.UTF-8', 18:25:18 INFO - 'LANGUAGE': 'en_US:en', 18:25:18 INFO - 'LOGNAME': 'cltbld', 18:25:18 INFO - 'MAIL': '/var/mail/cltbld', 18:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:18 INFO - 'MOZ_NO_REMOTE': '1', 18:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:18 INFO - 'NO_EM_RESTART': '1', 18:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:18 INFO - 'PWD': '/builds/slave/test', 18:25:18 INFO - 'SHELL': '/bin/bash', 18:25:18 INFO - 'SHLVL': '1', 18:25:18 INFO - 'TERM': 'linux', 18:25:18 INFO - 'TMOUT': '86400', 18:25:18 INFO - 'USER': 'cltbld', 18:25:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', 18:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:18 INFO - '_': '/tools/buildbot/bin/python'} 18:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:18 INFO - Downloading/unpacking jsonschema==2.5.1 18:25: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 18:25: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 18:25: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 18:25: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 18:25:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:25:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:25:19 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 18:25:19 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 18:25:19 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 18:25:19 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 18:25:19 INFO - Downloading functools32-3.2.3-2.tar.gz 18:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:25:20 INFO - warning: no files found matching '*.txt' 18:25:20 INFO - no previously-included directories found matching 'build' 18:25:20 INFO - no previously-included directories found matching 'dist' 18:25:20 INFO - no previously-included directories found matching '.git*' 18:25:20 INFO - Installing collected packages: jsonschema, functools32 18:25:20 INFO - Running setup.py install for functools32 18:25:20 INFO - warning: no files found matching '*.txt' 18:25:20 INFO - no previously-included directories found matching 'build' 18:25:20 INFO - no previously-included directories found matching 'dist' 18:25:20 INFO - no previously-included directories found matching '.git*' 18:25:20 INFO - Successfully installed jsonschema functools32 18:25:20 INFO - Cleaning up... 18:25:20 INFO - Return code: 0 18:25:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:25:20 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')]} 18:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:20 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')]} 18:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:20 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 0xa671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc33a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3eb0>, '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 0xdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd5240>, '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': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', '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 18:25:20 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 18:25:20 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 18:25:20 INFO - Using env: {'DISPLAY': ':0', 18:25:20 INFO - 'HOME': '/home/cltbld', 18:25:20 INFO - 'LANG': 'en_US.UTF-8', 18:25:20 INFO - 'LANGUAGE': 'en_US:en', 18:25:20 INFO - 'LOGNAME': 'cltbld', 18:25:20 INFO - 'MAIL': '/var/mail/cltbld', 18:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:20 INFO - 'MOZ_NO_REMOTE': '1', 18:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:20 INFO - 'NO_EM_RESTART': '1', 18:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:20 INFO - 'PWD': '/builds/slave/test', 18:25:20 INFO - 'SHELL': '/bin/bash', 18:25:20 INFO - 'SHLVL': '1', 18:25:20 INFO - 'TERM': 'linux', 18:25:20 INFO - 'TMOUT': '86400', 18:25:20 INFO - 'USER': 'cltbld', 18:25:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', 18:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:20 INFO - '_': '/tools/buildbot/bin/python'} 18:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:25:20 INFO - Cleaning up... 18:25:20 INFO - Return code: 0 18:25:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:25:20 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')]} 18:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:20 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')]} 18:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:20 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 0xa671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc33a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3eb0>, '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 0xdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd5240>, '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': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', '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 18:25:20 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 18:25:20 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 18:25:20 INFO - Using env: {'DISPLAY': ':0', 18:25:20 INFO - 'HOME': '/home/cltbld', 18:25:20 INFO - 'LANG': 'en_US.UTF-8', 18:25:20 INFO - 'LANGUAGE': 'en_US:en', 18:25:20 INFO - 'LOGNAME': 'cltbld', 18:25:20 INFO - 'MAIL': '/var/mail/cltbld', 18:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:20 INFO - 'MOZ_NO_REMOTE': '1', 18:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:20 INFO - 'NO_EM_RESTART': '1', 18:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:20 INFO - 'PWD': '/builds/slave/test', 18:25:20 INFO - 'SHELL': '/bin/bash', 18:25:20 INFO - 'SHLVL': '1', 18:25:20 INFO - 'TERM': 'linux', 18:25:20 INFO - 'TMOUT': '86400', 18:25:20 INFO - 'USER': 'cltbld', 18:25:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', 18:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:20 INFO - '_': '/tools/buildbot/bin/python'} 18:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:20 INFO - Downloading/unpacking blobuploader==1.2.4 18:25: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 18:25: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 18:25: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 18:25: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 18:25:21 INFO - Downloading blobuploader-1.2.4.tar.gz 18:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:25:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:25:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:22 INFO - Downloading docopt-0.6.1.tar.gz 18:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:25:22 INFO - Installing collected packages: blobuploader, requests, docopt 18:25:22 INFO - Running setup.py install for blobuploader 18:25:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:25:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:25:22 INFO - Running setup.py install for requests 18:25:22 INFO - Running setup.py install for docopt 18:25:22 INFO - Successfully installed blobuploader requests docopt 18:25:22 INFO - Cleaning up... 18:25:22 INFO - Return code: 0 18:25:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:22 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')]} 18:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:22 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')]} 18:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:22 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 0xa671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc33a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3eb0>, '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 0xdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd5240>, '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': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', '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 18:25:22 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 18:25:22 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 18:25:22 INFO - Using env: {'DISPLAY': ':0', 18:25:22 INFO - 'HOME': '/home/cltbld', 18:25:22 INFO - 'LANG': 'en_US.UTF-8', 18:25:22 INFO - 'LANGUAGE': 'en_US:en', 18:25:22 INFO - 'LOGNAME': 'cltbld', 18:25:22 INFO - 'MAIL': '/var/mail/cltbld', 18:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:22 INFO - 'MOZ_NO_REMOTE': '1', 18:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:22 INFO - 'NO_EM_RESTART': '1', 18:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:22 INFO - 'PWD': '/builds/slave/test', 18:25:22 INFO - 'SHELL': '/bin/bash', 18:25:22 INFO - 'SHLVL': '1', 18:25:22 INFO - 'TERM': 'linux', 18:25:22 INFO - 'TMOUT': '86400', 18:25:22 INFO - 'USER': 'cltbld', 18:25:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', 18:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:22 INFO - '_': '/tools/buildbot/bin/python'} 18:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:23 INFO - Running setup.py (path:/tmp/pip-_yhGI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:23 INFO - Running setup.py (path:/tmp/pip-EMykgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:23 INFO - Running setup.py (path:/tmp/pip-6oj6mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:23 INFO - Running setup.py (path:/tmp/pip-ktVCGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:23 INFO - Running setup.py (path:/tmp/pip-YgTnJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:23 INFO - Running setup.py (path:/tmp/pip-GhZLrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:23 INFO - Running setup.py (path:/tmp/pip-ncxO7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:23 INFO - Running setup.py (path:/tmp/pip-CIHHqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:23 INFO - Running setup.py (path:/tmp/pip-0xodFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:23 INFO - Running setup.py (path:/tmp/pip-HkYe4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:23 INFO - Running setup.py (path:/tmp/pip-7oaMAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:23 INFO - Running setup.py (path:/tmp/pip-BhgKY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:24 INFO - Running setup.py (path:/tmp/pip-sS00RO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:24 INFO - Running setup.py (path:/tmp/pip-KLpNVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:24 INFO - Running setup.py (path:/tmp/pip-tn2sBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:24 INFO - Running setup.py (path:/tmp/pip-LJx0Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:24 INFO - Running setup.py (path:/tmp/pip-rHTCIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:25:24 INFO - Running setup.py install for manifestparser 18:25:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:25:24 INFO - Running setup.py install for mozcrash 18:25:24 INFO - Running setup.py install for mozdebug 18:25:24 INFO - Running setup.py install for mozdevice 18:25:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:25:24 INFO - Running setup.py install for mozfile 18:25:24 INFO - Running setup.py install for mozhttpd 18:25:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:25:24 INFO - Running setup.py install for mozinfo 18:25:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:25:25 INFO - Running setup.py install for mozInstall 18:25:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:25:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:25:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:25:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:25:25 INFO - Running setup.py install for mozleak 18:25:25 INFO - Running setup.py install for mozlog 18:25:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:25:25 INFO - Running setup.py install for moznetwork 18:25:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:25:25 INFO - Running setup.py install for mozprocess 18:25:25 INFO - Running setup.py install for mozprofile 18:25:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:25:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:25:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:25:25 INFO - Running setup.py install for mozrunner 18:25:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:25:25 INFO - Running setup.py install for mozscreenshot 18:25:25 INFO - Running setup.py install for moztest 18:25:26 INFO - Running setup.py install for mozversion 18:25:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:25:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:25:26 INFO - Cleaning up... 18:25:26 INFO - Return code: 0 18:25:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:26 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')]} 18:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:26 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')]} 18:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:26 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 0xa671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc33a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3eb0>, '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 0xdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd5240>, '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': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', '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 18:25:26 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 18:25:26 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 18:25:26 INFO - Using env: {'DISPLAY': ':0', 18:25:26 INFO - 'HOME': '/home/cltbld', 18:25:26 INFO - 'LANG': 'en_US.UTF-8', 18:25:26 INFO - 'LANGUAGE': 'en_US:en', 18:25:26 INFO - 'LOGNAME': 'cltbld', 18:25:26 INFO - 'MAIL': '/var/mail/cltbld', 18:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:26 INFO - 'MOZ_NO_REMOTE': '1', 18:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:26 INFO - 'NO_EM_RESTART': '1', 18:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:26 INFO - 'PWD': '/builds/slave/test', 18:25:26 INFO - 'SHELL': '/bin/bash', 18:25:26 INFO - 'SHLVL': '1', 18:25:26 INFO - 'TERM': 'linux', 18:25:26 INFO - 'TMOUT': '86400', 18:25:26 INFO - 'USER': 'cltbld', 18:25:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', 18:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:26 INFO - '_': '/tools/buildbot/bin/python'} 18:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:26 INFO - Running setup.py (path:/tmp/pip-fFmib4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:26 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)) 18:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:26 INFO - Running setup.py (path:/tmp/pip-v756Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:26 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)) 18:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:26 INFO - Running setup.py (path:/tmp/pip-G_Kl0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:26 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)) 18:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:26 INFO - Running setup.py (path:/tmp/pip-AeMS0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:26 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)) 18:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:26 INFO - Running setup.py (path:/tmp/pip-ifeXdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:26 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)) 18:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:26 INFO - Running setup.py (path:/tmp/pip-4V27xZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:26 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)) 18:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:26 INFO - Running setup.py (path:/tmp/pip-JDk46l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:26 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)) 18:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:26 INFO - Running setup.py (path:/tmp/pip-yldMMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:26 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)) 18:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:26 INFO - Running setup.py (path:/tmp/pip-N9rle5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:27 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)) 18:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:27 INFO - Running setup.py (path:/tmp/pip-KxuGna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:27 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)) 18:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:27 INFO - Running setup.py (path:/tmp/pip-FzzIYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:27 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)) 18:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:27 INFO - Running setup.py (path:/tmp/pip-U6WkOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:27 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)) 18:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:27 INFO - Running setup.py (path:/tmp/pip-f1u27t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:27 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)) 18:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:27 INFO - Running setup.py (path:/tmp/pip-XabBRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:27 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)) 18:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:27 INFO - Running setup.py (path:/tmp/pip-zK1RLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:27 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)) 18:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:27 INFO - Running setup.py (path:/tmp/pip-vuyWUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:27 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)) 18:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:27 INFO - Running setup.py (path:/tmp/pip-vnd93Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:27 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)) 18:25:27 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)) 18:25:27 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)) 18:25:27 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)) 18:25:27 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)) 18:25:27 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)) 18:25:27 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)) 18:25:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:25: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 18:25: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 18:25: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 18:25: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 18:25:28 INFO - Downloading blessings-1.6.tar.gz 18:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:25:28 INFO - Installing collected packages: blessings 18:25:28 INFO - Running setup.py install for blessings 18:25:28 INFO - Successfully installed blessings 18:25:28 INFO - Cleaning up... 18:25:28 INFO - Return code: 0 18:25:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:25:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:29 INFO - Reading from file tmpfile_stdout 18:25:29 INFO - Current package versions: 18:25:29 INFO - argparse == 1.2.1 18:25:29 INFO - blessings == 1.6 18:25:29 INFO - blobuploader == 1.2.4 18:25:29 INFO - docopt == 0.6.1 18:25:29 INFO - functools32 == 3.2.3-2 18:25:29 INFO - jsonschema == 2.5.1 18:25:29 INFO - manifestparser == 1.1 18:25:29 INFO - mozInstall == 1.13 18:25:29 INFO - mozcrash == 1.0 18:25:29 INFO - mozdebug == 0.1 18:25:29 INFO - mozdevice == 0.51 18:25:29 INFO - mozfile == 1.2 18:25:29 INFO - mozhttpd == 0.7 18:25:29 INFO - mozinfo == 0.10 18:25:29 INFO - mozleak == 0.1 18:25:29 INFO - mozlog == 3.5 18:25:29 INFO - moznetwork == 0.27 18:25:29 INFO - mozprocess == 0.25 18:25:29 INFO - mozprofile == 0.28 18:25:29 INFO - mozrunner == 6.13 18:25:29 INFO - mozscreenshot == 0.1 18:25:29 INFO - mozsystemmonitor == 0.3 18:25:29 INFO - moztest == 0.8 18:25:29 INFO - mozversion == 1.4 18:25:29 INFO - psutil == 3.1.1 18:25:29 INFO - requests == 1.2.3 18:25:29 INFO - wsgiref == 0.1.2 18:25:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:29 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')]} 18:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:29 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')]} 18:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:29 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 0xa671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc33a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3eb0>, '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 0xdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd5240>, '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': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', '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 18:25:29 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 18:25:29 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 18:25:29 INFO - Using env: {'DISPLAY': ':0', 18:25:29 INFO - 'HOME': '/home/cltbld', 18:25:29 INFO - 'LANG': 'en_US.UTF-8', 18:25:29 INFO - 'LANGUAGE': 'en_US:en', 18:25:29 INFO - 'LOGNAME': 'cltbld', 18:25:29 INFO - 'MAIL': '/var/mail/cltbld', 18:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:29 INFO - 'MOZ_NO_REMOTE': '1', 18:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:29 INFO - 'NO_EM_RESTART': '1', 18:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:29 INFO - 'PWD': '/builds/slave/test', 18:25:29 INFO - 'SHELL': '/bin/bash', 18:25:29 INFO - 'SHLVL': '1', 18:25:29 INFO - 'TERM': 'linux', 18:25:29 INFO - 'TMOUT': '86400', 18:25:29 INFO - 'USER': 'cltbld', 18:25:29 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', 18:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:29 INFO - '_': '/tools/buildbot/bin/python'} 18:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:29 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)) 18:25:29 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)) 18:25:29 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)) 18:25:29 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)) 18:25:29 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)) 18:25:29 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)) 18:25:29 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)) 18:25:29 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)) 18:25:29 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)) 18:25:29 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:30 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:25:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:25:30 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:25:30 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 18:25:30 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 18:25:30 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 18:25:30 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 18:25:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:25:30 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)) 18:25:30 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)) 18:25:30 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)) 18:25:30 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)) 18:25:30 INFO - Installing collected packages: marionette-driver, simplejson 18:25:30 INFO - Running setup.py install for marionette-driver 18:25:30 INFO - Running setup.py install for simplejson 18:25:30 INFO - building 'simplejson._speedups' extension 18:25:30 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 18:25:31 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 18:25:31 INFO - Successfully installed marionette-driver simplejson 18:25:31 INFO - Cleaning up... 18:25:31 INFO - Return code: 0 18:25:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:25:31 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')]} 18:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:31 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')]} 18:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:31 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 0xa671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc33a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd3eb0>, '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 0xdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd5240>, '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': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', '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 18:25:31 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 18:25:31 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 18:25:31 INFO - Using env: {'DISPLAY': ':0', 18:25:31 INFO - 'HOME': '/home/cltbld', 18:25:31 INFO - 'LANG': 'en_US.UTF-8', 18:25:31 INFO - 'LANGUAGE': 'en_US:en', 18:25:31 INFO - 'LOGNAME': 'cltbld', 18:25:31 INFO - 'MAIL': '/var/mail/cltbld', 18:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:31 INFO - 'MOZ_NO_REMOTE': '1', 18:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:31 INFO - 'NO_EM_RESTART': '1', 18:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:31 INFO - 'PWD': '/builds/slave/test', 18:25:31 INFO - 'SHELL': '/bin/bash', 18:25:31 INFO - 'SHLVL': '1', 18:25:31 INFO - 'TERM': 'linux', 18:25:31 INFO - 'TMOUT': '86400', 18:25:31 INFO - 'USER': 'cltbld', 18:25:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', 18:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:31 INFO - '_': '/tools/buildbot/bin/python'} 18:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:25:32 INFO - Cleaning up... 18:25:32 INFO - Return code: 0 18:25:32 INFO - Running post-action listener: _resource_record_post_action 18:25:32 INFO - Running post-action listener: _start_resource_monitoring 18:25:32 INFO - Starting resource monitoring. 18:25:32 INFO - [mozharness: 2017-07-29 01:25:32.205737Z] Finished create-virtualenv step (success) 18:25:32 INFO - [mozharness: 2017-07-29 01:25:32.206254Z] Running install step. 18:25:32 INFO - Running pre-action listener: _resource_record_pre_action 18:25:32 INFO - Running main action method: install 18:25:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:32 INFO - Reading from file tmpfile_stdout 18:25:32 INFO - Detecting whether we're running mozinstall >=1.0... 18:25:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:25:32 INFO - Reading from file tmpfile_stdout 18:25:32 INFO - Output received: 18:25:32 INFO - Usage: mozinstall [options] installer 18:25:32 INFO - Options: 18:25:32 INFO - -h, --help show this help message and exit 18:25:32 INFO - -d DEST, --destination=DEST 18:25:32 INFO - Directory to install application into. [default: 18:25:32 INFO - "/builds/slave/test"] 18:25:32 INFO - --app=APP Application being installed. [default: firefox] 18:25:32 INFO - mkdir: /builds/slave/test/build/application 18:25:32 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'] 18:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:25:50 INFO - Reading from file tmpfile_stdout 18:25:50 INFO - Output received: 18:25:50 INFO - /builds/slave/test/build/application/firefox/firefox 18:25:50 INFO - Running post-action listener: _resource_record_post_action 18:25:50 INFO - [mozharness: 2017-07-29 01:25:50.550002Z] Finished install step (success) 18:25:50 INFO - [mozharness: 2017-07-29 01:25:50.550351Z] Running setup-mitmproxy step. 18:25:50 INFO - Running pre-action listener: _resource_record_pre_action 18:25:50 INFO - Running main action method: setup_mitmproxy 18:25:50 INFO - Skipping: mitmproxy is not required 18:25:50 INFO - Running post-action listener: _resource_record_post_action 18:25:50 INFO - [mozharness: 2017-07-29 01:25:50.551967Z] Finished setup-mitmproxy step (success) 18:25:50 INFO - [mozharness: 2017-07-29 01:25:50.552281Z] Running run-tests step. 18:25:50 INFO - Running pre-action listener: _resource_record_pre_action 18:25:50 INFO - Running pre-action listener: _set_gcov_prefix 18:25:50 INFO - Running main action method: run_tests 18:25:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:25:50 INFO - Python 2.7.3 18:25:50 INFO - Return code: 0 18:25:50 INFO - grabbing minidump binary from tooltool 18:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:50 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 0xdd3eb0>, '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 0xdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd5240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:25:50 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 18:25:50 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 18:25:50 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 18:25:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:25:50 INFO - Return code: 0 18:25:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:25:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:25:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:25:50 INFO - ENV: RUST_BACKTRACE is now 1 18:25:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:25:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:25:50 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/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 18:25:50 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/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 18:25:50 INFO - Using env: {'DISPLAY': ':0', 18:25:50 INFO - 'HOME': '/home/cltbld', 18:25:50 INFO - 'LANG': 'en_US.UTF-8', 18:25:50 INFO - 'LANGUAGE': 'en_US:en', 18:25:50 INFO - 'LOGNAME': 'cltbld', 18:25:50 INFO - 'MAIL': '/var/mail/cltbld', 18:25:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:25:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:50 INFO - 'MOZ_NO_REMOTE': '1', 18:25:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:50 INFO - 'NO_EM_RESTART': '1', 18:25:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:50 INFO - 'PWD': '/builds/slave/test', 18:25:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:25:50 INFO - 'RUST_BACKTRACE': '1', 18:25:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:25:50 INFO - 'SHELL': '/bin/bash', 18:25:50 INFO - 'SHLVL': '1', 18:25:50 INFO - 'STYLO_FORCE_ENABLED': '1', 18:25:50 INFO - 'TERM': 'linux', 18:25:50 INFO - 'TMOUT': '86400', 18:25:50 INFO - 'USER': 'cltbld', 18:25:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331', 18:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:50 INFO - '_': '/tools/buildbot/bin/python'} 18:25:50 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/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 18:25:50 INFO - mozversion application_buildid: 20170729004054 18:25:50 INFO - mozversion application_changeset: ec666e910442ae55686160c1bd0c93b00a08dead 18:25:50 INFO - mozversion application_display_name: Nightly 18:25:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:25:50 INFO - mozversion application_name: Firefox 18:25:50 INFO - mozversion application_remotingname: firefox 18:25:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:25:50 INFO - mozversion application_vendor: Mozilla 18:25:50 INFO - mozversion application_version: 56.0a1 18:25:50 INFO - mozversion platform_buildid: 20170729004054 18:25:50 INFO - mozversion platform_changeset: ec666e910442ae55686160c1bd0c93b00a08dead 18:25:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:25:50 INFO - mozversion platform_version: 56.0a1 18:25:50 INFO - using testdate: 1501291550 18:25:50 INFO - actual date: 1501291550 18:25:50 INFO - starting webserver on 'localhost:59227' 18:25:50 INFO - SUITE-START | Running 2 tests 18:25:50 INFO - TEST-START | dromaeo_css 18:25:50 INFO - Initialising browser for dromaeo_css test... 18:25:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59227/getInfo.html -profile /tmp/tmpTed7_p/profile 18:25:50 INFO - TEST-INFO | started process 31707 (/builds/slave/test/build/application/firefox/firefox http://localhost:59227/getInfo.html) 18:25:56 INFO - TEST-INFO | 31707: exit 0 18:25:56 INFO - Browser initialized. 18:25:56 INFO - Running cycle 1/1 for dromaeo_css test... 18:25:56 INFO - TEST-INFO | started process 31929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTed7_p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:25:57 INFO - PID 31929 | 18:25:57 INFO - PID 31929 | (/builds/slave/test/build/application/firefox/firefox:31984): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:25:57 INFO - PID 31929 | 18:26:08 INFO - PID 31929 | RSS: Main: 173506560 18:26:08 INFO - PID 31929 | 18:29:07 INFO - PID 31929 | Cycle 1(1): loaded http://localhost:59227/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59227/tests/dromaeo/cssquery-ext.html) 18:29:09 INFO - PID 31929 | RSS: Main: 175353856 18:29:09 INFO - PID 31929 | 18:32:10 INFO - PID 31929 | Cycle 1(1): loaded http://localhost:59227/tests/dromaeo/cssquery-ext.html (next: http://localhost:59227/tests/dromaeo/cssquery-jquery.html) 18:32:11 INFO - PID 31929 | RSS: Main: 173342720 18:32:11 INFO - PID 31929 | 18:35:13 INFO - PID 31929 | Cycle 1(1): loaded http://localhost:59227/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59227/tests/dromaeo/cssquery-mootools.html) 18:35:14 INFO - PID 31929 | RSS: Main: 175513600 18:35:14 INFO - PID 31929 | 18:38:15 INFO - PID 31929 | Cycle 1(1): loaded http://localhost:59227/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59227/tests/dromaeo/cssquery-prototype.html) 18:38:16 INFO - PID 31929 | RSS: Main: 173813760 18:38:16 INFO - PID 31929 | 18:41:20 INFO - PID 31929 | Cycle 1(1): loaded http://localhost:59227/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59227/tests/dromaeo/cssquery-yui.html) 18:41:20 INFO - PID 31929 | RSS: Main: 172998656 18:41:20 INFO - PID 31929 | 18:44:22 INFO - PID 31929 | Cycle 1(1): loaded http://localhost:59227/tests/dromaeo/cssquery-yui.html (next: http://localhost:59227/tests/dromaeo/cssquery-dojo.html) 18:44:23 INFO - PID 31929 | RSS: Main: 176857088 18:44:23 INFO - PID 31929 | 18:44:23 INFO - PID 31929 | __start_tp_report 18:44:23 INFO - PID 31929 | _x_x_mozilla_page_load 18:44:23 INFO - PID 31929 | _x_x_mozilla_page_load_details 18:44:23 INFO - PID 31929 | |i|pagename|runs| 18:44:23 INFO - PID 31929 | |0;dojo.html;3130.0922732407603;3146.8898588549405;3157.46323125069;3166.9683303166967;3183.3633273345336;6091.14723938649;6163.476104531114;6167.290761562416;6198;6229.065640153974;6017.939820601804;6120.173776540166;6154.569180157391;6165.907511387333;6173.32093469718;5570.164475328703;5637.689927054011;5643.971780141093;5705.315362156547;5719.485246327829;5507.311586051744;5684.886302273952;5701.6864072476;5709.6574205547595;5761;5499.4225606311165;5551.1673249012765;5578.386377498492;5618.0449323615085;5642.830715078534;5520.91718624221;5566.415526369754;5572.888542229132;5584.162375643686;5586.748596313176;5591.133374326986;5613.550915926757;5621.80323688673;5623.49388555028;5649.887002259932;6065.211522502046;6065.514758819284;6067.514598832083;6121.051237058263;6128.877422451526;6554.082428460019;6592.538522303441;6630.569013014187;6651.401373876374;6674.899876501856;6641;6646.401823835878;6724.7646332378135;6742.325767423267;6760.76337328196;6075.878482430371;6169.629822210682;6170.784022559234;6170.876582468325;6248.687565621746;6809.216940051859;6849.315068493111;6872.62200578973;6878.27778083294;6895.862082758316;6495.8700825983215;6497.9675101625135;6503.057056726748;6506.3818937200895;6507.804765857032;6593.769218077345;6601.735930562723;6604.14146160996;6618.30507796684;6626.966865165643;6522.347765223534;6528.836779080561;6555.770548030796;6577.6053436793945;6585.539012269191;5843.824685259364;6577.013447982745;6581.934180658228;6616.338366163345;6679.2318883329035;5386.13821788512;5451.64564303319;5472.72636368188;5478.424765399655;5486.396496385394;4572.245579479415;4599.33309670096;4608.953910460852;4686.179918514246;4692.319613656069;5684.8010319638615;5693.373728889819;5719.885602287931;5729.598928075078;5729.8567535811935;6671.39957403836;6671.799846004627;6687.665616719145;6694.698738556776;6709.194896612437;5659;5728.79949201776;5740.712964351766;5752.022156233366;5763.769449221984;5719.256496655491;5831.708414579254;5925.911111333334;5930.436608522184;5940.435658612511;6335.271443784024;6401.167848179707;6403.519736019817;6497.252815926135;6501.642409667419;6446.161998940108;6458.451031662361;6458.612483250832;6494.480441564758;6524.4780417565535;6287.088372185916;6312.337204593451;6414.711337989708;6438.6136831790245;6513.609183449008;6508.642024688498;6529.9020514691365;6542.051402546509;6616.702248398929;6634.966825165843;6563.967180164069;6580.243272023587;6624.314006203793;6659.500537459807;6756.189257289157;6477.967610161919;6499.545031847725;6517.022446632854;6518.478521718156;6520.087187793808;6425.421712045938;6497.5126865484335;6514.1531600891585;6517;6522.902156467751;6365.1088847562305;6378.202724659418;6434.420902118832;6452.612843229421;6454.225492940877;6441.259255185526;6464.159659244268;6509.772157974448;6607.075009498578;6630.801075967729;6141.631502109888;6181.443670069715;6201.348858369986;6219.813405597839;6343.904841427475 18:44:23 INFO - PID 31929 | |1;ext.html;804.7585724282721;815.9469634473759;855.1149560205187;856.7215654912155;882.6601758323047;41020.17959640809;41114.17771644565;41385.37921931166;41459;41746.582534174646;38007;38120.80939595305;38182.23635527288;38308.23383532328;38451;6961.443084553236;7054.541454805421;7065.258147894474;7080.29197080293;7082.327178917994;6997.195322537922;7027;7039.049728286667;7089.71641134354;7100.183478899941;6987.965060174717;7004.614746188958;7023.7541686040995;7026.683799229021;7064.222935477119;7030.3321184487395;7036.296370362974;7051.682674279644;7063.788086357417;7065.116860392451;6332.176817013758;6369.490440764727;6372.808815735535;6381.585196962183;6431.067495213168;32631.836840815882;32714;32891.67108328934;32916.6708332916;32932.83533582341;3318.1206980150278;3348.8827891023698;3363.7309015278965;3364.074879408158;3364.9158771030675;27231.319217019536;27351.589726154125;27528.898844046213;27621.171364858885;27637.585436218473;4264.978675106636;4298.290782020994;4347.630451411634;4357.063231405232;4384.561543845622;179065;181369;184956;185843;200337;48683;48713.269300960514;48717;48858.75570622124;48938.75530622324;51491.7425412878;51541.742291288305;51547;51576.48423515792;51641;14777.113373197642;14921.030133041317;14926.626834329229;14928.92535537337;15031.248437578077;12128.332941688292;12141.635750927486;12185;12186.26882387042;12193;12920.160189587647;12925.676858078436;12953;13003.414846331938;13023.47906083765;5488.4785945335125;5524.14375771756;5540.196671482693;5545.972270138624;5582.441755824466;967.1634036558467;968.951552422376;980.6959842448864;1002.2942285967458;1019.1744686803713;22612.886935565217;22781.31656050288;22783.886080569824;23089.653655195187;23239.53520929572;1087.6465148826662;1113.4544073403974;1115.3861488776306;1122.1359553144034;1124.1288001798507;11728.413579321;12147.392630368622;12321.137520373488;14432.494862679756;14913.776293355608;220160;220752;220992;221326;223143;50726.49273507218;50895.23657145146;51002.48997509977;51027.48972510302;59980.600775969346;1469.4489566412594;1475.232878902943;1480.6816534445145;1486.37572219668;1527.725009498301;26958.865205673847;28173.57739633866;28216.43567128687;28287.45262318039;28315.43369132647;38820.41769373405;38982;39169.804150979064;39311;39433;201999;203077;203803;206106;206175;36082.63917360793;36590.26819463649;37728.81135594304;37912.43131352977;37923;47485.52514474811;48343.75828120837;48837;48884.511154887994;48969.2654610174;33168;33479.83260083684;33577.49633755447;33715.83142084274;34293.657063430044;31793.682063179072;32557.863560172776;33176;33635;33984.66015339815;38095.23809523849;38479.807600961816;38621;38667.80666096652;38931.41602875903;32570;33591.66408335885;33750.662493375734;33826.3234735299;33935.83032084824;23680.52638947177;23887.522249554564;24082.39794005164;24115.15596954098;24401.26796196117 18:44:23 INFO - PID 31929 | |2;jquery.html;566.9794370133758;572.3589579670767;575.390086508301;576.1473019930502;595.5860676829603;21727.891360543195;22600.66099008516;22686.659700104472;22695.432614184632;22698.432539186528;25297.74702252977;25938.22185334443;26020.609690854606;26050;26057.478850423027;6505.902411463831;6680.93319066808;6685.565438246498;6695.698693558777;6697.162854643169;6437.485001199892;6616;6672.032555279481;7030.85938281234;7109.537880037807;7001.824954376156;7073.964630176842;7079.61062141582;7083.079199704031;7089;7001.649917504155;7027.191872934602;7031.402330801888;7035.964820175917;7036;6869.7595584154315;6900.861982760317;6948.583085014865;6967.686454109577;6978.406835418996;30884.53673194904;31479.213019674462;31520.211994700087;31613.8419307902;31912.521312180335;1899.7340372347883;1908.4179325305777;1912.9956772694309;1918.8464922806143;1928.864979451439;19742.60514789696;20398.898005510026;20451.48871278215;20471.283505077252;20540.383788486368;2360.072780976557;2373.2880135959144;2450.4486490539484;2470.505898820243;2520.8361456505268;133984;136361.3181934094;137274;137531;137729;20391.592168156552;21907.67138492924;22013;22037.449063773212;22393;22866.771332286797;23322.65016024761;23523;23574.29277121689;44255.11489770251;10183.134433573081;10355;10405.167586593054;10420.791584168273;10540.841887371696;9576.515640075799;9600.615975360908;9605.13553780163;9799.216062714966;9805.215582753362;8893.421927574687;9013.008569057398;9120.084782195812;9248.676296329731;9312.394694344846;2598.7141414444395;2605.71337152913;2671.358873870257;2710.2546799629863;2724.7820174386397;936.864154697565;948.8481842905102;966.0918736387773;969.2633598465077;976.7802244495074;19267.614647706967;19284.1322140504;19325.903370483058;19356.225750970087;19534.902325488565;995.1292618958412;1002.819492491344;1026.825439675257;1053.9947300263602;1055.8680164979378;10654.893451065545;10666.839997400046;11068.114550835913;12876.163049401759;13627.523036693867;506699;508742;514970;517788;536146;121446;129860;133051;133338;134505;1287.2340957130493;1300.5773123735014;1308.19545979224;1325.6752095736606;1333.5865881576742;20277.35161091078;20593.38219853407;20604.79395206029;21221.791202544726;21260.468488287916;57926;59353;59803;60124.39875601188;60310;76171.23828761642;76829.61585192039;77233.61383193047;77337.61331193308;77548;19807.60384792325;20498;20500.692489612968;20531.897340513202;20576.074076666286;23018.309450716504;23102.42243943915;23241.186558470374;23270;23632.29103126909;17884.483988250195;18028.81971180324;18106.81893181104;18136.18387172554;18188.09059546991;15071.321790519234;15124.168170750714;16057.598560036093;16390.590235244214;16691.49925502237;17865;18496.260149593865;18839.24643014319;18853.15160817794;18855.811441885406;20239.19043238254;20651.27720529774;20727.68908466344;20728.170873164905;20883;17718.291268349636;17875.46373608794;18065.367712130013;18146.727799083288;18200.180991855133 18:44:23 INFO - PID 31929 | |3;mootools.html;1345.9057865949383;1414.603910904947;1420.7655736803424;1427.0866645346987;1432.090622454741;13477;13985.160890346586;14029.228392438412;14051.227182504957;14053;13440.596782096529;13798;14287.71424571508;14299.57101286963;14313.78529322061;2678.1296078774426;2751.9449611007767;2753.655793025872;2759.7378249066305;2759.889604415821;2584.961225581618;2665.5068812269697;2703.3917368592106;2717.375003749139;2717.660292463442;2450.15469662966;2494.912678056259;2496.9750302497014;2500.349909023658;2581.8838152283192;2481.8883150258193;2527.6966763988257;2547.770700636933;2549.77052065315;2552.808539359537;2594.0661361909697;2599.0643368387364;2618.5024845279336;2634.4467661791045;2636.380450594109;13260.60218193446;13712.3829427675;13722.313884305844;13811.309434528333;13828.446862125504;7428.4428667850125;7742.690292388298;7752.612369381508;7764.689412423496;7785.922140778576;5010.498950104997;5127.102757017507;5221.373435187764;5280.049591073605;5284.365876094893;1802.1890149432809;1810.900400477973;1818.6453641539906;1849.2880241107136;1862.3202531076195;22760.430989225402;22956.770432295798;22993.195238166583;23001.88499057511;23036.884815575984;6102.877942441126;6186.690665466709;6449.903251451232;6468.870622587522;6511.804645860631;15550.611234719223;15679.608009799846;15680.05919644825;15717.21413929299;15722.528324150293;6961.199462061928;7355.77932662021;7547.16981132075;7557.886631700529;7559.924400755922;5984.072468767348;6153.323134455206;6223.875522489616;6903.482238832007;7130.750423735144;5030.647854650212;5225.686458812484;5252;5259.184826351921;5275.182346736262;1509.3358922074253;1523.116592376419;1535.4088675859875;1542.6529030967943;1562.5859147325968;805.5287656720767;823.3001948343859;829.8713699376606;853.906070332263;866.6143566113145;6710.563813352116;6735.42748866342;6815.2843951385385;6838.350356716104;6933.965330173317;690.4614400767409;707.5825263094696;719.5179229915968;925.509479975614;933.6032186320787;4396.824127034947;4510.72935623857;4547.067851090518;4561.521040290788;4607.861764147081;17762.200700968486;18625.7206141908;18934.810651893582;19018.42944711661;19043.80956190448;17923.73114403285;18515.907420462812;18686.71969920452;18722.063896805106;18886.244550217838;9982.700518984442;10532.842007369896;10533.315334503233;10537.631182908715;10552.841707374395;6833.248342682202;7017.754378596725;7118.537295075804;7185.640717963976;7213.639318034182;15295.158766267961;15713.450029248921;15894;16455.42406015784;16665.500034998968;16107.147678016709;16704.24830882589;16741.49775506737;16856.66286674235;16906.154692265583;10277.486125693536;10589.52347144365;10739.087177589992;10827.458627068772;11149.609763658233;12578.496860125493;12613.74772504563;12665.87334126647;12667;12678.112532122663;9566.426014439156;10009.349392289478;10179.03299186576;10241.795164096528;10433.791324173626;9655.324127311022;10017.54921028541;10127.645532406625;10198.643047493302;10233.283670143019;8559.101294364002;8681.2186903179;8689.435186712843;8690.044095149402;8700.216980471789;6041.395860413923;6186.1339412483185;6510.707018184098;6545.901811472927;6714.966425167843;5822.73797679097;6107.144999699956;6671.299513551007;6730.32696730323;6769.593824370553 18:44:23 INFO - PID 31929 | |4;prototype.html;489.50070927653815;497.5522030172844;514.686041514676;516.535118393446;522.8431470558834;6127.479164271037;6169.969150154248;6186.257649082105;6253.1870856788555;6255.249370075586;5870.501007414375;6026.548008899339;6079.392060793918;6106.48094911933;6131.325554189047;4855.635827312948;4866.221404575269;4931.235658472924;4944.7774850131655;4954.281629163769;4875.804967801284;4886.682365646239;4916.237983112624;4928;4962.230854217602;4716.1982462981205;4798.592119669815;4829.4446138693975;4832.17852964995;4877.756112194394;4805.783739731721;4859.760761005921;4876.244182151772;4880.2679598060395;4883.804647814083;4333.913321733579;4349.2385583838595;4354.56454354562;4389.846355377578;4418.403515525395;5934;5964.657951960818;6027.071337172107;6028.879422411571;6036.849078773022;5678;5684.289463817023;5690.7439165237665;5700.25896633435;5710.914336284959;6272.2159730033745;6346.777862774781;6376.7130479128555;6388.265349484822;6502.967485162591;4738.312944623045;4833.3958255218095;4833.685810422347;4859.343988561534;4864.91078165364;6615.801525954229;6887.931120688829;6926.168859736814;6940.861182776316;6944.652767361612;4922.852314430573;4925.4335751388335;4928.433230178503;4984.177610694195;4999.125153098194;5075.3148324975655;5089.51649593288;5092.974535127375;5094.133997220407;5100.336956195671;5635.6618602883955;5698.3162020556965;5699.116636921284;5707.971460142756;5730.455606717355;6374.74501019954;6420.101185833987;6469.447332640227;6470.4823614110755;6558.934410655832;1634.2400783635667;1696.703076961527;1743.1197245390997;1750.9212085456186;1761.1947753552454;1186.323795436593;1203.6990752311922;1210.4915935307192;1236.7650146472142;1237.5235534319352;5557.3331200256225;5568.164775283659;5604.971975140098;5650;5660.632058916157;6506.332403714454;6511.28375878653;6528.706208220641;6575.868482630321;6589.341065893468;5499.3675727291875;5681.886362272731;5689.6586204827845;5738.483536481736;5774.092021781452;3529.2412131391875;3550.55618047744;3575.928481430357;3584.6773790358993;3599.6220396858475;6318.304986451487;6384.48924086072;6385.840353991094;6455.806325810233;6502.479801615859;6801.149856267966;6812.250652428229;6850.212225594021;6891.483138764613;6910.792676219721;6364.49084073273;6398.5201109916015;6490.578112422678;6551.279359270381;6575.178102737158;6520.315366886409;6534.3279555118315;6622.238442578972;6668.533202675961;6727.697253623501;6474.870502589828;6555.967220163869;6645.700943457459;6649.135612370361;6667.166604174478;6367.840803979938;6388.297287298301;6423.775167869102;6477.708503117466;6512.706928188338;4890.364252647133;4914.262860570943;4916.680415773107;4919.901601968012;4944.48082951285;6650.966745166436;6663.13379260693;6690.19717633887;6695.799126026227;6719.966400167968;6444.13004244421;6500.837479063061;6514.413702766774;6546.985217291328;6585.781630398392;6376.489880809431;6378.425941665272;6395.386606567275;6447.774327898501;6453.547052533737;6190.319064902767;6335.271443784024;6370.904436433365;6387.457066149429;6393.1688880445245;6153.876922461615;6410.839729006812;6451.225852897683;6456.483481321577;6459.483241340776;6125.295591007091;6157.96921015392;6178.382161783786;6243.656598887105;6287.937120628918 18:44:23 INFO - PID 31929 | |5;yui.html;873.0919843362902;879.2789912271936;885.7918389178544;895.623837988045;897.129784109414;17924.46226613202;18687.719684204712;18699;18707.438776836683;18763.967981761016;19436.416907492763;20946.581068378622;21083.367498975054;21208.045637946292;21299.25452609159;1039.776448063668;1074.951627176775;1075.0754351257913;1076.2896488317713;1076.6608518316743;983.3755565216068;993.175664198717;1014.1025192704473;1061.1669839176247;1062.1927335225246;1100.5157730598512;1104.9337039777638;1105.7843720474511;1106.164845541615;1106.6624679472757;1067.4555976451988;1079.3901445683164;1083.312096818518;1084.376483521974;1087.526925787285;808.0586117173544;808.720991258015;809.3889113719164;809.951402915827;810.4165001199127;18651.720224196648;19320.61358772831;19623.31318403849;19832;19891.303804366777;20163;20311.5937681247;20719.896400518053;20840.895795521075;20849.8957505213;15487.612809679735;15586;15617.843821561753;15684.215789210608;15706.136162511057;3479.3215323012023;3496.930061398758;3509.64903509647;3509.842057107436;3511.6312787157235;123687.3815630916;125883;127685.99999999907;131045;132199.33900330533;15366.462173823862;15736.842631573767;15824.525264242091;15854;16092.75860862088;27909;29346.266343341587;29434.11697649074;29550.408991820044;29553.704462955524;8254.133316001853;8393.496390216484;8407.62165702545;8415.53714545706;8420.031696354876;3922.646961773454;4021.9597804021587;4024.074462873497;4029.9597004029583;4042.838286468508;4871.269309603588;4997.30037794709;5777.74000169985;5881.529477641779;5926.525877929756;1053.4837929414532;1062.7396287909512;1093.7101668057971;1098.4782228441586;1101.4547798839626;629.0784001437823;644.5359341274275;669.3473862983552;673.8147009572407;682.011083928306;11343.659690209306;13920.443182272798;14004.50984215568;14091.36588853504;14124.43502259898;656.4420242793587;675.1021141881287;676.3338111959715;685.8045457044718;703.9859202815915;5525.696086715269;5584;5622.437756224426;5719.142128680648;5986.610870293417;96092.51953740326;101349.49325253327;102323;102518;104372;88472;92054.37296738273;92813.53593231991;93450.53274733583;96788.51605742067;78075.60962195267;78165.2183478158;82704.58647706723;83245.16754832375;84623.57688211642;11444.828327574927;12059.15585909013;12742;12840.293783841606;13122.840652647243;32883.34233315368;35839.28321433609;36272;36338.09154771152;37710.434343485416;62007.689961549906;65265;67017;68300;69232.65383673049;18410.539736506693;18904.054797259807;18965.525861853563;19151;19158.904205478884;20797.37607871766;20909.163633454493;20958.266460673804;20959.323254139326;21059.15763369448;18420.263189472273;18448.169832357307;18583.628327433646;18646.81353186505;18648.16083276283;18198.090095495438;18327.17527711283;18468.538286542946;18532.351367702067;18569.628607427505;18376.632467350846;18460.723089153405;18511.53721156982;18655.347062852736;18980.145893435103;12858.228506289652;13393.66515837112;13691.726165476834;13763.105398149088;14118.717625647225;13327.133736307109;14537.92731036338;14553.92723036378;14679.6661540529;15222.346636807308 18:44:23 INFO - PID 31929 | __end_tp_report 18:44:23 INFO - PID 31929 | __start_cc_report 18:44:23 INFO - PID 31929 | _x_x_mozilla_cycle_collect,368 18:44:23 INFO - PID 31929 | __end_cc_report 18:44:23 INFO - PID 31929 | __startTimestamp1501292663163__endTimestamp 18:44:23 INFO - PID 31929 | 18:44:23 INFO - PID 31929 | ------- Summary: start ------- 18:44:23 INFO - PID 31929 | Number of tests: 6 18:44:23 INFO - PID 31929 | 18:44:23 INFO - PID 31929 | [#0] dojo.html Cycles:165 Average:6086.78 Median:6335.27 stddev:713.44 (11.3%) stddev-sans-first:676.88 18:44:23 INFO - PID 31929 | Values: 3130.1 3146.9 3157.5 3167.0 3183.4 6091.1 6163.5 6167.3 6198.0 6229.1 6017.9 6120.2 6154.6 6165.9 6173.3 5570.2 5637.7 5644.0 5705.3 5719.5 5507.3 5684.9 5701.7 5709.7 5761.0 5499.4 5551.2 5578.4 5618.0 5642.8 5520.9 5566.4 5572.9 5584.2 5586.7 5591.1 5613.6 5621.8 5623.5 5649.9 6065.2 6065.5 6067.5 6121.1 6128.9 6554.1 6592.5 6630.6 6651.4 6674.9 6641.0 6646.4 6724.8 6742.3 6760.8 6075.9 6169.6 6170.8 6170.9 6248.7 6809.2 6849.3 6872.6 6878.3 6895.9 6495.9 6498.0 6503.1 6506.4 6507.8 6593.8 6601.7 6604.1 6618.3 6627.0 6522.3 6528.8 6555.8 6577.6 6585.5 5843.8 6577.0 6581.9 6616.3 6679.2 5386.1 5451.6 5472.7 5478.4 5486.4 4572.2 4599.3 4609.0 4686.2 4692.3 5684.8 5693.4 5719.9 5729.6 5729.9 6671.4 6671.8 6687.7 6694.7 6709.2 5659.0 5728.8 5740.7 5752.0 5763.8 5719.3 5831.7 5925.9 5930.4 5940.4 6335.3 6401.2 6403.5 6497.3 6501.6 6446.2 6458.5 6458.6 6494.5 6524.5 6287.1 6312.3 6414.7 6438.6 6513.6 6508.6 6529.9 6542.1 6616.7 6635.0 6564.0 6580.2 6624.3 6659.5 6756.2 6478.0 6499.5 6517.0 6518.5 6520.1 6425.4 6497.5 6514.2 6517.0 6522.9 6365.1 6378.2 6434.4 6452.6 6454.2 6441.3 6464.2 6509.8 6607.1 6630.8 6141.6 6181.4 6201.3 6219.8 6343.9 18:44:23 INFO - PID 31929 | 18:44:23 INFO - PID 31929 | [#1] ext.html Cycles:180 Average:37463.46 Median:34139.16 stddev:53052.94 (155.4%) stddev-sans-first:53130.36 18:44:23 INFO - PID 31929 | Values: 804.8 815.9 855.1 856.7 882.7 41020.2 41114.2 41385.4 41459.0 41746.6 38007.0 38120.8 38182.2 38308.2 38451.0 6961.4 7054.5 7065.3 7080.3 7082.3 6997.2 7027.0 7039.0 7089.7 7100.2 6988.0 7004.6 7023.8 7026.7 7064.2 7030.3 7036.3 7051.7 7063.8 7065.1 6332.2 6369.5 6372.8 6381.6 6431.1 32631.8 32714.0 32891.7 32916.7 32932.8 3318.1 3348.9 3363.7 3364.1 3364.9 27231.3 27351.6 27528.9 27621.2 27637.6 4265.0 4298.3 4347.6 4357.1 4384.6 179065.0 181369.0 184956.0 185843.0 200337.0 48683.0 48713.3 48717.0 48858.8 48938.8 51491.7 51541.7 51547.0 51576.5 51641.0 14777.1 14921.0 14926.6 14928.9 15031.2 12128.3 12141.6 12185.0 12186.3 12193.0 12920.2 12925.7 12953.0 13003.4 13023.5 5488.5 5524.1 5540.2 5546.0 5582.4 967.2 969.0 980.7 1002.3 1019.2 22612.9 22781.3 22783.9 23089.7 23239.5 1087.6 1113.5 1115.4 1122.1 1124.1 11728.4 12147.4 12321.1 14432.5 14913.8 220160.0 220752.0 220992.0 221326.0 223143.0 50726.5 50895.2 51002.5 51027.5 59980.6 1469.4 1475.2 1480.7 1486.4 1527.7 26958.9 28173.6 28216.4 28287.5 28315.4 38820.4 38982.0 39169.8 39311.0 39433.0 201999.0 203077.0 203803.0 206106.0 206175.0 36082.6 36590.3 37728.8 37912.4 37923.0 47485.5 48343.8 48837.0 48884.5 48969.3 33168.0 33479.8 33577.5 33715.8 34293.7 31793.7 32557.9 33176.0 33635.0 33984.7 38095.2 38479.8 38621.0 38667.8 38931.4 32570.0 33591.7 33750.7 33826.3 33935.8 23680.5 23887.5 24082.4 24115.2 24401.3 18:44:23 INFO - PID 31929 | 18:44:23 INFO - PID 31929 | [#2] jquery.html Cycles:180 Average:36974.00 Median:23060.37 stddev:87039.27 (377.4%) stddev-sans-first:87240.52 18:44:23 INFO - PID 31929 | Values: 567.0 572.4 575.4 576.1 595.6 21727.9 22600.7 22686.7 22695.4 22698.4 25297.7 25938.2 26020.6 26050.0 26057.5 6505.9 6680.9 6685.6 6695.7 6697.2 6437.5 6616.0 6672.0 7030.9 7109.5 7001.8 7074.0 7079.6 7083.1 7089.0 7001.6 7027.2 7031.4 7036.0 7036.0 6869.8 6900.9 6948.6 6967.7 6978.4 30884.5 31479.2 31520.2 31613.8 31912.5 1899.7 1908.4 1913.0 1918.8 1928.9 19742.6 20398.9 20451.5 20471.3 20540.4 2360.1 2373.3 2450.4 2470.5 2520.8 133984.0 136361.3 137274.0 137531.0 137729.0 20391.6 21907.7 22013.0 22037.4 22393.0 22866.8 23322.7 23523.0 23574.3 44255.1 10183.1 10355.0 10405.2 10420.8 10540.8 9576.5 9600.6 9605.1 9799.2 9805.2 8893.4 9013.0 9120.1 9248.7 9312.4 2598.7 2605.7 2671.4 2710.3 2724.8 936.9 948.8 966.1 969.3 976.8 19267.6 19284.1 19325.9 19356.2 19534.9 995.1 1002.8 1026.8 1054.0 1055.9 10654.9 10666.8 11068.1 12876.2 13627.5 506699.0 508742.0 514970.0 517788.0 536146.0 121446.0 129860.0 133051.0 133338.0 134505.0 1287.2 1300.6 1308.2 1325.7 1333.6 20277.4 20593.4 20604.8 21221.8 21260.5 57926.0 59353.0 59803.0 60124.4 60310.0 76171.2 76829.6 77233.6 77337.6 77548.0 19807.6 20498.0 20500.7 20531.9 20576.1 23018.3 23102.4 23241.2 23270.0 23632.3 17884.5 18028.8 18106.8 18136.2 18188.1 15071.3 15124.2 16057.6 16390.6 16691.5 17865.0 18496.3 18839.2 18853.2 18855.8 20239.2 20651.3 20727.7 20728.2 20883.0 17718.3 17875.5 18065.4 18146.7 18200.2 18:44:23 INFO - PID 31929 | 18:44:23 INFO - PID 31929 | [#3] mootools.html Cycles:180 Average:8380.96 Median:2567.35 stddev:5796.30 (225.8%) stddev-sans-first:5788.45 18:44:23 INFO - PID 31929 | Values: 1345.9 1414.6 1420.8 1427.1 1432.1 13477.0 13985.2 14029.2 14051.2 14053.0 13440.6 13798.0 14287.7 14299.6 14313.8 2678.1 2751.9 2753.7 2759.7 2759.9 2585.0 2665.5 2703.4 2717.4 2717.7 2450.2 2494.9 2497.0 2500.3 2581.9 2481.9 2527.7 2547.8 2549.8 2552.8 2594.1 2599.1 2618.5 2634.4 2636.4 13260.6 13712.4 13722.3 13811.3 13828.4 7428.4 7742.7 7752.6 7764.7 7785.9 5010.5 5127.1 5221.4 5280.0 5284.4 1802.2 1810.9 1818.6 1849.3 1862.3 22760.4 22956.8 22993.2 23001.9 23036.9 6102.9 6186.7 6449.9 6468.9 6511.8 15550.6 15679.6 15680.1 15717.2 15722.5 6961.2 7355.8 7547.2 7557.9 7559.9 5984.1 6153.3 6223.9 6903.5 7130.8 5030.6 5225.7 5252.0 5259.2 5275.2 1509.3 1523.1 1535.4 1542.7 1562.6 805.5 823.3 829.9 853.9 866.6 6710.6 6735.4 6815.3 6838.4 6934.0 690.5 707.6 719.5 925.5 933.6 4396.8 4510.7 4547.1 4561.5 4607.9 17762.2 18625.7 18934.8 19018.4 19043.8 17923.7 18515.9 18686.7 18722.1 18886.2 9982.7 10532.8 10533.3 10537.6 10552.8 6833.2 7017.8 7118.5 7185.6 7213.6 15295.2 15713.5 15894.0 16455.4 16665.5 16107.1 16704.2 16741.5 16856.7 16906.2 10277.5 10589.5 10739.1 10827.5 11149.6 12578.5 12613.7 12665.9 12667.0 12678.1 9566.4 10009.3 10179.0 10241.8 10433.8 9655.3 10017.5 10127.6 10198.6 10233.3 8559.1 8681.2 8689.4 8690.0 8700.2 6041.4 6186.1 6510.7 6545.9 6715.0 5822.7 6107.1 6671.3 6730.3 6769.6 18:44:23 INFO - PID 31929 | 18:44:23 INFO - PID 31929 | [#4] prototype.html Cycles:180 Average:5436.99 Median:6032.86 stddev:1526.00 (25.3%) stddev-sans-first:1484.41 18:44:23 INFO - PID 31929 | Values: 489.5 497.6 514.7 516.5 522.8 6127.5 6170.0 6186.3 6253.2 6255.2 5870.5 6026.5 6079.4 6106.5 6131.3 4855.6 4866.2 4931.2 4944.8 4954.3 4875.8 4886.7 4916.2 4928.0 4962.2 4716.2 4798.6 4829.4 4832.2 4877.8 4805.8 4859.8 4876.2 4880.3 4883.8 4333.9 4349.2 4354.6 4389.8 4418.4 5934.0 5964.7 6027.1 6028.9 6036.8 5678.0 5684.3 5690.7 5700.3 5710.9 6272.2 6346.8 6376.7 6388.3 6503.0 4738.3 4833.4 4833.7 4859.3 4864.9 6615.8 6887.9 6926.2 6940.9 6944.7 4922.9 4925.4 4928.4 4984.2 4999.1 5075.3 5089.5 5093.0 5094.1 5100.3 5635.7 5698.3 5699.1 5708.0 5730.5 6374.7 6420.1 6469.4 6470.5 6558.9 1634.2 1696.7 1743.1 1750.9 1761.2 1186.3 1203.7 1210.5 1236.8 1237.5 5557.3 5568.2 5605.0 5650.0 5660.6 6506.3 6511.3 6528.7 6575.9 6589.3 5499.4 5681.9 5689.7 5738.5 5774.1 3529.2 3550.6 3575.9 3584.7 3599.6 6318.3 6384.5 6385.8 6455.8 6502.5 6801.1 6812.3 6850.2 6891.5 6910.8 6364.5 6398.5 6490.6 6551.3 6575.2 6520.3 6534.3 6622.2 6668.5 6727.7 6474.9 6556.0 6645.7 6649.1 6667.2 6367.8 6388.3 6423.8 6477.7 6512.7 4890.4 4914.3 4916.7 4919.9 4944.5 6651.0 6663.1 6690.2 6695.8 6720.0 6444.1 6500.8 6514.4 6547.0 6585.8 6376.5 6378.4 6395.4 6447.8 6453.5 6190.3 6335.3 6370.9 6387.5 6393.2 6153.9 6410.8 6451.2 6456.5 6459.5 6125.3 6158.0 6178.4 6243.7 6287.9 18:44:23 INFO - PID 31929 | 18:44:23 INFO - PID 31929 | [#5] yui.html Cycles:180 Average:23068.69 Median:19727.66 stddev:30869.26 (156.5%) stddev-sans-first:30910.87 18:44:23 INFO - PID 31929 | Values: 873.1 879.3 885.8 895.6 897.1 17924.5 18687.7 18699.0 18707.4 18764.0 19436.4 20946.6 21083.4 21208.0 21299.3 1039.8 1075.0 1075.1 1076.3 1076.7 983.4 993.2 1014.1 1061.2 1062.2 1100.5 1104.9 1105.8 1106.2 1106.7 1067.5 1079.4 1083.3 1084.4 1087.5 808.1 808.7 809.4 810.0 810.4 18651.7 19320.6 19623.3 19832.0 19891.3 20163.0 20311.6 20719.9 20840.9 20849.9 15487.6 15586.0 15617.8 15684.2 15706.1 3479.3 3496.9 3509.6 3509.8 3511.6 123687.4 125883.0 127686.0 131045.0 132199.3 15366.5 15736.8 15824.5 15854.0 16092.8 27909.0 29346.3 29434.1 29550.4 29553.7 8254.1 8393.5 8407.6 8415.5 8420.0 3922.6 4022.0 4024.1 4030.0 4042.8 4871.3 4997.3 5777.7 5881.5 5926.5 1053.5 1062.7 1093.7 1098.5 1101.5 629.1 644.5 669.3 673.8 682.0 11343.7 13920.4 14004.5 14091.4 14124.4 656.4 675.1 676.3 685.8 704.0 5525.7 5584.0 5622.4 5719.1 5986.6 96092.5 101349.5 102323.0 102518.0 104372.0 88472.0 92054.4 92813.5 93450.5 96788.5 78075.6 78165.2 82704.6 83245.2 84623.6 11444.8 12059.2 12742.0 12840.3 13122.8 32883.3 35839.3 36272.0 36338.1 37710.4 62007.7 65265.0 67017.0 68300.0 69232.7 18410.5 18904.1 18965.5 19151.0 19158.9 20797.4 20909.2 20958.3 20959.3 21059.2 18420.3 18448.2 18583.6 18646.8 18648.2 18198.1 18327.2 18468.5 18532.4 18569.6 18376.6 18460.7 18511.5 18655.3 18980.1 12858.2 13393.7 13691.7 13763.1 14118.7 13327.1 14537.9 14553.9 14679.7 15222.3 18:44:23 INFO - PID 31929 | -------- Summary: end -------- 18:44:23 INFO - PID 31929 | 18:44:23 INFO - TEST-INFO | 31929: exit 0 18:44:23 INFO - TEST-OK | dromaeo_css | took 1112958ms 18:44:23 INFO - TEST-START | kraken 18:44:23 INFO - Initialising browser for kraken test... 18:44:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59227/getInfo.html -profile /tmp/tmp1ca0Lj/profile 18:44:23 INFO - TEST-INFO | started process 32306 (/builds/slave/test/build/application/firefox/firefox http://localhost:59227/getInfo.html) 18:44:29 INFO - TEST-INFO | 32306: exit 0 18:44:29 INFO - Browser initialized. 18:44:29 INFO - Running cycle 1/1 for kraken test... 18:44:29 INFO - TEST-INFO | started process 32532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ca0Lj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:44:30 INFO - PID 32532 | 18:44:30 INFO - PID 32532 | (/builds/slave/test/build/application/firefox/firefox:32586): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:44:30 INFO - PID 32532 | 18:44:40 INFO - PID 32532 | RSS: Main: 173035520 18:44:40 INFO - PID 32532 | 18:44:43 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59227/tests/kraken/driver.html?testName=audio-beat-detection) 18:44:44 INFO - PID 32532 | RSS: Main: 178294784 18:44:44 INFO - PID 32532 | 18:44:47 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59227/tests/kraken/driver.html?testName=audio-dft) 18:44:47 INFO - PID 32532 | RSS: Main: 179101696 18:44:47 INFO - PID 32532 | 18:44:51 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59227/tests/kraken/driver.html?testName=audio-fft) 18:44:51 INFO - PID 32532 | RSS: Main: 173944832 18:44:51 INFO - PID 32532 | 18:44:53 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59227/tests/kraken/driver.html?testName=audio-oscillator) 18:44:54 INFO - PID 32532 | RSS: Main: 174546944 18:44:54 INFO - PID 32532 | 18:44:56 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59227/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:44:57 INFO - PID 32532 | RSS: Main: 174432256 18:44:57 INFO - PID 32532 | 18:45:00 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59227/tests/kraken/driver.html?testName=imaging-darkroom) 18:45:01 INFO - PID 32532 | RSS: Main: 177266688 18:45:01 INFO - PID 32532 | 18:45:04 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59227/tests/kraken/driver.html?testName=imaging-desaturate) 18:45:05 INFO - PID 32532 | RSS: Main: 176427008 18:45:05 INFO - PID 32532 | 18:45:08 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59227/tests/kraken/driver.html?testName=json-parse-financial) 18:45:08 INFO - PID 32532 | RSS: Main: 177385472 18:45:08 INFO - PID 32532 | 18:45:10 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59227/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:45:11 INFO - PID 32532 | RSS: Main: 177164288 18:45:11 INFO - PID 32532 | 18:45:13 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59227/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:45:13 INFO - PID 32532 | RSS: Main: 174198784 18:45:13 INFO - PID 32532 | 18:45:16 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59227/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:45:16 INFO - PID 32532 | RSS: Main: 174395392 18:45:16 INFO - PID 32532 | 18:45:19 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59227/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:45:20 INFO - PID 32532 | RSS: Main: 174682112 18:45:20 INFO - PID 32532 | 18:45:23 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59227/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:45:24 INFO - PID 32532 | RSS: Main: 174383104 18:45:24 INFO - PID 32532 | 18:45:25 INFO - PID 32532 | Cycle 1(1): loaded http://localhost:59227/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59227/tests/kraken/driver.html?testName=ai-astar) 18:45:26 INFO - PID 32532 | RSS: Main: 176238592 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | __start_tp_report 18:45:26 INFO - PID 32532 | _x_x_mozilla_page_load 18:45:26 INFO - PID 32532 | _x_x_mozilla_page_load_details 18:45:26 INFO - PID 32532 | |i|pagename|runs| 18:45:26 INFO - PID 32532 | |0;ai-astar;100;109;104;108;108;112;116;100;112;117 18:45:26 INFO - PID 32532 | |1;audio-beat-detection;145;120;149;169;122;150;148;125;185;126 18:45:26 INFO - PID 32532 | |2;audio-dft;163;168;170;164;164;165;169;167;162;163 18:45:26 INFO - PID 32532 | |3;audio-fft;75;75;74;180;75;77;81;92;100;75 18:45:26 INFO - PID 32532 | |4;audio-oscillator;79;81;135;79;79;79;126;83;80;129 18:45:26 INFO - PID 32532 | |5;imaging-gaussian-blur;116;118;114;113;114;115;115;114;114;114 18:45:26 INFO - PID 32532 | |6;imaging-darkroom;151;150;150;157;152;152;150;158;153;151 18:45:26 INFO - PID 32532 | |7;imaging-desaturate;101;95;94;98;94;94;98;100;93;95 18:45:26 INFO - PID 32532 | |8;json-parse-financial;63;56;56;57;60;59;61;61;57;60 18:45:26 INFO - PID 32532 | |9;json-stringify-tinderbox;65;61;53;54;53;54;58;56;54;54 18:45:26 INFO - PID 32532 | |10;stanford-crypto-aes;81;82;84;81;83;80;82;84;82;82 18:45:26 INFO - PID 32532 | |11;stanford-crypto-ccm;130;136;131;137;129;135;145;130;131;173 18:45:26 INFO - PID 32532 | |12;stanford-crypto-pbkdf2;191;187;188;184;186;182;192;182;199;181 18:45:26 INFO - PID 32532 | |13;stanford-crypto-sha256-iterative;69;72;72;75;72;69;68;73;68;72 18:45:26 INFO - PID 32532 | __end_tp_report 18:45:26 INFO - PID 32532 | __start_cc_report 18:45:26 INFO - PID 32532 | _x_x_mozilla_cycle_collect,935 18:45:26 INFO - PID 32532 | __end_cc_report 18:45:26 INFO - PID 32532 | __startTimestamp1501292726237__endTimestamp 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | ------- Summary: start ------- 18:45:26 INFO - PID 32532 | Number of tests: 14 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:5.95 (5.4%) stddev-sans-first:5.43 18:45:26 INFO - PID 32532 | Values: 100.0 109.0 104.0 108.0 108.0 112.0 116.0 100.0 112.0 117.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:148.50 stddev:21.42 (14.4%) stddev-sans-first:22.71 18:45:26 INFO - PID 32532 | Values: 145.0 120.0 149.0 169.0 122.0 150.0 148.0 125.0 185.0 126.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#2] audio-dft Cycles:10 Average:165.50 Median:166.00 stddev:2.80 (1.7%) stddev-sans-first:2.82 18:45:26 INFO - PID 32532 | Values: 163.0 168.0 170.0 164.0 164.0 165.0 169.0 167.0 162.0 163.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#3] audio-fft Cycles:10 Average:90.40 Median:75.00 stddev:32.67 (43.6%) stddev-sans-first:34.18 18:45:26 INFO - PID 32532 | Values: 75.0 75.0 74.0 180.0 75.0 77.0 81.0 92.0 100.0 75.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:79.00 stddev:24.28 (30.7%) stddev-sans-first:25.05 18:45:26 INFO - PID 32532 | Values: 79.0 81.0 135.0 79.0 79.0 79.0 126.0 83.0 80.0 129.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.42 (1.2%) stddev-sans-first:1.42 18:45:26 INFO - PID 32532 | Values: 116.0 118.0 114.0 113.0 114.0 115.0 115.0 114.0 114.0 114.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#6] imaging-darkroom Cycles:10 Average:152.40 Median:152.00 stddev:2.88 (1.9%) stddev-sans-first:3.00 18:45:26 INFO - PID 32532 | Values: 151.0 150.0 150.0 157.0 152.0 152.0 150.0 158.0 153.0 151.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:94.50 stddev:2.82 (3.0%) stddev-sans-first:2.40 18:45:26 INFO - PID 32532 | Values: 101.0 95.0 94.0 98.0 94.0 94.0 98.0 100.0 93.0 95.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:60.00 stddev:2.40 (4.0%) stddev-sans-first:2.07 18:45:26 INFO - PID 32532 | Values: 63.0 56.0 56.0 57.0 60.0 59.0 61.0 61.0 57.0 60.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:55.00 stddev:3.99 (7.3%) stddev-sans-first:2.68 18:45:26 INFO - PID 32532 | Values: 65.0 61.0 53.0 54.0 53.0 54.0 58.0 56.0 54.0 54.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:1.29 (1.6%) stddev-sans-first:1.30 18:45:26 INFO - PID 32532 | Values: 81.0 82.0 84.0 81.0 83.0 80.0 82.0 84.0 82.0 82.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:135.50 stddev:13.31 (9.8%) stddev-sans-first:13.82 18:45:26 INFO - PID 32532 | Values: 130.0 136.0 131.0 137.0 129.0 135.0 145.0 130.0 131.0 173.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.20 Median:187.50 stddev:5.59 (3.0%) stddev-sans-first:5.76 18:45:26 INFO - PID 32532 | Values: 191.0 187.0 188.0 184.0 186.0 182.0 192.0 182.0 199.0 181.0 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:72.00 stddev:2.36 (3.3%) stddev-sans-first:2.39 18:45:26 INFO - PID 32532 | Values: 69.0 72.0 72.0 75.0 72.0 69.0 68.0 73.0 68.0 72.0 18:45:26 INFO - PID 32532 | -------- Summary: end -------- 18:45:26 INFO - PID 32532 | 18:45:26 INFO - PID 32532 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:45:27 INFO - TEST-INFO | 32532: exit 0 18:45:27 INFO - TEST-OK | kraken | took 63212ms 18:45:27 INFO - SUITE-END | took 1176s 18:45:27 INFO - Completed test suite (00:19:36) 18:45:27 INFO - javascript benchmark 18:45:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8427.973824305222, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.0922732407603, 3146.8898588549405, 3157.46323125069, 3166.9683303166967, 3183.3633273345336, 6091.14723938649, 6163.476104531114, 6167.290761562416, 6198.0, 6229.065640153974, 6017.939820601804, 6120.173776540166, 6154.569180157391, 6165.907511387333, 6173.32093469718, 5570.164475328703, 5637.689927054011, 5643.971780141093, 5705.315362156547, 5719.485246327829, 5507.311586051744, 5684.886302273952, 5701.6864072476, 5709.6574205547595, 5761.0, 5499.4225606311165, 5551.1673249012765, 5578.386377498492, 5618.0449323615085, 5642.830715078534, 5520.91718624221, 5566.415526369754, 5572.888542229132, 5584.162375643686, 5586.748596313176, 5591.133374326986, 5613.550915926757, 5621.80323688673, 5623.49388555028, 5649.887002259932, 6065.211522502046, 6065.514758819284, 6067.514598832083, 6121.051237058263, 6128.877422451526, 6554.082428460019, 6592.538522303441, 6630.569013014187, 6651.401373876374, 6674.899876501856, 6641.0, 6646.401823835878, 6724.7646332378135, 6742.325767423267, 6760.76337328196, 6075.878482430371, 6169.629822210682, 6170.784022559234, 6170.876582468325, 6248.687565621746, 6809.216940051859, 6849.315068493111, 6872.62200578973, 6878.27778083294, 6895.862082758316, 6495.8700825983215, 6497.9675101625135, 6503.057056726748, 6506.3818937200895, 6507.804765857032, 6593.769218077345, 6601.735930562723, 6604.14146160996, 6618.30507796684, 6626.966865165643, 6522.347765223534, 6528.836779080561, 6555.770548030796, 6577.6053436793945, 6585.539012269191, 5843.824685259364, 6577.013447982745, 6581.934180658228, 6616.338366163345, 6679.2318883329035, 5386.13821788512, 5451.64564303319, 5472.72636368188, 5478.424765399655, 5486.396496385394, 4572.245579479415, 4599.33309670096, 4608.953910460852, 4686.179918514246, 4692.319613656069, 5684.8010319638615, 5693.373728889819, 5719.885602287931, 5729.598928075078, 5729.8567535811935, 6671.39957403836, 6671.799846004627, 6687.665616719145, 6694.698738556776, 6709.194896612437, 5659.0, 5728.79949201776, 5740.712964351766, 5752.022156233366, 5763.769449221984, 5719.256496655491, 5831.708414579254, 5925.911111333334, 5930.436608522184, 5940.435658612511, 6335.271443784024, 6401.167848179707, 6403.519736019817, 6497.252815926135, 6501.642409667419, 6446.161998940108, 6458.451031662361, 6458.612483250832, 6494.480441564758, 6524.4780417565535, 6287.088372185916, 6312.337204593451, 6414.711337989708, 6438.6136831790245, 6513.609183449008, 6508.642024688498, 6529.9020514691365, 6542.051402546509, 6616.702248398929, 6634.966825165843, 6563.967180164069, 6580.243272023587, 6624.314006203793, 6659.500537459807, 6756.189257289157, 6477.967610161919, 6499.545031847725, 6517.022446632854, 6518.478521718156, 6520.087187793808, 6425.421712045938, 6497.5126865484335, 6514.1531600891585, 6517.0, 6522.902156467751, 6365.1088847562305, 6378.202724659418, 6434.420902118832, 6452.612843229421, 6454.225492940877, 6441.259255185526, 6464.159659244268, 6509.772157974448, 6607.075009498578, 6630.801075967729, 6141.631502109888, 6181.443670069715, 6201.348858369986, 6219.813405597839, 6343.904841427475], "value": 6034.1977470144175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.7585724282721, 815.9469634473759, 855.1149560205187, 856.7215654912155, 882.6601758323047, 41020.17959640809, 41114.17771644565, 41385.37921931166, 41459.0, 41746.582534174646, 38007.0, 38120.80939595305, 38182.23635527288, 38308.23383532328, 38451.0, 6961.443084553236, 7054.541454805421, 7065.258147894474, 7080.29197080293, 7082.327178917994, 6997.195322537922, 7027.0, 7039.049728286667, 7089.71641134354, 7100.183478899941, 6987.965060174717, 7004.614746188958, 7023.7541686040995, 7026.683799229021, 7064.222935477119, 7030.3321184487395, 7036.296370362974, 7051.682674279644, 7063.788086357417, 7065.116860392451, 6332.176817013758, 6369.490440764727, 6372.808815735535, 6381.585196962183, 6431.067495213168, 32631.836840815882, 32714.0, 32891.67108328934, 32916.6708332916, 32932.83533582341, 3318.1206980150278, 3348.8827891023698, 3363.7309015278965, 3364.074879408158, 3364.9158771030675, 27231.319217019536, 27351.589726154125, 27528.898844046213, 27621.171364858885, 27637.585436218473, 4264.978675106636, 4298.290782020994, 4347.630451411634, 4357.063231405232, 4384.561543845622, 179065.0, 181369.0, 184956.0, 185843.0, 200337.0, 48683.0, 48713.269300960514, 48717.0, 48858.75570622124, 48938.75530622324, 51491.7425412878, 51541.742291288305, 51547.0, 51576.48423515792, 51641.0, 14777.113373197642, 14921.030133041317, 14926.626834329229, 14928.92535537337, 15031.248437578077, 12128.332941688292, 12141.635750927486, 12185.0, 12186.26882387042, 12193.0, 12920.160189587647, 12925.676858078436, 12953.0, 13003.414846331938, 13023.47906083765, 5488.4785945335125, 5524.14375771756, 5540.196671482693, 5545.972270138624, 5582.441755824466, 967.1634036558467, 968.951552422376, 980.6959842448864, 1002.2942285967458, 1019.1744686803713, 22612.886935565217, 22781.31656050288, 22783.886080569824, 23089.653655195187, 23239.53520929572, 1087.6465148826662, 1113.4544073403974, 1115.3861488776306, 1122.1359553144034, 1124.1288001798507, 11728.413579321, 12147.392630368622, 12321.137520373488, 14432.494862679756, 14913.776293355608, 220160.0, 220752.0, 220992.0, 221326.0, 223143.0, 50726.49273507218, 50895.23657145146, 51002.48997509977, 51027.48972510302, 59980.600775969346, 1469.4489566412594, 1475.232878902943, 1480.6816534445145, 1486.37572219668, 1527.725009498301, 26958.865205673847, 28173.57739633866, 28216.43567128687, 28287.45262318039, 28315.43369132647, 38820.41769373405, 38982.0, 39169.804150979064, 39311.0, 39433.0, 201999.0, 203077.0, 203803.0, 206106.0, 206175.0, 36082.63917360793, 36590.26819463649, 37728.81135594304, 37912.43131352977, 37923.0, 47485.52514474811, 48343.75828120837, 48837.0, 48884.511154887994, 48969.2654610174, 33168.0, 33479.83260083684, 33577.49633755447, 33715.83142084274, 34293.657063430044, 31793.682063179072, 32557.863560172776, 33176.0, 33635.0, 33984.66015339815, 38095.23809523849, 38479.807600961816, 38621.0, 38667.80666096652, 38931.41602875903, 32570.0, 33591.66408335885, 33750.662493375734, 33826.3234735299, 33935.83032084824, 23680.52638947177, 23887.522249554564, 24082.39794005164, 24115.15596954098, 24401.26796196117], "value": 16817.16175475321, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.9794370133758, 572.3589579670767, 575.390086508301, 576.1473019930502, 595.5860676829603, 21727.891360543195, 22600.66099008516, 22686.659700104472, 22695.432614184632, 22698.432539186528, 25297.74702252977, 25938.22185334443, 26020.609690854606, 26050.0, 26057.478850423027, 6505.902411463831, 6680.93319066808, 6685.565438246498, 6695.698693558777, 6697.162854643169, 6437.485001199892, 6616.0, 6672.032555279481, 7030.85938281234, 7109.537880037807, 7001.824954376156, 7073.964630176842, 7079.61062141582, 7083.079199704031, 7089.0, 7001.649917504155, 7027.191872934602, 7031.402330801888, 7035.964820175917, 7036.0, 6869.7595584154315, 6900.861982760317, 6948.583085014865, 6967.686454109577, 6978.406835418996, 30884.53673194904, 31479.213019674462, 31520.211994700087, 31613.8419307902, 31912.521312180335, 1899.7340372347883, 1908.4179325305777, 1912.9956772694309, 1918.8464922806143, 1928.864979451439, 19742.60514789696, 20398.898005510026, 20451.48871278215, 20471.283505077252, 20540.383788486368, 2360.072780976557, 2373.2880135959144, 2450.4486490539484, 2470.505898820243, 2520.8361456505268, 133984.0, 136361.3181934094, 137274.0, 137531.0, 137729.0, 20391.592168156552, 21907.67138492924, 22013.0, 22037.449063773212, 22393.0, 22866.771332286797, 23322.65016024761, 23523.0, 23574.29277121689, 44255.11489770251, 10183.134433573081, 10355.0, 10405.167586593054, 10420.791584168273, 10540.841887371696, 9576.515640075799, 9600.615975360908, 9605.13553780163, 9799.216062714966, 9805.215582753362, 8893.421927574687, 9013.008569057398, 9120.084782195812, 9248.676296329731, 9312.394694344846, 2598.7141414444395, 2605.71337152913, 2671.358873870257, 2710.2546799629863, 2724.7820174386397, 936.864154697565, 948.8481842905102, 966.0918736387773, 969.2633598465077, 976.7802244495074, 19267.614647706967, 19284.1322140504, 19325.903370483058, 19356.225750970087, 19534.902325488565, 995.1292618958412, 1002.819492491344, 1026.825439675257, 1053.9947300263602, 1055.8680164979378, 10654.893451065545, 10666.839997400046, 11068.114550835913, 12876.163049401759, 13627.523036693867, 506699.0, 508742.0, 514970.0, 517788.0, 536146.0, 121446.0, 129860.0, 133051.0, 133338.0, 134505.0, 1287.2340957130493, 1300.5773123735014, 1308.19545979224, 1325.6752095736606, 1333.5865881576742, 20277.35161091078, 20593.38219853407, 20604.79395206029, 21221.791202544726, 21260.468488287916, 57926.0, 59353.0, 59803.0, 60124.39875601188, 60310.0, 76171.23828761642, 76829.61585192039, 77233.61383193047, 77337.61331193308, 77548.0, 19807.60384792325, 20498.0, 20500.692489612968, 20531.897340513202, 20576.074076666286, 23018.309450716504, 23102.42243943915, 23241.186558470374, 23270.0, 23632.29103126909, 17884.483988250195, 18028.81971180324, 18106.81893181104, 18136.18387172554, 18188.09059546991, 15071.321790519234, 15124.168170750714, 16057.598560036093, 16390.590235244214, 16691.49925502237, 17865.0, 18496.260149593865, 18839.24643014319, 18853.15160817794, 18855.811441885406, 20239.19043238254, 20651.27720529774, 20727.68908466344, 20728.170873164905, 20883.0, 17718.291268349636, 17875.46373608794, 18065.367712130013, 18146.727799083288, 18200.180991855133], "value": 12704.046105209305, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.9057865949383, 1414.603910904947, 1420.7655736803424, 1427.0866645346987, 1432.090622454741, 13477.0, 13985.160890346586, 14029.228392438412, 14051.227182504957, 14053.0, 13440.596782096529, 13798.0, 14287.71424571508, 14299.57101286963, 14313.78529322061, 2678.1296078774426, 2751.9449611007767, 2753.655793025872, 2759.7378249066305, 2759.889604415821, 2584.961225581618, 2665.5068812269697, 2703.3917368592106, 2717.375003749139, 2717.660292463442, 2450.15469662966, 2494.912678056259, 2496.9750302497014, 2500.349909023658, 2581.8838152283192, 2481.8883150258193, 2527.6966763988257, 2547.770700636933, 2549.77052065315, 2552.808539359537, 2594.0661361909697, 2599.0643368387364, 2618.5024845279336, 2634.4467661791045, 2636.380450594109, 13260.60218193446, 13712.3829427675, 13722.313884305844, 13811.309434528333, 13828.446862125504, 7428.4428667850125, 7742.690292388298, 7752.612369381508, 7764.689412423496, 7785.922140778576, 5010.498950104997, 5127.102757017507, 5221.373435187764, 5280.049591073605, 5284.365876094893, 1802.1890149432809, 1810.900400477973, 1818.6453641539906, 1849.2880241107136, 1862.3202531076195, 22760.430989225402, 22956.770432295798, 22993.195238166583, 23001.88499057511, 23036.884815575984, 6102.877942441126, 6186.690665466709, 6449.903251451232, 6468.870622587522, 6511.804645860631, 15550.611234719223, 15679.608009799846, 15680.05919644825, 15717.21413929299, 15722.528324150293, 6961.199462061928, 7355.77932662021, 7547.16981132075, 7557.886631700529, 7559.924400755922, 5984.072468767348, 6153.323134455206, 6223.875522489616, 6903.482238832007, 7130.750423735144, 5030.647854650212, 5225.686458812484, 5252.0, 5259.184826351921, 5275.182346736262, 1509.3358922074253, 1523.116592376419, 1535.4088675859875, 1542.6529030967943, 1562.5859147325968, 805.5287656720767, 823.3001948343859, 829.8713699376606, 853.906070332263, 866.6143566113145, 6710.563813352116, 6735.42748866342, 6815.2843951385385, 6838.350356716104, 6933.965330173317, 690.4614400767409, 707.5825263094696, 719.5179229915968, 925.509479975614, 933.6032186320787, 4396.824127034947, 4510.72935623857, 4547.067851090518, 4561.521040290788, 4607.861764147081, 17762.200700968486, 18625.7206141908, 18934.810651893582, 19018.42944711661, 19043.80956190448, 17923.73114403285, 18515.907420462812, 18686.71969920452, 18722.063896805106, 18886.244550217838, 9982.700518984442, 10532.842007369896, 10533.315334503233, 10537.631182908715, 10552.841707374395, 6833.248342682202, 7017.754378596725, 7118.537295075804, 7185.640717963976, 7213.639318034182, 15295.158766267961, 15713.450029248921, 15894.0, 16455.42406015784, 16665.500034998968, 16107.147678016709, 16704.24830882589, 16741.49775506737, 16856.66286674235, 16906.154692265583, 10277.486125693536, 10589.52347144365, 10739.087177589992, 10827.458627068772, 11149.609763658233, 12578.496860125493, 12613.74772504563, 12665.87334126647, 12667.0, 12678.112532122663, 9566.426014439156, 10009.349392289478, 10179.03299186576, 10241.795164096528, 10433.791324173626, 9655.324127311022, 10017.54921028541, 10127.645532406625, 10198.643047493302, 10233.283670143019, 8559.101294364002, 8681.2186903179, 8689.435186712843, 8690.044095149402, 8700.216980471789, 6041.395860413923, 6186.1339412483185, 6510.707018184098, 6545.901811472927, 6714.966425167843, 5822.73797679097, 6107.144999699956, 6671.299513551007, 6730.32696730323, 6769.593824370553], "value": 6111.024970359419, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.50070927653815, 497.5522030172844, 514.686041514676, 516.535118393446, 522.8431470558834, 6127.479164271037, 6169.969150154248, 6186.257649082105, 6253.1870856788555, 6255.249370075586, 5870.501007414375, 6026.548008899339, 6079.392060793918, 6106.48094911933, 6131.325554189047, 4855.635827312948, 4866.221404575269, 4931.235658472924, 4944.7774850131655, 4954.281629163769, 4875.804967801284, 4886.682365646239, 4916.237983112624, 4928.0, 4962.230854217602, 4716.1982462981205, 4798.592119669815, 4829.4446138693975, 4832.17852964995, 4877.756112194394, 4805.783739731721, 4859.760761005921, 4876.244182151772, 4880.2679598060395, 4883.804647814083, 4333.913321733579, 4349.2385583838595, 4354.56454354562, 4389.846355377578, 4418.403515525395, 5934.0, 5964.657951960818, 6027.071337172107, 6028.879422411571, 6036.849078773022, 5678.0, 5684.289463817023, 5690.7439165237665, 5700.25896633435, 5710.914336284959, 6272.2159730033745, 6346.777862774781, 6376.7130479128555, 6388.265349484822, 6502.967485162591, 4738.312944623045, 4833.3958255218095, 4833.685810422347, 4859.343988561534, 4864.91078165364, 6615.801525954229, 6887.931120688829, 6926.168859736814, 6940.861182776316, 6944.652767361612, 4922.852314430573, 4925.4335751388335, 4928.433230178503, 4984.177610694195, 4999.125153098194, 5075.3148324975655, 5089.51649593288, 5092.974535127375, 5094.133997220407, 5100.336956195671, 5635.6618602883955, 5698.3162020556965, 5699.116636921284, 5707.971460142756, 5730.455606717355, 6374.74501019954, 6420.101185833987, 6469.447332640227, 6470.4823614110755, 6558.934410655832, 1634.2400783635667, 1696.703076961527, 1743.1197245390997, 1750.9212085456186, 1761.1947753552454, 1186.323795436593, 1203.6990752311922, 1210.4915935307192, 1236.7650146472142, 1237.5235534319352, 5557.3331200256225, 5568.164775283659, 5604.971975140098, 5650.0, 5660.632058916157, 6506.332403714454, 6511.28375878653, 6528.706208220641, 6575.868482630321, 6589.341065893468, 5499.3675727291875, 5681.886362272731, 5689.6586204827845, 5738.483536481736, 5774.092021781452, 3529.2412131391875, 3550.55618047744, 3575.928481430357, 3584.6773790358993, 3599.6220396858475, 6318.304986451487, 6384.48924086072, 6385.840353991094, 6455.806325810233, 6502.479801615859, 6801.149856267966, 6812.250652428229, 6850.212225594021, 6891.483138764613, 6910.792676219721, 6364.49084073273, 6398.5201109916015, 6490.578112422678, 6551.279359270381, 6575.178102737158, 6520.315366886409, 6534.3279555118315, 6622.238442578972, 6668.533202675961, 6727.697253623501, 6474.870502589828, 6555.967220163869, 6645.700943457459, 6649.135612370361, 6667.166604174478, 6367.840803979938, 6388.297287298301, 6423.775167869102, 6477.708503117466, 6512.706928188338, 4890.364252647133, 4914.262860570943, 4916.680415773107, 4919.901601968012, 4944.48082951285, 6650.966745166436, 6663.13379260693, 6690.19717633887, 6695.799126026227, 6719.966400167968, 6444.13004244421, 6500.837479063061, 6514.413702766774, 6546.985217291328, 6585.781630398392, 6376.489880809431, 6378.425941665272, 6395.386606567275, 6447.774327898501, 6453.547052533737, 6190.319064902767, 6335.271443784024, 6370.904436433365, 6387.457066149429, 6393.1688880445245, 6153.876922461615, 6410.839729006812, 6451.225852897683, 6456.483481321577, 6459.483241340776, 6125.295591007091, 6157.96921015392, 6178.382161783786, 6243.656598887105, 6287.937120628918], "value": 4988.709684105933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.0919843362902, 879.2789912271936, 885.7918389178544, 895.623837988045, 897.129784109414, 17924.46226613202, 18687.719684204712, 18699.0, 18707.438776836683, 18763.967981761016, 19436.416907492763, 20946.581068378622, 21083.367498975054, 21208.045637946292, 21299.25452609159, 1039.776448063668, 1074.951627176775, 1075.0754351257913, 1076.2896488317713, 1076.6608518316743, 983.3755565216068, 993.175664198717, 1014.1025192704473, 1061.1669839176247, 1062.1927335225246, 1100.5157730598512, 1104.9337039777638, 1105.7843720474511, 1106.164845541615, 1106.6624679472757, 1067.4555976451988, 1079.3901445683164, 1083.312096818518, 1084.376483521974, 1087.526925787285, 808.0586117173544, 808.720991258015, 809.3889113719164, 809.951402915827, 810.4165001199127, 18651.720224196648, 19320.61358772831, 19623.31318403849, 19832.0, 19891.303804366777, 20163.0, 20311.5937681247, 20719.896400518053, 20840.895795521075, 20849.8957505213, 15487.612809679735, 15586.0, 15617.843821561753, 15684.215789210608, 15706.136162511057, 3479.3215323012023, 3496.930061398758, 3509.64903509647, 3509.842057107436, 3511.6312787157235, 123687.3815630916, 125883.0, 127685.99999999907, 131045.0, 132199.33900330533, 15366.462173823862, 15736.842631573767, 15824.525264242091, 15854.0, 16092.75860862088, 27909.0, 29346.266343341587, 29434.11697649074, 29550.408991820044, 29553.704462955524, 8254.133316001853, 8393.496390216484, 8407.62165702545, 8415.53714545706, 8420.031696354876, 3922.646961773454, 4021.9597804021587, 4024.074462873497, 4029.9597004029583, 4042.838286468508, 4871.269309603588, 4997.30037794709, 5777.74000169985, 5881.529477641779, 5926.525877929756, 1053.4837929414532, 1062.7396287909512, 1093.7101668057971, 1098.4782228441586, 1101.4547798839626, 629.0784001437823, 644.5359341274275, 669.3473862983552, 673.8147009572407, 682.011083928306, 11343.659690209306, 13920.443182272798, 14004.50984215568, 14091.36588853504, 14124.43502259898, 656.4420242793587, 675.1021141881287, 676.3338111959715, 685.8045457044718, 703.9859202815915, 5525.696086715269, 5584.0, 5622.437756224426, 5719.142128680648, 5986.610870293417, 96092.51953740326, 101349.49325253327, 102323.0, 102518.0, 104372.0, 88472.0, 92054.37296738273, 92813.53593231991, 93450.53274733583, 96788.51605742067, 78075.60962195267, 78165.2183478158, 82704.58647706723, 83245.16754832375, 84623.57688211642, 11444.828327574927, 12059.15585909013, 12742.0, 12840.293783841606, 13122.840652647243, 32883.34233315368, 35839.28321433609, 36272.0, 36338.09154771152, 37710.434343485416, 62007.689961549906, 65265.0, 67017.0, 68300.0, 69232.65383673049, 18410.539736506693, 18904.054797259807, 18965.525861853563, 19151.0, 19158.904205478884, 20797.37607871766, 20909.163633454493, 20958.266460673804, 20959.323254139326, 21059.15763369448, 18420.263189472273, 18448.169832357307, 18583.628327433646, 18646.81353186505, 18648.16083276283, 18198.090095495438, 18327.17527711283, 18468.538286542946, 18532.351367702067, 18569.628607427505, 18376.632467350846, 18460.723089153405, 18511.53721156982, 18655.347062852736, 18980.145893435103, 12858.228506289652, 13393.66515837112, 13691.726165476834, 13763.105398149088, 14118.717625647225, 13327.133736307109, 14537.92731036338, 14553.92723036378, 14679.6661540529, 15222.346636807308], "value": 9117.88120723123, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 104.0, 108.0, 108.0, 112.0, 116.0, 100.0, 112.0, 117.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 120.0, 149.0, 169.0, 122.0, 150.0, 148.0, 125.0, 185.0, 126.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 170.0, 164.0, 164.0, 165.0, 169.0, 167.0, 162.0, 163.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 180.0, 75.0, 77.0, 81.0, 92.0, 100.0, 75.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 135.0, 79.0, 79.0, 79.0, 126.0, 83.0, 80.0, 129.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 114.0, 113.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 157.0, 152.0, 152.0, 150.0, 158.0, 153.0, 151.0], "value": 152.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 95.0, 94.0, 98.0, 94.0, 94.0, 98.0, 100.0, 93.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 56.0, 56.0, 57.0, 60.0, 59.0, 61.0, 61.0, 57.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 53.0, 54.0, 53.0, 54.0, 58.0, 56.0, 54.0, 54.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 84.0, 81.0, 83.0, 80.0, 82.0, 84.0, 82.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 136.0, 131.0, 137.0, 129.0, 135.0, 145.0, 130.0, 131.0, 173.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 187.0, 188.0, 184.0, 186.0, 182.0, 192.0, 182.0, 199.0, 181.0], "value": 187.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 72.0, 75.0, 72.0, 69.0, 68.0, 73.0, 68.0, 72.0], "value": 71.0, "unit": "score"}]}]} 18:45:27 INFO - Return code: 0 18:45:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:45:27 INFO - # TBPL SUCCESS # 18:45:27 INFO - Running post-action listener: _package_coverage_data 18:45:27 INFO - Running post-action listener: _resource_record_post_action 18:45:27 INFO - [mozharness: 2017-07-29 01:45:27.537620Z] Finished run-tests step (success) 18:45:27 INFO - Running post-run listener: _resource_record_post_run 18:45:27 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 12288; Write bytes: 433246208; Read time: 364; Write time: 286800 18:45:27 INFO - TinderboxPrint: CPU usage
13.2% 18:45:27 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 364 18:45:27 INFO - TinderboxPrint: I/O write bytes / time
433,246,208 / 286,800 18:45:27 INFO - TinderboxPrint: CPU idle
8,273.4 (86.8%) 18:45:27 INFO - TinderboxPrint: CPU user
1,204.1 (12.6%) 18:45:27 INFO - TinderboxPrint: Swap in / out
0 / 0 18:45:27 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109019136; Read time: 192; Write time: 100496 18:45:27 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:45:27 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324227072; Read time: 164; Write time: 186304 18:45:28 INFO - Running post-run listener: _upload_blobber_files 18:45:28 INFO - Blob upload gear active. 18:45:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:45:28 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 18:45:28 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'] 18:45:28 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 18:45:28 INFO - (blobuploader) - INFO - Open directory for files ... 18:45:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:45:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:45:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:33 INFO - (blobuploader) - INFO - Done attempting. 18:45:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:45:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:45:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:34 INFO - (blobuploader) - INFO - Done attempting. 18:45:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:45:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:45:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:35 INFO - (blobuploader) - INFO - Done attempting. 18:45:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:45:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:45:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:36 INFO - (blobuploader) - INFO - Done attempting. 18:45:36 INFO - (blobuploader) - INFO - Iteration through files over. 18:45:36 INFO - Return code: 0 18:45:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:45:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:45:36 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b50af6fafa67e8b1daf19d7ef7d8b2a6839d6048fe32a6cc5f2891b205e29cd2a44475d61e31325e951bca534d80f491d53232e626c97a22793eddd00262ad1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d33b53ef1bc6b8f81aeb6790646c3930fa64ff04ab0195d7d3a60c309eaa86c42efc08f771eb384f157a57c31f633cda1f090369dc678d313b9c51a9a8d7e787", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b135aec95ed63fcf646e2a6230815a3b38abcd7e7d0efc032c4f828f980f2fffe771fc22fc44055127fd676eda4871e5141e037e5574b1896bd114ed9804e2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be277d52fa83647afe78f71c974a0e0f2eb032dbdf6a3b7ebc8f8fb545e5cd6aa4301f541020d88587d88f18a0de123d7a7d1c762ac57b5387db460ea227a051"} 18:45:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:45:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:45:36 INFO - Contents: 18:45:36 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b50af6fafa67e8b1daf19d7ef7d8b2a6839d6048fe32a6cc5f2891b205e29cd2a44475d61e31325e951bca534d80f491d53232e626c97a22793eddd00262ad1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d33b53ef1bc6b8f81aeb6790646c3930fa64ff04ab0195d7d3a60c309eaa86c42efc08f771eb384f157a57c31f633cda1f090369dc678d313b9c51a9a8d7e787", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b135aec95ed63fcf646e2a6230815a3b38abcd7e7d0efc032c4f828f980f2fffe771fc22fc44055127fd676eda4871e5141e037e5574b1896bd114ed9804e2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be277d52fa83647afe78f71c974a0e0f2eb032dbdf6a3b7ebc8f8fb545e5cd6aa4301f541020d88587d88f18a0de123d7a7d1c762ac57b5387db460ea227a051"} 18:45:36 INFO - Running post-run listener: copy_logs_to_upload_dir 18:45:36 INFO - Copying logs to upload dir... 18:45:36 INFO - mkdir: /builds/slave/test/build/upload/logs 18:45:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.453138 ========= master_lag: -0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-07-28 18:45:34.951377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 18:45:34.957641) ========= 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=232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331 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/3b50af6fafa67e8b1daf19d7ef7d8b2a6839d6048fe32a6cc5f2891b205e29cd2a44475d61e31325e951bca534d80f491d53232e626c97a22793eddd00262ad1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d33b53ef1bc6b8f81aeb6790646c3930fa64ff04ab0195d7d3a60c309eaa86c42efc08f771eb384f157a57c31f633cda1f090369dc678d313b9c51a9a8d7e787", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b135aec95ed63fcf646e2a6230815a3b38abcd7e7d0efc032c4f828f980f2fffe771fc22fc44055127fd676eda4871e5141e037e5574b1896bd114ed9804e2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be277d52fa83647afe78f71c974a0e0f2eb032dbdf6a3b7ebc8f8fb545e5cd6aa4301f541020d88587d88f18a0de123d7a7d1c762ac57b5387db460ea227a051"} build_url:https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b50af6fafa67e8b1daf19d7ef7d8b2a6839d6048fe32a6cc5f2891b205e29cd2a44475d61e31325e951bca534d80f491d53232e626c97a22793eddd00262ad1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d33b53ef1bc6b8f81aeb6790646c3930fa64ff04ab0195d7d3a60c309eaa86c42efc08f771eb384f157a57c31f633cda1f090369dc678d313b9c51a9a8d7e787", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b135aec95ed63fcf646e2a6230815a3b38abcd7e7d0efc032c4f828f980f2fffe771fc22fc44055127fd676eda4871e5141e037e5574b1896bd114ed9804e2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be277d52fa83647afe78f71c974a0e0f2eb032dbdf6a3b7ebc8f8fb545e5cd6aa4301f541020d88587d88f18a0de123d7a7d1c762ac57b5387db460ea227a051"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 18:45:34.992643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-07-28 18:45:34.992981) ========= 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=232498196343f89f466a4a9a000001c8-1501281358.600095-1803450331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004653 ========= master_lag: 1.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-07-28 18:45:36.041835) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 18:45:36.042146) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 18:45:36.097232) ========= ========= Total master_lag: 1.00 =========