builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1501120116.78 results: success (0) revision: f1693d664f8e8ee4c79801630c181c28095cad56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:36.779318) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:36.779777) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:36.780067) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:36.795874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:36.796138) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-26 18:48:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2017-07-26 18:48:37 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123763 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:36.932711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:36.932993) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019454 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:36.989511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:36.989852) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f1693d664f8e8ee4c79801630c181c28095cad56 --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 f1693d664f8e8ee4c79801630c181c28095cad56 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-26 18:48:37,233 truncating revision to first 12 chars 2017-07-26 18:48:37,233 Setting DEBUG logging. 2017-07-26 18:48:37,233 attempt 1/10 2017-07-26 18:48:37,233 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f1693d664f8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-26 18:48:37,647 unpacking tar archive at: mozilla-central-f1693d664f8e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.710377 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:37.715669) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:37.715998) ========= script_repo_revision: f1693d664f8e8ee4c79801630c181c28095cad56 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:37.716407) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:37.716695) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-26 18:48:37.725796) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-26 18:48:37.726075) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:48:38 INFO - MultiFileLogger online at 20170726 18:48:38 in /builds/slave/test 18:48:38 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:48:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:48:38 INFO - {'append_to_log': False, 18:48:38 INFO - 'base_work_dir': '/builds/slave/test', 18:48:38 INFO - 'blob_upload_branch': 'Firefox', 18:48:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:48:38 INFO - 'branch': 'Firefox', 18:48:38 INFO - 'buildbot_json_path': 'buildprops.json', 18:48:38 INFO - 'code_coverage': False, 18:48:38 INFO - 'config_files': ('talos/linux_config.py',), 18:48:38 INFO - 'default_actions': ('clobber', 18:48:38 INFO - 'read-buildbot-config', 18:48:38 INFO - 'download-and-extract', 18:48:38 INFO - 'populate-webroot', 18:48:38 INFO - 'create-virtualenv', 18:48:38 INFO - 'install', 18:48:38 INFO - 'setup-mitmproxy', 18:48:38 INFO - 'run-tests'), 18:48:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:48:38 INFO - 'disable_ccov_upload': False, 18:48:38 INFO - 'download_minidump_stackwalk': True, 18:48:38 INFO - 'download_symbols': 'ondemand', 18:48:38 INFO - 'enable_stylo': False, 18:48:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:48:38 INFO - 'tooltool.py': '/tools/tooltool.py', 18:48:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:48:38 INFO - '/tools/misc-python/virtualenv.py')}, 18:48:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:48:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:48:38 INFO - 'gecko_profile': False, 18:48:38 INFO - 'gecko_profile_interval': 0, 18:48:38 INFO - 'installer_path': 'installer.exe', 18:48:38 INFO - 'log_level': 'info', 18:48:38 INFO - 'log_name': 'talos', 18:48:38 INFO - 'log_to_console': True, 18:48:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:48:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:48:38 INFO - 'opt_config_files': (), 18:48:38 INFO - 'pip_index': False, 18:48:38 INFO - 'suite': 'dromaeojs-e10s', 18:48:38 INFO - 'system_bits': '32', 18:48:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:48:38 INFO - 'title': 'talos-linux64-ix-076', 18:48:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:48:38 INFO - 'use_talos_json': True, 18:48:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:48:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:48:38 INFO - 'work_dir': 'build'} 18:48:38 INFO - [mozharness: 2017-07-27 01:48:38.074900Z] Running clobber step. 18:48:38 INFO - Running pre-action listener: _resource_record_pre_action 18:48:38 INFO - Running main action method: clobber 18:48:38 INFO - rmtree: /builds/slave/test/build 18:48:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:48:39 INFO - Running post-action listener: _resource_record_post_action 18:48:39 INFO - [mozharness: 2017-07-27 01:48:39.104189Z] Finished clobber step (success) 18:48:39 INFO - [mozharness: 2017-07-27 01:48:39.104291Z] Running read-buildbot-config step. 18:48:39 INFO - Running pre-action listener: _resource_record_pre_action 18:48:39 INFO - Running main action method: read_buildbot_config 18:48:39 INFO - Using buildbot properties: 18:48:39 INFO - { 18:48:39 INFO - "project": "", 18:48:39 INFO - "product": "firefox", 18:48:39 INFO - "who": "kwierso@gmail.com", 18:48:39 INFO - "installer_path": "public/build/target.tar.bz2", 18:48:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:48:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:48:39 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:48:39 INFO - "stage_platform": "linux64-stylo", 18:48:39 INFO - "basedir": "/builds/slave/test", 18:48:39 INFO - "buildnumber": 51, 18:48:39 INFO - "platform": "ubuntu64_hw_stylo", 18:48:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:48:39 INFO - "slavebuilddir": "test", 18:48:39 INFO - "taskId": "Yy34vkbAS0aNa02NjudyiQ", 18:48:39 INFO - "branch": "mozilla-central", 18:48:39 INFO - "script_repo_revision": "production", 18:48:39 INFO - "revision": "f1693d664f8e8ee4c79801630c181c28095cad56", 18:48:39 INFO - "slavename": "talos-linux64-ix-076", 18:48:39 INFO - "repo_path": "mozilla-central" 18:48:39 INFO - } 18:48:39 INFO - Finding installer, test and symbols from parent task. 18:48:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yy34vkbAS0aNa02NjudyiQ'}, attempt #1 18:48:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yy34vkbAS0aNa02NjudyiQ'}, attempt #1 18:48:39 INFO - Task dependencies: SoMb-NCNQqKm-PGrwDTeyQ 18:48:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ'}, attempt #1 18:48:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2 18:48:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/test_packages.json 18:48:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.crashreporter-symbols.zip 18:48:40 INFO - Running post-action listener: _resource_record_post_action 18:48:40 INFO - [mozharness: 2017-07-27 01:48:40.442283Z] Finished read-buildbot-config step (success) 18:48:40 INFO - [mozharness: 2017-07-27 01:48:40.442504Z] Running download-and-extract step. 18:48:40 INFO - Running pre-action listener: _resource_record_pre_action 18:48:40 INFO - Running main action method: download_and_extract 18:48:40 INFO - mkdir: /builds/slave/test/build/tests 18:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:48:40 INFO - trying https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.test_packages.json 18:48:40 INFO - Downloading https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:48:41 INFO - Downloaded 989 bytes. 18:48:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:48:41 INFO - Using the following test package requirements: 18:48:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:48:41 INFO - u'common': [u'target.common.tests.zip'], 18:48:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:48:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:48:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:48:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:48:41 INFO - u'mozbase': [u'target.common.tests.zip'], 18:48:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:48:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:48:41 INFO - u'web-platform': [u'target.common.tests.zip', 18:48:41 INFO - u'target.web-platform.tests.tar.gz'], 18:48:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:48:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:48:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.common.tests.zip 18:48:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:48:41 INFO - Fetch https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.common.tests.zip into memory 18:48:43 INFO - Content-Length response header: 72522739 18:48:43 INFO - Bytes received: 72522739 18:48:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:48:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.common.tests.zip 18:48:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:48:54 INFO - Fetch https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.common.tests.zip into memory 18:48:55 INFO - Content-Length response header: 72522739 18:48:55 INFO - Bytes received: 72522739 18:49:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.talos.tests.zip 18:49:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:49:10 INFO - Fetch https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.talos.tests.zip into memory 18:49:10 INFO - Content-Length response header: 14496448 18:49:10 INFO - Bytes received: 14496448 18:49:11 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:49:11 INFO - trying https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2 18:49:11 INFO - Downloading https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:49:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:49:12 INFO - Downloaded 62197101 bytes. 18:49:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2 18:49:12 INFO - mkdir: /builds/slave/test/properties 18:49:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:49:12 INFO - Writing to file /builds/slave/test/properties/build_url 18:49:12 INFO - Contents: 18:49:12 INFO - build_url:https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2 18:49:12 INFO - Running post-action listener: _resource_record_post_action 18:49:12 INFO - Running post-action listener: set_extra_try_arguments 18:49:12 INFO - [mozharness: 2017-07-27 01:49:12.111516Z] Finished download-and-extract step (success) 18:49:12 INFO - [mozharness: 2017-07-27 01:49:12.111613Z] Running populate-webroot step. 18:49:12 INFO - Running pre-action listener: _resource_record_pre_action 18:49:12 INFO - Running main action method: populate_webroot 18:49:12 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:49:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:49:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:49:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:49:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:49:12 INFO - 'tests': ['damp', 'tps']}, 18:49:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:49:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:49:12 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:49:12 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:49:12 INFO - 'other-e10s': {'tests': ['a11yr', 18:49:12 INFO - 'ts_paint', 18:49:12 INFO - 'tpaint', 18:49:12 INFO - 'sessionrestore', 18:49:12 INFO - 'sessionrestore_many_windows', 18:49:12 INFO - 'sessionrestore_no_auto_restore', 18:49:12 INFO - 'tabpaint']}, 18:49:12 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:49:12 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:49:12 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:49:12 INFO - 'talos_options': ['--mitmproxy', 18:49:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:49:12 INFO - '--firstNonBlankPaint'], 18:49:12 INFO - 'tests': ['quantum_pageload_google', 18:49:12 INFO - 'quantum_pageload_youtube', 18:49:12 INFO - 'quantum_pageload_amazon', 18:49:12 INFO - 'quantum_pageload_facebook']}, 18:49:12 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:49:12 INFO - 'talos_options': ['--stylo', 18:49:12 INFO - '--mitmproxy', 18:49:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:49:12 INFO - '--firstNonBlankPaint'], 18:49:12 INFO - 'tests': ['quantum_pageload_google', 18:49:12 INFO - 'quantum_pageload_youtube', 18:49:12 INFO - 'quantum_pageload_amazon', 18:49:12 INFO - 'quantum_pageload_facebook']}, 18:49:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:49:12 INFO - 'tsvgr_opacity', 18:49:12 INFO - 'tart', 18:49:12 INFO - 'tscrollx', 18:49:12 INFO - 'cart', 18:49:12 INFO - 'tsvg_static']}, 18:49:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:49:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:49:12 INFO - 'talos_options': ['--xperf_path', 18:49:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:49:12 INFO - 'tests': ['tp5n']}}} 18:49:12 INFO - Running post-action listener: _resource_record_post_action 18:49:12 INFO - [mozharness: 2017-07-27 01:49:12.118951Z] Finished populate-webroot step (success) 18:49:12 INFO - [mozharness: 2017-07-27 01:49:12.119041Z] Running create-virtualenv step. 18:49:12 INFO - Running pre-action listener: _resource_record_pre_action 18:49:12 INFO - Running main action method: create_virtualenv 18:49:12 INFO - Creating virtualenv /builds/slave/test/build/venv 18:49:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:49:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:49:12 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:49:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:49:12 INFO - Using real prefix '/usr' 18:49:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:49:12 INFO - Installing distribute.............................................................................................................................................................................................done. 18:49:14 INFO - Installing pip.................done. 18:49:14 INFO - Return code: 0 18:49:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:49:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:49:14 INFO - Reading from file tmpfile_stdout 18:49:14 INFO - Output received: 18:49: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:49:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:49: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:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49: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:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49: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 0x221f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258beb0>, '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 0x258cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258d240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', '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:49: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:49: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:49:14 INFO - Using env: {'DISPLAY': ':0', 18:49:14 INFO - 'HOME': '/home/cltbld', 18:49:14 INFO - 'LANG': 'en_US.UTF-8', 18:49:14 INFO - 'LANGUAGE': 'en_US:en', 18:49:14 INFO - 'LOGNAME': 'cltbld', 18:49:14 INFO - 'MAIL': '/var/mail/cltbld', 18:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:14 INFO - 'MOZ_NO_REMOTE': '1', 18:49:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:14 INFO - 'NO_EM_RESTART': '1', 18:49:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:14 INFO - 'PWD': '/builds/slave/test', 18:49:14 INFO - 'SHELL': '/bin/bash', 18:49:14 INFO - 'SHLVL': '1', 18:49:14 INFO - 'TERM': 'linux', 18:49:14 INFO - 'TMOUT': '86400', 18:49:14 INFO - 'USER': 'cltbld', 18:49:14 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', 18:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:14 INFO - '_': '/tools/buildbot/bin/python'} 18:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:49:15 INFO - Cleaning up... 18:49:15 INFO - Return code: 0 18:49:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258beb0>, '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 0x258cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258d240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', '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:49:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:49:15 INFO - Using env: {'DISPLAY': ':0', 18:49:15 INFO - 'HOME': '/home/cltbld', 18:49:15 INFO - 'LANG': 'en_US.UTF-8', 18:49:15 INFO - 'LANGUAGE': 'en_US:en', 18:49:15 INFO - 'LOGNAME': 'cltbld', 18:49:15 INFO - 'MAIL': '/var/mail/cltbld', 18:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:15 INFO - 'MOZ_NO_REMOTE': '1', 18:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:15 INFO - 'NO_EM_RESTART': '1', 18:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:15 INFO - 'PWD': '/builds/slave/test', 18:49:15 INFO - 'SHELL': '/bin/bash', 18:49:15 INFO - 'SHLVL': '1', 18:49:15 INFO - 'TERM': 'linux', 18:49:15 INFO - 'TMOUT': '86400', 18:49:15 INFO - 'USER': 'cltbld', 18:49:15 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', 18:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:15 INFO - '_': '/tools/buildbot/bin/python'} 18:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:15 INFO - Downloading/unpacking psutil>=3.1.1 18:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:49:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:49:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:49:16 INFO - Installing collected packages: psutil 18:49:16 INFO - Running setup.py install for psutil 18:49:16 INFO - building 'psutil._psutil_linux' extension 18:49: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:49: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:49:16 INFO - building 'psutil._psutil_posix' extension 18:49: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:49: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:49:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:49:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:49:17 INFO - Successfully installed psutil 18:49:17 INFO - Cleaning up... 18:49:17 INFO - Return code: 0 18:49:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258beb0>, '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 0x258cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258d240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', '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:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:49:17 INFO - Using env: {'DISPLAY': ':0', 18:49:17 INFO - 'HOME': '/home/cltbld', 18:49:17 INFO - 'LANG': 'en_US.UTF-8', 18:49:17 INFO - 'LANGUAGE': 'en_US:en', 18:49:17 INFO - 'LOGNAME': 'cltbld', 18:49:17 INFO - 'MAIL': '/var/mail/cltbld', 18:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:17 INFO - 'MOZ_NO_REMOTE': '1', 18:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:17 INFO - 'NO_EM_RESTART': '1', 18:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:17 INFO - 'PWD': '/builds/slave/test', 18:49:17 INFO - 'SHELL': '/bin/bash', 18:49:17 INFO - 'SHLVL': '1', 18:49:17 INFO - 'TERM': 'linux', 18:49:17 INFO - 'TMOUT': '86400', 18:49:17 INFO - 'USER': 'cltbld', 18:49:17 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', 18:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:17 INFO - '_': '/tools/buildbot/bin/python'} 18:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:49:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:49:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:49:18 INFO - Installing collected packages: mozsystemmonitor 18:49:18 INFO - Running setup.py install for mozsystemmonitor 18:49:18 INFO - Successfully installed mozsystemmonitor 18:49:18 INFO - Cleaning up... 18:49:18 INFO - Return code: 0 18:49:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:49: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:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49: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:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49: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 0x221f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258beb0>, '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 0x258cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258d240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', '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:49: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:49: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:49:18 INFO - Using env: {'DISPLAY': ':0', 18:49:18 INFO - 'HOME': '/home/cltbld', 18:49:18 INFO - 'LANG': 'en_US.UTF-8', 18:49:18 INFO - 'LANGUAGE': 'en_US:en', 18:49:18 INFO - 'LOGNAME': 'cltbld', 18:49:18 INFO - 'MAIL': '/var/mail/cltbld', 18:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:18 INFO - 'MOZ_NO_REMOTE': '1', 18:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:18 INFO - 'NO_EM_RESTART': '1', 18:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:18 INFO - 'PWD': '/builds/slave/test', 18:49:18 INFO - 'SHELL': '/bin/bash', 18:49:18 INFO - 'SHLVL': '1', 18:49:18 INFO - 'TERM': 'linux', 18:49:18 INFO - 'TMOUT': '86400', 18:49:18 INFO - 'USER': 'cltbld', 18:49:18 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', 18:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:18 INFO - '_': '/tools/buildbot/bin/python'} 18:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:18 INFO - Downloading/unpacking jsonschema==2.5.1 18:49: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:49: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:49: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:49: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:49:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:49:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:49: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:49: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:49: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:49: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:49:19 INFO - Downloading functools32-3.2.3-2.tar.gz 18:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:49:20 INFO - warning: no files found matching '*.txt' 18:49:20 INFO - no previously-included directories found matching 'build' 18:49:20 INFO - no previously-included directories found matching 'dist' 18:49:20 INFO - no previously-included directories found matching '.git*' 18:49:20 INFO - Installing collected packages: jsonschema, functools32 18:49:20 INFO - Running setup.py install for functools32 18:49:20 INFO - warning: no files found matching '*.txt' 18:49:20 INFO - no previously-included directories found matching 'build' 18:49:20 INFO - no previously-included directories found matching 'dist' 18:49:20 INFO - no previously-included directories found matching '.git*' 18:49:20 INFO - Successfully installed jsonschema functools32 18:49:20 INFO - Cleaning up... 18:49:20 INFO - Return code: 0 18:49:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258beb0>, '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 0x258cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258d240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', '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:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:49:20 INFO - Using env: {'DISPLAY': ':0', 18:49:20 INFO - 'HOME': '/home/cltbld', 18:49:20 INFO - 'LANG': 'en_US.UTF-8', 18:49:20 INFO - 'LANGUAGE': 'en_US:en', 18:49:20 INFO - 'LOGNAME': 'cltbld', 18:49:20 INFO - 'MAIL': '/var/mail/cltbld', 18:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:20 INFO - 'MOZ_NO_REMOTE': '1', 18:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:20 INFO - 'NO_EM_RESTART': '1', 18:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:20 INFO - 'PWD': '/builds/slave/test', 18:49:20 INFO - 'SHELL': '/bin/bash', 18:49:20 INFO - 'SHLVL': '1', 18:49:20 INFO - 'TERM': 'linux', 18:49:20 INFO - 'TMOUT': '86400', 18:49:20 INFO - 'USER': 'cltbld', 18:49:20 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', 18:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:20 INFO - '_': '/tools/buildbot/bin/python'} 18:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:49:20 INFO - Cleaning up... 18:49:20 INFO - Return code: 0 18:49:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258beb0>, '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 0x258cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258d240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', '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:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:49:20 INFO - Using env: {'DISPLAY': ':0', 18:49:20 INFO - 'HOME': '/home/cltbld', 18:49:20 INFO - 'LANG': 'en_US.UTF-8', 18:49:20 INFO - 'LANGUAGE': 'en_US:en', 18:49:20 INFO - 'LOGNAME': 'cltbld', 18:49:20 INFO - 'MAIL': '/var/mail/cltbld', 18:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:20 INFO - 'MOZ_NO_REMOTE': '1', 18:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:20 INFO - 'NO_EM_RESTART': '1', 18:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:20 INFO - 'PWD': '/builds/slave/test', 18:49:20 INFO - 'SHELL': '/bin/bash', 18:49:20 INFO - 'SHLVL': '1', 18:49:20 INFO - 'TERM': 'linux', 18:49:20 INFO - 'TMOUT': '86400', 18:49:20 INFO - 'USER': 'cltbld', 18:49:20 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', 18:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:20 INFO - '_': '/tools/buildbot/bin/python'} 18:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:20 INFO - Downloading/unpacking blobuploader==1.2.4 18:49: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:49: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:49: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:49: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:49:21 INFO - Downloading blobuploader-1.2.4.tar.gz 18:49:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:49:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:49: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:49: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:49: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:49: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:49:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:49:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:22 INFO - Downloading docopt-0.6.1.tar.gz 18:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:49:22 INFO - Installing collected packages: blobuploader, requests, docopt 18:49:22 INFO - Running setup.py install for blobuploader 18:49:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:49:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:49:22 INFO - Running setup.py install for requests 18:49:22 INFO - Running setup.py install for docopt 18:49:22 INFO - Successfully installed blobuploader requests docopt 18:49:22 INFO - Cleaning up... 18:49:22 INFO - Return code: 0 18:49:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:49: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:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49: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:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49: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 0x221f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258beb0>, '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 0x258cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258d240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', '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:49: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:49: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:49:22 INFO - Using env: {'DISPLAY': ':0', 18:49:22 INFO - 'HOME': '/home/cltbld', 18:49:22 INFO - 'LANG': 'en_US.UTF-8', 18:49:22 INFO - 'LANGUAGE': 'en_US:en', 18:49:22 INFO - 'LOGNAME': 'cltbld', 18:49:22 INFO - 'MAIL': '/var/mail/cltbld', 18:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:22 INFO - 'MOZ_NO_REMOTE': '1', 18:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:22 INFO - 'NO_EM_RESTART': '1', 18:49:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:22 INFO - 'PWD': '/builds/slave/test', 18:49:22 INFO - 'SHELL': '/bin/bash', 18:49:22 INFO - 'SHLVL': '1', 18:49:22 INFO - 'TERM': 'linux', 18:49:22 INFO - 'TMOUT': '86400', 18:49:22 INFO - 'USER': 'cltbld', 18:49:22 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', 18:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:22 INFO - '_': '/tools/buildbot/bin/python'} 18:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:49:23 INFO - Running setup.py (path:/tmp/pip-H3jpH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:49:23 INFO - Running setup.py (path:/tmp/pip-0yB1P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:49:23 INFO - Running setup.py (path:/tmp/pip-ENE3F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:49:23 INFO - Running setup.py (path:/tmp/pip-TES2qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:49:23 INFO - Running setup.py (path:/tmp/pip-azXHYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:49:23 INFO - Running setup.py (path:/tmp/pip-83MWlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:49:23 INFO - Running setup.py (path:/tmp/pip-ko2Aw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:49:23 INFO - Running setup.py (path:/tmp/pip-HHrADG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:49:23 INFO - Running setup.py (path:/tmp/pip-ZrQi7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:49:23 INFO - Running setup.py (path:/tmp/pip-5KdUkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:49:23 INFO - Running setup.py (path:/tmp/pip-EAzjld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:49:23 INFO - Running setup.py (path:/tmp/pip-JPilQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:49:24 INFO - Running setup.py (path:/tmp/pip-InJnX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:49:24 INFO - Running setup.py (path:/tmp/pip-EiykL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:49:24 INFO - Running setup.py (path:/tmp/pip-ja0HSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:49:24 INFO - Running setup.py (path:/tmp/pip-JoR4YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:49:24 INFO - Running setup.py (path:/tmp/pip-OFgme3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:49:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:49:24 INFO - Running setup.py install for manifestparser 18:49:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:49:24 INFO - Running setup.py install for mozcrash 18:49:24 INFO - Running setup.py install for mozdebug 18:49:24 INFO - Running setup.py install for mozdevice 18:49:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:49:24 INFO - Running setup.py install for mozfile 18:49:24 INFO - Running setup.py install for mozhttpd 18:49:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:49:24 INFO - Running setup.py install for mozinfo 18:49:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:49:25 INFO - Running setup.py install for mozInstall 18:49:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:49:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:49:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:49:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:49:25 INFO - Running setup.py install for mozleak 18:49:25 INFO - Running setup.py install for mozlog 18:49:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:49:25 INFO - Running setup.py install for moznetwork 18:49:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:49:25 INFO - Running setup.py install for mozprocess 18:49:25 INFO - Running setup.py install for mozprofile 18:49:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:49:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:49:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:49:25 INFO - Running setup.py install for mozrunner 18:49:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:49:25 INFO - Running setup.py install for mozscreenshot 18:49:25 INFO - Running setup.py install for moztest 18:49:26 INFO - Running setup.py install for mozversion 18:49:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:49:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:49:26 INFO - Cleaning up... 18:49:26 INFO - Return code: 0 18:49:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258beb0>, '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 0x258cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258d240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', '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:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:49:26 INFO - Using env: {'DISPLAY': ':0', 18:49:26 INFO - 'HOME': '/home/cltbld', 18:49:26 INFO - 'LANG': 'en_US.UTF-8', 18:49:26 INFO - 'LANGUAGE': 'en_US:en', 18:49:26 INFO - 'LOGNAME': 'cltbld', 18:49:26 INFO - 'MAIL': '/var/mail/cltbld', 18:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:26 INFO - 'MOZ_NO_REMOTE': '1', 18:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:26 INFO - 'NO_EM_RESTART': '1', 18:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:26 INFO - 'PWD': '/builds/slave/test', 18:49:26 INFO - 'SHELL': '/bin/bash', 18:49:26 INFO - 'SHLVL': '1', 18:49:26 INFO - 'TERM': 'linux', 18:49:26 INFO - 'TMOUT': '86400', 18:49:26 INFO - 'USER': 'cltbld', 18:49:26 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', 18:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:26 INFO - '_': '/tools/buildbot/bin/python'} 18:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:49:26 INFO - Running setup.py (path:/tmp/pip-UM_ArX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:49: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:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:49:26 INFO - Running setup.py (path:/tmp/pip-MziSyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:49: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:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:49:26 INFO - Running setup.py (path:/tmp/pip-0DJYSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:49: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:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:49:26 INFO - Running setup.py (path:/tmp/pip-CsQztL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:49: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:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:49:26 INFO - Running setup.py (path:/tmp/pip-aEa3t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:49: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:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:49:26 INFO - Running setup.py (path:/tmp/pip-LmOCKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:49: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:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:49:26 INFO - Running setup.py (path:/tmp/pip-n_pjE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:49: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:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:49:26 INFO - Running setup.py (path:/tmp/pip-Nv3NLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:49: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:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:49:26 INFO - Running setup.py (path:/tmp/pip-ksvMUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:49:27 INFO - Running setup.py (path:/tmp/pip-MM6oZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:49:27 INFO - Running setup.py (path:/tmp/pip-NILDbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:49:27 INFO - Running setup.py (path:/tmp/pip-kctE8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:49: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:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:49:27 INFO - Running setup.py (path:/tmp/pip-Wl4GpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:49: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:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:49:27 INFO - Running setup.py (path:/tmp/pip-filRd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:49: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:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:49:27 INFO - Running setup.py (path:/tmp/pip-o35Ak1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:49: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:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:49:27 INFO - Running setup.py (path:/tmp/pip-j3vtGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:49: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:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:49:27 INFO - Running setup.py (path:/tmp/pip-Yj8EXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:49: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:49: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:49: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:49: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:49: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:49: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:49: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:49:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:49: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:49: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:49: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:49: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:49:28 INFO - Downloading blessings-1.6.tar.gz 18:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:49:28 INFO - Installing collected packages: blessings 18:49:28 INFO - Running setup.py install for blessings 18:49:28 INFO - Successfully installed blessings 18:49:28 INFO - Cleaning up... 18:49:28 INFO - Return code: 0 18:49:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:49:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:49:29 INFO - Reading from file tmpfile_stdout 18:49:29 INFO - Current package versions: 18:49:29 INFO - argparse == 1.2.1 18:49:29 INFO - blessings == 1.6 18:49:29 INFO - blobuploader == 1.2.4 18:49:29 INFO - docopt == 0.6.1 18:49:29 INFO - functools32 == 3.2.3-2 18:49:29 INFO - jsonschema == 2.5.1 18:49:29 INFO - manifestparser == 1.1 18:49:29 INFO - mozInstall == 1.13 18:49:29 INFO - mozcrash == 1.0 18:49:29 INFO - mozdebug == 0.1 18:49:29 INFO - mozdevice == 0.51 18:49:29 INFO - mozfile == 1.2 18:49:29 INFO - mozhttpd == 0.7 18:49:29 INFO - mozinfo == 0.10 18:49:29 INFO - mozleak == 0.1 18:49:29 INFO - mozlog == 3.5 18:49:29 INFO - moznetwork == 0.27 18:49:29 INFO - mozprocess == 0.25 18:49:29 INFO - mozprofile == 0.28 18:49:29 INFO - mozrunner == 6.13 18:49:29 INFO - mozscreenshot == 0.1 18:49:29 INFO - mozsystemmonitor == 0.3 18:49:29 INFO - moztest == 0.8 18:49:29 INFO - mozversion == 1.4 18:49:29 INFO - psutil == 3.1.1 18:49:29 INFO - requests == 1.2.3 18:49:29 INFO - wsgiref == 0.1.2 18:49:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258beb0>, '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 0x258cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258d240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', '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:49:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:49:29 INFO - Using env: {'DISPLAY': ':0', 18:49:29 INFO - 'HOME': '/home/cltbld', 18:49:29 INFO - 'LANG': 'en_US.UTF-8', 18:49:29 INFO - 'LANGUAGE': 'en_US:en', 18:49:29 INFO - 'LOGNAME': 'cltbld', 18:49:29 INFO - 'MAIL': '/var/mail/cltbld', 18:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:29 INFO - 'MOZ_NO_REMOTE': '1', 18:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:29 INFO - 'NO_EM_RESTART': '1', 18:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:29 INFO - 'PWD': '/builds/slave/test', 18:49:29 INFO - 'SHELL': '/bin/bash', 18:49:29 INFO - 'SHLVL': '1', 18:49:29 INFO - 'TERM': 'linux', 18:49:29 INFO - 'TMOUT': '86400', 18:49:29 INFO - 'USER': 'cltbld', 18:49:29 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', 18:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:29 INFO - '_': '/tools/buildbot/bin/python'} 18:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49: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:49: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:49: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:49: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:49: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:49: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:49: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:49: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:49: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:49:29 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:49: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:49: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:49: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:49: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:49:30 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:49:30 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:49: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:49: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:49: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:49: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:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:49: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:49: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:49: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:49: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:49:30 INFO - Installing collected packages: marionette-driver, simplejson 18:49:30 INFO - Running setup.py install for marionette-driver 18:49:30 INFO - Running setup.py install for simplejson 18:49:30 INFO - building 'simplejson._speedups' extension 18:49: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:49: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:49:31 INFO - Successfully installed marionette-driver simplejson 18:49:31 INFO - Cleaning up... 18:49:31 INFO - Return code: 0 18:49:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:49: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:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49: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:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49: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 0x221f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258beb0>, '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 0x258cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258d240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', '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:49: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:49: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:49:31 INFO - Using env: {'DISPLAY': ':0', 18:49:31 INFO - 'HOME': '/home/cltbld', 18:49:31 INFO - 'LANG': 'en_US.UTF-8', 18:49:31 INFO - 'LANGUAGE': 'en_US:en', 18:49:31 INFO - 'LOGNAME': 'cltbld', 18:49:31 INFO - 'MAIL': '/var/mail/cltbld', 18:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:31 INFO - 'MOZ_NO_REMOTE': '1', 18:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:31 INFO - 'NO_EM_RESTART': '1', 18:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:31 INFO - 'PWD': '/builds/slave/test', 18:49:31 INFO - 'SHELL': '/bin/bash', 18:49:31 INFO - 'SHLVL': '1', 18:49:31 INFO - 'TERM': 'linux', 18:49:31 INFO - 'TMOUT': '86400', 18:49:31 INFO - 'USER': 'cltbld', 18:49:31 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', 18:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:31 INFO - '_': '/tools/buildbot/bin/python'} 18:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:49:32 INFO - Cleaning up... 18:49:32 INFO - Return code: 0 18:49:32 INFO - Running post-action listener: _resource_record_post_action 18:49:32 INFO - Running post-action listener: _start_resource_monitoring 18:49:32 INFO - Starting resource monitoring. 18:49:32 INFO - [mozharness: 2017-07-27 01:49:32.125373Z] Finished create-virtualenv step (success) 18:49:32 INFO - [mozharness: 2017-07-27 01:49:32.125831Z] Running install step. 18:49:32 INFO - Running pre-action listener: _resource_record_pre_action 18:49:32 INFO - Running main action method: install 18:49:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:49:32 INFO - Reading from file tmpfile_stdout 18:49:32 INFO - Detecting whether we're running mozinstall >=1.0... 18:49:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:49:32 INFO - Reading from file tmpfile_stdout 18:49:32 INFO - Output received: 18:49:32 INFO - Usage: mozinstall [options] installer 18:49:32 INFO - Options: 18:49:32 INFO - -h, --help show this help message and exit 18:49:32 INFO - -d DEST, --destination=DEST 18:49:32 INFO - Directory to install application into. [default: 18:49:32 INFO - "/builds/slave/test"] 18:49:32 INFO - --app=APP Application being installed. [default: firefox] 18:49:32 INFO - mkdir: /builds/slave/test/build/application 18:49: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:49: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:49:50 INFO - Reading from file tmpfile_stdout 18:49:50 INFO - Output received: 18:49:50 INFO - /builds/slave/test/build/application/firefox/firefox 18:49:50 INFO - Running post-action listener: _resource_record_post_action 18:49:50 INFO - [mozharness: 2017-07-27 01:49:50.456061Z] Finished install step (success) 18:49:50 INFO - [mozharness: 2017-07-27 01:49:50.456206Z] Running setup-mitmproxy step. 18:49:50 INFO - Running pre-action listener: _resource_record_pre_action 18:49:50 INFO - Running main action method: setup_mitmproxy 18:49:50 INFO - Skipping: mitmproxy is not required 18:49:50 INFO - Running post-action listener: _resource_record_post_action 18:49:50 INFO - [mozharness: 2017-07-27 01:49:50.457135Z] Finished setup-mitmproxy step (success) 18:49:50 INFO - [mozharness: 2017-07-27 01:49:50.457355Z] Running run-tests step. 18:49:50 INFO - Running pre-action listener: _resource_record_pre_action 18:49:50 INFO - Running pre-action listener: _set_gcov_prefix 18:49:50 INFO - Running main action method: run_tests 18:49:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:49:50 INFO - Python 2.7.3 18:49:50 INFO - Return code: 0 18:49:50 INFO - grabbing minidump binary from tooltool 18:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49: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 0x258beb0>, '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 0x258cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258d240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:49: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:49: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:49: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:49:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:49:50 INFO - Return code: 0 18:49:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:49:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:49:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:49:50 INFO - ENV: RUST_BACKTRACE is now 1 18:49:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:49:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:49: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/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:49: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/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:49:50 INFO - Using env: {'DISPLAY': ':0', 18:49:50 INFO - 'HOME': '/home/cltbld', 18:49:50 INFO - 'LANG': 'en_US.UTF-8', 18:49:50 INFO - 'LANGUAGE': 'en_US:en', 18:49:50 INFO - 'LOGNAME': 'cltbld', 18:49:50 INFO - 'MAIL': '/var/mail/cltbld', 18:49:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:49:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:50 INFO - 'MOZ_NO_REMOTE': '1', 18:49:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:50 INFO - 'NO_EM_RESTART': '1', 18:49:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:50 INFO - 'PWD': '/builds/slave/test', 18:49:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:49:50 INFO - 'RUST_BACKTRACE': '1', 18:49:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:49:50 INFO - 'SHELL': '/bin/bash', 18:49:50 INFO - 'SHLVL': '1', 18:49:50 INFO - 'STYLO_FORCE_ENABLED': '1', 18:49:50 INFO - 'TERM': 'linux', 18:49:50 INFO - 'TMOUT': '86400', 18:49:50 INFO - 'USER': 'cltbld', 18:49:50 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330', 18:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:50 INFO - '_': '/tools/buildbot/bin/python'} 18:49: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/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:49:50 INFO - mozversion application_buildid: 20170727010339 18:49:50 INFO - mozversion application_changeset: f1693d664f8e8ee4c79801630c181c28095cad56 18:49:50 INFO - mozversion application_display_name: Nightly 18:49:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:49:50 INFO - mozversion application_name: Firefox 18:49:50 INFO - mozversion application_remotingname: firefox 18:49:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:49:50 INFO - mozversion application_vendor: Mozilla 18:49:50 INFO - mozversion application_version: 56.0a1 18:49:50 INFO - mozversion platform_buildid: 20170727010339 18:49:50 INFO - mozversion platform_changeset: f1693d664f8e8ee4c79801630c181c28095cad56 18:49:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:49:50 INFO - mozversion platform_version: 56.0a1 18:49:50 INFO - using testdate: 1501120190 18:49:50 INFO - actual date: 1501120190 18:49:50 INFO - starting webserver on 'localhost:52436' 18:49:50 INFO - SUITE-START | Running 2 tests 18:49:50 INFO - TEST-START | dromaeo_css 18:49:50 INFO - Initialising browser for dromaeo_css test... 18:49:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52436/getInfo.html -profile /tmp/tmpKljZIF/profile 18:49:50 INFO - TEST-INFO | started process 4768 (/builds/slave/test/build/application/firefox/firefox http://localhost:52436/getInfo.html) 18:49:56 INFO - TEST-INFO | 4768: exit 0 18:49:56 INFO - Browser initialized. 18:49:56 INFO - Running cycle 1/1 for dromaeo_css test... 18:49:56 INFO - TEST-INFO | started process 4995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKljZIF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:57 INFO - PID 4995 | 18:49:57 INFO - PID 4995 | (/builds/slave/test/build/application/firefox/firefox:5049): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:49:57 INFO - PID 4995 | 18:50:08 INFO - PID 4995 | RSS: Main: 170741760 18:50:08 INFO - PID 4995 | 18:53:07 INFO - PID 4995 | Cycle 1(1): loaded http://localhost:52436/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52436/tests/dromaeo/cssquery-ext.html) 18:53:08 INFO - PID 4995 | RSS: Main: 174215168 18:53:08 INFO - PID 4995 | 18:56:10 INFO - PID 4995 | Cycle 1(1): loaded http://localhost:52436/tests/dromaeo/cssquery-ext.html (next: http://localhost:52436/tests/dromaeo/cssquery-jquery.html) 18:56:11 INFO - PID 4995 | RSS: Main: 172204032 18:56:11 INFO - PID 4995 | 18:59:13 INFO - PID 4995 | Cycle 1(1): loaded http://localhost:52436/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52436/tests/dromaeo/cssquery-mootools.html) 18:59:14 INFO - PID 4995 | RSS: Main: 173981696 18:59:14 INFO - PID 4995 | 19:02:15 INFO - PID 4995 | Cycle 1(1): loaded http://localhost:52436/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52436/tests/dromaeo/cssquery-prototype.html) 19:02:16 INFO - PID 4995 | RSS: Main: 172756992 19:02:16 INFO - PID 4995 | 19:05:20 INFO - PID 4995 | Cycle 1(1): loaded http://localhost:52436/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52436/tests/dromaeo/cssquery-yui.html) 19:05:21 INFO - PID 4995 | RSS: Main: 173457408 19:05:21 INFO - PID 4995 | 19:08:23 INFO - PID 4995 | Cycle 1(1): loaded http://localhost:52436/tests/dromaeo/cssquery-yui.html (next: http://localhost:52436/tests/dromaeo/cssquery-dojo.html) 19:08:23 INFO - PID 4995 | RSS: Main: 176513024 19:08:23 INFO - PID 4995 | 19:08:23 INFO - PID 4995 | __start_tp_report 19:08:23 INFO - PID 4995 | _x_x_mozilla_page_load 19:08:23 INFO - PID 4995 | _x_x_mozilla_page_load_details 19:08:23 INFO - PID 4995 | |i|pagename|runs| 19:08:23 INFO - PID 4995 | |0;dojo.html;3086.567880496731;3104.1618762934;3123.2191952012;3144.2296637323857;3151.6060492438446;6163.106349579309;6201.968990155043;6205.751769929203;6248.062790581409;6249.218847644044;6002;6085.2089228400355;6106.236720409949;6118.877622447549;6139.72371243294;5622.184783206432;5631.887362252753;5643.68959707216;5669.121286200645;5680.318361796591;5665.433456654343;5673.092305231164;5684.687342196177;5689.971550142264;5690.829275121753;5712.086066229404;5746.051901436279;5781.768729250825;5800.622959507618;5809.73856176471;5686.886262274773;5745.540356771448;5754.338251101093;5757.107648314518;5762.481376676119;5459.290292262021;5581.748821303051;5609.943900561024;5632.605717599769;5674.914876276818;6036.788712395045;6109.419605137505;6109.938900610981;6169.598976066542;6180.969095154541;6606.735730570771;6616.8345791355605;6675.46596272297;6676.766313179064;6684.565503242274;6558.475321974231;6622.37087476689;6634.635095069769;6645.6344901030425;6649.900251496183;6125.050617154348;6131.570790044743;6139.631622102688;6140.201773769381;6142.385761423822;6739.056532085512;6740.056392105109;6756.932430675729;6757.087793147862;6758.966205169041;6383.2978372379;6421.5825971311715;6438.45273151778;6456.612603243821;6463.7737679181;6532.05285233648;6532.118164047888;6546.574472659262;6548.050532672736;6550.672466376757;6532.902006469907;6535.379138981789;6539.346065393518;6641.435477984329;6652.234992975773;6546.738130474728;6555.147830781968;6569.967150164219;6660.433863121592;6675.766348177887;5234.18870075139;5247.475252474798;5319.840404787863;5357.919631205535;5362.544183744425;4597.310403439511;4615.676902616851;4657.650676199299;4679.766011699401;4684.039771846763;5581.6930068846605;5778.306603207642;5799.971000144972;5806.30324361071;5810.244668193108;6586.440152586988;6637.103990961158;6650.467962562983;6656.034874943106;6659;5732.799352022743;5745.9425405745405;5754.395788442237;5783.392743761929;5788.623739456922;5710.086386178275;5801.564882633819;5801.88396232073;5865.648061116347;5872.823815285548;6277.1525844010475;6399.232092148972;6405.455536279375;6490.415862572391;6492.156019717407;6347.587406818542;6627.204735431779;6635;6657.567258128206;6684.532082754355;6364.07720880479;6466.902996455151;6468.126802881551;6514.413702766774;6540.182477190351;6507.186601674791;6533.444657204001;6596.340365963365;6617.933820661732;6626.171728533934;6496.837579060372;6605.504587155887;6629.668516574248;6634.933650663432;6758.020087087247;6502.934970650233;6519.250286217146;6522.412982831568;6525.836854078686;6528.37980391862;6430.164078669743;6437.1631687882145;6477.319881412383;6527.477801775752;6530.314316996647;6370.203724534434;6372.044193371032;6449.580777249652;6450.741970321134;6467.514936379696;6351.71417286214;6449.193850768654;6468.223813142453;6472.093906852951;6563.146790917151;6217.782377616762;6275.058741188858;6275.560710750204;6276.184096067482;6276.811695649138 19:08:23 INFO - PID 4995 | |1;ext.html;782.2060608482387;860.264473874837;879.2965627498002;888.8622263549148;1171.1041053594008;30674.23314417141;31165.065048048567;31347.373052538936;42781;43128.78435607818;43822;44249.77875110628;44310.55689443104;44348.556514434844;44536;7252;7632.732854350085;7697.153313135551;7778.766637000899;7878;7697.653605587762;7788.14330423653;7817.765467035998;7818.296353328199;7821.687132514721;7781.961090194541;7782.260685234894;7813.335866451358;7829.765107046797;7851.371890248766;7746.535207887545;7770.145284018753;7776.416768742367;7805.219478052206;7823.295903368724;7625.923740762632;7688.461807673465;7744.49660772048;7745.573993430359;7750.651220695026;39370.40944385836;39932.600673993176;40227.19545609101;40306.596934030575;40314.59685403167;3536.0275924120815;3552.467129930531;3575.5888072871694;3575.9808454590316;3581.230035542345;32091;32092.839535802406;32194.195145121324;32225.516617250527;32236.19409514781;4675.976620116878;4900;4926.975365123188;4939.110960027194;4954.826581069645;195908;197555;197990;198432.99999999854;198491.0075449628;49336;49365.50634493681;49453.50546494561;49518.50481495211;49593;52035.73982130065;52314;52351.738241309315;52352;52377.73811130996;14341.780948619484;14343.928280358532;14450.494232701805;14473.348699308557;14482.782758258634;9379.390339627902;9597.23222142227;11540.653780386601;11979.34113623759;12105.273683579013;14698.55904322872;14715.117092974457;14819.481318153812;14851.554453366416;15013.624659383602;5818.661707807228;5923.703814809242;5948.762049517971;5976.894274559134;6079.787207447806;970.3886551472527;983.537737263485;990.5245482168599;1020.0768304684273;1034.6171916390983;21748.565028699653;21912.89043554772;21970.89014554949;21996;22236.221732239293;1109.3399427340719;1113.6269349767917;1118.3290025984345;1127.475723788426;1127.9661610151709;11930.403479826147;11936.701582460335;11942.641720748392;11952.40237988097;11979.221350612183;219704;221137;221551;221795;221905;52698.47301527012;52892.206616900774;52899.206511902354;53035;53191;1448.507507447494;1453.3024148408822;1493.2309860421892;1493.432495651667;1501.9173945433106;21687.674684879425;22044.33866983993;22487.550248995256;22789.658155128018;23094.42263943415;49349.75325123352;52499.73750131225;52692.736536317076;53006.4699353017;53072.46927530675;203135;203534;203678;203710;205044;35673.64326356807;36393.454098189075;36747.81626091959;36776;37188;46013;46116.847078823295;46263.30605040994;46452.53547464482;46673.29990050084;32129;34340;35391.82304088463;35525.644743552235;35689.1077723059;33266.16834579155;34165.316693666486;34914.65085349216;34958.12604684802;35435.64564354427;38135.04662383463;38412.61587384202;38561.22877542378;38736.61263387443;39232.607673922896;32810.835945820116;33464.832675836464;33617.49573756347;33674;33724.831375842965;22712.772872271067;23268.767312327338;23603.881980589988;24437;24747.752522474544 19:08:23 INFO - PID 4995 | |2;jquery.html;567.2370661460337;569.9800506982257;578.3840210176164;582.4001278682957;595.6932179927337;22032.669509957363;22669.206577769783;22844.657330140042;22883.542329153406;22938.65592016121;24718.50562988739;26702.332441688966;26748.197554073362;26852.5972110418;26913.32716682084;6306.779262725817;6406.007068904327;6449.451796597272;6459.773907913224;6461.030845373208;6191.659458729768;6411.775587854426;6456.289808121103;6480.6435646039445;6488.708008139645;6779.76270830521;6790.388865002149;6791.932080679179;6795.32046795319;6799.660016999155;6747.291534388867;6764.222114456851;6778.49161312901;6779.694913728869;6793.762218322359;6639.867202655968;6647.900281495781;6654.26803051664;6670.599764014175;6677.699503522354;30191;31225.53161702576;31888.681113188803;32291.51562726561;32378.676213237803;1929.4211736479;1955.3058664174155;1964.980350196494;1979.2281010405952;1981.1184023109722;19757.703634445494;20215.29246476366;20245.595088098304;20313.390598281927;20422.79577204224;2397.784199422043;2426.7087949446004;2496.5131799299143;2502.0867383405107;2510.7363726808603;139522.30238848843;141787;142869;143420;144343.27828360896;19746.210151594063;20869.791302086785;21308.893455532623;21356.893215534135;21990;22538.323850284516;24056.51886962251;44702.776486117364;45024;45035.54964450379;10133.189344852393;10211.7447063824;10365.222608304257;10434.113100386401;10943.343399396063;9503.239740820718;9512.09635084666;9512.334136610509;9626.374285671409;9629.711108666752;9058.773530661787;9185.586648600829;9427.198688111588;9457.19613832832;9517.333786634868;2692.4345887363875;2766.4467106578763;2766.61267422561;2771.708970558103;2845.4166895786316;953.3136141977903;957.8323793336139;958.8705524754068;983.311681822727;992.8560358747941;18753.7186942196;18982.240710371705;19282.90358548198;19295.131719072677;19396.32112876071;986.2455221755363;990.9355891867006;1042.968710938673;1051.0908064524285;1060.1571750458404;10304.227182961307;10381.117605003508;10542.051215390651;11017.724556886142;11207.719807004727;452077;485060;486646;489643;504780;115682;116419.41790291163;121098;121414.39292803656;121435.39282303532;1222.394914517302;1266.866978967195;1280.8783165599252;1288.2528133682442;1296.0344543315102;19674.80325196787;20808.479788004814;21034.78965210328;21209.89395053015;21301.6804747932;59512.404875952416;59785.70107149436;60421.395786041576;60701.69649151726;62865.37134628595;71624.64187679028;71808.64095679489;72043;72119;72189.27810722035;14602.269886505419;15159.696806063597;15162.848371516144;15234.466793662168;15253.542393728207;23986.760132398453;24048.15831445891;24189.75810241875;24215.51568968646;24294.17793665447;18780.248790048245;18881;19120.61758764845;19145.8085419144;19323.903380483007;16316.836831631532;17650.382236621655;17842.19710113022;17977.550561236072;18080.638387232444;19698.31055913036;20646.793532064486;20675.586488269848;20732.481687957923;20842.583148337253;14718.0433271837;14936;15137.243137843285;15170.772438413653;15204.695906082037;19383.612327753646;19446.8055319445;19510.414687559394;19530;19548 19:08:23 INFO - PID 4995 | |3;mootools.html;1297.487492440486;1362.3869258833527;1381.9309034548273;1384.6953670192554;1388.8125103111076;13485;14353.35409906554;14373.856261437382;14376.856231437709;14390.856091439082;13978.161310321388;14171.220582867938;14194.432222711079;14251.57245282643;14272.357743901523;2529.962050569243;2654.973450265497;2676.6787985441774;2680.0485827531143;2681.892724291026;2655.6414883990606;2665.506881226979;2697.973020269792;2701.8649067546644;2718.293243756628;2561.9359516012064;2599.116300457844;2605.4398304364654;2608.11324149789;2653.9601905971426;2535.1760677779794;2549.247971848309;2584.974150258511;2588.844669319828;2591.4298854252033;2499.550080985422;2510.2092840755286;2538.695356557225;2552.961705574418;2558.590625499911;13553.728925421436;13694.315284235849;13712.45150193991;13718.725625487434;13723;7266.564006159648;7533.547987120735;7631.198724133997;7660.119086305091;7670.424718146106;4753.382060332135;5020.573251273646;5161.045206636784;5161.81933632321;5171.715555644438;1708.9572760680958;1737.652469506104;1742.8082910879793;1787.4012205911035;1791.435697755203;21678;21688.674669879965;21869.12523499074;21886.671699924515;21914.23300184486;5992.880142397127;6239;6263.812085637347;6361.840953976188;6434.195725534309;15462.613434664223;15463.226838658022;15467.071975681494;15476.690466190614;15487.457938972082;6527.5757075789925;7323.633818309063;7578.810529736801;7583.848323033509;7590.582517961455;6199.070139479114;6522.967385163044;6932.306769323128;7098.751543695946;7157.033800436874;4675.719456832601;4742.359781429463;4844.176489996709;4845.3216549683075;4891.413030436299;1313.080843409617;1354.5800801751489;1363.2842757552364;1373.169232614274;1378.4141739760562;832.8292699996607;835.3233880556769;854.1031916487788;869.9347548933855;884.0540621535024;6326.905096423558;6545.541812073205;6648.501362397839;6730.414861297795;6797.490188235902;693.6115775165923;709.5281637710967;725.8729722298576;728.6320408193934;739.5525706947327;4728.432588089451;4874.599095599534;4989.575886049726;5015.749212539358;5184.7926082956255;18236.361727339743;18733.625327493373;18832.152553135144;18861.622767544573;18875.716864247046;17779.46661600154;17906.373276935246;18090.095495225185;18437.07814609291;18498.907505462656;10110.140638045848;10548.736281592868;10570.365778053341;10572.84140737905;10725.89274107249;7703.3067023968115;8111.351091912751;8129.187081291823;8270.958645206736;8322.54226017575;15322.770158447409;15822.446214382442;16320;16636.417725379553;16670;15200.163990980602;15982;16803.07583082942;17105.743413848555;17174;10994.395308258123;11776.470058847544;11791.115666325231;11796.410179491162;11800.586979455678;13178.868211317764;13264.668383290495;13274.336283185996;13280.734385312433;13290.401931912893;10791.082757965662;10808.891911081104;10885.619003334845;10894.128469722245;11038.448077595927;9509.476978766234;10151.187904967732;10174.898251017396;10243.129334006693;10421.166306695597;8592.054873963734;9074.27405807547;9076.001639819746;9103.590338434919;9118.908810912071;6340.207474065742;6379.393957574023;6608.372204640552;6672.266050734513;6718.630475323904;6765.086713293643;6866.725330986705;6983.1620205575655;7033.366996970092;7042.647867606702 19:08:23 INFO - PID 4995 | |4;prototype.html;500.24213316825006;500.7834037405049;511.2586749213641;521.5384384819434;526.1502673182808;6134.754609815614;6205.379462053798;6239.875202495948;6256.624602523846;6256.873762722708;5909.340796641507;6037.849053773658;6042.788502402417;6110.908336374958;6168.457885528618;4860.805567777294;4930.506949305059;4936.950630493685;4940.407151141868;4959.578435832958;4746.430428348603;4768.928466073012;4895.4125504939275;4926.211806111023;4940.333055037578;4839.201531747258;4868.221084626461;4935.629827762914;4970.707616019843;5009.724465154415;4843.612510999112;4913.582345500655;4946.950530494703;4967.218357719688;4986.750662466862;4418.7848341706285;4426.468823741139;4438.733675979419;4447.955520444819;4449.733016019017;5975.133605627203;5982.760689572412;6000.309964354112;6028.457438830483;6090.299615544181;5522.5581953443625;5583.106702927553;5645.774169033275;5674.120511320752;5707.571932105108;6347.619142851444;6368.395002474757;6369.6496692681885;6395.456386207178;6462.870742585122;4808.591269742041;4823.321378263079;4824.614030877521;4854.223324268136;4861.465238823726;6724.7646332378135;6787.762428314985;6860.725570977155;6869.450443964471;6932.514723969374;4918.262260660858;4927.507249275115;4944.415298908263;4947.60419166473;4971.328870602422;5059.949400506021;5086.033653605803;5090.211017292251;5094.2103973884105;5104.3619547556555;5693.829185124453;5703.458171473703;5709.143628455682;5730.455606717355;5739.569532285095;6565.179352580927;6565.540412171198;6574.638394888327;6576.539642224999;6578.736850526021;1662.9334826607042;1709.6495218480181;1715.5882588178747;1738.3828740796835;1767.7184041570017;1204.1811568133753;1219.3842109734705;1219.8902098810972;1233.9876601233873;1244.7883859743865;5593.8321850344555;5637.68992705397;5640.915386269209;5648.209250704905;5686.147077938343;6478.514111441661;6478.546501744832;6514.348565143448;6526.715649522724;6530.35520614152;5526.392096869341;5695.661519542904;5712.685802280831;5736.397678243808;5744.913826292609;3555.36003519369;3556.1820781220463;3558.5907620623443;3561.6260292669413;3586.7130629549574;6370.617762934239;6424.550281480251;6432.292447830735;6443.194600674916;6453.161089058486;6871.587704737732;6873.828154296182;6949.339812717783;6950.644624298315;6955.89566156508;6435.646039467874;6453.322136244704;6496.090547323379;6513.316101809241;6528.640924749185;6597.2742998271115;6651.301613330531;6708.362705542965;6725.49558783103;6754.425873800782;6525.314841941527;6654.633995130314;6736.4274036705465;6740.046066141284;6750.223724271772;6296.464800492009;6332.588381755171;6421.004744264646;6471.282061534072;6474.902876456763;4835.854924352275;4903.289023091703;4969.608509617313;4976.109078550127;4985.775640096277;6676.298988606127;6692.866142677021;6701;6728.7308507659145;6731.4951378647775;6462.676866156768;6506.60960342381;6522.510456905533;6556.8360790980605;6556.967215163893;6406.615603063831;6430.3891130342545;6431.070678796436;6480.837979050561;6522.412982831568;6122.969385153046;6187.752489900354;6381.234251889803;6388.8083357499345;6388.840278993062;6308;6387.616742995435;6406.615603063831;6463.418292353711;6516.73933042673;6191.492445559556;6242.687865606611;6255.24937007562;6279.560430769802;6417.582857114273 19:08:23 INFO - PID 4995 | |5;yui.html;922.9353945223833;931.2689538712112;942.100294219021;948.1135138645362;950.3157726436963;18195;19028.14373353199;19108.808911910895;19131.90434047828;21188;19922.70115948258;19947.40157795265;20122.899385503053;20158.59682806343;20171.495712607157;1016.085523029274;1040.089921318846;1048.6696690542492;1051.3534176481485;1052.0373857920033;1040.3965699894043;1047.8585390972198;1051.1800795379577;1055.2771351624162;1055.625253035173;1018.5518371916334;1104.9226554141214;1109.1293334732236;1109.9112071034338;1110.4281295133012;1099.8185299425625;1100.0044959311756;1100.9339439633607;1104.0615476844698;1104.9392283424409;800.1838125112411;802.077610747639;802.6829402386084;802.8153524689354;804.6741069866713;19725.21099156032;19851.404457866287;20108.698369524467;20162.69755953662;20596;20159.79840201594;20652.27717029912;20676.17295308186;21141.788582114135;21149.788502114934;16157.434489792919;16507.58731031722;16635.41776037845;16683.165841707865;16683.83316166847;3465.930681386383;3505.5618047744033;3505.8247087645514;3507.2985402919517;3508.2281897982402;115939;117728.41135794352;119917;122680;125188;16508.587285317964;17038;17093.743593846102;17098.230579623945;17115.400960966308;28682.13953581396;30076.84961575178;30253.848730756206;30311.848440757654;30373;8336.416450848503;8627.137286271323;8650.6972255972;8680.956595216983;8795.340349473816;4121.97939010309;4205.137946720914;4205.705600607928;4206.516250631216;4214.136102099063;5333.120035194227;5453.263809385761;5628.943710562924;5852.092925596539;5879.118132280192;1067.066316972649;1082.86464191976;1100.6697990602788;1108.3128460354633;1108.4900945564968;663.8207683925314;671.090672139254;686.3136863136863;706.9505134640629;716.4411758828122;12290.385480725929;12634.305113218677;13008.284544349963;13291.468341266434;13575.185488870698;700.1423256510835;701.7543859649082;706.8974998625273;728.4136270302457;729.2415887476965;5275.920861187085;5435.266239057677;5487.835364939058;5654.5193658538665;5778.248827652378;97956.51021744988;100151;104740.8577742669;106143.4692826531;107143.46428267965;86544.56727716321;89292.35920124357;89768.5511572438;90587;94667.0533294672;77593.22406776086;78607.21392786113;79093.20906790858;80138.19861801308;82655.17344826474;10622.628208012682;11004.449777511252;12207.511699531919;12248.632541023784;12503;33839.492407614394;36227.63772362243;36339.81830090833;36361;37699.05752356213;63887;65977.34022659712;66200.33799661942;67910;71548.28451715416;18010;18553.16510757046;18636.906815465834;18765.530861728566;18823.90588047051;20781.688274676195;21270.36188914335;21382.572348553254;21417.678734818677;21500.56998859983;16783.664326713155;16801.579960501087;19500.707489387954;19542.120604572545;19775.40673779789;19072.237110515423;19119.42641720695;19306.90346548258;19405.4178374649;19419.902900485406;18088.276468941094;18578.25686972506;18741.718874216625;18908.810911890705;19540.90229548843;12773;12904.483820647069;13129.218732044688;13139.868601313865;13511.932440337736;13640.254641701194;14159.433622654979;14317.928410357881;14351.569452916428;14549.854501455273 19:08:23 INFO - PID 4995 | __end_tp_report 19:08:23 INFO - PID 4995 | __start_cc_report 19:08:23 INFO - PID 4995 | _x_x_mozilla_cycle_collect,349 19:08:23 INFO - PID 4995 | __end_cc_report 19:08:23 INFO - PID 4995 | __startTimestamp1501121303354__endTimestamp 19:08:23 INFO - PID 4995 | 19:08:23 INFO - PID 4995 | ------- Summary: start ------- 19:08:23 INFO - PID 4995 | Number of tests: 6 19:08:23 INFO - PID 4995 | 19:08:23 INFO - PID 4995 | [#0] dojo.html Cycles:165 Average:6092.00 Median:6351.71 stddev:710.10 (11.2%) stddev-sans-first:672.00 19:08:23 INFO - PID 4995 | Values: 3086.6 3104.2 3123.2 3144.2 3151.6 6163.1 6202.0 6205.8 6248.1 6249.2 6002.0 6085.2 6106.2 6118.9 6139.7 5622.2 5631.9 5643.7 5669.1 5680.3 5665.4 5673.1 5684.7 5690.0 5690.8 5712.1 5746.1 5781.8 5800.6 5809.7 5686.9 5745.5 5754.3 5757.1 5762.5 5459.3 5581.7 5609.9 5632.6 5674.9 6036.8 6109.4 6109.9 6169.6 6181.0 6606.7 6616.8 6675.5 6676.8 6684.6 6558.5 6622.4 6634.6 6645.6 6649.9 6125.1 6131.6 6139.6 6140.2 6142.4 6739.1 6740.1 6756.9 6757.1 6759.0 6383.3 6421.6 6438.5 6456.6 6463.8 6532.1 6532.1 6546.6 6548.1 6550.7 6532.9 6535.4 6539.3 6641.4 6652.2 6546.7 6555.1 6570.0 6660.4 6675.8 5234.2 5247.5 5319.8 5357.9 5362.5 4597.3 4615.7 4657.7 4679.8 4684.0 5581.7 5778.3 5800.0 5806.3 5810.2 6586.4 6637.1 6650.5 6656.0 6659.0 5732.8 5745.9 5754.4 5783.4 5788.6 5710.1 5801.6 5801.9 5865.6 5872.8 6277.2 6399.2 6405.5 6490.4 6492.2 6347.6 6627.2 6635.0 6657.6 6684.5 6364.1 6466.9 6468.1 6514.4 6540.2 6507.2 6533.4 6596.3 6617.9 6626.2 6496.8 6605.5 6629.7 6634.9 6758.0 6502.9 6519.3 6522.4 6525.8 6528.4 6430.2 6437.2 6477.3 6527.5 6530.3 6370.2 6372.0 6449.6 6450.7 6467.5 6351.7 6449.2 6468.2 6472.1 6563.1 6217.8 6275.1 6275.6 6276.2 6276.8 19:08:23 INFO - PID 4995 | 19:08:23 INFO - PID 4995 | [#1] ext.html Cycles:180 Average:38438.70 Median:36570.64 stddev:53920.45 (147.4%) stddev-sans-first:53997.58 19:08:23 INFO - PID 4995 | Values: 782.2 860.3 879.3 888.9 1171.1 30674.2 31165.1 31347.4 42781.0 43128.8 43822.0 44249.8 44310.6 44348.6 44536.0 7252.0 7632.7 7697.2 7778.8 7878.0 7697.7 7788.1 7817.8 7818.3 7821.7 7782.0 7782.3 7813.3 7829.8 7851.4 7746.5 7770.1 7776.4 7805.2 7823.3 7625.9 7688.5 7744.5 7745.6 7750.7 39370.4 39932.6 40227.2 40306.6 40314.6 3536.0 3552.5 3575.6 3576.0 3581.2 32091.0 32092.8 32194.2 32225.5 32236.2 4676.0 4900.0 4927.0 4939.1 4954.8 195908.0 197555.0 197990.0 198433.0 198491.0 49336.0 49365.5 49453.5 49518.5 49593.0 52035.7 52314.0 52351.7 52352.0 52377.7 14341.8 14343.9 14450.5 14473.3 14482.8 9379.4 9597.2 11540.7 11979.3 12105.3 14698.6 14715.1 14819.5 14851.6 15013.6 5818.7 5923.7 5948.8 5976.9 6079.8 970.4 983.5 990.5 1020.1 1034.6 21748.6 21912.9 21970.9 21996.0 22236.2 1109.3 1113.6 1118.3 1127.5 1128.0 11930.4 11936.7 11942.6 11952.4 11979.2 219704.0 221137.0 221551.0 221795.0 221905.0 52698.5 52892.2 52899.2 53035.0 53191.0 1448.5 1453.3 1493.2 1493.4 1501.9 21687.7 22044.3 22487.6 22789.7 23094.4 49349.8 52499.7 52692.7 53006.5 53072.5 203135.0 203534.0 203678.0 203710.0 205044.0 35673.6 36393.5 36747.8 36776.0 37188.0 46013.0 46116.8 46263.3 46452.5 46673.3 32129.0 34340.0 35391.8 35525.6 35689.1 33266.2 34165.3 34914.7 34958.1 35435.6 38135.0 38412.6 38561.2 38736.6 39232.6 32810.8 33464.8 33617.5 33674.0 33724.8 22712.8 23268.8 23603.9 24437.0 24747.8 19:08:23 INFO - PID 4995 | 19:08:23 INFO - PID 4995 | [#2] jquery.html Cycles:180 Average:35859.58 Median:24017.46 stddev:81827.62 (340.7%) stddev-sans-first:82014.27 19:08:23 INFO - PID 4995 | Values: 567.2 570.0 578.4 582.4 595.7 22032.7 22669.2 22844.7 22883.5 22938.7 24718.5 26702.3 26748.2 26852.6 26913.3 6306.8 6406.0 6449.5 6459.8 6461.0 6191.7 6411.8 6456.3 6480.6 6488.7 6779.8 6790.4 6791.9 6795.3 6799.7 6747.3 6764.2 6778.5 6779.7 6793.8 6639.9 6647.9 6654.3 6670.6 6677.7 30191.0 31225.5 31888.7 32291.5 32378.7 1929.4 1955.3 1965.0 1979.2 1981.1 19757.7 20215.3 20245.6 20313.4 20422.8 2397.8 2426.7 2496.5 2502.1 2510.7 139522.3 141787.0 142869.0 143420.0 144343.3 19746.2 20869.8 21308.9 21356.9 21990.0 22538.3 24056.5 44702.8 45024.0 45035.5 10133.2 10211.7 10365.2 10434.1 10943.3 9503.2 9512.1 9512.3 9626.4 9629.7 9058.8 9185.6 9427.2 9457.2 9517.3 2692.4 2766.4 2766.6 2771.7 2845.4 953.3 957.8 958.9 983.3 992.9 18753.7 18982.2 19282.9 19295.1 19396.3 986.2 990.9 1043.0 1051.1 1060.2 10304.2 10381.1 10542.1 11017.7 11207.7 452077.0 485060.0 486646.0 489643.0 504780.0 115682.0 116419.4 121098.0 121414.4 121435.4 1222.4 1266.9 1280.9 1288.3 1296.0 19674.8 20808.5 21034.8 21209.9 21301.7 59512.4 59785.7 60421.4 60701.7 62865.4 71624.6 71808.6 72043.0 72119.0 72189.3 14602.3 15159.7 15162.8 15234.5 15253.5 23986.8 24048.2 24189.8 24215.5 24294.2 18780.2 18881.0 19120.6 19145.8 19323.9 16316.8 17650.4 17842.2 17977.6 18080.6 19698.3 20646.8 20675.6 20732.5 20842.6 14718.0 14936.0 15137.2 15170.8 15204.7 19383.6 19446.8 19510.4 19530.0 19548.0 19:08:23 INFO - PID 4995 | 19:08:23 INFO - PID 4995 | [#3] mootools.html Cycles:180 Average:8449.20 Median:2555.78 stddev:5744.53 (224.8%) stddev-sans-first:5735.51 19:08:23 INFO - PID 4995 | Values: 1297.5 1362.4 1381.9 1384.7 1388.8 13485.0 14353.4 14373.9 14376.9 14390.9 13978.2 14171.2 14194.4 14251.6 14272.4 2530.0 2655.0 2676.7 2680.0 2681.9 2655.6 2665.5 2698.0 2701.9 2718.3 2561.9 2599.1 2605.4 2608.1 2654.0 2535.2 2549.2 2585.0 2588.8 2591.4 2499.6 2510.2 2538.7 2553.0 2558.6 13553.7 13694.3 13712.5 13718.7 13723.0 7266.6 7533.5 7631.2 7660.1 7670.4 4753.4 5020.6 5161.0 5161.8 5171.7 1709.0 1737.7 1742.8 1787.4 1791.4 21678.0 21688.7 21869.1 21886.7 21914.2 5992.9 6239.0 6263.8 6361.8 6434.2 15462.6 15463.2 15467.1 15476.7 15487.5 6527.6 7323.6 7578.8 7583.8 7590.6 6199.1 6523.0 6932.3 7098.8 7157.0 4675.7 4742.4 4844.2 4845.3 4891.4 1313.1 1354.6 1363.3 1373.2 1378.4 832.8 835.3 854.1 869.9 884.1 6326.9 6545.5 6648.5 6730.4 6797.5 693.6 709.5 725.9 728.6 739.6 4728.4 4874.6 4989.6 5015.7 5184.8 18236.4 18733.6 18832.2 18861.6 18875.7 17779.5 17906.4 18090.1 18437.1 18498.9 10110.1 10548.7 10570.4 10572.8 10725.9 7703.3 8111.4 8129.2 8271.0 8322.5 15322.8 15822.4 16320.0 16636.4 16670.0 15200.2 15982.0 16803.1 17105.7 17174.0 10994.4 11776.5 11791.1 11796.4 11800.6 13178.9 13264.7 13274.3 13280.7 13290.4 10791.1 10808.9 10885.6 10894.1 11038.4 9509.5 10151.2 10174.9 10243.1 10421.2 8592.1 9074.3 9076.0 9103.6 9118.9 6340.2 6379.4 6608.4 6672.3 6718.6 6765.1 6866.7 6983.2 7033.4 7042.6 19:08:23 INFO - PID 4995 | 19:08:23 INFO - PID 4995 | [#4] prototype.html Cycles:180 Average:5455.94 Median:6040.32 stddev:1530.77 (25.3%) stddev-sans-first:1489.19 19:08:23 INFO - PID 4995 | Values: 500.2 500.8 511.3 521.5 526.2 6134.8 6205.4 6239.9 6256.6 6256.9 5909.3 6037.8 6042.8 6110.9 6168.5 4860.8 4930.5 4937.0 4940.4 4959.6 4746.4 4768.9 4895.4 4926.2 4940.3 4839.2 4868.2 4935.6 4970.7 5009.7 4843.6 4913.6 4947.0 4967.2 4986.8 4418.8 4426.5 4438.7 4448.0 4449.7 5975.1 5982.8 6000.3 6028.5 6090.3 5522.6 5583.1 5645.8 5674.1 5707.6 6347.6 6368.4 6369.6 6395.5 6462.9 4808.6 4823.3 4824.6 4854.2 4861.5 6724.8 6787.8 6860.7 6869.5 6932.5 4918.3 4927.5 4944.4 4947.6 4971.3 5059.9 5086.0 5090.2 5094.2 5104.4 5693.8 5703.5 5709.1 5730.5 5739.6 6565.2 6565.5 6574.6 6576.5 6578.7 1662.9 1709.6 1715.6 1738.4 1767.7 1204.2 1219.4 1219.9 1234.0 1244.8 5593.8 5637.7 5640.9 5648.2 5686.1 6478.5 6478.5 6514.3 6526.7 6530.4 5526.4 5695.7 5712.7 5736.4 5744.9 3555.4 3556.2 3558.6 3561.6 3586.7 6370.6 6424.6 6432.3 6443.2 6453.2 6871.6 6873.8 6949.3 6950.6 6955.9 6435.6 6453.3 6496.1 6513.3 6528.6 6597.3 6651.3 6708.4 6725.5 6754.4 6525.3 6654.6 6736.4 6740.0 6750.2 6296.5 6332.6 6421.0 6471.3 6474.9 4835.9 4903.3 4969.6 4976.1 4985.8 6676.3 6692.9 6701.0 6728.7 6731.5 6462.7 6506.6 6522.5 6556.8 6557.0 6406.6 6430.4 6431.1 6480.8 6522.4 6123.0 6187.8 6381.2 6388.8 6388.8 6308.0 6387.6 6406.6 6463.4 6516.7 6191.5 6242.7 6255.2 6279.6 6417.6 19:08:23 INFO - PID 4995 | 19:08:23 INFO - PID 4995 | [#5] yui.html Cycles:180 Average:22902.53 Median:19935.05 stddev:30059.71 (150.8%) stddev-sans-first:30098.73 19:08:23 INFO - PID 4995 | Values: 922.9 931.3 942.1 948.1 950.3 18195.0 19028.1 19108.8 19131.9 21188.0 19922.7 19947.4 20122.9 20158.6 20171.5 1016.1 1040.1 1048.7 1051.4 1052.0 1040.4 1047.9 1051.2 1055.3 1055.6 1018.6 1104.9 1109.1 1109.9 1110.4 1099.8 1100.0 1100.9 1104.1 1104.9 800.2 802.1 802.7 802.8 804.7 19725.2 19851.4 20108.7 20162.7 20596.0 20159.8 20652.3 20676.2 21141.8 21149.8 16157.4 16507.6 16635.4 16683.2 16683.8 3465.9 3505.6 3505.8 3507.3 3508.2 115939.0 117728.4 119917.0 122680.0 125188.0 16508.6 17038.0 17093.7 17098.2 17115.4 28682.1 30076.8 30253.8 30311.8 30373.0 8336.4 8627.1 8650.7 8681.0 8795.3 4122.0 4205.1 4205.7 4206.5 4214.1 5333.1 5453.3 5628.9 5852.1 5879.1 1067.1 1082.9 1100.7 1108.3 1108.5 663.8 671.1 686.3 707.0 716.4 12290.4 12634.3 13008.3 13291.5 13575.2 700.1 701.8 706.9 728.4 729.2 5275.9 5435.3 5487.8 5654.5 5778.2 97956.5 100151.0 104740.9 106143.5 107143.5 86544.6 89292.4 89768.6 90587.0 94667.1 77593.2 78607.2 79093.2 80138.2 82655.2 10622.6 11004.4 12207.5 12248.6 12503.0 33839.5 36227.6 36339.8 36361.0 37699.1 63887.0 65977.3 66200.3 67910.0 71548.3 18010.0 18553.2 18636.9 18765.5 18823.9 20781.7 21270.4 21382.6 21417.7 21500.6 16783.7 16801.6 19500.7 19542.1 19775.4 19072.2 19119.4 19306.9 19405.4 19419.9 18088.3 18578.3 18741.7 18908.8 19540.9 12773.0 12904.5 13129.2 13139.9 13511.9 13640.3 14159.4 14317.9 14351.6 14549.9 19:08:23 INFO - PID 4995 | -------- Summary: end -------- 19:08:23 INFO - PID 4995 | 19:08:24 INFO - TEST-INFO | 4995: exit 0 19:08:24 INFO - TEST-OK | dromaeo_css | took 1113244ms 19:08:24 INFO - TEST-START | kraken 19:08:24 INFO - Initialising browser for kraken test... 19:08:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52436/getInfo.html -profile /tmp/tmp82FSq0/profile 19:08:24 INFO - TEST-INFO | started process 5374 (/builds/slave/test/build/application/firefox/firefox http://localhost:52436/getInfo.html) 19:08:29 INFO - TEST-INFO | 5374: exit 0 19:08:29 INFO - Browser initialized. 19:08:29 INFO - Running cycle 1/1 for kraken test... 19:08:29 INFO - TEST-INFO | started process 5603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp82FSq0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:30 INFO - PID 5603 | 19:08:30 INFO - PID 5603 | (/builds/slave/test/build/application/firefox/firefox:5657): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:08:30 INFO - PID 5603 | 19:08:41 INFO - PID 5603 | RSS: Main: 172978176 19:08:41 INFO - PID 5603 | 19:08:43 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52436/tests/kraken/driver.html?testName=audio-beat-detection) 19:08:44 INFO - PID 5603 | RSS: Main: 177815552 19:08:44 INFO - PID 5603 | 19:08:47 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52436/tests/kraken/driver.html?testName=audio-dft) 19:08:48 INFO - PID 5603 | RSS: Main: 178450432 19:08:48 INFO - PID 5603 | 19:08:51 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52436/tests/kraken/driver.html?testName=audio-fft) 19:08:51 INFO - PID 5603 | RSS: Main: 173084672 19:08:51 INFO - PID 5603 | 19:08:53 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52436/tests/kraken/driver.html?testName=audio-oscillator) 19:08:54 INFO - PID 5603 | RSS: Main: 173518848 19:08:54 INFO - PID 5603 | 19:08:56 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52436/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:08:57 INFO - PID 5603 | RSS: Main: 174034944 19:08:57 INFO - PID 5603 | 19:09:00 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52436/tests/kraken/driver.html?testName=imaging-darkroom) 19:09:01 INFO - PID 5603 | RSS: Main: 176721920 19:09:01 INFO - PID 5603 | 19:09:04 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52436/tests/kraken/driver.html?testName=imaging-desaturate) 19:09:05 INFO - PID 5603 | RSS: Main: 176517120 19:09:05 INFO - PID 5603 | 19:09:08 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52436/tests/kraken/driver.html?testName=json-parse-financial) 19:09:08 INFO - PID 5603 | RSS: Main: 176926720 19:09:08 INFO - PID 5603 | 19:09:10 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52436/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:09:10 INFO - PID 5603 | RSS: Main: 176857088 19:09:10 INFO - PID 5603 | 19:09:12 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:09:13 INFO - PID 5603 | RSS: Main: 174034944 19:09:13 INFO - PID 5603 | 19:09:15 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:09:16 INFO - PID 5603 | RSS: Main: 173916160 19:09:16 INFO - PID 5603 | 19:09:18 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:09:19 INFO - PID 5603 | RSS: Main: 174448640 19:09:19 INFO - PID 5603 | 19:09:22 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:09:23 INFO - PID 5603 | RSS: Main: 174329856 19:09:23 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52436/tests/kraken/driver.html?testName=ai-astar) 19:09:25 INFO - PID 5603 | RSS: Main: 176062464 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | __start_tp_report 19:09:25 INFO - PID 5603 | _x_x_mozilla_page_load 19:09:25 INFO - PID 5603 | _x_x_mozilla_page_load_details 19:09:25 INFO - PID 5603 | |i|pagename|runs| 19:09:25 INFO - PID 5603 | |0;ai-astar;99;109;104;107;108;109;110;100;110;110 19:09:25 INFO - PID 5603 | |1;audio-beat-detection;153;118;142;187;124;141;156;128;175;118 19:09:25 INFO - PID 5603 | |2;audio-dft;164;164;162;163;162;162;163;163;165;162 19:09:25 INFO - PID 5603 | |3;audio-fft;74;74;77;174;75;75;75;77;159;80 19:09:25 INFO - PID 5603 | |4;audio-oscillator;79;79;131;78;79;79;129;79;80;134 19:09:25 INFO - PID 5603 | |5;imaging-gaussian-blur;114;114;115;114;115;116;114;114;114;114 19:09:25 INFO - PID 5603 | |6;imaging-darkroom;154;154;152;151;151;151;149;150;149;149 19:09:25 INFO - PID 5603 | |7;imaging-desaturate;94;93;94;93;93;94;94;94;98;98 19:09:25 INFO - PID 5603 | |8;json-parse-financial;65;55;55;55;55;56;54;57;56;54 19:09:25 INFO - PID 5603 | |9;json-stringify-tinderbox;54;55;54;54;53;54;54;54;54;54 19:09:25 INFO - PID 5603 | |10;stanford-crypto-aes;86;90;77;78;78;78;78;82;82;78 19:09:25 INFO - PID 5603 | |11;stanford-crypto-ccm;134;133;127;133;136;123;132;128;123;168 19:09:25 INFO - PID 5603 | |12;stanford-crypto-pbkdf2;175;179;184;178;178;179;172;170;185;182 19:09:25 INFO - PID 5603 | |13;stanford-crypto-sha256-iterative;69;74;67;79;80;67;66;73;72;67 19:09:25 INFO - PID 5603 | __end_tp_report 19:09:25 INFO - PID 5603 | __start_cc_report 19:09:25 INFO - PID 5603 | _x_x_mozilla_cycle_collect,965 19:09:25 INFO - PID 5603 | __end_cc_report 19:09:25 INFO - PID 5603 | __startTimestamp1501121365371__endTimestamp 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | ------- Summary: start ------- 19:09:25 INFO - PID 5603 | Number of tests: 14 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#0] ai-astar Cycles:10 Average:106.60 Median:109.50 stddev:4.17 (3.8%) stddev-sans-first:3.40 19:09:25 INFO - PID 5603 | Values: 99.0 109.0 104.0 107.0 108.0 109.0 110.0 100.0 110.0 110.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:147.50 stddev:23.70 (16.1%) stddev-sans-first:24.92 19:09:25 INFO - PID 5603 | Values: 153.0 118.0 142.0 187.0 124.0 141.0 156.0 128.0 175.0 118.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.05 (0.6%) stddev-sans-first:1.05 19:09:25 INFO - PID 5603 | Values: 164.0 164.0 162.0 163.0 162.0 162.0 163.0 163.0 165.0 162.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:38.42 (51.2%) stddev-sans-first:40.06 19:09:25 INFO - PID 5603 | Values: 74.0 74.0 77.0 174.0 75.0 75.0 75.0 77.0 159.0 80.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:25.31 (32.0%) stddev-sans-first:26.20 19:09:25 INFO - PID 5603 | Values: 79.0 79.0 131.0 78.0 79.0 79.0 129.0 79.0 80.0 134.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 19:09:25 INFO - PID 5603 | Values: 114.0 114.0 115.0 114.0 115.0 116.0 114.0 114.0 114.0 114.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:1.89 (1.2%) stddev-sans-first:1.66 19:09:25 INFO - PID 5603 | Values: 154.0 154.0 152.0 151.0 151.0 151.0 149.0 150.0 149.0 149.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.90 (2.0%) stddev-sans-first:2.01 19:09:25 INFO - PID 5603 | Values: 94.0 93.0 94.0 93.0 93.0 94.0 94.0 94.0 98.0 98.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.50 stddev:3.22 (5.8%) stddev-sans-first:0.97 19:09:25 INFO - PID 5603 | Values: 65.0 55.0 55.0 55.0 55.0 56.0 54.0 57.0 56.0 54.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 19:09:25 INFO - PID 5603 | Values: 54.0 55.0 54.0 54.0 53.0 54.0 54.0 54.0 54.0 54.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:4.32 (5.4%) stddev-sans-first:4.14 19:09:25 INFO - PID 5603 | Values: 86.0 90.0 77.0 78.0 78.0 78.0 78.0 82.0 82.0 78.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:133.00 stddev:12.88 (9.7%) stddev-sans-first:13.66 19:09:25 INFO - PID 5603 | Values: 134.0 133.0 127.0 133.0 136.0 123.0 132.0 128.0 123.0 168.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:179.00 stddev:4.85 (2.7%) stddev-sans-first:5.00 19:09:25 INFO - PID 5603 | Values: 175.0 179.0 184.0 178.0 178.0 179.0 172.0 170.0 185.0 182.0 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:72.50 stddev:5.10 (7.0%) stddev-sans-first:5.34 19:09:25 INFO - PID 5603 | Values: 69.0 74.0 67.0 79.0 80.0 67.0 66.0 73.0 72.0 67.0 19:09:25 INFO - PID 5603 | -------- Summary: end -------- 19:09:25 INFO - PID 5603 | 19:09:25 INFO - PID 5603 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:09:26 INFO - TEST-INFO | 5603: exit 0 19:09:26 INFO - TEST-OK | kraken | took 61978ms 19:09:26 INFO - SUITE-END | took 1175s 19:09:26 INFO - Completed test suite (00:19:35) 19:09:26 INFO - javascript benchmark 19:09:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8483.551263839678, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3086.567880496731, 3104.1618762934, 3123.2191952012, 3144.2296637323857, 3151.6060492438446, 6163.106349579309, 6201.968990155043, 6205.751769929203, 6248.062790581409, 6249.218847644044, 6002.0, 6085.2089228400355, 6106.236720409949, 6118.877622447549, 6139.72371243294, 5622.184783206432, 5631.887362252753, 5643.68959707216, 5669.121286200645, 5680.318361796591, 5665.433456654343, 5673.092305231164, 5684.687342196177, 5689.971550142264, 5690.829275121753, 5712.086066229404, 5746.051901436279, 5781.768729250825, 5800.622959507618, 5809.73856176471, 5686.886262274773, 5745.540356771448, 5754.338251101093, 5757.107648314518, 5762.481376676119, 5459.290292262021, 5581.748821303051, 5609.943900561024, 5632.605717599769, 5674.914876276818, 6036.788712395045, 6109.419605137505, 6109.938900610981, 6169.598976066542, 6180.969095154541, 6606.735730570771, 6616.8345791355605, 6675.46596272297, 6676.766313179064, 6684.565503242274, 6558.475321974231, 6622.37087476689, 6634.635095069769, 6645.6344901030425, 6649.900251496183, 6125.050617154348, 6131.570790044743, 6139.631622102688, 6140.201773769381, 6142.385761423822, 6739.056532085512, 6740.056392105109, 6756.932430675729, 6757.087793147862, 6758.966205169041, 6383.2978372379, 6421.5825971311715, 6438.45273151778, 6456.612603243821, 6463.7737679181, 6532.05285233648, 6532.118164047888, 6546.574472659262, 6548.050532672736, 6550.672466376757, 6532.902006469907, 6535.379138981789, 6539.346065393518, 6641.435477984329, 6652.234992975773, 6546.738130474728, 6555.147830781968, 6569.967150164219, 6660.433863121592, 6675.766348177887, 5234.18870075139, 5247.475252474798, 5319.840404787863, 5357.919631205535, 5362.544183744425, 4597.310403439511, 4615.676902616851, 4657.650676199299, 4679.766011699401, 4684.039771846763, 5581.6930068846605, 5778.306603207642, 5799.971000144972, 5806.30324361071, 5810.244668193108, 6586.440152586988, 6637.103990961158, 6650.467962562983, 6656.034874943106, 6659.0, 5732.799352022743, 5745.9425405745405, 5754.395788442237, 5783.392743761929, 5788.623739456922, 5710.086386178275, 5801.564882633819, 5801.88396232073, 5865.648061116347, 5872.823815285548, 6277.1525844010475, 6399.232092148972, 6405.455536279375, 6490.415862572391, 6492.156019717407, 6347.587406818542, 6627.204735431779, 6635.0, 6657.567258128206, 6684.532082754355, 6364.07720880479, 6466.902996455151, 6468.126802881551, 6514.413702766774, 6540.182477190351, 6507.186601674791, 6533.444657204001, 6596.340365963365, 6617.933820661732, 6626.171728533934, 6496.837579060372, 6605.504587155887, 6629.668516574248, 6634.933650663432, 6758.020087087247, 6502.934970650233, 6519.250286217146, 6522.412982831568, 6525.836854078686, 6528.37980391862, 6430.164078669743, 6437.1631687882145, 6477.319881412383, 6527.477801775752, 6530.314316996647, 6370.203724534434, 6372.044193371032, 6449.580777249652, 6450.741970321134, 6467.514936379696, 6351.71417286214, 6449.193850768654, 6468.223813142453, 6472.093906852951, 6563.146790917151, 6217.782377616762, 6275.058741188858, 6275.560710750204, 6276.184096067482, 6276.811695649138], "value": 6039.040369979107, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.2060608482387, 860.264473874837, 879.2965627498002, 888.8622263549148, 1171.1041053594008, 30674.23314417141, 31165.065048048567, 31347.373052538936, 42781.0, 43128.78435607818, 43822.0, 44249.77875110628, 44310.55689443104, 44348.556514434844, 44536.0, 7252.0, 7632.732854350085, 7697.153313135551, 7778.766637000899, 7878.0, 7697.653605587762, 7788.14330423653, 7817.765467035998, 7818.296353328199, 7821.687132514721, 7781.961090194541, 7782.260685234894, 7813.335866451358, 7829.765107046797, 7851.371890248766, 7746.535207887545, 7770.145284018753, 7776.416768742367, 7805.219478052206, 7823.295903368724, 7625.923740762632, 7688.461807673465, 7744.49660772048, 7745.573993430359, 7750.651220695026, 39370.40944385836, 39932.600673993176, 40227.19545609101, 40306.596934030575, 40314.59685403167, 3536.0275924120815, 3552.467129930531, 3575.5888072871694, 3575.9808454590316, 3581.230035542345, 32091.0, 32092.839535802406, 32194.195145121324, 32225.516617250527, 32236.19409514781, 4675.976620116878, 4900.0, 4926.975365123188, 4939.110960027194, 4954.826581069645, 195908.0, 197555.0, 197990.0, 198432.99999999854, 198491.0075449628, 49336.0, 49365.50634493681, 49453.50546494561, 49518.50481495211, 49593.0, 52035.73982130065, 52314.0, 52351.738241309315, 52352.0, 52377.73811130996, 14341.780948619484, 14343.928280358532, 14450.494232701805, 14473.348699308557, 14482.782758258634, 9379.390339627902, 9597.23222142227, 11540.653780386601, 11979.34113623759, 12105.273683579013, 14698.55904322872, 14715.117092974457, 14819.481318153812, 14851.554453366416, 15013.624659383602, 5818.661707807228, 5923.703814809242, 5948.762049517971, 5976.894274559134, 6079.787207447806, 970.3886551472527, 983.537737263485, 990.5245482168599, 1020.0768304684273, 1034.6171916390983, 21748.565028699653, 21912.89043554772, 21970.89014554949, 21996.0, 22236.221732239293, 1109.3399427340719, 1113.6269349767917, 1118.3290025984345, 1127.475723788426, 1127.9661610151709, 11930.403479826147, 11936.701582460335, 11942.641720748392, 11952.40237988097, 11979.221350612183, 219704.0, 221137.0, 221551.0, 221795.0, 221905.0, 52698.47301527012, 52892.206616900774, 52899.206511902354, 53035.0, 53191.0, 1448.507507447494, 1453.3024148408822, 1493.2309860421892, 1493.432495651667, 1501.9173945433106, 21687.674684879425, 22044.33866983993, 22487.550248995256, 22789.658155128018, 23094.42263943415, 49349.75325123352, 52499.73750131225, 52692.736536317076, 53006.4699353017, 53072.46927530675, 203135.0, 203534.0, 203678.0, 203710.0, 205044.0, 35673.64326356807, 36393.454098189075, 36747.81626091959, 36776.0, 37188.0, 46013.0, 46116.847078823295, 46263.30605040994, 46452.53547464482, 46673.29990050084, 32129.0, 34340.0, 35391.82304088463, 35525.644743552235, 35689.1077723059, 33266.16834579155, 34165.316693666486, 34914.65085349216, 34958.12604684802, 35435.64564354427, 38135.04662383463, 38412.61587384202, 38561.22877542378, 38736.61263387443, 39232.607673922896, 32810.835945820116, 33464.832675836464, 33617.49573756347, 33674.0, 33724.831375842965, 22712.772872271067, 23268.767312327338, 23603.881980589988, 24437.0, 24747.752522474544], "value": 17430.979838361996, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.2370661460337, 569.9800506982257, 578.3840210176164, 582.4001278682957, 595.6932179927337, 22032.669509957363, 22669.206577769783, 22844.657330140042, 22883.542329153406, 22938.65592016121, 24718.50562988739, 26702.332441688966, 26748.197554073362, 26852.5972110418, 26913.32716682084, 6306.779262725817, 6406.007068904327, 6449.451796597272, 6459.773907913224, 6461.030845373208, 6191.659458729768, 6411.775587854426, 6456.289808121103, 6480.6435646039445, 6488.708008139645, 6779.76270830521, 6790.388865002149, 6791.932080679179, 6795.32046795319, 6799.660016999155, 6747.291534388867, 6764.222114456851, 6778.49161312901, 6779.694913728869, 6793.762218322359, 6639.867202655968, 6647.900281495781, 6654.26803051664, 6670.599764014175, 6677.699503522354, 30191.0, 31225.53161702576, 31888.681113188803, 32291.51562726561, 32378.676213237803, 1929.4211736479, 1955.3058664174155, 1964.980350196494, 1979.2281010405952, 1981.1184023109722, 19757.703634445494, 20215.29246476366, 20245.595088098304, 20313.390598281927, 20422.79577204224, 2397.784199422043, 2426.7087949446004, 2496.5131799299143, 2502.0867383405107, 2510.7363726808603, 139522.30238848843, 141787.0, 142869.0, 143420.0, 144343.27828360896, 19746.210151594063, 20869.791302086785, 21308.893455532623, 21356.893215534135, 21990.0, 22538.323850284516, 24056.51886962251, 44702.776486117364, 45024.0, 45035.54964450379, 10133.189344852393, 10211.7447063824, 10365.222608304257, 10434.113100386401, 10943.343399396063, 9503.239740820718, 9512.09635084666, 9512.334136610509, 9626.374285671409, 9629.711108666752, 9058.773530661787, 9185.586648600829, 9427.198688111588, 9457.19613832832, 9517.333786634868, 2692.4345887363875, 2766.4467106578763, 2766.61267422561, 2771.708970558103, 2845.4166895786316, 953.3136141977903, 957.8323793336139, 958.8705524754068, 983.311681822727, 992.8560358747941, 18753.7186942196, 18982.240710371705, 19282.90358548198, 19295.131719072677, 19396.32112876071, 986.2455221755363, 990.9355891867006, 1042.968710938673, 1051.0908064524285, 1060.1571750458404, 10304.227182961307, 10381.117605003508, 10542.051215390651, 11017.724556886142, 11207.719807004727, 452077.0, 485060.0, 486646.0, 489643.0, 504780.0, 115682.0, 116419.41790291163, 121098.0, 121414.39292803656, 121435.39282303532, 1222.394914517302, 1266.866978967195, 1280.8783165599252, 1288.2528133682442, 1296.0344543315102, 19674.80325196787, 20808.479788004814, 21034.78965210328, 21209.89395053015, 21301.6804747932, 59512.404875952416, 59785.70107149436, 60421.395786041576, 60701.69649151726, 62865.37134628595, 71624.64187679028, 71808.64095679489, 72043.0, 72119.0, 72189.27810722035, 14602.269886505419, 15159.696806063597, 15162.848371516144, 15234.466793662168, 15253.542393728207, 23986.760132398453, 24048.15831445891, 24189.75810241875, 24215.51568968646, 24294.17793665447, 18780.248790048245, 18881.0, 19120.61758764845, 19145.8085419144, 19323.903380483007, 16316.836831631532, 17650.382236621655, 17842.19710113022, 17977.550561236072, 18080.638387232444, 19698.31055913036, 20646.793532064486, 20675.586488269848, 20732.481687957923, 20842.583148337253, 14718.0433271837, 14936.0, 15137.243137843285, 15170.772438413653, 15204.695906082037, 19383.612327753646, 19446.8055319445, 19510.414687559394, 19530.0, 19548.0], "value": 12568.629526446066, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.487492440486, 1362.3869258833527, 1381.9309034548273, 1384.6953670192554, 1388.8125103111076, 13485.0, 14353.35409906554, 14373.856261437382, 14376.856231437709, 14390.856091439082, 13978.161310321388, 14171.220582867938, 14194.432222711079, 14251.57245282643, 14272.357743901523, 2529.962050569243, 2654.973450265497, 2676.6787985441774, 2680.0485827531143, 2681.892724291026, 2655.6414883990606, 2665.506881226979, 2697.973020269792, 2701.8649067546644, 2718.293243756628, 2561.9359516012064, 2599.116300457844, 2605.4398304364654, 2608.11324149789, 2653.9601905971426, 2535.1760677779794, 2549.247971848309, 2584.974150258511, 2588.844669319828, 2591.4298854252033, 2499.550080985422, 2510.2092840755286, 2538.695356557225, 2552.961705574418, 2558.590625499911, 13553.728925421436, 13694.315284235849, 13712.45150193991, 13718.725625487434, 13723.0, 7266.564006159648, 7533.547987120735, 7631.198724133997, 7660.119086305091, 7670.424718146106, 4753.382060332135, 5020.573251273646, 5161.045206636784, 5161.81933632321, 5171.715555644438, 1708.9572760680958, 1737.652469506104, 1742.8082910879793, 1787.4012205911035, 1791.435697755203, 21678.0, 21688.674669879965, 21869.12523499074, 21886.671699924515, 21914.23300184486, 5992.880142397127, 6239.0, 6263.812085637347, 6361.840953976188, 6434.195725534309, 15462.613434664223, 15463.226838658022, 15467.071975681494, 15476.690466190614, 15487.457938972082, 6527.5757075789925, 7323.633818309063, 7578.810529736801, 7583.848323033509, 7590.582517961455, 6199.070139479114, 6522.967385163044, 6932.306769323128, 7098.751543695946, 7157.033800436874, 4675.719456832601, 4742.359781429463, 4844.176489996709, 4845.3216549683075, 4891.413030436299, 1313.080843409617, 1354.5800801751489, 1363.2842757552364, 1373.169232614274, 1378.4141739760562, 832.8292699996607, 835.3233880556769, 854.1031916487788, 869.9347548933855, 884.0540621535024, 6326.905096423558, 6545.541812073205, 6648.501362397839, 6730.414861297795, 6797.490188235902, 693.6115775165923, 709.5281637710967, 725.8729722298576, 728.6320408193934, 739.5525706947327, 4728.432588089451, 4874.599095599534, 4989.575886049726, 5015.749212539358, 5184.7926082956255, 18236.361727339743, 18733.625327493373, 18832.152553135144, 18861.622767544573, 18875.716864247046, 17779.46661600154, 17906.373276935246, 18090.095495225185, 18437.07814609291, 18498.907505462656, 10110.140638045848, 10548.736281592868, 10570.365778053341, 10572.84140737905, 10725.89274107249, 7703.3067023968115, 8111.351091912751, 8129.187081291823, 8270.958645206736, 8322.54226017575, 15322.770158447409, 15822.446214382442, 16320.0, 16636.417725379553, 16670.0, 15200.163990980602, 15982.0, 16803.07583082942, 17105.743413848555, 17174.0, 10994.395308258123, 11776.470058847544, 11791.115666325231, 11796.410179491162, 11800.586979455678, 13178.868211317764, 13264.668383290495, 13274.336283185996, 13280.734385312433, 13290.401931912893, 10791.082757965662, 10808.891911081104, 10885.619003334845, 10894.128469722245, 11038.448077595927, 9509.476978766234, 10151.187904967732, 10174.898251017396, 10243.129334006693, 10421.166306695597, 8592.054873963734, 9074.27405807547, 9076.001639819746, 9103.590338434919, 9118.908810912071, 6340.207474065742, 6379.393957574023, 6608.372204640552, 6672.266050734513, 6718.630475323904, 6765.086713293643, 6866.725330986705, 6983.1620205575655, 7033.366996970092, 7042.647867606702], "value": 6129.406609100926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.24213316825006, 500.7834037405049, 511.2586749213641, 521.5384384819434, 526.1502673182808, 6134.754609815614, 6205.379462053798, 6239.875202495948, 6256.624602523846, 6256.873762722708, 5909.340796641507, 6037.849053773658, 6042.788502402417, 6110.908336374958, 6168.457885528618, 4860.805567777294, 4930.506949305059, 4936.950630493685, 4940.407151141868, 4959.578435832958, 4746.430428348603, 4768.928466073012, 4895.4125504939275, 4926.211806111023, 4940.333055037578, 4839.201531747258, 4868.221084626461, 4935.629827762914, 4970.707616019843, 5009.724465154415, 4843.612510999112, 4913.582345500655, 4946.950530494703, 4967.218357719688, 4986.750662466862, 4418.7848341706285, 4426.468823741139, 4438.733675979419, 4447.955520444819, 4449.733016019017, 5975.133605627203, 5982.760689572412, 6000.309964354112, 6028.457438830483, 6090.299615544181, 5522.5581953443625, 5583.106702927553, 5645.774169033275, 5674.120511320752, 5707.571932105108, 6347.619142851444, 6368.395002474757, 6369.6496692681885, 6395.456386207178, 6462.870742585122, 4808.591269742041, 4823.321378263079, 4824.614030877521, 4854.223324268136, 4861.465238823726, 6724.7646332378135, 6787.762428314985, 6860.725570977155, 6869.450443964471, 6932.514723969374, 4918.262260660858, 4927.507249275115, 4944.415298908263, 4947.60419166473, 4971.328870602422, 5059.949400506021, 5086.033653605803, 5090.211017292251, 5094.2103973884105, 5104.3619547556555, 5693.829185124453, 5703.458171473703, 5709.143628455682, 5730.455606717355, 5739.569532285095, 6565.179352580927, 6565.540412171198, 6574.638394888327, 6576.539642224999, 6578.736850526021, 1662.9334826607042, 1709.6495218480181, 1715.5882588178747, 1738.3828740796835, 1767.7184041570017, 1204.1811568133753, 1219.3842109734705, 1219.8902098810972, 1233.9876601233873, 1244.7883859743865, 5593.8321850344555, 5637.68992705397, 5640.915386269209, 5648.209250704905, 5686.147077938343, 6478.514111441661, 6478.546501744832, 6514.348565143448, 6526.715649522724, 6530.35520614152, 5526.392096869341, 5695.661519542904, 5712.685802280831, 5736.397678243808, 5744.913826292609, 3555.36003519369, 3556.1820781220463, 3558.5907620623443, 3561.6260292669413, 3586.7130629549574, 6370.617762934239, 6424.550281480251, 6432.292447830735, 6443.194600674916, 6453.161089058486, 6871.587704737732, 6873.828154296182, 6949.339812717783, 6950.644624298315, 6955.89566156508, 6435.646039467874, 6453.322136244704, 6496.090547323379, 6513.316101809241, 6528.640924749185, 6597.2742998271115, 6651.301613330531, 6708.362705542965, 6725.49558783103, 6754.425873800782, 6525.314841941527, 6654.633995130314, 6736.4274036705465, 6740.046066141284, 6750.223724271772, 6296.464800492009, 6332.588381755171, 6421.004744264646, 6471.282061534072, 6474.902876456763, 4835.854924352275, 4903.289023091703, 4969.608509617313, 4976.109078550127, 4985.775640096277, 6676.298988606127, 6692.866142677021, 6701.0, 6728.7308507659145, 6731.4951378647775, 6462.676866156768, 6506.60960342381, 6522.510456905533, 6556.8360790980605, 6556.967215163893, 6406.615603063831, 6430.3891130342545, 6431.070678796436, 6480.837979050561, 6522.412982831568, 6122.969385153046, 6187.752489900354, 6381.234251889803, 6388.8083357499345, 6388.840278993062, 6308.0, 6387.616742995435, 6406.615603063831, 6463.418292353711, 6516.73933042673, 6191.492445559556, 6242.687865606611, 6255.24937007562, 6279.560430769802, 6417.582857114273], "value": 5006.870692412484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [922.9353945223833, 931.2689538712112, 942.100294219021, 948.1135138645362, 950.3157726436963, 18195.0, 19028.14373353199, 19108.808911910895, 19131.90434047828, 21188.0, 19922.70115948258, 19947.40157795265, 20122.899385503053, 20158.59682806343, 20171.495712607157, 1016.085523029274, 1040.089921318846, 1048.6696690542492, 1051.3534176481485, 1052.0373857920033, 1040.3965699894043, 1047.8585390972198, 1051.1800795379577, 1055.2771351624162, 1055.625253035173, 1018.5518371916334, 1104.9226554141214, 1109.1293334732236, 1109.9112071034338, 1110.4281295133012, 1099.8185299425625, 1100.0044959311756, 1100.9339439633607, 1104.0615476844698, 1104.9392283424409, 800.1838125112411, 802.077610747639, 802.6829402386084, 802.8153524689354, 804.6741069866713, 19725.21099156032, 19851.404457866287, 20108.698369524467, 20162.69755953662, 20596.0, 20159.79840201594, 20652.27717029912, 20676.17295308186, 21141.788582114135, 21149.788502114934, 16157.434489792919, 16507.58731031722, 16635.41776037845, 16683.165841707865, 16683.83316166847, 3465.930681386383, 3505.5618047744033, 3505.8247087645514, 3507.2985402919517, 3508.2281897982402, 115939.0, 117728.41135794352, 119917.0, 122680.0, 125188.0, 16508.587285317964, 17038.0, 17093.743593846102, 17098.230579623945, 17115.400960966308, 28682.13953581396, 30076.84961575178, 30253.848730756206, 30311.848440757654, 30373.0, 8336.416450848503, 8627.137286271323, 8650.6972255972, 8680.956595216983, 8795.340349473816, 4121.97939010309, 4205.137946720914, 4205.705600607928, 4206.516250631216, 4214.136102099063, 5333.120035194227, 5453.263809385761, 5628.943710562924, 5852.092925596539, 5879.118132280192, 1067.066316972649, 1082.86464191976, 1100.6697990602788, 1108.3128460354633, 1108.4900945564968, 663.8207683925314, 671.090672139254, 686.3136863136863, 706.9505134640629, 716.4411758828122, 12290.385480725929, 12634.305113218677, 13008.284544349963, 13291.468341266434, 13575.185488870698, 700.1423256510835, 701.7543859649082, 706.8974998625273, 728.4136270302457, 729.2415887476965, 5275.920861187085, 5435.266239057677, 5487.835364939058, 5654.5193658538665, 5778.248827652378, 97956.51021744988, 100151.0, 104740.8577742669, 106143.4692826531, 107143.46428267965, 86544.56727716321, 89292.35920124357, 89768.5511572438, 90587.0, 94667.0533294672, 77593.22406776086, 78607.21392786113, 79093.20906790858, 80138.19861801308, 82655.17344826474, 10622.628208012682, 11004.449777511252, 12207.511699531919, 12248.632541023784, 12503.0, 33839.492407614394, 36227.63772362243, 36339.81830090833, 36361.0, 37699.05752356213, 63887.0, 65977.34022659712, 66200.33799661942, 67910.0, 71548.28451715416, 18010.0, 18553.16510757046, 18636.906815465834, 18765.530861728566, 18823.90588047051, 20781.688274676195, 21270.36188914335, 21382.572348553254, 21417.678734818677, 21500.56998859983, 16783.664326713155, 16801.579960501087, 19500.707489387954, 19542.120604572545, 19775.40673779789, 19072.237110515423, 19119.42641720695, 19306.90346548258, 19405.4178374649, 19419.902900485406, 18088.276468941094, 18578.25686972506, 18741.718874216625, 18908.810911890705, 19540.90229548843, 12773.0, 12904.483820647069, 13129.218732044688, 13139.868601313865, 13511.932440337736, 13640.254641701194, 14159.433622654979, 14317.928410357881, 14351.569452916428, 14549.854501455273], "value": 9180.673538826979, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 104.0, 107.0, 108.0, 109.0, 110.0, 100.0, 110.0, 110.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 118.0, 142.0, 187.0, 124.0, 141.0, 156.0, 128.0, 175.0, 118.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 163.0, 162.0, 162.0, 163.0, 163.0, 165.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 174.0, 75.0, 75.0, 75.0, 77.0, 159.0, 80.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 131.0, 78.0, 79.0, 79.0, 129.0, 79.0, 80.0, 134.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 115.0, 116.0, 114.0, 114.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 152.0, 151.0, 151.0, 151.0, 149.0, 150.0, 149.0, 149.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 98.0, 98.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 55.0, 55.0, 55.0, 55.0, 56.0, 54.0, 57.0, 56.0, 54.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 77.0, 78.0, 78.0, 78.0, 78.0, 82.0, 82.0, 78.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 127.0, 133.0, 136.0, 123.0, 132.0, 128.0, 123.0, 168.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 184.0, 178.0, 178.0, 179.0, 172.0, 170.0, 185.0, 182.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 67.0, 79.0, 80.0, 67.0, 66.0, 73.0, 72.0, 67.0], "value": 71.4, "unit": "score"}]}]} 19:09:26 INFO - Return code: 0 19:09:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:09:26 INFO - # TBPL SUCCESS # 19:09:26 INFO - Running post-action listener: _package_coverage_data 19:09:26 INFO - Running post-action listener: _resource_record_post_action 19:09:26 INFO - [mozharness: 2017-07-27 02:09:26.631580Z] Finished run-tests step (success) 19:09:26 INFO - Running post-run listener: _resource_record_post_run 19:09:26 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 445206528; Read time: 12; Write time: 404368 19:09:26 INFO - TinderboxPrint: CPU usage
13.2% 19:09:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:09:26 INFO - TinderboxPrint: I/O write bytes / time
445,206,528 / 404,368 19:09:26 INFO - TinderboxPrint: CPU idle
8,266.0 (86.8%) 19:09:26 INFO - TinderboxPrint: CPU user
1,203.4 (12.6%) 19:09:26 INFO - TinderboxPrint: Swap in / out
0 / 0 19:09:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119447552; Read time: 0; Write time: 119436 19:09:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:09:26 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 325758976; Read time: 0; Write time: 284932 19:09:27 INFO - Running post-run listener: _upload_blobber_files 19:09:27 INFO - Blob upload gear active. 19:09:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:09:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:09:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:09:27 INFO - (blobuploader) - INFO - Open directory for files ... 19:09:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:09:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:09:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:28 INFO - (blobuploader) - INFO - Done attempting. 19:09:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:09:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:09:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:31 INFO - (blobuploader) - INFO - Done attempting. 19:09:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:09:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:09:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:32 INFO - (blobuploader) - INFO - Done attempting. 19:09:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:09:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:09:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:33 INFO - (blobuploader) - INFO - Done attempting. 19:09:33 INFO - (blobuploader) - INFO - Iteration through files over. 19:09:33 INFO - Return code: 0 19:09:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:09:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:09:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c31d155a3c3deae4f1a1cb8333f294df24c8cb66ce5de7427c5e6bfc77e8dc434296ae7a2618d86e8c04c1d47fd832ccb687f23c5d8836ec303414e13ce24d2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f1ebd05f3a61a3ac30ca59c782edcb13abe0cfe16f69be48119dc146bc8e5b04a9013d37ca24aa8c508dd590b7ef4cf2bc318ffd58e8697a19fa4a1776d07a5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e961b537f7a14a0739151295e750e0d7f2ac82b74a2dacfe5f43a571b15fadc321eedcd233ecd5094d347214052ca7016210441d1df50982c4c36f91372ee60", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70cefe2119127993589515a4b3b8db2f1bf1082bde179044e5dcecebadb5e42bc2cb1a195768283548cc29859e4d3aa6fa952025fd6dcca36326581f96345199"} 19:09:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:09:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:09:33 INFO - Contents: 19:09:33 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c31d155a3c3deae4f1a1cb8333f294df24c8cb66ce5de7427c5e6bfc77e8dc434296ae7a2618d86e8c04c1d47fd832ccb687f23c5d8836ec303414e13ce24d2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f1ebd05f3a61a3ac30ca59c782edcb13abe0cfe16f69be48119dc146bc8e5b04a9013d37ca24aa8c508dd590b7ef4cf2bc318ffd58e8697a19fa4a1776d07a5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e961b537f7a14a0739151295e750e0d7f2ac82b74a2dacfe5f43a571b15fadc321eedcd233ecd5094d347214052ca7016210441d1df50982c4c36f91372ee60", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70cefe2119127993589515a4b3b8db2f1bf1082bde179044e5dcecebadb5e42bc2cb1a195768283548cc29859e4d3aa6fa952025fd6dcca36326581f96345199"} 19:09:33 INFO - Running post-run listener: copy_logs_to_upload_dir 19:09:33 INFO - Copying logs to upload dir... 19:09:33 INFO - mkdir: /builds/slave/test/build/upload/logs 19:09:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.213118 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-26 19:09:32.956895) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-26 19:09:32.961913) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330 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/c31d155a3c3deae4f1a1cb8333f294df24c8cb66ce5de7427c5e6bfc77e8dc434296ae7a2618d86e8c04c1d47fd832ccb687f23c5d8836ec303414e13ce24d2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f1ebd05f3a61a3ac30ca59c782edcb13abe0cfe16f69be48119dc146bc8e5b04a9013d37ca24aa8c508dd590b7ef4cf2bc318ffd58e8697a19fa4a1776d07a5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e961b537f7a14a0739151295e750e0d7f2ac82b74a2dacfe5f43a571b15fadc321eedcd233ecd5094d347214052ca7016210441d1df50982c4c36f91372ee60", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70cefe2119127993589515a4b3b8db2f1bf1082bde179044e5dcecebadb5e42bc2cb1a195768283548cc29859e4d3aa6fa952025fd6dcca36326581f96345199"} build_url:https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c31d155a3c3deae4f1a1cb8333f294df24c8cb66ce5de7427c5e6bfc77e8dc434296ae7a2618d86e8c04c1d47fd832ccb687f23c5d8836ec303414e13ce24d2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f1ebd05f3a61a3ac30ca59c782edcb13abe0cfe16f69be48119dc146bc8e5b04a9013d37ca24aa8c508dd590b7ef4cf2bc318ffd58e8697a19fa4a1776d07a5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e961b537f7a14a0739151295e750e0d7f2ac82b74a2dacfe5f43a571b15fadc321eedcd233ecd5094d347214052ca7016210441d1df50982c4c36f91372ee60", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70cefe2119127993589515a4b3b8db2f1bf1082bde179044e5dcecebadb5e42bc2cb1a195768283548cc29859e4d3aa6fa952025fd6dcca36326581f96345199"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-26 19:09:32.989118) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 19:09:32.989404) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1501112989.962950-1038798330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 19:09:33.070099) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-26 19:09:33.070389) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-26 19:09:33.073691) ========= ========= Total master_lag: 0.18 =========