builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1501291470.82 results: success (0) revision: ec666e910442ae55686160c1bd0c93b00a08dead ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:30.818083) ========= 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:30.818910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:30.819231) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:30.933635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:30.933991) ========= 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=5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-28 18:24:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 225M=0s 2017-07-28 18:24:31 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122070 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.134175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.134520) ========= 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=5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017412 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.200993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.201374) ========= 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=5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-28 18:24:31,598 truncating revision to first 12 chars 2017-07-28 18:24:31,598 Setting DEBUG logging. 2017-07-28 18:24:31,598 attempt 1/10 2017-07-28 18:24:31,598 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:32,001 unpacking tar archive at: mozilla-central-ec666e910442/testing/mozharness/ program finished with exit code 0 elapsedTime=0.709221 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.987344) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.988011) ========= script_repo_revision: ec666e910442ae55686160c1bd0c93b00a08dead ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.992850) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:31.993441) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 18:24:32.171070) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-07-28 18:24:32.171415) ========= /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=5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:24:32 INFO - MultiFileLogger online at 20170728 18:24:32 in /builds/slave/test 18:24:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:24:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:24:32 INFO - {'append_to_log': False, 18:24:32 INFO - 'base_work_dir': '/builds/slave/test', 18:24:32 INFO - 'blob_upload_branch': 'Firefox', 18:24:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:24:32 INFO - 'branch': 'Firefox', 18:24:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:24:32 INFO - 'code_coverage': False, 18:24:32 INFO - 'config_files': ('talos/linux_config.py',), 18:24:32 INFO - 'default_actions': ('clobber', 18:24:32 INFO - 'read-buildbot-config', 18:24:32 INFO - 'download-and-extract', 18:24:32 INFO - 'populate-webroot', 18:24:32 INFO - 'create-virtualenv', 18:24:32 INFO - 'install', 18:24:32 INFO - 'setup-mitmproxy', 18:24:32 INFO - 'run-tests'), 18:24:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:24:32 INFO - 'disable_ccov_upload': False, 18:24:32 INFO - 'download_minidump_stackwalk': True, 18:24:32 INFO - 'download_symbols': 'ondemand', 18:24:32 INFO - 'enable_stylo': False, 18:24:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:24:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:24:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:24:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:24:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:24:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:24:32 INFO - 'gecko_profile': False, 18:24:32 INFO - 'gecko_profile_interval': 0, 18:24:32 INFO - 'installer_path': 'installer.exe', 18:24:32 INFO - 'log_level': 'info', 18:24:32 INFO - 'log_name': 'talos', 18:24:32 INFO - 'log_to_console': True, 18:24:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:24:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:24:32 INFO - 'opt_config_files': (), 18:24:32 INFO - 'pip_index': False, 18:24:32 INFO - 'suite': 'dromaeojs-e10s', 18:24:32 INFO - 'system_bits': '32', 18:24:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:24:32 INFO - 'title': 'talos-linux64-ix-039', 18:24:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:24:32 INFO - 'use_talos_json': True, 18:24:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:24:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:24:32 INFO - 'work_dir': 'build'} 18:24:32 INFO - [mozharness: 2017-07-29 01:24:32.670338Z] Running clobber step. 18:24:32 INFO - Running pre-action listener: _resource_record_pre_action 18:24:32 INFO - Running main action method: clobber 18:24:32 INFO - rmtree: /builds/slave/test/build 18:24:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:24:33 INFO - Running post-action listener: _resource_record_post_action 18:24:33 INFO - [mozharness: 2017-07-29 01:24:33.705044Z] Finished clobber step (success) 18:24:33 INFO - [mozharness: 2017-07-29 01:24:33.705146Z] Running read-buildbot-config step. 18:24:33 INFO - Running pre-action listener: _resource_record_pre_action 18:24:33 INFO - Running main action method: read_buildbot_config 18:24:33 INFO - Using buildbot properties: 18:24:33 INFO - { 18:24:33 INFO - "project": "", 18:24:33 INFO - "product": "firefox", 18:24:33 INFO - "who": "kwierso@gmail.com", 18:24:33 INFO - "installer_path": "public/build/target.tar.bz2", 18:24:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:24:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:24:33 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:24:33 INFO - "stage_platform": "linux64-stylosequential", 18:24:33 INFO - "basedir": "/builds/slave/test", 18:24:33 INFO - "buildnumber": 128, 18:24:33 INFO - "platform": "ubuntu64_hw_styloseq", 18:24:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:24:33 INFO - "slavebuilddir": "test", 18:24:33 INFO - "taskId": "IVrXMcMSQGWlgi7unAdC_g", 18:24:33 INFO - "branch": "mozilla-central", 18:24:33 INFO - "script_repo_revision": "production", 18:24:33 INFO - "revision": "ec666e910442ae55686160c1bd0c93b00a08dead", 18:24:33 INFO - "slavename": "talos-linux64-ix-039", 18:24:33 INFO - "repo_path": "mozilla-central" 18:24:33 INFO - } 18:24:33 INFO - Finding installer, test and symbols from parent task. 18:24:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IVrXMcMSQGWlgi7unAdC_g'}, attempt #1 18:24:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IVrXMcMSQGWlgi7unAdC_g'}, attempt #1 18:24:34 INFO - Task dependencies: esOdlu_7SECy18fFonV7ig 18:24:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig'}, attempt #1 18:24:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2 18:24:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/test_packages.json 18:24:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.crashreporter-symbols.zip 18:24:35 INFO - Running post-action listener: _resource_record_post_action 18:24:35 INFO - [mozharness: 2017-07-29 01:24:35.175847Z] Finished read-buildbot-config step (success) 18:24:35 INFO - [mozharness: 2017-07-29 01:24:35.176068Z] Running download-and-extract step. 18:24:35 INFO - Running pre-action listener: _resource_record_pre_action 18:24:35 INFO - Running main action method: download_and_extract 18:24:35 INFO - mkdir: /builds/slave/test/build/tests 18:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:24:35 INFO - trying https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.test_packages.json 18:24:35 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:35 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:35 INFO - Downloaded 989 bytes. 18:24:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:24:35 INFO - Using the following test package requirements: 18:24:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:24:35 INFO - u'common': [u'target.common.tests.zip'], 18:24:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:24:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:24:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:24:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:24:35 INFO - u'mozbase': [u'target.common.tests.zip'], 18:24:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:24:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:24:35 INFO - u'web-platform': [u'target.common.tests.zip', 18:24:35 INFO - u'target.web-platform.tests.tar.gz'], 18:24:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:24:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:24:35 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:35 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:35 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:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:24:50 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:50 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:50 INFO - Fetch https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.common.tests.zip into memory 18:24:53 INFO - Content-Length response header: 72565189 18:24:53 INFO - Bytes received: 72565189 18:25:08 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:08 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:08 INFO - Fetch https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.talos.tests.zip into memory 18:25:09 INFO - Content-Length response header: 14496686 18:25:09 INFO - Bytes received: 14496686 18:25:09 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:09 INFO - trying https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2 18:25:09 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:09 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:11 INFO - Downloaded 62111661 bytes. 18:25:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2 18:25:11 INFO - mkdir: /builds/slave/test/properties 18:25:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:25:11 INFO - Writing to file /builds/slave/test/properties/build_url 18:25:11 INFO - Contents: 18:25:11 INFO - build_url:https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2 18:25:11 INFO - Running post-action listener: _resource_record_post_action 18:25:11 INFO - Running post-action listener: set_extra_try_arguments 18:25:11 INFO - [mozharness: 2017-07-29 01:25:11.611744Z] Finished download-and-extract step (success) 18:25:11 INFO - [mozharness: 2017-07-29 01:25:11.611841Z] Running populate-webroot step. 18:25:11 INFO - Running pre-action listener: _resource_record_pre_action 18:25:11 INFO - Running main action method: populate_webroot 18:25:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:25:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:25:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:25:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:25:11 INFO - 'tests': ['damp', 'tps']}, 18:25:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:25:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:25:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:25:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:25:11 INFO - 'other-e10s': {'tests': ['a11yr', 18:25:11 INFO - 'ts_paint', 18:25:11 INFO - 'tpaint', 18:25:11 INFO - 'sessionrestore', 18:25:11 INFO - 'sessionrestore_many_windows', 18:25:11 INFO - 'sessionrestore_no_auto_restore', 18:25:11 INFO - 'tabpaint']}, 18:25:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:25:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:25:11 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:25:11 INFO - 'talos_options': ['--mitmproxy', 18:25:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:25:11 INFO - '--firstNonBlankPaint'], 18:25:11 INFO - 'tests': ['quantum_pageload_google', 18:25:11 INFO - 'quantum_pageload_youtube', 18:25:11 INFO - 'quantum_pageload_amazon', 18:25:11 INFO - 'quantum_pageload_facebook']}, 18:25:11 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:25:11 INFO - 'talos_options': ['--stylo', 18:25:11 INFO - '--mitmproxy', 18:25:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:25:11 INFO - '--firstNonBlankPaint'], 18:25:11 INFO - 'tests': ['quantum_pageload_google', 18:25:11 INFO - 'quantum_pageload_youtube', 18:25:11 INFO - 'quantum_pageload_amazon', 18:25:11 INFO - 'quantum_pageload_facebook']}, 18:25:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:25:11 INFO - 'tsvgr_opacity', 18:25:11 INFO - 'tart', 18:25:11 INFO - 'tscrollx', 18:25:11 INFO - 'cart', 18:25:11 INFO - 'tsvg_static']}, 18:25:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:25:11 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:25:11 INFO - 'talos_options': ['--stylo', 18:25:11 INFO - '--stylo-threads=1', 18:25:11 INFO - '--mitmproxy', 18:25:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:25:11 INFO - '--firstNonBlankPaint'], 18:25:11 INFO - 'tests': ['tp6_google', 18:25:11 INFO - 'tp6_youtube', 18:25:11 INFO - 'tp6_amazon', 18:25:11 INFO - 'tp6_facebook']}, 18:25:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:25:11 INFO - 'talos_options': ['--xperf_path', 18:25:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:11 INFO - 'tests': ['tp5n']}}} 18:25:11 INFO - Running post-action listener: _resource_record_post_action 18:25:11 INFO - [mozharness: 2017-07-29 01:25:11.620480Z] Finished populate-webroot step (success) 18:25:11 INFO - [mozharness: 2017-07-29 01:25:11.620571Z] Running create-virtualenv step. 18:25:11 INFO - Running pre-action listener: _resource_record_pre_action 18:25:11 INFO - Running main action method: create_virtualenv 18:25:11 INFO - Creating virtualenv /builds/slave/test/build/venv 18:25:11 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:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:25:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:25:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:25:11 INFO - Using real prefix '/usr' 18:25:11 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 0x122a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596eb0>, '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 0x1597db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1598240>, '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', 18:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:14 INFO - '_': '/tools/buildbot/bin/python'} 18:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:14 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:14 INFO - Cleaning up... 18:25:14 INFO - Return code: 0 18:25:14 INFO - Installing psutil>=3.1.1 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', '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 0x122a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596eb0>, '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 0x1597db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1598240>, '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', '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', 'psutil>=3.1.1'] 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 psutil>=3.1.1 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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', 18:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:14 INFO - '_': '/tools/buildbot/bin/python'} 18:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:14 INFO - Downloading/unpacking psutil>=3.1.1 18:25:14 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:14 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:14 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:14 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 - 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: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 - Successfully installed psutil 18:25:16 INFO - Cleaning up... 18:25:16 INFO - Return code: 0 18:25:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596eb0>, '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 0x1597db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1598240>, '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', '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:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:25:16 INFO - Using env: {'DISPLAY': ':0', 18:25:16 INFO - 'HOME': '/home/cltbld', 18:25:16 INFO - 'LANG': 'en_US.UTF-8', 18:25:16 INFO - 'LANGUAGE': 'en_US:en', 18:25:16 INFO - 'LOGNAME': 'cltbld', 18:25:16 INFO - 'MAIL': '/var/mail/cltbld', 18:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:16 INFO - 'MOZ_NO_REMOTE': '1', 18:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:16 INFO - 'NO_EM_RESTART': '1', 18:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:16 INFO - 'PWD': '/builds/slave/test', 18:25:16 INFO - 'SHELL': '/bin/bash', 18:25:16 INFO - 'SHLVL': '1', 18:25:16 INFO - 'TERM': 'linux', 18:25:16 INFO - 'TMOUT': '86400', 18:25:16 INFO - 'USER': 'cltbld', 18:25:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', 18:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:16 INFO - '_': '/tools/buildbot/bin/python'} 18:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:25:16 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:16 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 - 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:16 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 - Downloading mozsystemmonitor-0.3.tar.gz 18:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:25:17 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:17 INFO - Installing collected packages: mozsystemmonitor 18:25:17 INFO - Running setup.py install for mozsystemmonitor 18:25:17 INFO - Successfully installed mozsystemmonitor 18:25:17 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 0x122a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596eb0>, '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 0x1597db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1598240>, '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', 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:19 INFO - warning: no files found matching '*.txt' 18:25:19 INFO - no previously-included directories found matching 'build' 18:25:19 INFO - no previously-included directories found matching 'dist' 18:25:19 INFO - no previously-included directories found matching '.git*' 18:25:19 INFO - Installing collected packages: jsonschema, functools32 18:25:19 INFO - Running setup.py install for functools32 18:25:19 INFO - warning: no files found matching '*.txt' 18:25:19 INFO - no previously-included directories found matching 'build' 18:25:19 INFO - no previously-included directories found matching 'dist' 18:25:19 INFO - no previously-included directories found matching '.git*' 18:25:19 INFO - Successfully installed jsonschema functools32 18:25:19 INFO - Cleaning up... 18:25:19 INFO - Return code: 0 18:25:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:19 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 0x122a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596eb0>, '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 0x1597db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1598240>, '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 18:25:19 INFO - 'HOME': '/home/cltbld', 18:25:19 INFO - 'LANG': 'en_US.UTF-8', 18:25:19 INFO - 'LANGUAGE': 'en_US:en', 18:25:19 INFO - 'LOGNAME': 'cltbld', 18:25:19 INFO - 'MAIL': '/var/mail/cltbld', 18:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:19 INFO - 'MOZ_NO_REMOTE': '1', 18:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:19 INFO - 'NO_EM_RESTART': '1', 18:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:19 INFO - 'PWD': '/builds/slave/test', 18:25:19 INFO - 'SHELL': '/bin/bash', 18:25:19 INFO - 'SHLVL': '1', 18:25:19 INFO - 'TERM': 'linux', 18:25:19 INFO - 'TMOUT': '86400', 18:25:19 INFO - 'USER': 'cltbld', 18:25:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', 18:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:19 INFO - '_': '/tools/buildbot/bin/python'} 18:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:25:19 INFO - Cleaning up... 18:25:19 INFO - Return code: 0 18:25:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:19 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 0x122a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596eb0>, '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 0x1597db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1598240>, '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 18:25:19 INFO - 'HOME': '/home/cltbld', 18:25:19 INFO - 'LANG': 'en_US.UTF-8', 18:25:19 INFO - 'LANGUAGE': 'en_US:en', 18:25:19 INFO - 'LOGNAME': 'cltbld', 18:25:19 INFO - 'MAIL': '/var/mail/cltbld', 18:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:19 INFO - 'MOZ_NO_REMOTE': '1', 18:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:19 INFO - 'NO_EM_RESTART': '1', 18:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:19 INFO - 'PWD': '/builds/slave/test', 18:25:19 INFO - 'SHELL': '/bin/bash', 18:25:19 INFO - 'SHLVL': '1', 18:25:19 INFO - 'TERM': 'linux', 18:25:19 INFO - 'TMOUT': '86400', 18:25:19 INFO - 'USER': 'cltbld', 18:25:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', 18:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:19 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:21 INFO - Downloading/unpacking docopt==0.6.1 (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 - Downloading docopt-0.6.1.tar.gz 18:25:21 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 0x122a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596eb0>, '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 0x1597db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1598240>, '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', 18:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:22 INFO - '_': '/tools/buildbot/bin/python'} 18:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:22 INFO - Running setup.py (path:/tmp/pip-JuxJ2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:22 INFO - Running setup.py (path:/tmp/pip-czT6tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:22 INFO - Running setup.py (path:/tmp/pip-qmW_5J-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-cczToy-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-sUpsUe-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-gq_bF6-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-RCs4X8-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-oslfN4-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-kM9tgO-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-o1JV7F-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-ZWgKO1-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-vL_bcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:23 INFO - Running setup.py (path:/tmp/pip-lW18SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:23 INFO - Running setup.py (path:/tmp/pip-EUeFOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:23 INFO - Running setup.py (path:/tmp/pip-ZIHalX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:23 INFO - Running setup.py (path:/tmp/pip-MGx6rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:23 INFO - Running setup.py (path:/tmp/pip-BKoZOC-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:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:25:24 INFO - Running setup.py install for mozInstall 18:25:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:25:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:25:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:25:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:25:24 INFO - Running setup.py install for mozleak 18:25:24 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:25 INFO - Running setup.py install for mozversion 18:25:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:25:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:25:25 INFO - Cleaning up... 18:25:25 INFO - Return code: 0 18:25:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:25 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:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:25 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:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:25 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 0x122a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596eb0>, '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 0x1597db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1598240>, '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', '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:25 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:25 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:25 INFO - Using env: {'DISPLAY': ':0', 18:25:25 INFO - 'HOME': '/home/cltbld', 18:25:25 INFO - 'LANG': 'en_US.UTF-8', 18:25:25 INFO - 'LANGUAGE': 'en_US:en', 18:25:25 INFO - 'LOGNAME': 'cltbld', 18:25:25 INFO - 'MAIL': '/var/mail/cltbld', 18:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:25 INFO - 'MOZ_NO_REMOTE': '1', 18:25:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:25 INFO - 'NO_EM_RESTART': '1', 18:25:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:25 INFO - 'PWD': '/builds/slave/test', 18:25:25 INFO - 'SHELL': '/bin/bash', 18:25:25 INFO - 'SHLVL': '1', 18:25:25 INFO - 'TERM': 'linux', 18:25:25 INFO - 'TMOUT': '86400', 18:25:25 INFO - 'USER': 'cltbld', 18:25:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', 18:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:25 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-VF3DHh-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-NA1tuJ-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-_RsvLh-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-cq0Jjc-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-AdQUQL-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-lPrTMC-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-e8_2Kq-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-qORzUG-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-3fEGAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:26 INFO - Running setup.py (path:/tmp/pip-QNXp7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:26 INFO - Running setup.py (path:/tmp/pip-4J2a3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:26 INFO - Running setup.py (path:/tmp/pip-VLj5C7-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-8Ygo7D-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-S_C9Rh-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-fKpFvW-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-QLDT7_-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-SWQ17G-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:28 INFO - Reading from file tmpfile_stdout 18:25:28 INFO - Current package versions: 18:25:28 INFO - argparse == 1.2.1 18:25:28 INFO - blessings == 1.6 18:25:28 INFO - blobuploader == 1.2.4 18:25:28 INFO - docopt == 0.6.1 18:25:28 INFO - functools32 == 3.2.3-2 18:25:28 INFO - jsonschema == 2.5.1 18:25:28 INFO - manifestparser == 1.1 18:25:28 INFO - mozInstall == 1.13 18:25:28 INFO - mozcrash == 1.0 18:25:28 INFO - mozdebug == 0.1 18:25:28 INFO - mozdevice == 0.51 18:25:28 INFO - mozfile == 1.2 18:25:28 INFO - mozhttpd == 0.7 18:25:28 INFO - mozinfo == 0.10 18:25:28 INFO - mozleak == 0.1 18:25:28 INFO - mozlog == 3.5 18:25:28 INFO - moznetwork == 0.27 18:25:28 INFO - mozprocess == 0.25 18:25:28 INFO - mozprofile == 0.28 18:25:28 INFO - mozrunner == 6.13 18:25:28 INFO - mozscreenshot == 0.1 18:25:28 INFO - mozsystemmonitor == 0.3 18:25:28 INFO - moztest == 0.8 18:25:28 INFO - mozversion == 1.4 18:25:28 INFO - psutil == 3.1.1 18:25:28 INFO - requests == 1.2.3 18:25:28 INFO - wsgiref == 0.1.2 18:25:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:28 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:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:28 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:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:28 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 0x122a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596eb0>, '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 0x1597db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1598240>, '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 18:25:28 INFO - 'HOME': '/home/cltbld', 18:25:28 INFO - 'LANG': 'en_US.UTF-8', 18:25:28 INFO - 'LANGUAGE': 'en_US:en', 18:25:28 INFO - 'LOGNAME': 'cltbld', 18:25:28 INFO - 'MAIL': '/var/mail/cltbld', 18:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:28 INFO - 'MOZ_NO_REMOTE': '1', 18:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:28 INFO - 'NO_EM_RESTART': '1', 18:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:28 INFO - 'PWD': '/builds/slave/test', 18:25:28 INFO - 'SHELL': '/bin/bash', 18:25:28 INFO - 'SHLVL': '1', 18:25:28 INFO - 'TERM': 'linux', 18:25:28 INFO - 'TMOUT': '86400', 18:25:28 INFO - 'USER': 'cltbld', 18:25:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', 18:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:28 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 0x122a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1599d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596eb0>, '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 0x1597db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1598240>, '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', '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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', 18:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:31 INFO - '_': '/tools/buildbot/bin/python'} 18:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:25:31 INFO - Cleaning up... 18:25:31 INFO - Return code: 0 18:25:31 INFO - Running post-action listener: _resource_record_post_action 18:25:31 INFO - Running post-action listener: _start_resource_monitoring 18:25:31 INFO - Starting resource monitoring. 18:25:31 INFO - [mozharness: 2017-07-29 01:25:31.951503Z] Finished create-virtualenv step (success) 18:25:31 INFO - [mozharness: 2017-07-29 01:25:31.952010Z] Running install step. 18:25:31 INFO - Running pre-action listener: _resource_record_pre_action 18:25:31 INFO - Running main action method: install 18:25:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:31 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.306732Z] Finished install step (success) 18:25:50 INFO - [mozharness: 2017-07-29 01:25:50.306983Z] 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.308112Z] Finished setup-mitmproxy step (success) 18:25:50 INFO - [mozharness: 2017-07-29 01:25:50.308332Z] 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 0x1596eb0>, '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 0x1597db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1598240>, '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-039', '--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-039 --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': '5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858', 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-039', '--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:44469' 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:44469/getInfo.html -profile /tmp/tmpCFts9u/profile 18:25:50 INFO - TEST-INFO | started process 15822 (/builds/slave/test/build/application/firefox/firefox http://localhost:44469/getInfo.html) 18:25:56 INFO - TEST-INFO | 15822: exit 0 18:25:57 INFO - Browser initialized. 18:25:57 INFO - Running cycle 1/1 for dromaeo_css test... 18:25:57 INFO - TEST-INFO | started process 16048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCFts9u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:25:58 INFO - PID 16048 | 18:25:58 INFO - PID 16048 | (/builds/slave/test/build/application/firefox/firefox:16102): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:25:58 INFO - PID 16048 | 18:26:08 INFO - PID 16048 | RSS: Main: 173535232 18:26:08 INFO - PID 16048 | 18:29:08 INFO - PID 16048 | Cycle 1(1): loaded http://localhost:44469/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44469/tests/dromaeo/cssquery-ext.html) 18:29:10 INFO - PID 16048 | RSS: Main: 175603712 18:29:10 INFO - PID 16048 | 18:32:11 INFO - PID 16048 | Cycle 1(1): loaded http://localhost:44469/tests/dromaeo/cssquery-ext.html (next: http://localhost:44469/tests/dromaeo/cssquery-jquery.html) 18:32:12 INFO - PID 16048 | RSS: Main: 173101056 18:32:12 INFO - PID 16048 | 18:35:14 INFO - PID 16048 | Cycle 1(1): loaded http://localhost:44469/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44469/tests/dromaeo/cssquery-mootools.html) 18:35:15 INFO - PID 16048 | RSS: Main: 175276032 18:35:15 INFO - PID 16048 | 18:38:17 INFO - PID 16048 | Cycle 1(1): loaded http://localhost:44469/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44469/tests/dromaeo/cssquery-prototype.html) 18:38:17 INFO - PID 16048 | RSS: Main: 173584384 18:38:17 INFO - PID 16048 | 18:41:21 INFO - PID 16048 | Cycle 1(1): loaded http://localhost:44469/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44469/tests/dromaeo/cssquery-yui.html) 18:41:22 INFO - PID 16048 | RSS: Main: 173420544 18:41:22 INFO - PID 16048 | 18:44:23 INFO - PID 16048 | Cycle 1(1): loaded http://localhost:44469/tests/dromaeo/cssquery-yui.html (next: http://localhost:44469/tests/dromaeo/cssquery-dojo.html) 18:44:24 INFO - PID 16048 | RSS: Main: 177553408 18:44:24 INFO - PID 16048 | 18:44:24 INFO - PID 16048 | __start_tp_report 18:44:24 INFO - PID 16048 | _x_x_mozilla_page_load 18:44:24 INFO - PID 16048 | _x_x_mozilla_page_load_details 18:44:24 INFO - PID 16048 | |i|pagename|runs| 18:44:24 INFO - PID 16048 | |0;dojo.html;3127.2025633463477;3130.012442099267;3151.2121969507625;3158.384115097554;3202.647708752037;6028.487578555822;6086.5435092368025;6091.751191005844;6120.2043734314475;6134.294556126047;6115.785947491839;6138.263408390988;6143.631382117065;6144.662043587601;6162;5643.774249030034;5654.519365853907;5655.802046928358;5683.573731970118;5703.0589952657765;5600.2159697642155;5664.065429204176;5682.914756278659;5687.744051517691;5740.282464691913;5630.662160270376;5672.120821272689;5715.257016587838;5732.0542110551705;5736;5550.58370622205;5602.299712535933;5618.606697531174;5644.78637093027;5764.682942438164;5571.665700057969;5611.803586874481;5622.634528755618;5657.519110875581;5665.121906104519;6093.421124993119;6102.755889764404;6139.723712432951;6154;6179.907301390483;6479.416852483299;6595.70319335631;6611.537192396534;6653.135092438;6680.3987641112535;6657.434118099919;6766.560173588701;6768.76309329176;6781.050652908597;6782;6203.2245969253845;6222.657753823538;6238.937610623926;6249.125122482856;6271.3728627136925;6829.692663830139;6848.760293389807;6861.656917154222;6942.028116063755;6946.756863509753;6377.681115944277;6500.089987401768;6503.544751867418;6506.869862602722;6613.074169616258;6503.154589903377;6575.046618240328;6578.868422631521;6581.539292249592;6590.637514936724;6462.612243265419;6503.089567460559;6540.476761859135;6551.475881929434;6556.18047744032;6514.478841692653;6564.245111812203;6578.5395022347975;6597.736090556324;6616.636085015274;5380.784768609212;5385.892282154335;5389.299391079213;5389.865253368697;5407.810726624628;4620;4642.675012749075;4698.036902434993;4699.577038066591;4721.6694831362165;5644.32268127819;5648.124540696199;5735.8566035849435;5736.541076713853;5745.368009518949;6512.348765123545;6542.738290468328;6560.278369379364;6571.704273307617;6648.268690444047;5693.658380497183;5715.371309155989;5725.370209276976;5743.569232307594;5747.453991870849;5818.330891947396;5832.854178645568;5852.414758524199;5858.531317494675;5933;6416.967915160394;6430.582012169194;6491;6523.608583485006;6535.052417399355;6553.148090748172;6589.505787065893;6590.47276217911;6634.601923884582;6696.698648560924;6410.743570257137;6410.967945160244;6454.031895215755;6456.225252969673;6468.320826313357;6407.359264073555;6454.741810327534;6474.676266186578;6517.055027021151;6545.181852268466;6632.137822083098;6714.798556043326;6721.260661327152;6725.461963042847;6725.562838415487;6420.325865784025;6421.839454013687;6510;6521.9673901630185;6531.346865313621;6296.842578935563;6394.038730345079;6423.743050277936;6428.260750013621;6429.807105786834;6370.8088757337355;6442.710078046405;6443.291237963726;6455.289918109098;6455.580387274812;6453.677316134268;6535.705893234721;6575.605463672195;6577.6053436793945;6586.1438013058;6233.065040244;6300.590461620163;6350.968245158745;6352.6506042166275;6380.042993551005 18:44:24 INFO - PID 16048 | |1;ext.html;796.3549524884844;848.7411339541437;859.5186695450548;884.6594061286403;888.6756333938113;39282.80358598207;40145.3978190327;40250.798746006265;40271.798641006826;40355.192896142056;36800.63199368006;36972.445413318754;37006.259874802556;37068.62931370686;37206.44190337147;6636.435902948243;6702.7654032108885;6745.392914637681;6754.088198093244;6761.2900645432255;6697;6772;6779.72881084756;6786.423154031913;6787.219469760991;6697.2967838377;7480.812979675497;7589.658465369044;7664.808379790494;7707.267809558111;7588.848223035536;7655.961720191392;7657.46397752152;7658;7659.540427574363;7294.671739771723;7300.671469783872;7353.338199562012;7360.043194384749;7446.441516886201;38202.80898595489;38432.23135537301;38486.42270365947;38525;38526.42210366847;3537.0449978505917;3596.9280614387567;3597.6762091411897;3610.4403817408343;3610.9097272568397;30281.545776813364;30323.848380758176;30388;30486.84756576225;30777;4743.169945259566;4749.667523273372;4754.120487709784;4787.40157480315;4795.688280261772;195088;195845;198568;203653;209564;49829.50170498249;49939.50060499348;49950;50222;50383.74808125936;51436.22845657318;51484.74257628763;51513.7424312876;51680.483195168315;51691.22463163055;16490.42283520095;16522.50432487027;16635;16698.415555455744;16746;13426.731465370638;13632;13646.317684115755;13674.453021879212;13709.725805484033;14145;14257.50098746539;14300.642483937985;14305.140331757013;14340.856591434162;5767.567432442584;5823.475887170175;5828.504577110993;5854.795082172103;5891.3814049525035;977.7213494154274;993.2302465589227;1000.7147962830559;1019.5208252121491;1020.1991436722137;22306.330810075724;22482.55034899293;23310;27224.863875680494;27934.720652793618;1071.4374953149659;1085.8045551800594;1105.4196546812987;1117.0951529261324;1118.2284223885492;12075.335856527976;12238.388080595934;12239.510419583296;12281.508739650313;12503.437345319482;227926;228916;229566;229709;229837;50918.49081509212;51576.48423515792;51640.74179629078;51683.741581292605;51716;1466.9853301467062;1469.2727100085526;1472.7790831375164;1486.9330880110422;1509.9018563793538;21686;21772.774889806566;22407.551848963256;22892.656610150527;22925;36437;47578;50424.24363634475;51186.48813511966;51251.23123153081;201299;201757;202099;202657;202883;29415.558766618946;29755.256118597208;30350.696493034786;30497.237569060064;33141.502877456376;37662.246755064196;43485.56514434942;43648.34527482027;43710.781446092566;43913;28581.571276430455;30338.84830575833;30738.231544211572;31047.84476077605;31277.84361078271;28003.299917501412;29877.701222988362;30234;30607.234819128807;30785;34285.31429371348;34574.13564660904;34695.47956780701;34735.82632086823;34750.304993900485;28272.85863570669;29891.402171956004;30127.397452050398;30723.2319192022;31054.844725776227;22888.084476621414;23123.306300811004;23304.76695233026;23342.416439589146;23429.41426464352 18:44:24 INFO - PID 16048 | |2;jquery.html;570.2444261353708;572.2132068405942;578.6672663218648;582.3332284534208;588.5556404914289;21541.784582154192;22507.099716011362;22512.437189070282;22544.66183007252;22555.323340299776;24020.279391618278;25185.244442666703;26321.473570528626;26394.20817375477;26486.543240121784;6281.685915704231;6478.125453063847;6479.611223326616;6486.4162225399705;6486.4162225399705;6307.526935479835;6336.714847831836;6337.081123237128;6339.429451349378;6341.1756471658855;6139.324674285825;6422.678866056678;6427.260865000515;6427.614343139427;6433.774817881375;6281.43467087962;6305.96847015762;6311.179546658928;6317.87364252717;6330.208723909512;5860.589758716891;5875.294964604275;5877;5882.323532793698;5901.73442195098;28565.857170714222;29087.272818179503;29157.70842291571;29574.408511829857;29916.10251692431;1868.3834334669527;1931.3433432632971;1932.8550358723012;1934.845212383006;1936.9225230990744;18037.27850885963;18713.251469941188;18852.15165317564;18868.15093320804;18896.338628148085;2269.5574362999223;2322.826972378955;2369.419492224416;2375.180562705864;2380.6310021946624;136005.3199734005;139015;139214;139240.3037984814;139632.30183849117;13795.551112221945;14657.92671036638;14673.266336683337;14834.554963351116;15339;23128.537429251322;23456.179033733737;23552.882235588713;23752.406189845045;23883.761162388502;10618.256722029384;10627;10705.197110216764;10816.783664326827;10875.83686244707;9894.901050989398;9999.700008999742;10003.849942250872;10047.748806279755;10080.29437939352;8930.464172149692;9486.430814151174;9531.568635291289;9602.90397096034;9620.75948101303;2620.685517737884;2657.4419371931726;2708.7697545708834;2732.1257197696546;2836.187279978906;926.6849271247808;928.7028150991753;949.6866034208695;977.5942983661843;983.9458829764288;19365.225390984484;23680.28959131229;24761.876190618932;24893.875530622594;25007;1006.1938819818444;1007.3452256033637;1033.8862725100232;1038.1642777563982;1043.186314674555;11052.613158539574;11275.32348059119;11371.943140284411;11415.315081095161;11470.48382822775;501238;517491;520740;528754;542866;117017;118891;119375;119883.40058299828;120587;1267.499337761579;1298.5909438526835;1301.1477482248952;1304.0936549098476;1306.8693130686854;17251.91374043172;17710.114494274978;18324.633507329512;18336.633267334313;18338.358157464423;55708.44291557195;56409.71795140998;57482.7125864368;57680;58451;72971.27028729644;73701;73902;73954;74479;14240.003199775916;14591.124532527658;14660.706785864437;14671;14754.852451475348;22805.97373118247;23150.42123946915;23420.531589368456;23484.6477302844;23608.17371391993;18235.635287294444;18236.908815455838;18493.90753046226;18638.627227455105;18708.438746837615;15619.375224990874;16016.919915400349;16341.836581634507;16534.59455946258;16759.41342053022;19905.60188796245;19991.40025799228;20006.799932000493;20148.59702805965;20194.79805201988;14281.14313141215;14865.554033379016;15025.323860426088;15113;15124.621884452978;19002.809971900657;19154.8084519153;19171.712424313366;19248.422547323604;19318.71021934644 18:44:24 INFO - PID 16048 | |3;mootools.html;1302.225176020268;1356.7354365898648;1363.8090667306572;1366.9111507751988;1387.9791803122955;13464.932675336622;13925.094868833532;14055.226962517057;14102.788458173123;14599.41602335908;14252.073615215004;14521.709565808678;14523.636909077279;14537.273136343194;14541.563753087425;2607.4915391498666;2725.127959053109;2765.7234276572385;2771.3348796288847;2781.3185769486504;2629.5661215899354;2765.1013420638274;2771.0993926973715;2772.7365900239447;2774.9861250693716;2668.052841241351;2679.5578729509607;2689.7713694336003;2693.6902256240587;2705.147878418302;2598.740125987386;2623.488419758138;2637.934051648705;2640.8679566021624;2646.9205923822315;2601.414681696622;2637.0638423359624;2639.261006918066;2649.668791401075;2650;13665.453381864714;13942.093763905314;13945.721085578332;13949.093308934887;13956.581302560939;7573.31840134385;7842.254985776342;7859.096203936506;7888.447808653396;7931.246531579491;5124.948750512522;5235.685858848481;5263.184206448007;5409.459054094598;5411.242426060355;1815.4402292767136;1830.103249407794;1842.9170687319104;1874.08169996702;1885.8302752752181;22107.226247081435;22542.77457225423;22846.31461056171;22863.085476580916;22896.198633047763;6875.896861547081;6968.512204145661;7126.073610430611;7206.819829504304;7222.638868056576;17944.371946982053;18059.54851128706;18129.818701813077;18151.183196756177;18164.545886352684;7381.335679788845;7440.10718713747;7602.7339043133225;7605.6957721691615;7606;5929.940700592939;6117.84705382369;6954.652267386711;7048.823779405556;7062.081929349151;5318.547923426475;5406.459354064562;5415.566754659618;5512.283403157564;5552.194931734876;1663.1102360237458;1712.9314827407013;1715.7941047074182;1727.2313820349823;1728.4296182259825;814.8288859339486;818.6029775558849;831.9376046796515;846.7840700621302;860.3762272352494;6340.397662222082;6591.868162636721;6649.4347980421235;7309.415246780245;7513.887291690629;925.1997022575558;950.3870003847618;953.7472569769017;964.4117088575963;967.1778987860403;4340.65274778017;4431.290993441098;4481.148581769454;4510.774461276923;4675.158471475167;18532;19105.426837194907;19244.326448574513;19311.22755089809;19337.903310483358;18277.26890924348;18507.35224267144;18509.629807404046;18531;18545.165467553994;9817.214622830157;10458.163346932228;10520.947395262974;10605.89394106049;10609.681709548726;6375;6829.726810927507;7125.251848555827;7246.347828695442;7311.4150867929375;14724.926375368055;16212.918935405247;16352;16478.176091195153;16875.07187104721;16011.839881601501;16488.17559122015;16670.58323541921;16944.74582881233;16979.320827166775;10128.59485620567;10413.9479302603;10942.343459392461;11205.551777928791;11208.66374008781;12018.278903265833;13161.473541058633;13191.736165276832;13242.404091816084;13251.867481325064;9841.863431461887;10165.491725413847;10280.537375817956;10347.223958203014;10551.94724026375;10103.393796372242;10152.695419137437;10231.386116833013;10258.794824103625;10307.94846025765;8260.793480163044;8429.747107586782;8475.660973560989;8514.914850851412;8518.233358997471;6061.909071363845;6168.352814065381;6373.553851230369;6416.262129855127;6474.967625162032;5956.523478121827;6176.8764624706355;6252.937470625236;6297.874042519215;6399.072134540373 18:44:24 INFO - PID 16048 | |4;prototype.html;479.30261469561793;501.9447860735319;511.39144418142433;517.2629003669771;530.7266757619826;6044.727987240573;6160.691965401735;6173.845653858656;6205.8758824823535;6239.532035097369;5744.626599271044;5965.642061476315;6026.397360263972;6037.879242415149;6049.274087109542;4857.927131093036;4886.9511304886855;4927.536231884058;4933.5939257311675;4940.580050695695;4757.571818536331;4919.950800491985;4946.208606622941;4959.6528243023;4973.477784832577;4866.172750632401;4876.171050921352;4881.414230292352;4898;4901.926471102936;4873.098476781806;4878.902421951559;4903.632227582945;4925.433575138869;4927.679700819435;4324.545922678105;4357.956420435787;4387.934180987288;4417.293233082723;4451.354553589744;5902.793402230945;5969.761209551612;6004.639721616717;6047.425494578008;6081.756729730805;5631.183478395651;5668.489835914787;5669.206311116447;5695.971520142414;5698.601097923147;6331.081993111019;6391.488680905516;6400;6458.90311645321;6495.220573531159;4776.47458779534;4812.639052071108;4822.782974766109;4827.54138356859;4879.634027447955;6665.533412661116;6790.388865002174;6816.920839144109;6863.519553631248;6889.689963951634;4955.950440495621;4956.702597844141;4965.726885021286;4970.801167953241;5023.547880690755;4932.556069953722;4939.629527785431;4982.576480999083;4995.225740010304;5053.36832895888;5579.302587176603;5612.579056570774;5612.747426365741;5624.875024995017;5626.521745651584;6354.824357493879;6414.166158399378;6462.159919210472;6475.352464753487;6622.569532980341;1614.5398561410177;1673.8660907127644;1696.6097797506643;1718.8796784225235;1727.8768800279918;1157.7279339355246;1207.6799648093263;1210.2194084815244;1223.0399136677665;1226.0865655087018;5500.964643082085;5558.972205138948;5610.288861897079;5615.466530679579;5653.462921022497;6499.902501462482;6533.738650454024;6554;6628.635425051572;6672;5685.403032681509;5709.8287051388525;5720.226729713802;5725.799597014167;5746.712664366765;3494.807785571818;3556.270964452333;3572.392693242155;3583.122135076923;3583.2475180212446;6454.19322584677;6498.6425746583445;6509.316521765147;6511.641859697762;6554.770583029571;6784.966075169593;6853.554518956252;6874;6892.931070689329;6907.20567134786;6341.746330146835;6342.904856427157;6506.934930650727;6524.380183882618;6568.934310656832;6583.736650533925;6668.966655166693;6669.233038200669;6705.22889867652;6754.696038678369;6620.437262832713;6631.602103873783;6684.6991885364305;6688.966555167193;6738.59568425896;6450.258430223719;6508.17771024114;6525;6556.8360790978695;6572.4084832365315;4883.853484395474;4939.407271127488;4957.529034741694;4979.975100124476;4989.750512474289;6466.838329041811;6671.432928201158;6679.165104361955;6720.428763555153;6737.966310168418;6194.194754681863;6288.6855657217875;6332.176817013758;6360.968195158995;6369.585976911486;6299.559030867796;6322.399372059647;6365.9681701593045;6369.267534233622;6511.38141876521;6233.937660623335;6250.906236406367;6268.843278918063;6383.744650213939;6393.840153996187;6338.809835704937;6373.298937117006;6471.838204044749;6474.125992990886;6530.7387704493185;6244.906326405198;6254.155688981929;6265.906011409741;6288.151099601495;6341.143945567289 18:44:24 INFO - PID 16048 | |5;yui.html;868.3357231717737;903.9231665308448;904.457325604637;913.5021413329735;925.3152667026401;18382.90808545957;19058.428247152573;19104.1403136859;19208.71186932197;21703.240386586473;20143.697844532344;20651.277205297818;21030;21047.368578942616;21101.683474747853;1021.5096753558278;1045.3309881675734;1061.2253055269657;1061.4374381577777;1061.9946900265527;1008.9115530851141;1034.4930983817912;1049.0558497352367;1052.4264275969576;1052.8999745024248;1109.9056580190693;1112.6105862947984;1112.7718817642365;1112.8497652816848;1112.9109671226322;1106.446776611694;1108.152263518409;1108.8225883858624;1109.1792073865363;1110.572429614596;816.3102178659024;817.7546735979182;819.4345901328064;819.7868554175898;820.0364571628372;19191.32830350945;19502.804971950383;19776.505587360287;19788.604227915504;20118.899405503023;20098.497537561532;20120.79879201204;20566;20566;21033.368998929902;15527;15577.766333505006;15632.296546655427;15696;15900.920495397564;3457.2566898117025;3500.212452198235;3541.008517615072;3546.4680297955256;3547.609762926076;119895;122169.38915305366;122301.99999999911;122850;128012;16825.663486730442;17134.57163570896;17166.05586692719;17202.741958870625;17253.223604937808;29972.85013574918;30130;30782.53826192609;31021.224469387995;31052.68947310543;8271.2142346477;8394.202550757669;8408;8415.116412776693;8422.957885210657;3878.26313000529;3919.2749341371937;3936.1340505088833;3940.763554186758;3944.8224829882724;5108.59131269505;5116.641835071584;5248.239005344204;5255.421903590602;5278.9208161877605;1007.9042490963493;1026.3892983674702;1043.4521876015;1047.0942634621151;1052;643.5334382572692;666.2072134160334;695.051255036871;698.5738699393366;708.8157079159456;11130.220884538005;12314;12436.440360183813;12654.81017784734;12944.075263197117;640.3884290502652;677.8983152527161;689.4208864553799;689.7930620813736;695.9443244540525;5804.88390232193;5956.344802071769;6212.502999760099;6232.968835155795;6351.650659213788;100452;105584.47207763912;108097.45951270193;109818;110617;86940.56529717437;89299;89544;91318.54340728254;92375.53812230896;71157;78638.60680696674;79090;80711.19288807154;81346;12212.633620991384;12488.12583119173;12520;12715.80926286088;12795.296258705861;33679.83160084184;34853.477197841545;35629.109272268404;35853;36569.45145822762;43114.78442607767;43722.34416483819;44040.55959440365;44310.33534496921;44905.101897961205;18097.457076287734;18432;18462.63074738471;18539.2584296632;18621.534461638566;20904.268350607657;20967.05648245802;21050.68423973611;21152.894235528725;21567.137314507872;18138.72791908096;18147.092645367415;18352.17415216292;18510.81489185091;18522.351717689817;15681.843181568038;15775.132367719885;15804.841951580796;15829.050256984618;15883.602909927344;18065.819341806415;18493.72259416083;18495.815041849408;18611.348602798837;18706.15822287973;12853.485860565472;13279.269640169883;13288.601341959757;13428.731425371634;13882.236476993863;13603.659908502366;13767.31163441844;13805;13933.300368111739;14087.506937257147 18:44:24 INFO - PID 16048 | __end_tp_report 18:44:24 INFO - PID 16048 | __start_cc_report 18:44:24 INFO - PID 16048 | _x_x_mozilla_cycle_collect,368 18:44:24 INFO - PID 16048 | __end_cc_report 18:44:24 INFO - PID 16048 | __startTimestamp1501292664053__endTimestamp 18:44:24 INFO - PID 16048 | 18:44:24 INFO - PID 16048 | ------- Summary: start ------- 18:44:24 INFO - PID 16048 | Number of tests: 6 18:44:24 INFO - PID 16048 | 18:44:24 INFO - PID 16048 | [#0] dojo.html Cycles:165 Average:6099.37 Median:6380.04 stddev:710.03 (11.1%) stddev-sans-first:672.83 18:44:24 INFO - PID 16048 | Values: 3127.2 3130.0 3151.2 3158.4 3202.6 6028.5 6086.5 6091.8 6120.2 6134.3 6115.8 6138.3 6143.6 6144.7 6162.0 5643.8 5654.5 5655.8 5683.6 5703.1 5600.2 5664.1 5682.9 5687.7 5740.3 5630.7 5672.1 5715.3 5732.1 5736.0 5550.6 5602.3 5618.6 5644.8 5764.7 5571.7 5611.8 5622.6 5657.5 5665.1 6093.4 6102.8 6139.7 6154.0 6179.9 6479.4 6595.7 6611.5 6653.1 6680.4 6657.4 6766.6 6768.8 6781.1 6782.0 6203.2 6222.7 6238.9 6249.1 6271.4 6829.7 6848.8 6861.7 6942.0 6946.8 6377.7 6500.1 6503.5 6506.9 6613.1 6503.2 6575.0 6578.9 6581.5 6590.6 6462.6 6503.1 6540.5 6551.5 6556.2 6514.5 6564.2 6578.5 6597.7 6616.6 5380.8 5385.9 5389.3 5389.9 5407.8 4620.0 4642.7 4698.0 4699.6 4721.7 5644.3 5648.1 5735.9 5736.5 5745.4 6512.3 6542.7 6560.3 6571.7 6648.3 5693.7 5715.4 5725.4 5743.6 5747.5 5818.3 5832.9 5852.4 5858.5 5933.0 6417.0 6430.6 6491.0 6523.6 6535.1 6553.1 6589.5 6590.5 6634.6 6696.7 6410.7 6411.0 6454.0 6456.2 6468.3 6407.4 6454.7 6474.7 6517.1 6545.2 6632.1 6714.8 6721.3 6725.5 6725.6 6420.3 6421.8 6510.0 6522.0 6531.3 6296.8 6394.0 6423.7 6428.3 6429.8 6370.8 6442.7 6443.3 6455.3 6455.6 6453.7 6535.7 6575.6 6577.6 6586.1 6233.1 6300.6 6351.0 6352.7 6380.0 18:44:24 INFO - PID 16048 | 18:44:24 INFO - PID 16048 | [#1] ext.html Cycles:180 Average:37719.23 Median:34715.65 stddev:54762.84 (157.7%) stddev-sans-first:54846.28 18:44:24 INFO - PID 16048 | Values: 796.4 848.7 859.5 884.7 888.7 39282.8 40145.4 40250.8 40271.8 40355.2 36800.6 36972.4 37006.3 37068.6 37206.4 6636.4 6702.8 6745.4 6754.1 6761.3 6697.0 6772.0 6779.7 6786.4 6787.2 6697.3 7480.8 7589.7 7664.8 7707.3 7588.8 7656.0 7657.5 7658.0 7659.5 7294.7 7300.7 7353.3 7360.0 7446.4 38202.8 38432.2 38486.4 38525.0 38526.4 3537.0 3596.9 3597.7 3610.4 3610.9 30281.5 30323.8 30388.0 30486.8 30777.0 4743.2 4749.7 4754.1 4787.4 4795.7 195088.0 195845.0 198568.0 203653.0 209564.0 49829.5 49939.5 49950.0 50222.0 50383.7 51436.2 51484.7 51513.7 51680.5 51691.2 16490.4 16522.5 16635.0 16698.4 16746.0 13426.7 13632.0 13646.3 13674.5 13709.7 14145.0 14257.5 14300.6 14305.1 14340.9 5767.6 5823.5 5828.5 5854.8 5891.4 977.7 993.2 1000.7 1019.5 1020.2 22306.3 22482.6 23310.0 27224.9 27934.7 1071.4 1085.8 1105.4 1117.1 1118.2 12075.3 12238.4 12239.5 12281.5 12503.4 227926.0 228916.0 229566.0 229709.0 229837.0 50918.5 51576.5 51640.7 51683.7 51716.0 1467.0 1469.3 1472.8 1486.9 1509.9 21686.0 21772.8 22407.6 22892.7 22925.0 36437.0 47578.0 50424.2 51186.5 51251.2 201299.0 201757.0 202099.0 202657.0 202883.0 29415.6 29755.3 30350.7 30497.2 33141.5 37662.2 43485.6 43648.3 43710.8 43913.0 28581.6 30338.8 30738.2 31047.8 31277.8 28003.3 29877.7 30234.0 30607.2 30785.0 34285.3 34574.1 34695.5 34735.8 34750.3 28272.9 29891.4 30127.4 30723.2 31054.8 22888.1 23123.3 23304.8 23342.4 23429.4 18:44:24 INFO - PID 16048 | 18:44:24 INFO - PID 16048 | [#2] jquery.html Cycles:180 Average:36027.42 Median:22967.26 stddev:87695.43 (381.8%) stddev-sans-first:87901.03 18:44:24 INFO - PID 16048 | Values: 570.2 572.2 578.7 582.3 588.6 21541.8 22507.1 22512.4 22544.7 22555.3 24020.3 25185.2 26321.5 26394.2 26486.5 6281.7 6478.1 6479.6 6486.4 6486.4 6307.5 6336.7 6337.1 6339.4 6341.2 6139.3 6422.7 6427.3 6427.6 6433.8 6281.4 6306.0 6311.2 6317.9 6330.2 5860.6 5875.3 5877.0 5882.3 5901.7 28565.9 29087.3 29157.7 29574.4 29916.1 1868.4 1931.3 1932.9 1934.8 1936.9 18037.3 18713.3 18852.2 18868.2 18896.3 2269.6 2322.8 2369.4 2375.2 2380.6 136005.3 139015.0 139214.0 139240.3 139632.3 13795.6 14657.9 14673.3 14834.6 15339.0 23128.5 23456.2 23552.9 23752.4 23883.8 10618.3 10627.0 10705.2 10816.8 10875.8 9894.9 9999.7 10003.8 10047.7 10080.3 8930.5 9486.4 9531.6 9602.9 9620.8 2620.7 2657.4 2708.8 2732.1 2836.2 926.7 928.7 949.7 977.6 983.9 19365.2 23680.3 24761.9 24893.9 25007.0 1006.2 1007.3 1033.9 1038.2 1043.2 11052.6 11275.3 11371.9 11415.3 11470.5 501238.0 517491.0 520740.0 528754.0 542866.0 117017.0 118891.0 119375.0 119883.4 120587.0 1267.5 1298.6 1301.1 1304.1 1306.9 17251.9 17710.1 18324.6 18336.6 18338.4 55708.4 56409.7 57482.7 57680.0 58451.0 72971.3 73701.0 73902.0 73954.0 74479.0 14240.0 14591.1 14660.7 14671.0 14754.9 22806.0 23150.4 23420.5 23484.6 23608.2 18235.6 18236.9 18493.9 18638.6 18708.4 15619.4 16016.9 16341.8 16534.6 16759.4 19905.6 19991.4 20006.8 20148.6 20194.8 14281.1 14865.6 15025.3 15113.0 15124.6 19002.8 19154.8 19171.7 19248.4 19318.7 18:44:24 INFO - PID 16048 | 18:44:24 INFO - PID 16048 | [#3] mootools.html Cycles:180 Average:8535.45 Median:2640.06 stddev:5896.18 (223.3%) stddev-sans-first:5887.67 18:44:24 INFO - PID 16048 | Values: 1302.2 1356.7 1363.8 1366.9 1388.0 13464.9 13925.1 14055.2 14102.8 14599.4 14252.1 14521.7 14523.6 14537.3 14541.6 2607.5 2725.1 2765.7 2771.3 2781.3 2629.6 2765.1 2771.1 2772.7 2775.0 2668.1 2679.6 2689.8 2693.7 2705.1 2598.7 2623.5 2637.9 2640.9 2646.9 2601.4 2637.1 2639.3 2649.7 2650.0 13665.5 13942.1 13945.7 13949.1 13956.6 7573.3 7842.3 7859.1 7888.4 7931.2 5124.9 5235.7 5263.2 5409.5 5411.2 1815.4 1830.1 1842.9 1874.1 1885.8 22107.2 22542.8 22846.3 22863.1 22896.2 6875.9 6968.5 7126.1 7206.8 7222.6 17944.4 18059.5 18129.8 18151.2 18164.5 7381.3 7440.1 7602.7 7605.7 7606.0 5929.9 6117.8 6954.7 7048.8 7062.1 5318.5 5406.5 5415.6 5512.3 5552.2 1663.1 1712.9 1715.8 1727.2 1728.4 814.8 818.6 831.9 846.8 860.4 6340.4 6591.9 6649.4 7309.4 7513.9 925.2 950.4 953.7 964.4 967.2 4340.7 4431.3 4481.1 4510.8 4675.2 18532.0 19105.4 19244.3 19311.2 19337.9 18277.3 18507.4 18509.6 18531.0 18545.2 9817.2 10458.2 10520.9 10605.9 10609.7 6375.0 6829.7 7125.3 7246.3 7311.4 14724.9 16212.9 16352.0 16478.2 16875.1 16011.8 16488.2 16670.6 16944.7 16979.3 10128.6 10413.9 10942.3 11205.6 11208.7 12018.3 13161.5 13191.7 13242.4 13251.9 9841.9 10165.5 10280.5 10347.2 10551.9 10103.4 10152.7 10231.4 10258.8 10307.9 8260.8 8429.7 8475.7 8514.9 8518.2 6061.9 6168.4 6373.6 6416.3 6475.0 5956.5 6176.9 6252.9 6297.9 6399.1 18:44:24 INFO - PID 16048 | 18:44:24 INFO - PID 16048 | [#4] prototype.html Cycles:180 Average:5436.77 Median:6032.14 stddev:1529.46 (25.4%) stddev-sans-first:1487.80 18:44:24 INFO - PID 16048 | Values: 479.3 501.9 511.4 517.3 530.7 6044.7 6160.7 6173.8 6205.9 6239.5 5744.6 5965.6 6026.4 6037.9 6049.3 4857.9 4887.0 4927.5 4933.6 4940.6 4757.6 4920.0 4946.2 4959.7 4973.5 4866.2 4876.2 4881.4 4898.0 4901.9 4873.1 4878.9 4903.6 4925.4 4927.7 4324.5 4358.0 4387.9 4417.3 4451.4 5902.8 5969.8 6004.6 6047.4 6081.8 5631.2 5668.5 5669.2 5696.0 5698.6 6331.1 6391.5 6400.0 6458.9 6495.2 4776.5 4812.6 4822.8 4827.5 4879.6 6665.5 6790.4 6816.9 6863.5 6889.7 4956.0 4956.7 4965.7 4970.8 5023.5 4932.6 4939.6 4982.6 4995.2 5053.4 5579.3 5612.6 5612.7 5624.9 5626.5 6354.8 6414.2 6462.2 6475.4 6622.6 1614.5 1673.9 1696.6 1718.9 1727.9 1157.7 1207.7 1210.2 1223.0 1226.1 5501.0 5559.0 5610.3 5615.5 5653.5 6499.9 6533.7 6554.0 6628.6 6672.0 5685.4 5709.8 5720.2 5725.8 5746.7 3494.8 3556.3 3572.4 3583.1 3583.2 6454.2 6498.6 6509.3 6511.6 6554.8 6785.0 6853.6 6874.0 6892.9 6907.2 6341.7 6342.9 6506.9 6524.4 6568.9 6583.7 6669.0 6669.2 6705.2 6754.7 6620.4 6631.6 6684.7 6689.0 6738.6 6450.3 6508.2 6525.0 6556.8 6572.4 4883.9 4939.4 4957.5 4980.0 4989.8 6466.8 6671.4 6679.2 6720.4 6738.0 6194.2 6288.7 6332.2 6361.0 6369.6 6299.6 6322.4 6366.0 6369.3 6511.4 6233.9 6250.9 6268.8 6383.7 6393.8 6338.8 6373.3 6471.8 6474.1 6530.7 6244.9 6254.2 6265.9 6288.2 6341.1 18:44:24 INFO - PID 16048 | 18:44:24 INFO - PID 16048 | [#5] yui.html Cycles:180 Average:22248.63 Median:19639.66 stddev:29816.34 (151.8%) stddev-sans-first:29856.76 18:44:24 INFO - PID 16048 | Values: 868.3 903.9 904.5 913.5 925.3 18382.9 19058.4 19104.1 19208.7 21703.2 20143.7 20651.3 21030.0 21047.4 21101.7 1021.5 1045.3 1061.2 1061.4 1062.0 1008.9 1034.5 1049.1 1052.4 1052.9 1109.9 1112.6 1112.8 1112.8 1112.9 1106.4 1108.2 1108.8 1109.2 1110.6 816.3 817.8 819.4 819.8 820.0 19191.3 19502.8 19776.5 19788.6 20118.9 20098.5 20120.8 20566.0 20566.0 21033.4 15527.0 15577.8 15632.3 15696.0 15900.9 3457.3 3500.2 3541.0 3546.5 3547.6 119895.0 122169.4 122302.0 122850.0 128012.0 16825.7 17134.6 17166.1 17202.7 17253.2 29972.9 30130.0 30782.5 31021.2 31052.7 8271.2 8394.2 8408.0 8415.1 8423.0 3878.3 3919.3 3936.1 3940.8 3944.8 5108.6 5116.6 5248.2 5255.4 5278.9 1007.9 1026.4 1043.5 1047.1 1052.0 643.5 666.2 695.1 698.6 708.8 11130.2 12314.0 12436.4 12654.8 12944.1 640.4 677.9 689.4 689.8 695.9 5804.9 5956.3 6212.5 6233.0 6351.7 100452.0 105584.5 108097.5 109818.0 110617.0 86940.6 89299.0 89544.0 91318.5 92375.5 71157.0 78638.6 79090.0 80711.2 81346.0 12212.6 12488.1 12520.0 12715.8 12795.3 33679.8 34853.5 35629.1 35853.0 36569.5 43114.8 43722.3 44040.6 44310.3 44905.1 18097.5 18432.0 18462.6 18539.3 18621.5 20904.3 20967.1 21050.7 21152.9 21567.1 18138.7 18147.1 18352.2 18510.8 18522.4 15681.8 15775.1 15804.8 15829.1 15883.6 18065.8 18493.7 18495.8 18611.3 18706.2 12853.5 13279.3 13288.6 13428.7 13882.2 13603.7 13767.3 13805.0 13933.3 14087.5 18:44:24 INFO - PID 16048 | -------- Summary: end -------- 18:44:24 INFO - PID 16048 | 18:44:24 INFO - TEST-INFO | 16048: exit 0 18:44:24 INFO - TEST-OK | dromaeo_css | took 1114141ms 18:44:24 INFO - TEST-START | kraken 18:44:24 INFO - Initialising browser for kraken test... 18:44:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44469/getInfo.html -profile /tmp/tmpCXtTFI/profile 18:44:24 INFO - TEST-INFO | started process 16419 (/builds/slave/test/build/application/firefox/firefox http://localhost:44469/getInfo.html) 18:44:30 INFO - TEST-INFO | 16419: exit 0 18:44:30 INFO - Browser initialized. 18:44:30 INFO - Running cycle 1/1 for kraken test... 18:44:30 INFO - TEST-INFO | started process 16646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCXtTFI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:44:31 INFO - PID 16646 | 18:44:31 INFO - PID 16646 | (/builds/slave/test/build/application/firefox/firefox:16700): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:44:31 INFO - PID 16646 | 18:44:42 INFO - PID 16646 | RSS: Main: 173490176 18:44:42 INFO - PID 16646 | 18:44:45 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44469/tests/kraken/driver.html?testName=audio-beat-detection) 18:44:45 INFO - PID 16646 | RSS: Main: 178835456 18:44:45 INFO - PID 16646 | 18:44:48 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44469/tests/kraken/driver.html?testName=audio-dft) 18:44:49 INFO - PID 16646 | RSS: Main: 178929664 18:44:49 INFO - PID 16646 | 18:44:52 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44469/tests/kraken/driver.html?testName=audio-fft) 18:44:53 INFO - PID 16646 | RSS: Main: 173862912 18:44:53 INFO - PID 16646 | 18:44:55 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44469/tests/kraken/driver.html?testName=audio-oscillator) 18:44:55 INFO - PID 16646 | RSS: Main: 174301184 18:44:55 INFO - PID 16646 | 18:44:58 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44469/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:44:58 INFO - PID 16646 | RSS: Main: 174579712 18:44:58 INFO - PID 16646 | 18:45:01 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44469/tests/kraken/driver.html?testName=imaging-darkroom) 18:45:02 INFO - PID 16646 | RSS: Main: 177360896 18:45:02 INFO - PID 16646 | 18:45:06 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44469/tests/kraken/driver.html?testName=imaging-desaturate) 18:45:06 INFO - PID 16646 | RSS: Main: 176984064 18:45:06 INFO - PID 16646 | 18:45:09 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44469/tests/kraken/driver.html?testName=json-parse-financial) 18:45:10 INFO - PID 16646 | RSS: Main: 177405952 18:45:10 INFO - PID 16646 | 18:45:11 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44469/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:45:12 INFO - PID 16646 | RSS: Main: 177348608 18:45:12 INFO - PID 16646 | 18:45:14 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44469/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:45:15 INFO - PID 16646 | RSS: Main: 174354432 18:45:15 INFO - PID 16646 | 18:45:17 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44469/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:45:18 INFO - PID 16646 | RSS: Main: 174714880 18:45:18 INFO - PID 16646 | 18:45:20 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44469/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:45:21 INFO - PID 16646 | RSS: Main: 175095808 18:45:21 INFO - PID 16646 | 18:45:24 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44469/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:45:25 INFO - PID 16646 | RSS: Main: 174977024 18:45:25 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | Cycle 1(1): loaded http://localhost:44469/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44469/tests/kraken/driver.html?testName=ai-astar) 18:45:27 INFO - PID 16646 | RSS: Main: 176824320 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | __start_tp_report 18:45:27 INFO - PID 16646 | _x_x_mozilla_page_load 18:45:27 INFO - PID 16646 | _x_x_mozilla_page_load_details 18:45:27 INFO - PID 16646 | |i|pagename|runs| 18:45:27 INFO - PID 16646 | |0;ai-astar;99;110;110;108;109;110;111;100;114;113 18:45:27 INFO - PID 16646 | |1;audio-beat-detection;144;118;144;178;125;148;150;122;192;121 18:45:27 INFO - PID 16646 | |2;audio-dft;168;162;163;163;164;165;169;171;168;163 18:45:27 INFO - PID 16646 | |3;audio-fft;76;75;75;169;83;77;78;76;163;77 18:45:27 INFO - PID 16646 | |4;audio-oscillator;79;79;142;90;80;82;127;79;79;125 18:45:27 INFO - PID 16646 | |5;imaging-gaussian-blur;114;115;114;113;119;115;117;114;114;114 18:45:27 INFO - PID 16646 | |6;imaging-darkroom;150;150;151;151;151;151;153;150;156;153 18:45:27 INFO - PID 16646 | |7;imaging-desaturate;99;94;95;94;94;94;95;94;94;95 18:45:27 INFO - PID 16646 | |8;json-parse-financial;66;56;56;66;59;56;57;58;56;56 18:45:27 INFO - PID 16646 | |9;json-stringify-tinderbox;54;57;54;53;54;59;59;55;63;54 18:45:27 INFO - PID 16646 | |10;stanford-crypto-aes;80;82;82;81;80;81;80;89;84;81 18:45:27 INFO - PID 16646 | |11;stanford-crypto-ccm;129;128;128;134;129;138;136;129;127;172 18:45:27 INFO - PID 16646 | |12;stanford-crypto-pbkdf2;193;184;181;187;194;180;180;182;191;184 18:45:27 INFO - PID 16646 | |13;stanford-crypto-sha256-iterative;71;70;70;72;70;72;69;72;68;67 18:45:27 INFO - PID 16646 | __end_tp_report 18:45:27 INFO - PID 16646 | __start_cc_report 18:45:27 INFO - PID 16646 | _x_x_mozilla_cycle_collect,932 18:45:27 INFO - PID 16646 | __end_cc_report 18:45:27 INFO - PID 16646 | __startTimestamp1501292727491__endTimestamp 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | ------- Summary: start ------- 18:45:27 INFO - PID 16646 | Number of tests: 14 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.50 stddev:5.02 (4.5%) stddev-sans-first:4.00 18:45:27 INFO - PID 16646 | Values: 99.0 110.0 110.0 108.0 109.0 110.0 111.0 100.0 114.0 113.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:146.00 stddev:24.86 (17.0%) stddev-sans-first:26.37 18:45:27 INFO - PID 16646 | Values: 144.0 118.0 144.0 178.0 125.0 148.0 150.0 122.0 192.0 121.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#2] audio-dft Cycles:10 Average:165.60 Median:166.50 stddev:3.13 (1.9%) stddev-sans-first:3.20 18:45:27 INFO - PID 16646 | Values: 168.0 162.0 163.0 163.0 164.0 165.0 169.0 171.0 168.0 163.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.50 stddev:37.57 (49.1%) stddev-sans-first:39.22 18:45:27 INFO - PID 16646 | Values: 76.0 75.0 75.0 169.0 83.0 77.0 78.0 76.0 163.0 77.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:79.00 stddev:24.86 (31.5%) stddev-sans-first:25.58 18:45:27 INFO - PID 16646 | Values: 79.0 79.0 142.0 90.0 80.0 82.0 127.0 79.0 79.0 125.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.50 stddev:1.79 (1.6%) stddev-sans-first:1.87 18:45:27 INFO - PID 16646 | Values: 114.0 115.0 114.0 113.0 119.0 115.0 117.0 114.0 114.0 114.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.00 stddev:1.90 (1.3%) stddev-sans-first:1.92 18:45:27 INFO - PID 16646 | Values: 150.0 150.0 151.0 151.0 151.0 151.0 153.0 150.0 156.0 153.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.55 (1.6%) stddev-sans-first:0.50 18:45:27 INFO - PID 16646 | Values: 99.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.50 stddev:4.03 (7.0%) stddev-sans-first:3.27 18:45:27 INFO - PID 16646 | Values: 66.0 56.0 56.0 66.0 59.0 56.0 57.0 58.0 56.0 56.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:3.22 (5.8%) stddev-sans-first:3.32 18:45:27 INFO - PID 16646 | Values: 54.0 57.0 54.0 53.0 54.0 59.0 59.0 55.0 63.0 54.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:2.75 (3.4%) stddev-sans-first:2.82 18:45:27 INFO - PID 16646 | Values: 80.0 82.0 82.0 81.0 80.0 81.0 80.0 89.0 84.0 81.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:131.50 stddev:13.54 (10.3%) stddev-sans-first:14.19 18:45:27 INFO - PID 16646 | Values: 129.0 128.0 128.0 134.0 129.0 138.0 136.0 129.0 127.0 172.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.60 Median:185.50 stddev:5.36 (2.9%) stddev-sans-first:4.97 18:45:27 INFO - PID 16646 | Values: 193.0 184.0 181.0 187.0 194.0 180.0 180.0 182.0 191.0 184.0 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.73 (2.5%) stddev-sans-first:1.80 18:45:27 INFO - PID 16646 | Values: 71.0 70.0 70.0 72.0 70.0 72.0 69.0 72.0 68.0 67.0 18:45:27 INFO - PID 16646 | -------- Summary: end -------- 18:45:27 INFO - PID 16646 | 18:45:27 INFO - PID 16646 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:45:28 INFO - TEST-INFO | 16646: exit 0 18:45:28 INFO - TEST-OK | kraken | took 63472ms 18:45:28 INFO - SUITE-END | took 1177s 18:45:28 INFO - Completed test suite (00:19:37) 18:45:28 INFO - javascript benchmark 18:45:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8380.100988758619, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3127.2025633463477, 3130.012442099267, 3151.2121969507625, 3158.384115097554, 3202.647708752037, 6028.487578555822, 6086.5435092368025, 6091.751191005844, 6120.2043734314475, 6134.294556126047, 6115.785947491839, 6138.263408390988, 6143.631382117065, 6144.662043587601, 6162.0, 5643.774249030034, 5654.519365853907, 5655.802046928358, 5683.573731970118, 5703.0589952657765, 5600.2159697642155, 5664.065429204176, 5682.914756278659, 5687.744051517691, 5740.282464691913, 5630.662160270376, 5672.120821272689, 5715.257016587838, 5732.0542110551705, 5736.0, 5550.58370622205, 5602.299712535933, 5618.606697531174, 5644.78637093027, 5764.682942438164, 5571.665700057969, 5611.803586874481, 5622.634528755618, 5657.519110875581, 5665.121906104519, 6093.421124993119, 6102.755889764404, 6139.723712432951, 6154.0, 6179.907301390483, 6479.416852483299, 6595.70319335631, 6611.537192396534, 6653.135092438, 6680.3987641112535, 6657.434118099919, 6766.560173588701, 6768.76309329176, 6781.050652908597, 6782.0, 6203.2245969253845, 6222.657753823538, 6238.937610623926, 6249.125122482856, 6271.3728627136925, 6829.692663830139, 6848.760293389807, 6861.656917154222, 6942.028116063755, 6946.756863509753, 6377.681115944277, 6500.089987401768, 6503.544751867418, 6506.869862602722, 6613.074169616258, 6503.154589903377, 6575.046618240328, 6578.868422631521, 6581.539292249592, 6590.637514936724, 6462.612243265419, 6503.089567460559, 6540.476761859135, 6551.475881929434, 6556.18047744032, 6514.478841692653, 6564.245111812203, 6578.5395022347975, 6597.736090556324, 6616.636085015274, 5380.784768609212, 5385.892282154335, 5389.299391079213, 5389.865253368697, 5407.810726624628, 4620.0, 4642.675012749075, 4698.036902434993, 4699.577038066591, 4721.6694831362165, 5644.32268127819, 5648.124540696199, 5735.8566035849435, 5736.541076713853, 5745.368009518949, 6512.348765123545, 6542.738290468328, 6560.278369379364, 6571.704273307617, 6648.268690444047, 5693.658380497183, 5715.371309155989, 5725.370209276976, 5743.569232307594, 5747.453991870849, 5818.330891947396, 5832.854178645568, 5852.414758524199, 5858.531317494675, 5933.0, 6416.967915160394, 6430.582012169194, 6491.0, 6523.608583485006, 6535.052417399355, 6553.148090748172, 6589.505787065893, 6590.47276217911, 6634.601923884582, 6696.698648560924, 6410.743570257137, 6410.967945160244, 6454.031895215755, 6456.225252969673, 6468.320826313357, 6407.359264073555, 6454.741810327534, 6474.676266186578, 6517.055027021151, 6545.181852268466, 6632.137822083098, 6714.798556043326, 6721.260661327152, 6725.461963042847, 6725.562838415487, 6420.325865784025, 6421.839454013687, 6510.0, 6521.9673901630185, 6531.346865313621, 6296.842578935563, 6394.038730345079, 6423.743050277936, 6428.260750013621, 6429.807105786834, 6370.8088757337355, 6442.710078046405, 6443.291237963726, 6455.289918109098, 6455.580387274812, 6453.677316134268, 6535.705893234721, 6575.605463672195, 6577.6053436793945, 6586.1438013058, 6233.065040244, 6300.590461620163, 6350.968245158745, 6352.6506042166275, 6380.042993551005], "value": 6046.8999417141795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.3549524884844, 848.7411339541437, 859.5186695450548, 884.6594061286403, 888.6756333938113, 39282.80358598207, 40145.3978190327, 40250.798746006265, 40271.798641006826, 40355.192896142056, 36800.63199368006, 36972.445413318754, 37006.259874802556, 37068.62931370686, 37206.44190337147, 6636.435902948243, 6702.7654032108885, 6745.392914637681, 6754.088198093244, 6761.2900645432255, 6697.0, 6772.0, 6779.72881084756, 6786.423154031913, 6787.219469760991, 6697.2967838377, 7480.812979675497, 7589.658465369044, 7664.808379790494, 7707.267809558111, 7588.848223035536, 7655.961720191392, 7657.46397752152, 7658.0, 7659.540427574363, 7294.671739771723, 7300.671469783872, 7353.338199562012, 7360.043194384749, 7446.441516886201, 38202.80898595489, 38432.23135537301, 38486.42270365947, 38525.0, 38526.42210366847, 3537.0449978505917, 3596.9280614387567, 3597.6762091411897, 3610.4403817408343, 3610.9097272568397, 30281.545776813364, 30323.848380758176, 30388.0, 30486.84756576225, 30777.0, 4743.169945259566, 4749.667523273372, 4754.120487709784, 4787.40157480315, 4795.688280261772, 195088.0, 195845.0, 198568.0, 203653.0, 209564.0, 49829.50170498249, 49939.50060499348, 49950.0, 50222.0, 50383.74808125936, 51436.22845657318, 51484.74257628763, 51513.7424312876, 51680.483195168315, 51691.22463163055, 16490.42283520095, 16522.50432487027, 16635.0, 16698.415555455744, 16746.0, 13426.731465370638, 13632.0, 13646.317684115755, 13674.453021879212, 13709.725805484033, 14145.0, 14257.50098746539, 14300.642483937985, 14305.140331757013, 14340.856591434162, 5767.567432442584, 5823.475887170175, 5828.504577110993, 5854.795082172103, 5891.3814049525035, 977.7213494154274, 993.2302465589227, 1000.7147962830559, 1019.5208252121491, 1020.1991436722137, 22306.330810075724, 22482.55034899293, 23310.0, 27224.863875680494, 27934.720652793618, 1071.4374953149659, 1085.8045551800594, 1105.4196546812987, 1117.0951529261324, 1118.2284223885492, 12075.335856527976, 12238.388080595934, 12239.510419583296, 12281.508739650313, 12503.437345319482, 227926.0, 228916.0, 229566.0, 229709.0, 229837.0, 50918.49081509212, 51576.48423515792, 51640.74179629078, 51683.741581292605, 51716.0, 1466.9853301467062, 1469.2727100085526, 1472.7790831375164, 1486.9330880110422, 1509.9018563793538, 21686.0, 21772.774889806566, 22407.551848963256, 22892.656610150527, 22925.0, 36437.0, 47578.0, 50424.24363634475, 51186.48813511966, 51251.23123153081, 201299.0, 201757.0, 202099.0, 202657.0, 202883.0, 29415.558766618946, 29755.256118597208, 30350.696493034786, 30497.237569060064, 33141.502877456376, 37662.246755064196, 43485.56514434942, 43648.34527482027, 43710.781446092566, 43913.0, 28581.571276430455, 30338.84830575833, 30738.231544211572, 31047.84476077605, 31277.84361078271, 28003.299917501412, 29877.701222988362, 30234.0, 30607.234819128807, 30785.0, 34285.31429371348, 34574.13564660904, 34695.47956780701, 34735.82632086823, 34750.304993900485, 28272.85863570669, 29891.402171956004, 30127.397452050398, 30723.2319192022, 31054.844725776227, 22888.084476621414, 23123.306300811004, 23304.76695233026, 23342.416439589146, 23429.41426464352], "value": 16922.590571896333, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.2444261353708, 572.2132068405942, 578.6672663218648, 582.3332284534208, 588.5556404914289, 21541.784582154192, 22507.099716011362, 22512.437189070282, 22544.66183007252, 22555.323340299776, 24020.279391618278, 25185.244442666703, 26321.473570528626, 26394.20817375477, 26486.543240121784, 6281.685915704231, 6478.125453063847, 6479.611223326616, 6486.4162225399705, 6486.4162225399705, 6307.526935479835, 6336.714847831836, 6337.081123237128, 6339.429451349378, 6341.1756471658855, 6139.324674285825, 6422.678866056678, 6427.260865000515, 6427.614343139427, 6433.774817881375, 6281.43467087962, 6305.96847015762, 6311.179546658928, 6317.87364252717, 6330.208723909512, 5860.589758716891, 5875.294964604275, 5877.0, 5882.323532793698, 5901.73442195098, 28565.857170714222, 29087.272818179503, 29157.70842291571, 29574.408511829857, 29916.10251692431, 1868.3834334669527, 1931.3433432632971, 1932.8550358723012, 1934.845212383006, 1936.9225230990744, 18037.27850885963, 18713.251469941188, 18852.15165317564, 18868.15093320804, 18896.338628148085, 2269.5574362999223, 2322.826972378955, 2369.419492224416, 2375.180562705864, 2380.6310021946624, 136005.3199734005, 139015.0, 139214.0, 139240.3037984814, 139632.30183849117, 13795.551112221945, 14657.92671036638, 14673.266336683337, 14834.554963351116, 15339.0, 23128.537429251322, 23456.179033733737, 23552.882235588713, 23752.406189845045, 23883.761162388502, 10618.256722029384, 10627.0, 10705.197110216764, 10816.783664326827, 10875.83686244707, 9894.901050989398, 9999.700008999742, 10003.849942250872, 10047.748806279755, 10080.29437939352, 8930.464172149692, 9486.430814151174, 9531.568635291289, 9602.90397096034, 9620.75948101303, 2620.685517737884, 2657.4419371931726, 2708.7697545708834, 2732.1257197696546, 2836.187279978906, 926.6849271247808, 928.7028150991753, 949.6866034208695, 977.5942983661843, 983.9458829764288, 19365.225390984484, 23680.28959131229, 24761.876190618932, 24893.875530622594, 25007.0, 1006.1938819818444, 1007.3452256033637, 1033.8862725100232, 1038.1642777563982, 1043.186314674555, 11052.613158539574, 11275.32348059119, 11371.943140284411, 11415.315081095161, 11470.48382822775, 501238.0, 517491.0, 520740.0, 528754.0, 542866.0, 117017.0, 118891.0, 119375.0, 119883.40058299828, 120587.0, 1267.499337761579, 1298.5909438526835, 1301.1477482248952, 1304.0936549098476, 1306.8693130686854, 17251.91374043172, 17710.114494274978, 18324.633507329512, 18336.633267334313, 18338.358157464423, 55708.44291557195, 56409.71795140998, 57482.7125864368, 57680.0, 58451.0, 72971.27028729644, 73701.0, 73902.0, 73954.0, 74479.0, 14240.003199775916, 14591.124532527658, 14660.706785864437, 14671.0, 14754.852451475348, 22805.97373118247, 23150.42123946915, 23420.531589368456, 23484.6477302844, 23608.17371391993, 18235.635287294444, 18236.908815455838, 18493.90753046226, 18638.627227455105, 18708.438746837615, 15619.375224990874, 16016.919915400349, 16341.836581634507, 16534.59455946258, 16759.41342053022, 19905.60188796245, 19991.40025799228, 20006.799932000493, 20148.59702805965, 20194.79805201988, 14281.14313141215, 14865.554033379016, 15025.323860426088, 15113.0, 15124.621884452978, 19002.809971900657, 19154.8084519153, 19171.712424313366, 19248.422547323604, 19318.71021934644], "value": 12103.59774752512, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.225176020268, 1356.7354365898648, 1363.8090667306572, 1366.9111507751988, 1387.9791803122955, 13464.932675336622, 13925.094868833532, 14055.226962517057, 14102.788458173123, 14599.41602335908, 14252.073615215004, 14521.709565808678, 14523.636909077279, 14537.273136343194, 14541.563753087425, 2607.4915391498666, 2725.127959053109, 2765.7234276572385, 2771.3348796288847, 2781.3185769486504, 2629.5661215899354, 2765.1013420638274, 2771.0993926973715, 2772.7365900239447, 2774.9861250693716, 2668.052841241351, 2679.5578729509607, 2689.7713694336003, 2693.6902256240587, 2705.147878418302, 2598.740125987386, 2623.488419758138, 2637.934051648705, 2640.8679566021624, 2646.9205923822315, 2601.414681696622, 2637.0638423359624, 2639.261006918066, 2649.668791401075, 2650.0, 13665.453381864714, 13942.093763905314, 13945.721085578332, 13949.093308934887, 13956.581302560939, 7573.31840134385, 7842.254985776342, 7859.096203936506, 7888.447808653396, 7931.246531579491, 5124.948750512522, 5235.685858848481, 5263.184206448007, 5409.459054094598, 5411.242426060355, 1815.4402292767136, 1830.103249407794, 1842.9170687319104, 1874.08169996702, 1885.8302752752181, 22107.226247081435, 22542.77457225423, 22846.31461056171, 22863.085476580916, 22896.198633047763, 6875.896861547081, 6968.512204145661, 7126.073610430611, 7206.819829504304, 7222.638868056576, 17944.371946982053, 18059.54851128706, 18129.818701813077, 18151.183196756177, 18164.545886352684, 7381.335679788845, 7440.10718713747, 7602.7339043133225, 7605.6957721691615, 7606.0, 5929.940700592939, 6117.84705382369, 6954.652267386711, 7048.823779405556, 7062.081929349151, 5318.547923426475, 5406.459354064562, 5415.566754659618, 5512.283403157564, 5552.194931734876, 1663.1102360237458, 1712.9314827407013, 1715.7941047074182, 1727.2313820349823, 1728.4296182259825, 814.8288859339486, 818.6029775558849, 831.9376046796515, 846.7840700621302, 860.3762272352494, 6340.397662222082, 6591.868162636721, 6649.4347980421235, 7309.415246780245, 7513.887291690629, 925.1997022575558, 950.3870003847618, 953.7472569769017, 964.4117088575963, 967.1778987860403, 4340.65274778017, 4431.290993441098, 4481.148581769454, 4510.774461276923, 4675.158471475167, 18532.0, 19105.426837194907, 19244.326448574513, 19311.22755089809, 19337.903310483358, 18277.26890924348, 18507.35224267144, 18509.629807404046, 18531.0, 18545.165467553994, 9817.214622830157, 10458.163346932228, 10520.947395262974, 10605.89394106049, 10609.681709548726, 6375.0, 6829.726810927507, 7125.251848555827, 7246.347828695442, 7311.4150867929375, 14724.926375368055, 16212.918935405247, 16352.0, 16478.176091195153, 16875.07187104721, 16011.839881601501, 16488.17559122015, 16670.58323541921, 16944.74582881233, 16979.320827166775, 10128.59485620567, 10413.9479302603, 10942.343459392461, 11205.551777928791, 11208.66374008781, 12018.278903265833, 13161.473541058633, 13191.736165276832, 13242.404091816084, 13251.867481325064, 9841.863431461887, 10165.491725413847, 10280.537375817956, 10347.223958203014, 10551.94724026375, 10103.393796372242, 10152.695419137437, 10231.386116833013, 10258.794824103625, 10307.94846025765, 8260.793480163044, 8429.747107586782, 8475.660973560989, 8514.914850851412, 8518.233358997471, 6061.909071363845, 6168.352814065381, 6373.553851230369, 6416.262129855127, 6474.967625162032, 5956.523478121827, 6176.8764624706355, 6252.937470625236, 6297.874042519215, 6399.072134540373], "value": 6249.873804334884, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.30261469561793, 501.9447860735319, 511.39144418142433, 517.2629003669771, 530.7266757619826, 6044.727987240573, 6160.691965401735, 6173.845653858656, 6205.8758824823535, 6239.532035097369, 5744.626599271044, 5965.642061476315, 6026.397360263972, 6037.879242415149, 6049.274087109542, 4857.927131093036, 4886.9511304886855, 4927.536231884058, 4933.5939257311675, 4940.580050695695, 4757.571818536331, 4919.950800491985, 4946.208606622941, 4959.6528243023, 4973.477784832577, 4866.172750632401, 4876.171050921352, 4881.414230292352, 4898.0, 4901.926471102936, 4873.098476781806, 4878.902421951559, 4903.632227582945, 4925.433575138869, 4927.679700819435, 4324.545922678105, 4357.956420435787, 4387.934180987288, 4417.293233082723, 4451.354553589744, 5902.793402230945, 5969.761209551612, 6004.639721616717, 6047.425494578008, 6081.756729730805, 5631.183478395651, 5668.489835914787, 5669.206311116447, 5695.971520142414, 5698.601097923147, 6331.081993111019, 6391.488680905516, 6400.0, 6458.90311645321, 6495.220573531159, 4776.47458779534, 4812.639052071108, 4822.782974766109, 4827.54138356859, 4879.634027447955, 6665.533412661116, 6790.388865002174, 6816.920839144109, 6863.519553631248, 6889.689963951634, 4955.950440495621, 4956.702597844141, 4965.726885021286, 4970.801167953241, 5023.547880690755, 4932.556069953722, 4939.629527785431, 4982.576480999083, 4995.225740010304, 5053.36832895888, 5579.302587176603, 5612.579056570774, 5612.747426365741, 5624.875024995017, 5626.521745651584, 6354.824357493879, 6414.166158399378, 6462.159919210472, 6475.352464753487, 6622.569532980341, 1614.5398561410177, 1673.8660907127644, 1696.6097797506643, 1718.8796784225235, 1727.8768800279918, 1157.7279339355246, 1207.6799648093263, 1210.2194084815244, 1223.0399136677665, 1226.0865655087018, 5500.964643082085, 5558.972205138948, 5610.288861897079, 5615.466530679579, 5653.462921022497, 6499.902501462482, 6533.738650454024, 6554.0, 6628.635425051572, 6672.0, 5685.403032681509, 5709.8287051388525, 5720.226729713802, 5725.799597014167, 5746.712664366765, 3494.807785571818, 3556.270964452333, 3572.392693242155, 3583.122135076923, 3583.2475180212446, 6454.19322584677, 6498.6425746583445, 6509.316521765147, 6511.641859697762, 6554.770583029571, 6784.966075169593, 6853.554518956252, 6874.0, 6892.931070689329, 6907.20567134786, 6341.746330146835, 6342.904856427157, 6506.934930650727, 6524.380183882618, 6568.934310656832, 6583.736650533925, 6668.966655166693, 6669.233038200669, 6705.22889867652, 6754.696038678369, 6620.437262832713, 6631.602103873783, 6684.6991885364305, 6688.966555167193, 6738.59568425896, 6450.258430223719, 6508.17771024114, 6525.0, 6556.8360790978695, 6572.4084832365315, 4883.853484395474, 4939.407271127488, 4957.529034741694, 4979.975100124476, 4989.750512474289, 6466.838329041811, 6671.432928201158, 6679.165104361955, 6720.428763555153, 6737.966310168418, 6194.194754681863, 6288.6855657217875, 6332.176817013758, 6360.968195158995, 6369.585976911486, 6299.559030867796, 6322.399372059647, 6365.9681701593045, 6369.267534233622, 6511.38141876521, 6233.937660623335, 6250.906236406367, 6268.843278918063, 6383.744650213939, 6393.840153996187, 6338.809835704937, 6373.298937117006, 6471.838204044749, 6474.125992990886, 6530.7387704493185, 6244.906326405198, 6254.155688981929, 6265.906011409741, 6288.151099601495, 6341.143945567289], "value": 4985.802690285153, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [868.3357231717737, 903.9231665308448, 904.457325604637, 913.5021413329735, 925.3152667026401, 18382.90808545957, 19058.428247152573, 19104.1403136859, 19208.71186932197, 21703.240386586473, 20143.697844532344, 20651.277205297818, 21030.0, 21047.368578942616, 21101.683474747853, 1021.5096753558278, 1045.3309881675734, 1061.2253055269657, 1061.4374381577777, 1061.9946900265527, 1008.9115530851141, 1034.4930983817912, 1049.0558497352367, 1052.4264275969576, 1052.8999745024248, 1109.9056580190693, 1112.6105862947984, 1112.7718817642365, 1112.8497652816848, 1112.9109671226322, 1106.446776611694, 1108.152263518409, 1108.8225883858624, 1109.1792073865363, 1110.572429614596, 816.3102178659024, 817.7546735979182, 819.4345901328064, 819.7868554175898, 820.0364571628372, 19191.32830350945, 19502.804971950383, 19776.505587360287, 19788.604227915504, 20118.899405503023, 20098.497537561532, 20120.79879201204, 20566.0, 20566.0, 21033.368998929902, 15527.0, 15577.766333505006, 15632.296546655427, 15696.0, 15900.920495397564, 3457.2566898117025, 3500.212452198235, 3541.008517615072, 3546.4680297955256, 3547.609762926076, 119895.0, 122169.38915305366, 122301.99999999911, 122850.0, 128012.0, 16825.663486730442, 17134.57163570896, 17166.05586692719, 17202.741958870625, 17253.223604937808, 29972.85013574918, 30130.0, 30782.53826192609, 31021.224469387995, 31052.68947310543, 8271.2142346477, 8394.202550757669, 8408.0, 8415.116412776693, 8422.957885210657, 3878.26313000529, 3919.2749341371937, 3936.1340505088833, 3940.763554186758, 3944.8224829882724, 5108.59131269505, 5116.641835071584, 5248.239005344204, 5255.421903590602, 5278.9208161877605, 1007.9042490963493, 1026.3892983674702, 1043.4521876015, 1047.0942634621151, 1052.0, 643.5334382572692, 666.2072134160334, 695.051255036871, 698.5738699393366, 708.8157079159456, 11130.220884538005, 12314.0, 12436.440360183813, 12654.81017784734, 12944.075263197117, 640.3884290502652, 677.8983152527161, 689.4208864553799, 689.7930620813736, 695.9443244540525, 5804.88390232193, 5956.344802071769, 6212.502999760099, 6232.968835155795, 6351.650659213788, 100452.0, 105584.47207763912, 108097.45951270193, 109818.0, 110617.0, 86940.56529717437, 89299.0, 89544.0, 91318.54340728254, 92375.53812230896, 71157.0, 78638.60680696674, 79090.0, 80711.19288807154, 81346.0, 12212.633620991384, 12488.12583119173, 12520.0, 12715.80926286088, 12795.296258705861, 33679.83160084184, 34853.477197841545, 35629.109272268404, 35853.0, 36569.45145822762, 43114.78442607767, 43722.34416483819, 44040.55959440365, 44310.33534496921, 44905.101897961205, 18097.457076287734, 18432.0, 18462.63074738471, 18539.2584296632, 18621.534461638566, 20904.268350607657, 20967.05648245802, 21050.68423973611, 21152.894235528725, 21567.137314507872, 18138.72791908096, 18147.092645367415, 18352.17415216292, 18510.81489185091, 18522.351717689817, 15681.843181568038, 15775.132367719885, 15804.841951580796, 15829.050256984618, 15883.602909927344, 18065.819341806415, 18493.72259416083, 18495.815041849408, 18611.348602798837, 18706.15822287973, 12853.485860565472, 13279.269640169883, 13288.601341959757, 13428.731425371634, 13882.236476993863, 13603.659908502366, 13767.31163441844, 13805.0, 13933.300368111739, 14087.506937257147], "value": 8973.20646495589, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 110.0, 108.0, 109.0, 110.0, 111.0, 100.0, 114.0, 113.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 144.0, 178.0, 125.0, 148.0, 150.0, 122.0, 192.0, 121.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 162.0, 163.0, 163.0, 164.0, 165.0, 169.0, 171.0, 168.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 169.0, 83.0, 77.0, 78.0, 76.0, 163.0, 77.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 142.0, 90.0, 80.0, 82.0, 127.0, 79.0, 79.0, 125.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 113.0, 119.0, 115.0, 117.0, 114.0, 114.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 151.0, 151.0, 151.0, 153.0, 150.0, 156.0, 153.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 56.0, 56.0, 66.0, 59.0, 56.0, 57.0, 58.0, 56.0, 56.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 54.0, 53.0, 54.0, 59.0, 59.0, 55.0, 63.0, 54.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 82.0, 81.0, 80.0, 81.0, 80.0, 89.0, 84.0, 81.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 128.0, 134.0, 129.0, 138.0, 136.0, 129.0, 127.0, 172.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 184.0, 181.0, 187.0, 194.0, 180.0, 180.0, 182.0, 191.0, 184.0], "value": 185.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 72.0, 70.0, 72.0, 69.0, 72.0, 68.0, 67.0], "value": 70.1, "unit": "score"}]}]} 18:45:28 INFO - Return code: 0 18:45:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:45:28 INFO - # TBPL SUCCESS # 18:45:28 INFO - Running post-action listener: _package_coverage_data 18:45:28 INFO - Running post-action listener: _resource_record_post_action 18:45:28 INFO - [mozharness: 2017-07-29 01:45:28.784970Z] Finished run-tests step (success) 18:45:28 INFO - Running post-run listener: _resource_record_post_run 18:45:28 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 352256; Write bytes: 444329984; Read time: 356; Write time: 472560 18:45:28 INFO - TinderboxPrint: CPU usage
13.2% 18:45:28 INFO - TinderboxPrint: I/O read bytes / time
352,256 / 356 18:45:28 INFO - TinderboxPrint: I/O write bytes / time
444,329,984 / 472,560 18:45:28 INFO - TinderboxPrint: CPU idle
8,278.1 (86.8%) 18:45:28 INFO - TinderboxPrint: CPU user
1,204.4 (12.6%) 18:45:28 INFO - TinderboxPrint: Swap in / out
0 / 0 18:45:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 120975360; Read time: 0; Write time: 141516 18:45:28 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:28 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 348160; Write bytes: 323354624; Read time: 344; Write time: 331044 18:45:29 INFO - Running post-run listener: _upload_blobber_files 18:45:29 INFO - Blob upload gear active. 18:45:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:45:29 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:29 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:29 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:29 INFO - (blobuploader) - INFO - Open directory for files ... 18:45:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:45:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:45:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:31 INFO - (blobuploader) - INFO - Done attempting. 18:45:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:45:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:45:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:39 INFO - (blobuploader) - INFO - Done attempting. 18:45:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:45:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:45:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:40 INFO - (blobuploader) - INFO - Done attempting. 18:45:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:45:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:45:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:41 INFO - (blobuploader) - INFO - Done attempting. 18:45:41 INFO - (blobuploader) - INFO - Iteration through files over. 18:45:41 INFO - Return code: 0 18:45:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:45:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:45:41 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20d46b206b05a44ba3cef6d0cdb106b99560a89351e3e724c72efb9f9b3856298799672006454950a0df0822bbec5761ae1bd8a4a8111a2777ae9e175c8bb212", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/351dac174d7019cdad686ad3ccd46b84dd8df2c5fcae86c5329652d72c298f75236623d2bcaa34b0ef067a8138e13e80b06c2b7caf3772b0708a676677aa72e3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b62358ec5c0c27f46f8a60d4446b6227a3d124a3f788a009ba67faf7f3b2592e033624ad27b0160e76b20a72d007f174f2c9295edf9ac9759a2236317f6194f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efbb7d5a6eb9ca2fe3564170c5e6cbdf918edb77acc5e9e73fa798284736c894ba5d5692a4964ad646107c20145a48c6812917f95ee26ab7dde3c6c0be72ef8b"} 18:45:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:45:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:45:41 INFO - Contents: 18:45:41 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20d46b206b05a44ba3cef6d0cdb106b99560a89351e3e724c72efb9f9b3856298799672006454950a0df0822bbec5761ae1bd8a4a8111a2777ae9e175c8bb212", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/351dac174d7019cdad686ad3ccd46b84dd8df2c5fcae86c5329652d72c298f75236623d2bcaa34b0ef067a8138e13e80b06c2b7caf3772b0708a676677aa72e3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b62358ec5c0c27f46f8a60d4446b6227a3d124a3f788a009ba67faf7f3b2592e033624ad27b0160e76b20a72d007f174f2c9295edf9ac9759a2236317f6194f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efbb7d5a6eb9ca2fe3564170c5e6cbdf918edb77acc5e9e73fa798284736c894ba5d5692a4964ad646107c20145a48c6812917f95ee26ab7dde3c6c0be72ef8b"} 18:45:41 INFO - Running post-run listener: copy_logs_to_upload_dir 18:45:41 INFO - Copying logs to upload dir... 18:45:41 INFO - mkdir: /builds/slave/test/build/upload/logs 18:45:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.551789 ========= master_lag: 0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-07-28 18:45:41.000787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 18:45:41.006676) ========= 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=5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858 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/20d46b206b05a44ba3cef6d0cdb106b99560a89351e3e724c72efb9f9b3856298799672006454950a0df0822bbec5761ae1bd8a4a8111a2777ae9e175c8bb212", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/351dac174d7019cdad686ad3ccd46b84dd8df2c5fcae86c5329652d72c298f75236623d2bcaa34b0ef067a8138e13e80b06c2b7caf3772b0708a676677aa72e3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b62358ec5c0c27f46f8a60d4446b6227a3d124a3f788a009ba67faf7f3b2592e033624ad27b0160e76b20a72d007f174f2c9295edf9ac9759a2236317f6194f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efbb7d5a6eb9ca2fe3564170c5e6cbdf918edb77acc5e9e73fa798284736c894ba5d5692a4964ad646107c20145a48c6812917f95ee26ab7dde3c6c0be72ef8b"} build_url:https://queue.taskcluster.net/v1/task/esOdlu_7SECy18fFonV7ig/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011211 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/20d46b206b05a44ba3cef6d0cdb106b99560a89351e3e724c72efb9f9b3856298799672006454950a0df0822bbec5761ae1bd8a4a8111a2777ae9e175c8bb212", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/351dac174d7019cdad686ad3ccd46b84dd8df2c5fcae86c5329652d72c298f75236623d2bcaa34b0ef067a8138e13e80b06c2b7caf3772b0708a676677aa72e3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b62358ec5c0c27f46f8a60d4446b6227a3d124a3f788a009ba67faf7f3b2592e033624ad27b0160e76b20a72d007f174f2c9295edf9ac9759a2236317f6194f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efbb7d5a6eb9ca2fe3564170c5e6cbdf918edb77acc5e9e73fa798284736c894ba5d5692a4964ad646107c20145a48c6812917f95ee26ab7dde3c6c0be72ef8b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 18:45:41.034477) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:45:41.034810) ========= 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=5bd038846534b2fdfa68eeae000001e2-1501280784.292275-205436858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 18:45:41.088261) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 18:45:41.088568) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 18:45:41.088849) ========= ========= Total master_lag: 0.55 =========