builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-083 starttime: 1500718890.05 results: success (0) revision: a599289ac64ba1d52a1552e33150342746e3e61b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:30.048885) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:30.049339) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:30.049835) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:30.147779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:30.148115) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-22 03:21:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.3M=0s 2017-07-22 03:21:31 (41.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079758 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:30.265931) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:30.266330) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022740 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:30.340332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:30.340686) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a599289ac64ba1d52a1552e33150342746e3e61b --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 a599289ac64ba1d52a1552e33150342746e3e61b --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=3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-22 03:21:31,249 truncating revision to first 12 chars 2017-07-22 03:21:31,249 Setting DEBUG logging. 2017-07-22 03:21:31,249 attempt 1/10 2017-07-22 03:21:31,249 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a599289ac64b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-22 03:21:31,733 unpacking tar archive at: mozilla-central-a599289ac64b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.803526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:31.165507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:31.165837) ========= script_repo_revision: a599289ac64ba1d52a1552e33150342746e3e61b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:31.166247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:31.166550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 03:21:31.175065) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 23 secs) (at 2017-07-22 03:21:31.175379) ========= /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=3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:21:32 INFO - MultiFileLogger online at 20170722 03:21:32 in /builds/slave/test 03:21:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:21:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:21:32 INFO - {'append_to_log': False, 03:21:32 INFO - 'base_work_dir': '/builds/slave/test', 03:21:32 INFO - 'blob_upload_branch': 'Firefox', 03:21:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:21:32 INFO - 'branch': 'Firefox', 03:21:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:32 INFO - 'code_coverage': False, 03:21:32 INFO - 'config_files': ('talos/linux_config.py',), 03:21:32 INFO - 'default_actions': ('clobber', 03:21:32 INFO - 'read-buildbot-config', 03:21:32 INFO - 'download-and-extract', 03:21:32 INFO - 'populate-webroot', 03:21:32 INFO - 'create-virtualenv', 03:21:32 INFO - 'install', 03:21:32 INFO - 'setup-mitmproxy', 03:21:32 INFO - 'run-tests'), 03:21:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:32 INFO - 'disable_ccov_upload': False, 03:21:32 INFO - 'download_minidump_stackwalk': True, 03:21:32 INFO - 'download_symbols': 'ondemand', 03:21:32 INFO - 'enable_stylo': False, 03:21:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:32 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:32 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:32 INFO - 'gecko_profile': False, 03:21:32 INFO - 'gecko_profile_interval': 0, 03:21:32 INFO - 'installer_path': 'installer.exe', 03:21:32 INFO - 'log_level': 'info', 03:21:32 INFO - 'log_name': 'talos', 03:21:32 INFO - 'log_to_console': True, 03:21:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:21:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:21:32 INFO - 'opt_config_files': (), 03:21:32 INFO - 'pip_index': False, 03:21:32 INFO - 'suite': 'dromaeojs-e10s', 03:21:32 INFO - 'system_bits': '32', 03:21:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:32 INFO - 'title': 'talos-linux64-ix-083', 03:21:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:32 INFO - 'use_talos_json': True, 03:21:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:21:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:32 INFO - 'work_dir': 'build'} 03:21:32 INFO - [mozharness: 2017-07-22 10:21:32.177491Z] Running clobber step. 03:21:32 INFO - Running pre-action listener: _resource_record_pre_action 03:21:32 INFO - Running main action method: clobber 03:21:32 INFO - rmtree: /builds/slave/test/build 03:21:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:21:33 INFO - Running post-action listener: _resource_record_post_action 03:21:33 INFO - [mozharness: 2017-07-22 10:21:33.209045Z] Finished clobber step (success) 03:21:33 INFO - [mozharness: 2017-07-22 10:21:33.209146Z] Running read-buildbot-config step. 03:21:33 INFO - Running pre-action listener: _resource_record_pre_action 03:21:33 INFO - Running main action method: read_buildbot_config 03:21:33 INFO - Using buildbot properties: 03:21:33 INFO - { 03:21:33 INFO - "project": "", 03:21:33 INFO - "product": "firefox", 03:21:33 INFO - "who": "archaeopteryx@coole-files.de", 03:21:33 INFO - "installer_path": "public/build/target.tar.bz2", 03:21:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:21:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:21:33 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:21:33 INFO - "stage_platform": "linux64-stylo", 03:21:33 INFO - "basedir": "/builds/slave/test", 03:21:33 INFO - "buildnumber": 228, 03:21:33 INFO - "platform": "ubuntu64_hw_stylo", 03:21:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:21:33 INFO - "slavebuilddir": "test", 03:21:33 INFO - "taskId": "BGi8ua8vTl6iudUUWwnbnw", 03:21:33 INFO - "branch": "mozilla-central", 03:21:33 INFO - "script_repo_revision": "production", 03:21:33 INFO - "revision": "a599289ac64ba1d52a1552e33150342746e3e61b", 03:21:33 INFO - "slavename": "talos-linux64-ix-083", 03:21:33 INFO - "repo_path": "mozilla-central" 03:21:33 INFO - } 03:21:33 INFO - Finding installer, test and symbols from parent task. 03:21:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BGi8ua8vTl6iudUUWwnbnw'}, attempt #1 03:21:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BGi8ua8vTl6iudUUWwnbnw'}, attempt #1 03:21:33 INFO - retry: attempt #1 caught HTTPError exception: HTTP Error 500: Internal Server Error 03:21:33 INFO - retry: Failed, sleeping 60 seconds before retrying 03:22:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BGi8ua8vTl6iudUUWwnbnw'}, attempt #2 03:22:34 INFO - Task dependencies: RwKFdA9lQGydGPWJvR_XgA 03:22:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA'}, attempt #1 03:22:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.tar.bz2 03:22:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/test_packages.json 03:22:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.crashreporter-symbols.zip 03:22:34 INFO - Running post-action listener: _resource_record_post_action 03:22:34 INFO - [mozharness: 2017-07-22 10:22:34.931316Z] Finished read-buildbot-config step (success) 03:22:34 INFO - [mozharness: 2017-07-22 10:22:34.931544Z] Running download-and-extract step. 03:22:34 INFO - Running pre-action listener: _resource_record_pre_action 03:22:34 INFO - Running main action method: download_and_extract 03:22:34 INFO - mkdir: /builds/slave/test/build/tests 03:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:34 INFO - trying https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.test_packages.json 03:22:34 INFO - Downloading https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:22:35 INFO - Downloaded 989 bytes. 03:22:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:22:35 INFO - Using the following test package requirements: 03:22:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:22:35 INFO - u'common': [u'target.common.tests.zip'], 03:22:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:22:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:22:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:22:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:22:35 INFO - u'mozbase': [u'target.common.tests.zip'], 03:22:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:22:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:22:35 INFO - u'web-platform': [u'target.common.tests.zip', 03:22:35 INFO - u'target.web-platform.tests.tar.gz'], 03:22:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:22:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:22:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.common.tests.zip 03:22:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:22:35 INFO - Fetch https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.common.tests.zip into memory 03:22:36 INFO - Content-Length response header: 72760917 03:22:36 INFO - Bytes received: 72760917 03:22:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:22:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.common.tests.zip 03:22:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:22:47 INFO - Fetch https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.common.tests.zip into memory 03:22:47 INFO - retry: attempt #1 caught HTTPError exception: HTTP Error 500: Internal Server Error 03:22:47 INFO - retry: Failed, sleeping 30 seconds before retrying 03:23:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.common.tests.zip'}, attempt #2 03:23:18 INFO - Fetch https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.common.tests.zip into memory 03:23:19 INFO - Content-Length response header: 72760917 03:23:19 INFO - Bytes received: 72760917 03:23:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.talos.tests.zip 03:23:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:23:31 INFO - Fetch https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.talos.tests.zip into memory 03:23:32 INFO - Content-Length response header: 14498826 03:23:32 INFO - Bytes received: 14498826 03:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:32 INFO - trying https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.tar.bz2 03:23:32 INFO - Downloading https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:23:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:23:33 INFO - Downloaded 61975052 bytes. 03:23:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.tar.bz2 03:23:33 INFO - mkdir: /builds/slave/test/properties 03:23:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:23:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:23:33 INFO - Contents: 03:23:33 INFO - build_url:https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.tar.bz2 03:23:33 INFO - Running post-action listener: _resource_record_post_action 03:23:33 INFO - Running post-action listener: set_extra_try_arguments 03:23:33 INFO - [mozharness: 2017-07-22 10:23:33.653273Z] Finished download-and-extract step (success) 03:23:33 INFO - [mozharness: 2017-07-22 10:23:33.653370Z] Running populate-webroot step. 03:23:33 INFO - Running pre-action listener: _resource_record_pre_action 03:23:33 INFO - Running main action method: populate_webroot 03:23:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:23:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:23:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:23:33 INFO - 'tests': ['damp', 'tps']}, 03:23:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:23:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:23:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:23:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:23:33 INFO - 'other-e10s': {'tests': ['a11yr', 03:23:33 INFO - 'ts_paint', 03:23:33 INFO - 'tpaint', 03:23:33 INFO - 'sessionrestore', 03:23:33 INFO - 'sessionrestore_many_windows', 03:23:33 INFO - 'sessionrestore_no_auto_restore', 03:23:33 INFO - 'tabpaint']}, 03:23:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:23:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:23:33 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:23:33 INFO - 'talos_options': ['--mitmproxy', 03:23:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:23:33 INFO - '--firstNonBlankPaint'], 03:23:33 INFO - 'tests': ['quantum_pageload_google', 03:23:33 INFO - 'quantum_pageload_youtube', 03:23:33 INFO - 'quantum_pageload_amazon', 03:23:33 INFO - 'quantum_pageload_facebook']}, 03:23:33 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:23:33 INFO - 'talos_options': ['--stylo', 03:23:33 INFO - '--mitmproxy', 03:23:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:23:33 INFO - '--firstNonBlankPaint'], 03:23:33 INFO - 'tests': ['quantum_pageload_google', 03:23:33 INFO - 'quantum_pageload_youtube', 03:23:33 INFO - 'quantum_pageload_amazon', 03:23:33 INFO - 'quantum_pageload_facebook']}, 03:23:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:23:33 INFO - 'tsvgr_opacity', 03:23:33 INFO - 'tart', 03:23:33 INFO - 'tscrollx', 03:23:33 INFO - 'cart', 03:23:33 INFO - 'tsvg_static']}, 03:23:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:23:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:23:33 INFO - 'talos_options': ['--xperf_path', 03:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:33 INFO - 'tests': ['tp5n']}}} 03:23:33 INFO - Running post-action listener: _resource_record_post_action 03:23:33 INFO - [mozharness: 2017-07-22 10:23:33.660654Z] Finished populate-webroot step (success) 03:23:33 INFO - [mozharness: 2017-07-22 10:23:33.660744Z] Running create-virtualenv step. 03:23:33 INFO - Running pre-action listener: _resource_record_pre_action 03:23:33 INFO - Running main action method: create_virtualenv 03:23:33 INFO - Creating virtualenv /builds/slave/test/build/venv 03:23:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:23:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:23:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:23:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:23:33 INFO - Using real prefix '/usr' 03:23:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:23:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:23:36 INFO - Installing pip.................done. 03:23:36 INFO - Return code: 0 03:23:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:23:36 INFO - Reading from file tmpfile_stdout 03:23:36 INFO - Output received: 03:23:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:23:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884eb0>, '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 0x1885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1886240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:23:36 INFO - Using env: {'DISPLAY': ':0', 03:23:36 INFO - 'HOME': '/home/cltbld', 03:23:36 INFO - 'LANG': 'en_US.UTF-8', 03:23:36 INFO - 'LANGUAGE': 'en_US:en', 03:23:36 INFO - 'LOGNAME': 'cltbld', 03:23:36 INFO - 'MAIL': '/var/mail/cltbld', 03:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:36 INFO - 'MOZ_NO_REMOTE': '1', 03:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:36 INFO - 'NO_EM_RESTART': '1', 03:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:36 INFO - 'PWD': '/builds/slave/test', 03:23:36 INFO - 'SHELL': '/bin/bash', 03:23:36 INFO - 'SHLVL': '1', 03:23:36 INFO - 'TERM': 'linux', 03:23:36 INFO - 'TMOUT': '86400', 03:23:36 INFO - 'USER': 'cltbld', 03:23:36 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 03:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:36 INFO - '_': '/tools/buildbot/bin/python'} 03:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:23:36 INFO - Cleaning up... 03:23:36 INFO - Return code: 0 03:23:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884eb0>, '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 0x1885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1886240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:23:36 INFO - Using env: {'DISPLAY': ':0', 03:23:36 INFO - 'HOME': '/home/cltbld', 03:23:36 INFO - 'LANG': 'en_US.UTF-8', 03:23:36 INFO - 'LANGUAGE': 'en_US:en', 03:23:36 INFO - 'LOGNAME': 'cltbld', 03:23:36 INFO - 'MAIL': '/var/mail/cltbld', 03:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:36 INFO - 'MOZ_NO_REMOTE': '1', 03:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:36 INFO - 'NO_EM_RESTART': '1', 03:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:36 INFO - 'PWD': '/builds/slave/test', 03:23:36 INFO - 'SHELL': '/bin/bash', 03:23:36 INFO - 'SHLVL': '1', 03:23:36 INFO - 'TERM': 'linux', 03:23:36 INFO - 'TMOUT': '86400', 03:23:36 INFO - 'USER': 'cltbld', 03:23:36 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 03:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:36 INFO - '_': '/tools/buildbot/bin/python'} 03:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:36 INFO - Downloading/unpacking psutil>=3.1.1 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:23:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:38 INFO - Installing collected packages: psutil 03:23:38 INFO - Running setup.py install for psutil 03:23:38 INFO - building 'psutil._psutil_linux' extension 03:23:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:23:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:23:38 INFO - building 'psutil._psutil_posix' extension 03:23:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:23:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:23:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:38 INFO - Successfully installed psutil 03:23:38 INFO - Cleaning up... 03:23:38 INFO - Return code: 0 03:23:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884eb0>, '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 0x1885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1886240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:23:38 INFO - Using env: {'DISPLAY': ':0', 03:23:38 INFO - 'HOME': '/home/cltbld', 03:23:38 INFO - 'LANG': 'en_US.UTF-8', 03:23:38 INFO - 'LANGUAGE': 'en_US:en', 03:23:38 INFO - 'LOGNAME': 'cltbld', 03:23:38 INFO - 'MAIL': '/var/mail/cltbld', 03:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:38 INFO - 'MOZ_NO_REMOTE': '1', 03:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:38 INFO - 'NO_EM_RESTART': '1', 03:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:38 INFO - 'PWD': '/builds/slave/test', 03:23:38 INFO - 'SHELL': '/bin/bash', 03:23:38 INFO - 'SHLVL': '1', 03:23:38 INFO - 'TERM': 'linux', 03:23:38 INFO - 'TMOUT': '86400', 03:23:38 INFO - 'USER': 'cltbld', 03:23:38 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 03:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:38 INFO - '_': '/tools/buildbot/bin/python'} 03:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:23:39 INFO - Installing collected packages: mozsystemmonitor 03:23:39 INFO - Running setup.py install for mozsystemmonitor 03:23:40 INFO - Successfully installed mozsystemmonitor 03:23:40 INFO - Cleaning up... 03:23:40 INFO - Return code: 0 03:23:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:40 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884eb0>, '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 0x1885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1886240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:23:40 INFO - Using env: {'DISPLAY': ':0', 03:23:40 INFO - 'HOME': '/home/cltbld', 03:23:40 INFO - 'LANG': 'en_US.UTF-8', 03:23:40 INFO - 'LANGUAGE': 'en_US:en', 03:23:40 INFO - 'LOGNAME': 'cltbld', 03:23:40 INFO - 'MAIL': '/var/mail/cltbld', 03:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:40 INFO - 'MOZ_NO_REMOTE': '1', 03:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:40 INFO - 'NO_EM_RESTART': '1', 03:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:40 INFO - 'PWD': '/builds/slave/test', 03:23:40 INFO - 'SHELL': '/bin/bash', 03:23:40 INFO - 'SHLVL': '1', 03:23:40 INFO - 'TERM': 'linux', 03:23:40 INFO - 'TMOUT': '86400', 03:23:40 INFO - 'USER': 'cltbld', 03:23:40 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 03:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:40 INFO - '_': '/tools/buildbot/bin/python'} 03:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:40 INFO - Downloading/unpacking jsonschema==2.5.1 03:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:41 INFO - warning: no files found matching '*.txt' 03:23:41 INFO - no previously-included directories found matching 'build' 03:23:41 INFO - no previously-included directories found matching 'dist' 03:23:41 INFO - no previously-included directories found matching '.git*' 03:23:41 INFO - Installing collected packages: jsonschema, functools32 03:23:41 INFO - Running setup.py install for functools32 03:23:41 INFO - warning: no files found matching '*.txt' 03:23:41 INFO - no previously-included directories found matching 'build' 03:23:41 INFO - no previously-included directories found matching 'dist' 03:23:41 INFO - no previously-included directories found matching '.git*' 03:23:41 INFO - Successfully installed jsonschema functools32 03:23:41 INFO - Cleaning up... 03:23:41 INFO - Return code: 0 03:23:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:41 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884eb0>, '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 0x1885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1886240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:23:41 INFO - Using env: {'DISPLAY': ':0', 03:23:41 INFO - 'HOME': '/home/cltbld', 03:23:41 INFO - 'LANG': 'en_US.UTF-8', 03:23:41 INFO - 'LANGUAGE': 'en_US:en', 03:23:41 INFO - 'LOGNAME': 'cltbld', 03:23:41 INFO - 'MAIL': '/var/mail/cltbld', 03:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:41 INFO - 'MOZ_NO_REMOTE': '1', 03:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:41 INFO - 'NO_EM_RESTART': '1', 03:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:41 INFO - 'PWD': '/builds/slave/test', 03:23:41 INFO - 'SHELL': '/bin/bash', 03:23:41 INFO - 'SHLVL': '1', 03:23:41 INFO - 'TERM': 'linux', 03:23:41 INFO - 'TMOUT': '86400', 03:23:41 INFO - 'USER': 'cltbld', 03:23:41 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 03:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:41 INFO - '_': '/tools/buildbot/bin/python'} 03:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:23:41 INFO - Cleaning up... 03:23:41 INFO - Return code: 0 03:23:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:41 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884eb0>, '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 0x1885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1886240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:23:42 INFO - Using env: {'DISPLAY': ':0', 03:23:42 INFO - 'HOME': '/home/cltbld', 03:23:42 INFO - 'LANG': 'en_US.UTF-8', 03:23:42 INFO - 'LANGUAGE': 'en_US:en', 03:23:42 INFO - 'LOGNAME': 'cltbld', 03:23:42 INFO - 'MAIL': '/var/mail/cltbld', 03:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:42 INFO - 'MOZ_NO_REMOTE': '1', 03:23:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:42 INFO - 'NO_EM_RESTART': '1', 03:23:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:42 INFO - 'PWD': '/builds/slave/test', 03:23:42 INFO - 'SHELL': '/bin/bash', 03:23:42 INFO - 'SHLVL': '1', 03:23:42 INFO - 'TERM': 'linux', 03:23:42 INFO - 'TMOUT': '86400', 03:23:42 INFO - 'USER': 'cltbld', 03:23:42 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 03:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:42 INFO - '_': '/tools/buildbot/bin/python'} 03:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:43 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:43 INFO - Downloading docopt-0.6.1.tar.gz 03:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:43 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:43 INFO - Running setup.py install for blobuploader 03:23:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:43 INFO - Running setup.py install for requests 03:23:44 INFO - Running setup.py install for docopt 03:23:44 INFO - Successfully installed blobuploader requests docopt 03:23:44 INFO - Cleaning up... 03:23:44 INFO - Return code: 0 03:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:44 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884eb0>, '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 0x1885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1886240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:44 INFO - Using env: {'DISPLAY': ':0', 03:23:44 INFO - 'HOME': '/home/cltbld', 03:23:44 INFO - 'LANG': 'en_US.UTF-8', 03:23:44 INFO - 'LANGUAGE': 'en_US:en', 03:23:44 INFO - 'LOGNAME': 'cltbld', 03:23:44 INFO - 'MAIL': '/var/mail/cltbld', 03:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:44 INFO - 'MOZ_NO_REMOTE': '1', 03:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:44 INFO - 'NO_EM_RESTART': '1', 03:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:44 INFO - 'PWD': '/builds/slave/test', 03:23:44 INFO - 'SHELL': '/bin/bash', 03:23:44 INFO - 'SHLVL': '1', 03:23:44 INFO - 'TERM': 'linux', 03:23:44 INFO - 'TMOUT': '86400', 03:23:44 INFO - 'USER': 'cltbld', 03:23:44 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 03:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:44 INFO - '_': '/tools/buildbot/bin/python'} 03:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:44 INFO - Running setup.py (path:/tmp/pip-uv78ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:44 INFO - Running setup.py (path:/tmp/pip-ejOcWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:44 INFO - Running setup.py (path:/tmp/pip-W5K0YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:44 INFO - Running setup.py (path:/tmp/pip-yzez3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:44 INFO - Running setup.py (path:/tmp/pip-lfEOa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:45 INFO - Running setup.py (path:/tmp/pip-B8twiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:45 INFO - Running setup.py (path:/tmp/pip-_3oieh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:45 INFO - Running setup.py (path:/tmp/pip-Fnxkhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:45 INFO - Running setup.py (path:/tmp/pip-S9EWjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:45 INFO - Running setup.py (path:/tmp/pip-PRxcQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:45 INFO - Running setup.py (path:/tmp/pip-L195kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:45 INFO - Running setup.py (path:/tmp/pip-VVQqTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:45 INFO - Running setup.py (path:/tmp/pip-4Ymho_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:45 INFO - Running setup.py (path:/tmp/pip-51QLVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:45 INFO - Running setup.py (path:/tmp/pip-eyil41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:45 INFO - Running setup.py (path:/tmp/pip-9fvisD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:45 INFO - Running setup.py (path:/tmp/pip-VtspXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:45 INFO - Running setup.py install for manifestparser 03:23:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Running setup.py install for mozcrash 03:23:46 INFO - Running setup.py install for mozdebug 03:23:46 INFO - Running setup.py install for mozdevice 03:23:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Running setup.py install for mozfile 03:23:46 INFO - Running setup.py install for mozhttpd 03:23:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Running setup.py install for mozinfo 03:23:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Running setup.py install for mozInstall 03:23:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Running setup.py install for mozleak 03:23:46 INFO - Running setup.py install for mozlog 03:23:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Running setup.py install for moznetwork 03:23:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Running setup.py install for mozprocess 03:23:47 INFO - Running setup.py install for mozprofile 03:23:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Running setup.py install for mozrunner 03:23:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Running setup.py install for mozscreenshot 03:23:47 INFO - Running setup.py install for moztest 03:23:47 INFO - Running setup.py install for mozversion 03:23:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:47 INFO - Cleaning up... 03:23:47 INFO - Return code: 0 03:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:47 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884eb0>, '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 0x1885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1886240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:47 INFO - Using env: {'DISPLAY': ':0', 03:23:47 INFO - 'HOME': '/home/cltbld', 03:23:47 INFO - 'LANG': 'en_US.UTF-8', 03:23:47 INFO - 'LANGUAGE': 'en_US:en', 03:23:47 INFO - 'LOGNAME': 'cltbld', 03:23:47 INFO - 'MAIL': '/var/mail/cltbld', 03:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:47 INFO - 'MOZ_NO_REMOTE': '1', 03:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:47 INFO - 'NO_EM_RESTART': '1', 03:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:47 INFO - 'PWD': '/builds/slave/test', 03:23:47 INFO - 'SHELL': '/bin/bash', 03:23:47 INFO - 'SHLVL': '1', 03:23:47 INFO - 'TERM': 'linux', 03:23:47 INFO - 'TMOUT': '86400', 03:23:47 INFO - 'USER': 'cltbld', 03:23:47 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 03:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:47 INFO - '_': '/tools/buildbot/bin/python'} 03:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:47 INFO - Running setup.py (path:/tmp/pip-sR26tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:48 INFO - Running setup.py (path:/tmp/pip-Fm2fZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:48 INFO - Running setup.py (path:/tmp/pip-864_99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:48 INFO - Running setup.py (path:/tmp/pip-GuTJB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:48 INFO - Running setup.py (path:/tmp/pip-OiGj05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:48 INFO - Running setup.py (path:/tmp/pip-ZAJg7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:48 INFO - Running setup.py (path:/tmp/pip-k46OPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:48 INFO - Running setup.py (path:/tmp/pip-2lmtwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:48 INFO - Running setup.py (path:/tmp/pip-TQ6jvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:48 INFO - Running setup.py (path:/tmp/pip-KtI0_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:48 INFO - Running setup.py (path:/tmp/pip-_FaBvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:48 INFO - Running setup.py (path:/tmp/pip-mxLTqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:48 INFO - Running setup.py (path:/tmp/pip-PPSjT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:48 INFO - Running setup.py (path:/tmp/pip-kPWjZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:48 INFO - Running setup.py (path:/tmp/pip-SVi_do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:49 INFO - Running setup.py (path:/tmp/pip-Ajc5Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:49 INFO - Running setup.py (path:/tmp/pip-IaessY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:23:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:50 INFO - Downloading blessings-1.6.tar.gz 03:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:50 INFO - Installing collected packages: blessings 03:23:50 INFO - Running setup.py install for blessings 03:23:50 INFO - Successfully installed blessings 03:23:50 INFO - Cleaning up... 03:23:50 INFO - Return code: 0 03:23:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:50 INFO - Reading from file tmpfile_stdout 03:23:50 INFO - Current package versions: 03:23:50 INFO - argparse == 1.2.1 03:23:50 INFO - blessings == 1.6 03:23:50 INFO - blobuploader == 1.2.4 03:23:50 INFO - docopt == 0.6.1 03:23:50 INFO - functools32 == 3.2.3-2 03:23:50 INFO - jsonschema == 2.5.1 03:23:50 INFO - manifestparser == 1.1 03:23:50 INFO - mozInstall == 1.13 03:23:50 INFO - mozcrash == 1.0 03:23:50 INFO - mozdebug == 0.1 03:23:50 INFO - mozdevice == 0.51 03:23:50 INFO - mozfile == 1.2 03:23:50 INFO - mozhttpd == 0.7 03:23:50 INFO - mozinfo == 0.10 03:23:50 INFO - mozleak == 0.1 03:23:50 INFO - mozlog == 3.5 03:23:50 INFO - moznetwork == 0.27 03:23:50 INFO - mozprocess == 0.25 03:23:50 INFO - mozprofile == 0.28 03:23:50 INFO - mozrunner == 6.13 03:23:50 INFO - mozscreenshot == 0.1 03:23:50 INFO - mozsystemmonitor == 0.3 03:23:50 INFO - moztest == 0.8 03:23:50 INFO - mozversion == 1.4 03:23:50 INFO - psutil == 3.1.1 03:23:50 INFO - requests == 1.2.3 03:23:50 INFO - wsgiref == 0.1.2 03:23:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:50 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884eb0>, '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 0x1885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1886240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:50 INFO - Using env: {'DISPLAY': ':0', 03:23:50 INFO - 'HOME': '/home/cltbld', 03:23:50 INFO - 'LANG': 'en_US.UTF-8', 03:23:50 INFO - 'LANGUAGE': 'en_US:en', 03:23:50 INFO - 'LOGNAME': 'cltbld', 03:23:50 INFO - 'MAIL': '/var/mail/cltbld', 03:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:50 INFO - 'MOZ_NO_REMOTE': '1', 03:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:50 INFO - 'NO_EM_RESTART': '1', 03:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:50 INFO - 'PWD': '/builds/slave/test', 03:23:50 INFO - 'SHELL': '/bin/bash', 03:23:50 INFO - 'SHLVL': '1', 03:23:50 INFO - 'TERM': 'linux', 03:23:50 INFO - 'TMOUT': '86400', 03:23:50 INFO - 'USER': 'cltbld', 03:23:50 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 03:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:50 INFO - '_': '/tools/buildbot/bin/python'} 03:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:23:50 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:51 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:23:52 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:23:52 INFO - Installing collected packages: marionette-driver, simplejson 03:23:52 INFO - Running setup.py install for marionette-driver 03:23:52 INFO - Running setup.py install for simplejson 03:23:52 INFO - building 'simplejson._speedups' extension 03:23:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:23:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:23:53 INFO - Successfully installed marionette-driver simplejson 03:23:53 INFO - Cleaning up... 03:23:53 INFO - Return code: 0 03:23:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:53 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 0x15181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884eb0>, '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 0x1885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1886240>, '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': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:23:53 INFO - Using env: {'DISPLAY': ':0', 03:23:53 INFO - 'HOME': '/home/cltbld', 03:23:53 INFO - 'LANG': 'en_US.UTF-8', 03:23:53 INFO - 'LANGUAGE': 'en_US:en', 03:23:53 INFO - 'LOGNAME': 'cltbld', 03:23:53 INFO - 'MAIL': '/var/mail/cltbld', 03:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:53 INFO - 'MOZ_NO_REMOTE': '1', 03:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:53 INFO - 'NO_EM_RESTART': '1', 03:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:53 INFO - 'PWD': '/builds/slave/test', 03:23:53 INFO - 'SHELL': '/bin/bash', 03:23:53 INFO - 'SHLVL': '1', 03:23:53 INFO - 'TERM': 'linux', 03:23:53 INFO - 'TMOUT': '86400', 03:23:53 INFO - 'USER': 'cltbld', 03:23:53 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 03:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:53 INFO - '_': '/tools/buildbot/bin/python'} 03:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:23:53 INFO - Cleaning up... 03:23:53 INFO - Return code: 0 03:23:53 INFO - Running post-action listener: _resource_record_post_action 03:23:53 INFO - Running post-action listener: _start_resource_monitoring 03:23:53 INFO - Starting resource monitoring. 03:23:53 INFO - [mozharness: 2017-07-22 10:23:53.733008Z] Finished create-virtualenv step (success) 03:23:53 INFO - [mozharness: 2017-07-22 10:23:53.733521Z] Running install step. 03:23:53 INFO - Running pre-action listener: _resource_record_pre_action 03:23:53 INFO - Running main action method: install 03:23:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:53 INFO - Reading from file tmpfile_stdout 03:23:53 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:54 INFO - Reading from file tmpfile_stdout 03:23:54 INFO - Output received: 03:23:54 INFO - Usage: mozinstall [options] installer 03:23:54 INFO - Options: 03:23:54 INFO - -h, --help show this help message and exit 03:23:54 INFO - -d DEST, --destination=DEST 03:23:54 INFO - Directory to install application into. [default: 03:23:54 INFO - "/builds/slave/test"] 03:23:54 INFO - --app=APP Application being installed. [default: firefox] 03:23:54 INFO - mkdir: /builds/slave/test/build/application 03:23:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:24:12 INFO - Reading from file tmpfile_stdout 03:24:12 INFO - Output received: 03:24:12 INFO - /builds/slave/test/build/application/firefox/firefox 03:24:12 INFO - Running post-action listener: _resource_record_post_action 03:24:12 INFO - [mozharness: 2017-07-22 10:24:12.049558Z] Finished install step (success) 03:24:12 INFO - [mozharness: 2017-07-22 10:24:12.049808Z] Running setup-mitmproxy step. 03:24:12 INFO - Running pre-action listener: _resource_record_pre_action 03:24:12 INFO - Running main action method: setup_mitmproxy 03:24:12 INFO - Skipping: mitmproxy is not required 03:24:12 INFO - Running post-action listener: _resource_record_post_action 03:24:12 INFO - [mozharness: 2017-07-22 10:24:12.050928Z] Finished setup-mitmproxy step (success) 03:24:12 INFO - [mozharness: 2017-07-22 10:24:12.051148Z] Running run-tests step. 03:24:12 INFO - Running pre-action listener: _resource_record_pre_action 03:24:12 INFO - Running pre-action listener: _set_gcov_prefix 03:24:12 INFO - Running main action method: run_tests 03:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:24:12 INFO - Python 2.7.3 03:24:12 INFO - Return code: 0 03:24:12 INFO - grabbing minidump binary from tooltool 03:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:12 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 0x1884eb0>, '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 0x1885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1886240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:24:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:24:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:24:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:24:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:24:12 INFO - Return code: 0 03:24:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:24:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:24:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:24:12 INFO - ENV: RUST_BACKTRACE is now 1 03:24:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:24:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:24:12 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/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:24:12 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/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:24:12 INFO - Using env: {'DISPLAY': ':0', 03:24:12 INFO - 'HOME': '/home/cltbld', 03:24:12 INFO - 'LANG': 'en_US.UTF-8', 03:24:12 INFO - 'LANGUAGE': 'en_US:en', 03:24:12 INFO - 'LOGNAME': 'cltbld', 03:24:12 INFO - 'MAIL': '/var/mail/cltbld', 03:24:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:12 INFO - 'MOZ_NO_REMOTE': '1', 03:24:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:12 INFO - 'NO_EM_RESTART': '1', 03:24:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:12 INFO - 'PWD': '/builds/slave/test', 03:24:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:12 INFO - 'RUST_BACKTRACE': '1', 03:24:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:24:12 INFO - 'SHELL': '/bin/bash', 03:24:12 INFO - 'SHLVL': '1', 03:24:12 INFO - 'STYLO_FORCE_ENABLED': '1', 03:24:12 INFO - 'TERM': 'linux', 03:24:12 INFO - 'TMOUT': '86400', 03:24:12 INFO - 'USER': 'cltbld', 03:24:12 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782', 03:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:12 INFO - '_': '/tools/buildbot/bin/python'} 03:24:12 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/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:24:12 INFO - mozversion application_buildid: 20170722093904 03:24:12 INFO - mozversion application_changeset: a599289ac64ba1d52a1552e33150342746e3e61b 03:24:12 INFO - mozversion application_display_name: Nightly 03:24:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:24:12 INFO - mozversion application_name: Firefox 03:24:12 INFO - mozversion application_remotingname: firefox 03:24:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:24:12 INFO - mozversion application_vendor: Mozilla 03:24:12 INFO - mozversion application_version: 56.0a1 03:24:12 INFO - mozversion platform_buildid: 20170722093904 03:24:12 INFO - mozversion platform_changeset: a599289ac64ba1d52a1552e33150342746e3e61b 03:24:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:24:12 INFO - mozversion platform_version: 56.0a1 03:24:12 INFO - using testdate: 1500719052 03:24:12 INFO - actual date: 1500719052 03:24:12 INFO - starting webserver on 'localhost:33062' 03:24:12 INFO - SUITE-START | Running 2 tests 03:24:12 INFO - TEST-START | dromaeo_css 03:24:12 INFO - Initialising browser for dromaeo_css test... 03:24:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33062/getInfo.html -profile /tmp/tmpBMWnrw/profile 03:24:12 INFO - TEST-INFO | started process 1586 (/builds/slave/test/build/application/firefox/firefox http://localhost:33062/getInfo.html) 03:24:18 INFO - TEST-INFO | 1586: exit 0 03:24:18 INFO - Browser initialized. 03:24:18 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:18 INFO - TEST-INFO | started process 1821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBMWnrw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:30 INFO - PID 1821 | RSS: Main: 176701440 03:24:30 INFO - PID 1821 | 03:27:29 INFO - PID 1821 | Cycle 1(1): loaded http://localhost:33062/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33062/tests/dromaeo/cssquery-ext.html) 03:27:30 INFO - PID 1821 | RSS: Main: 182308864 03:27:30 INFO - PID 1821 | 03:30:32 INFO - PID 1821 | Cycle 1(1): loaded http://localhost:33062/tests/dromaeo/cssquery-ext.html (next: http://localhost:33062/tests/dromaeo/cssquery-jquery.html) 03:30:33 INFO - PID 1821 | RSS: Main: 180367360 03:30:33 INFO - PID 1821 | 03:33:35 INFO - PID 1821 | Cycle 1(1): loaded http://localhost:33062/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33062/tests/dromaeo/cssquery-mootools.html) 03:33:35 INFO - PID 1821 | RSS: Main: 181555200 03:33:35 INFO - PID 1821 | 03:36:37 INFO - PID 1821 | Cycle 1(1): loaded http://localhost:33062/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33062/tests/dromaeo/cssquery-prototype.html) 03:36:38 INFO - PID 1821 | RSS: Main: 181141504 03:36:38 INFO - PID 1821 | 03:39:42 INFO - PID 1821 | Cycle 1(1): loaded http://localhost:33062/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33062/tests/dromaeo/cssquery-yui.html) 03:39:43 INFO - PID 1821 | RSS: Main: 182652928 03:39:43 INFO - PID 1821 | 03:42:45 INFO - PID 1821 | Cycle 1(1): loaded http://localhost:33062/tests/dromaeo/cssquery-yui.html (next: http://localhost:33062/tests/dromaeo/cssquery-dojo.html) 03:42:45 INFO - PID 1821 | RSS: Main: 184086528 03:42:45 INFO - PID 1821 | 03:42:45 INFO - PID 1821 | __start_tp_report 03:42:45 INFO - PID 1821 | _x_x_mozilla_page_load 03:42:45 INFO - PID 1821 | _x_x_mozilla_page_load_details 03:42:45 INFO - PID 1821 | |i|pagename|runs| 03:42:45 INFO - PID 1821 | |0;dojo.html;3114.112477943785;3141.638711548172;3148.574942382778;3154.9053528394147;3180.2685382362056;6061.969690151549;6080.361562035989;6208.3481234470355;6259.937400625998;6265.248170219568;6025.3070896846875;6054.666993315377;6069.908951365733;6141.232345956755;6146.139540464339;5584;5601.159826026098;5622.072358060915;5623.7469313880765;5748.942510574903;5701.173329867167;5714.371419143891;5726.856828579298;5740.79907203248;5777.393373695764;5459.781608735646;5622;5696.487316141525;5752.079667253241;5776.59563830532;5599.7480113394995;5635.013872572284;5635.774569017234;5701.401352857932;5726.083826587767;5584.692841893694;5604.943950560483;5671.347795003545;5672.858178545528;5678.659280443146;5988.9101663475085;6004.54965877561;6092.329843717188;6155.322914479404;6155.907661385083;6548;6595.835104122388;6629.93370066298;6673.165854268216;6683.331666833326;6628.635425051621;6630.535862489628;6709.295523969961;6726.966365168143;6736.360045795642;6045.153678485016;6139.754409823602;6152.477039451696;6252.249730032379;6264.7807326743805;6734.966325168441;6778.796636100925;6814.795556133225;6826.795196144124;6830.863382732317;6487;6489.675516224264;6547.5416720830035;6564.507661925375;6579.934200657932;6580.078788969548;6597.406233439014;6665.266820649725;6675.532712710161;6679.265280819106;6412;6535.313792051861;6538.346165383518;6640.335966403418;6653.301403352675;6521.11964884744;6560.9343906560325;6571.244306904671;6590.143281373486;6617.569857959217;5281.102212623787;5315.548178404879;5341.305630268041;5355.036093503207;5358.839234822962;4488.192125417391;4542.9772851136195;4559.361689363492;4569.588737013684;4638.0491999140095;5767.077267637158;5818.4472475115645;5820.185174075633;5820.388859169726;5821.417858214145;6609.570377925419;6636.601803891782;6703.028060931138;6713.160854893138;6717.227518835396;5636.351819540805;5723.313202415737;5733.684647344436;5749.453801888814;5789.247397838254;5777.30672319316;5793.015187418065;5817.563682723812;5848.181254624356;5856.590038697335;6455.128557644658;6473.158489396348;6513.869722605521;6521.08704781331;6525.575837570448;6574.1453611032175;6636.402723754885;6663.933360666525;6743.494237932273;6764.154480689914;6312.905306420315;6388.329225431263;6411.134496843053;6500.772472963424;6517.348265173445;6456.967715161582;6513.609183449008;6535.183102112236;6537.607743535403;6541.574797638138;6643.036759669917;6671.83320416974;6677.998300254806;6755.729770809113;6766.086578311865;6421.935780642134;6435.935640643534;6489.837754056186;6520.771772987922;6541.901871472027;6274.1843560336865;6384.648844313608;6390.93609063922;6396.168498095218;6405.743770249138;6282.591631543935;6285.182926219562;6291.937080629318;6328.683565821782;6421.422072013354;6477.740890364333;6506.251781045051;6507.316731743099;6584.144061272004;6586.37429444202;6163.229596300463;6212.720427580679;6241.21984751906;6284.968575157095;6321.683915804283 03:42:45 INFO - PID 1821 | |1;ext.html;810.9189081091891;848.6393282854785;873.5806812729892;875.5315905990296;1156.491143896685;32041.83979080104;32386.83806580967;42216.788916055455;42675.35986960198;42801.78599107;43013.7849310753;43359.34960975588;43380;43440.56559434405;43449.34825977605;7614.771556853303;7622;7782.571958542278;7797.883031754528;7810.76567702967;7670.386369090487;7723.806904827368;7778.8444231115345;7779;7779.727709530168;7693.653785579662;7758.844823103563;7781.22187781223;7781.688732450723;7788.104367997667;7678.884816727754;7724.729634462767;7737.497062690907;7760.534367937942;7782.961085194566;7604.125525564576;7664;7665.4634175607725;7665.61671916402;7686.846263074764;38835.61164388376;39112.413313800316;39132.41301380481;39182.41226381606;39378;3356.848941797625;3392.1010932103013;3394.1684287349512;3401.6088149862835;3434.9828250858836;29833.850830745923;29883;29986.70013299861;30032.699673003208;30209.244768880733;4769.689970151963;4770;4832.830850920236;4889.022195560867;4889.902201955976;191386;192587;192957;193728;193838;47180.292295615596;47322;47385.28922066172;47617;47712;49301;49809.25286120711;49978.75010624924;50074.49925500698;50180;14286.21425821569;15790.842091579167;16025.43910963134;16026.278817453243;16026.75959860603;11886.940565297118;13349.466021359036;13507.864921350661;13509.189448633113;13516.324183790772;14238.430462781373;14420.495282665266;14435.927820361041;14473.92763036178;14598.34307456167;5787.5080618147085;5802.738876750472;5866.70666466675;5932.228810254639;6085.148079268906;966.8308046091905;970.6990832841842;998.7203582996773;1006.8791744990648;1015.7917626886618;21964;22149.55522882722;22398.216062437736;23054.769452305263;23097.769022309898;1010.5553556435145;1021.4790456867051;1027.4759872465097;1055.656911503749;1085.1806885801327;12138.543374794905;15070.472533461276;16273.51179464618;16294.42969496062;16682.416115435903;232072;232073;233276;233567;234955;57675.423245767844;58029.709851450476;58195.418045819846;58253.4174658248;58285.125723114186;1447.1461837515917;1455.825300963891;1485.7028594281187;1493.8132733408324;1511.7203317386318;26489.735102648727;26807.731922680523;27086.1874143776;27568;27733.722662773922;38210.80894595509;38473.42289865598;38554.6144538551;38564.80717596394;38586.22827543489;208764;209095;210766;211578;211930;33750;36830.44754328633;38868.41697374598;39217.80391098026;39251.607483924796;48191.27713084236;48780.756096219295;48888.2666760006;49062.01875962532;49081.75459122682;34043.31913361768;34323.65676343304;34635.47850866729;34790;35055.29889402249;33213.833930831155;34224.31551369008;34590;35228;35255.29489410249;38961;39053.2189356217;39206.803965981126;39336.803315983234;39427;31454.528182077745;33267.83366083251;33357.499637504974;33529.83235083809;33530.16174595557;24225;24236.919330046454;24440.75559244385;24452;25015.374615634028 03:42:45 INFO - PID 1821 | |2;jquery.html;575.7495489462084;576.4811669497452;578.4389142531743;588.3616276340172;594.3343455330031;22398.55202895941;23260.069597216134;23290.76709232907;23296.18463353783;23385.649215261783;18850.622987540275;19724.013799310014;19740.802591974076;20142.093605787737;20449.284275050377;6427.67861606919;6674.6662666866705;6682.498812589051;6700.262971073178;6701.597904125743;6545.181852268466;6638.701258443381;6643.667816609174;6665.866682666344;6676.232233293161;6335.936640633604;6569.802905912807;6604.174478190226;6621.73513059477;6646.734130634769;6590.50571207159;6613.735450581971;6616.338366163393;6618.371254730793;6640.601563906157;6140.907886381708;6147.815565533041;6161.4146656067605;6170;6177.073438984144;27749.306267343276;28713.56929646057;28922.855385722938;28931.855340723163;29621.111366659035;1850.69463538516;1909.7517322747954;1920.155131742043;1922.09661459114;1949.025487256372;18359.63280734391;18739.718904216446;18857.151428185764;18929;18946.147423365983;2290.5189910118893;2301.102569997702;2350.400647834791;2353.611654077092;2429.4290841652196;116152.41923790412;122740;125878.37060814729;131614.3419282907;132245;14506.854931450762;14728.631784205267;14923;14924.03486924035;15179.937404381808;23117.422064448187;23124.19065332739;23274.65088023681;23294.3011709649;23299.301020969397;9963.950180249052;9974.950125249326;10036.548355324028;10083.596656133672;10194.082532572103;9228.492432916253;9270.404286799707;9357.812843743088;9415.576299066559;9440.197583205505;9070.591823367964;9090.409123406956;9097.727068187965;9171;9183.724488265229;2577.87110644467;2648.8013398995154;2738.6165936768866;2774.2648198227484;2799.984011511708;877.4033657113097;891.0955380289012;892.5849479991834;894.4677916639589;910.5356268303213;17155.74040932244;17566.912165439346;17841.643167136845;18095.72856407155;18333.358332458567;951.6716732727198;962.6582563190107;970.6942313171328;1008.5007921079113;1051.353417648141;10285.22860785444;10298.639547615798;10351.482425878676;10573.154147668169;10895.83656245157;468261;473125;473754;478416;480807;117866;120405;121375;122915.38542307231;123250;1227.7605866855877;1280.539005957873;1296.695276609996;1299.7270573179549;1303.6610481274936;19454;19594.804051959298;19905;20013.3995980115;20153.992300385216;58034.4196558029;58413.4158658425;58993;59377.40622593892;61213;75151.62424187844;75812;77811;77972.2202777965;79250.6037469809;14549.781753273497;14823.777643335574;15027.09837409759;15036.548903532912;15116.168610726516;22860.885695571415;23030.539389211786;23179.07283708633;23237.186698465473;24148.637770433106;18416.263349465873;18593;18606.53483662919;18636.906815465834;18658.44024679262;16201.351945922032;16313;16637.16814159263;16880.57798555046;17337.826621734126;19082.809171908102;19326.22695092237;19372.903135484234;19408.320708775125;19540.706889396388;14011.299435028412;14552.27238638085;14779.334929927963;14812.555623331318;14883.47907823221;18071.548211294823;18211.089445527934;18215.089245537936;18248.543786405447;18286 03:42:45 INFO - PID 1821 | |3;mootools.html;1347.3330701302853;1384.833819941607;1411.18856657422;1419.7302512522626;1425.593705793849;13476.797848032274;13851.584452466443;14118.941079419033;14123.293835308219;14145.92927035366;13864.792028119586;14144.646383840409;14147.575572732834;14156.150630962149;14173.220472873987;2615.3461634591304;2652.1115426332203;2654.960175597358;2656.893724251028;2657.36223306407;2563.218218443383;2593.8314009589317;2636.0378461861474;2655.74770396812;2715.8370497770097;2674.679038515381;2704.8918043278245;2719.646445962022;2720.7415295546894;2728.822626529279;2644.93387665308;2654.190471906068;2669.3326668332916;2671.6526851509275;2678.7589116979466;2500.7749302562675;2520.243926821946;2523.835950663201;2524.9368765781;2526.621006848969;13835.239061851595;13932.721345573133;13947.442102315896;13956.720865582733;13965.720685586231;7317.743878964211;7559.69761209551;7560.73537426193;7580.50726702768;7594.126675432341;4715.740634265114;4768.260919557474;4791.544803243686;4900.607951363882;4913.508649135094;1766.3729376071567;1777.3512667876132;1793.8923664580168;1827.826356496144;1835.2567210279724;22872.88563557188;23471.4132146696;23474.295771126894;23495.76504234953;23519.647205291934;6496.577722448026;6518.44593209573;6733.158355205599;6772.288909664414;6813.148356455443;15670.529884103495;15700.76448853268;15790.842091578937;15818.76271855923;15866.127362994916;7294.708211671474;7421.925780742124;7488.475806693479;7509.699612015458;7513.699452021967;6626.469882409396;6632.9336706633285;6672.232693240242;6812.6934287957165;6942.375186233162;4835.202191638411;4979.257259958986;4988.401391832931;5008.17365134756;5046.949530504721;1304.5238487951829;1343.7043850352907;1350.2033800057816;1446.240723620108;1456.8980171388114;865.2731705367521;866.5320726807454;886.1271647427279;894.1728900766765;900.4237288135598;7705.9229407706325;7706.499077559941;7799.571023593757;7933.523988560705;7940.205979402013;933.3513208320288;962.9133377996014;963.4634025163009;981.4062492192121;1017.4251547875575;4715.599174070242;4798.808047678123;4836.879078023077;5217.087009773274;5519.116941289374;18029.639407211784;19837.206511739656;19850.70223946642;19861.503462413268;19879.204831806856;19169.424917252505;19191.90404047971;19514.12186451613;19517.414477565697;19522.12150453233;9655.420674759536;10281.794364112826;10430.322029068086;10439.37363758177;10456.215783816244;7778.77072783257;7980.201979801974;8023.799405014921;8117.837643246984;8202;16206.351745930031;16536.75194872054;16671.41650042291;16782.1608919556;17069.14654267257;16541.83458165451;16952.237149328557;17144.74282885733;17449.82550174482;17451;11197.776044479227;11499;11519.481623327138;11531.308121512737;11535.942320288344;12629.431675574437;12775.169613975062;12890.226586404846;12914.612561623166;12920.806187907001;10089.545970431202;10426.947865260929;10597.311174773615;10754.354738715701;10768.300060496043;9715.611375544899;10192.694219173436;10241.027102425258;10371.948140259552;10500.632477863239;9390.95304523473;9528.285378596494;9550;9551.42691438516;9577.138057574573;6706.8993965089585;7039.120109986252;7151.141862976476;7177.425805935617;7208.35124838767;6387.5209359297305;6755.695993680394;6948.887360858017;7226.740735938664;7295.635218238961 03:42:45 INFO - PID 1821 | |4;prototype.html;492.72161228905645;503.22252120473877;519.158962480781;522.8666689994051;530.4430348134458;6020.367861374552;6136.723847426871;6160.691965401735;6209.348018458059;6303.432691057804;5840.386759390267;6010.429009244126;6031.3968603139665;6032.6380417175;6051.818445446644;4882.755862206894;4906.509349065101;4915.820203151254;4930.753462326869;4939.629527785412;4816.397950256218;4868.123737727207;4930.112579735646;4962.280469331945;4974.602031837444;4847.224444088946;4922.655414121013;4931.9506804932025;4935.728534930578;4947.554720075193;4844.079624871263;4867.123917694814;4870.172070747982;4883.780229889646;4914.16459201933;4394.71434356769;4424.867253982386;4442.267025940716;4448;4489.9102017959785;5985.221921150266;6017.247844019497;6054.244269161938;6069.605475644069;6077.361877002895;5582.581306401996;5583.6928968906695;5613.578981576398;5617.668667503022;5684.289463817023;6375.617462952191;6381.489480841522;6428.710708018104;6459.450946669539;6474.4678724892765;4792.329073929653;4817.2898620989745;4818.132736107499;4836.661433699643;4837.661363704542;6726.596404215763;6746.392824645805;6758.425533829631;6763.719595995938;6858.965705171492;4856.8300109495995;4872.805087796449;4885.6335774817035;4923.187674033744;4958.206686930146;4952.801887924443;4983.259207435968;5018.347614810052;5024.271480635288;5030.84907452777;5561.944380556223;5595.097666793228;5638.97180514103;5642.548596112301;5648;6525.64108974011;6527.771527996498;6532.314107018789;6537.705803238866;6540.869182616321;1669.6410271791624;1706.385701147586;1718.1666891557584;1750.3721538968628;1750.783205672071;1190.6190019193775;1200.6218041316956;1203.7901908581819;1214.174361434233;1220.2434490615874;5618.719064046782;5623.465770751772;5658.773649054074;5692.971535142381;5703.999999999917;6409.198850143732;6506.967465162738;6514.6416947068365;6522.869542609121;6613.743388756121;5711.143328500758;5717.685527296038;5728.914066289009;5747.48272655463;5770.451807078321;3504.9649503505148;3506.7895926244505;3536.858525658945;3556;3559.5906470755676;6471.576253224283;6505.772297969548;6520.673966301666;6529.706163222666;6548;6814.250432452426;6831.385175334244;6863.925425998028;6886.311368863074;6891.689873955684;6382.106505089198;6386.2975072741965;6387.393197646124;6417.2299324081405;6463.547551671338;6612.768553100618;6655.169828297257;6671.299513551201;6671.966640166768;6678;6579.506537009839;6597.538172327891;6601.108850305147;6649.501287403367;6656.667166641551;6327.335629758809;6387.808365749035;6429.839254018687;6444.9355506444335;6450.870982580228;4866.537678920497;4877.6585639004925;4895.143349913679;4910.950890491049;4929.531694489017;6657.167854018247;6718.496112791462;6726.376713081804;6736.225334086643;6756.358145976124;6354.6822658867795;6384.329645387167;6388.712507937061;6418;6434.903476447764;6346.904796427965;6360.745570177326;6418.1656384669695;6451.774187903401;6453.580517266362;5988.6706231157705;6211.689415529115;6233.594816336924;6246.6876656166105;6381.968090159519;6316;6425;6443.7422503101225;6512.6092434454085;6522.34776522344;6228.065790131516;6243.751249750159;6279.497640188682;6324.747010119544;6382.914934441868 03:42:45 INFO - PID 1821 | |5;yui.html;872.2716531696034;911.8768966189566;915.6291701860747;916.1113719691897;927.9118483744041;17728.20223089961;18799.906000469997;18933.431997040076;18946.147423365946;18986.240550377985;15663.765043524356;16769.83230167698;16938.49184524466;16966.915165424187;16976.660466790687;1040.365377119958;1042.5256508288749;1046.5552140340326;1051.952662130202;1058.2856571814034;965.2519297544424;999.605155963394;1044.6813721814844;1048.1981284317503;1068.6847380022873;1110.97222569436;1111.3332000799537;1111.4331690837691;1112.6884472347715;1121.9495122719457;1101.1356085472905;1101.9449027548671;1104.282216559243;1105.1545567640762;1108.717277094344;801.0707579208091;803.9598020098972;805.7904944714357;806.891069705588;816.9959150204211;18119.45641630753;18866.622667546708;19077.713834292495;19081;19490.512737181543;19770.40688779339;19846.90076549608;20190.596188076302;20322.593548128956;20338.389848304574;15927.442539511061;15937.442189523426;16069.517914462467;16112;16144.919275403665;3504.211552400715;3541.9291614167573;3567.161716996504;3569.428891377393;3570.9285814283567;123047.38476307651;124548.9999999991;127287.36356318252;132188;132739;15499.767503487457;16352.182390880409;16360.590985225464;16378.918105409397;16391.508254752378;29451.558226626617;29599.40801183964;30181.69818301833;30235.09294721162;30255.243618909262;8369.748907532783;8452.112528184574;8467.40728149036;8543;8552.486850788973;3605.9278814423565;3942.5071866016747;4086.8773936781945;4105.34314509683;4108.301588729923;4453.376527286117;5738.512226460714;5903.970480147657;5905.350411454737;5936.910946335808;1080.5947769586405;1100.2298391126083;1117.5027112934665;1121.7588218533056;1122.8764835868049;683.2381894188044;686.3479694290444;695.7390978383106;699.3216579917472;699.9930000699928;11740.295582265091;12160.87839121615;12334.074944379208;12374.75250494985;12457.875421245853;655.6582042142472;658.0622612776774;668.8628831089615;673.6328700858044;676.0737789228788;5391.4608539145775;5405.324334458192;5448.91826622601;5600.747966341443;5633.098704207389;106873.46563267134;108026;108908;110975;111440.4427977855;85170.57414712886;87416;89855;94080.52959735157;95363;76495.23504764993;80849.59575202086;82766.58616706877;85786;88724;12038.217515861441;12235.93882030584;12315.26108433461;12431.937840311102;12668.366581670694;37799;37952.62047379491;38137.80931095327;39168.804155979036;39502.20995580015;43392.78303608462;49598.50401495939;66141;67877;71496.64251678708;17924.103794810468;17965.73051404256;18793.624127517647;19414.417567473;19444;20500.794992049887;21099.78900210978;21180.364589061737;21372.465688357915;21493.46266343354;17150.313987440863;18374.265029398674;18423.35518256908;19358.516037098623;19545.70681439808;17861.910690446464;18135.546611334823;18155.54611134732;18217.271309147487;18594.163262653485;16238.350465981228;16282.348706051625;16527.33890644361;18098.638027239645;18102.36641717586;13225.933870330588;13450.663733406744;14017.808486278373;14286.642833929234;14395.928020359832;12910.22538647684;13046.217226966412;13391.933040334736;13943.302834858014;13996.27259054947 03:42:45 INFO - PID 1821 | __end_tp_report 03:42:45 INFO - PID 1821 | __start_cc_report 03:42:45 INFO - PID 1821 | _x_x_mozilla_cycle_collect,379 03:42:45 INFO - PID 1821 | __end_cc_report 03:42:45 INFO - PID 1821 | __startTimestamp1500720165250__endTimestamp 03:42:45 INFO - PID 1821 | 03:42:45 INFO - PID 1821 | ------- Summary: start ------- 03:42:45 INFO - PID 1821 | Number of tests: 6 03:42:45 INFO - PID 1821 | 03:42:45 INFO - PID 1821 | [#0] dojo.html Cycles:165 Average:6093.80 Median:6291.94 stddev:719.82 (11.4%) stddev-sans-first:683.02 03:42:45 INFO - PID 1821 | Values: 3114.1 3141.6 3148.6 3154.9 3180.3 6062.0 6080.4 6208.3 6259.9 6265.2 6025.3 6054.7 6069.9 6141.2 6146.1 5584.0 5601.2 5622.1 5623.7 5748.9 5701.2 5714.4 5726.9 5740.8 5777.4 5459.8 5622.0 5696.5 5752.1 5776.6 5599.7 5635.0 5635.8 5701.4 5726.1 5584.7 5604.9 5671.3 5672.9 5678.7 5988.9 6004.5 6092.3 6155.3 6155.9 6548.0 6595.8 6629.9 6673.2 6683.3 6628.6 6630.5 6709.3 6727.0 6736.4 6045.2 6139.8 6152.5 6252.2 6264.8 6735.0 6778.8 6814.8 6826.8 6830.9 6487.0 6489.7 6547.5 6564.5 6579.9 6580.1 6597.4 6665.3 6675.5 6679.3 6412.0 6535.3 6538.3 6640.3 6653.3 6521.1 6560.9 6571.2 6590.1 6617.6 5281.1 5315.5 5341.3 5355.0 5358.8 4488.2 4543.0 4559.4 4569.6 4638.0 5767.1 5818.4 5820.2 5820.4 5821.4 6609.6 6636.6 6703.0 6713.2 6717.2 5636.4 5723.3 5733.7 5749.5 5789.2 5777.3 5793.0 5817.6 5848.2 5856.6 6455.1 6473.2 6513.9 6521.1 6525.6 6574.1 6636.4 6663.9 6743.5 6764.2 6312.9 6388.3 6411.1 6500.8 6517.3 6457.0 6513.6 6535.2 6537.6 6541.6 6643.0 6671.8 6678.0 6755.7 6766.1 6421.9 6435.9 6489.8 6520.8 6541.9 6274.2 6384.6 6390.9 6396.2 6405.7 6282.6 6285.2 6291.9 6328.7 6421.4 6477.7 6506.3 6507.3 6584.1 6586.4 6163.2 6212.7 6241.2 6285.0 6321.7 03:42:45 INFO - PID 1821 | 03:42:45 INFO - PID 1821 | [#1] ext.html Cycles:180 Average:38854.72 Median:36042.87 stddev:55132.28 (153.0%) stddev-sans-first:55212.94 03:42:45 INFO - PID 1821 | Values: 810.9 848.6 873.6 875.5 1156.5 32041.8 32386.8 42216.8 42675.4 42801.8 43013.8 43359.3 43380.0 43440.6 43449.3 7614.8 7622.0 7782.6 7797.9 7810.8 7670.4 7723.8 7778.8 7779.0 7779.7 7693.7 7758.8 7781.2 7781.7 7788.1 7678.9 7724.7 7737.5 7760.5 7783.0 7604.1 7664.0 7665.5 7665.6 7686.8 38835.6 39112.4 39132.4 39182.4 39378.0 3356.8 3392.1 3394.2 3401.6 3435.0 29833.9 29883.0 29986.7 30032.7 30209.2 4769.7 4770.0 4832.8 4889.0 4889.9 191386.0 192587.0 192957.0 193728.0 193838.0 47180.3 47322.0 47385.3 47617.0 47712.0 49301.0 49809.3 49978.8 50074.5 50180.0 14286.2 15790.8 16025.4 16026.3 16026.8 11886.9 13349.5 13507.9 13509.2 13516.3 14238.4 14420.5 14435.9 14473.9 14598.3 5787.5 5802.7 5866.7 5932.2 6085.1 966.8 970.7 998.7 1006.9 1015.8 21964.0 22149.6 22398.2 23054.8 23097.8 1010.6 1021.5 1027.5 1055.7 1085.2 12138.5 15070.5 16273.5 16294.4 16682.4 232072.0 232073.0 233276.0 233567.0 234955.0 57675.4 58029.7 58195.4 58253.4 58285.1 1447.1 1455.8 1485.7 1493.8 1511.7 26489.7 26807.7 27086.2 27568.0 27733.7 38210.8 38473.4 38554.6 38564.8 38586.2 208764.0 209095.0 210766.0 211578.0 211930.0 33750.0 36830.4 38868.4 39217.8 39251.6 48191.3 48780.8 48888.3 49062.0 49081.8 34043.3 34323.7 34635.5 34790.0 35055.3 33213.8 34224.3 34590.0 35228.0 35255.3 38961.0 39053.2 39206.8 39336.8 39427.0 31454.5 33267.8 33357.5 33529.8 33530.2 24225.0 24236.9 24440.8 24452.0 25015.4 03:42:45 INFO - PID 1821 | 03:42:45 INFO - PID 1821 | [#2] jquery.html Cycles:180 Average:34229.25 Median:23120.81 stddev:80125.50 (346.6%) stddev-sans-first:80310.43 03:42:45 INFO - PID 1821 | Values: 575.7 576.5 578.4 588.4 594.3 22398.6 23260.1 23290.8 23296.2 23385.6 18850.6 19724.0 19740.8 20142.1 20449.3 6427.7 6674.7 6682.5 6700.3 6701.6 6545.2 6638.7 6643.7 6665.9 6676.2 6335.9 6569.8 6604.2 6621.7 6646.7 6590.5 6613.7 6616.3 6618.4 6640.6 6140.9 6147.8 6161.4 6170.0 6177.1 27749.3 28713.6 28922.9 28931.9 29621.1 1850.7 1909.8 1920.2 1922.1 1949.0 18359.6 18739.7 18857.2 18929.0 18946.1 2290.5 2301.1 2350.4 2353.6 2429.4 116152.4 122740.0 125878.4 131614.3 132245.0 14506.9 14728.6 14923.0 14924.0 15179.9 23117.4 23124.2 23274.7 23294.3 23299.3 9964.0 9975.0 10036.5 10083.6 10194.1 9228.5 9270.4 9357.8 9415.6 9440.2 9070.6 9090.4 9097.7 9171.0 9183.7 2577.9 2648.8 2738.6 2774.3 2800.0 877.4 891.1 892.6 894.5 910.5 17155.7 17566.9 17841.6 18095.7 18333.4 951.7 962.7 970.7 1008.5 1051.4 10285.2 10298.6 10351.5 10573.2 10895.8 468261.0 473125.0 473754.0 478416.0 480807.0 117866.0 120405.0 121375.0 122915.4 123250.0 1227.8 1280.5 1296.7 1299.7 1303.7 19454.0 19594.8 19905.0 20013.4 20154.0 58034.4 58413.4 58993.0 59377.4 61213.0 75151.6 75812.0 77811.0 77972.2 79250.6 14549.8 14823.8 15027.1 15036.5 15116.2 22860.9 23030.5 23179.1 23237.2 24148.6 18416.3 18593.0 18606.5 18636.9 18658.4 16201.4 16313.0 16637.2 16880.6 17337.8 19082.8 19326.2 19372.9 19408.3 19540.7 14011.3 14552.3 14779.3 14812.6 14883.5 18071.5 18211.1 18215.1 18248.5 18286.0 03:42:45 INFO - PID 1821 | 03:42:45 INFO - PID 1821 | [#3] mootools.html Cycles:180 Average:8642.46 Median:2604.59 stddev:5951.76 (228.5%) stddev-sans-first:5943.22 03:42:45 INFO - PID 1821 | Values: 1347.3 1384.8 1411.2 1419.7 1425.6 13476.8 13851.6 14118.9 14123.3 14145.9 13864.8 14144.6 14147.6 14156.2 14173.2 2615.3 2652.1 2655.0 2656.9 2657.4 2563.2 2593.8 2636.0 2655.7 2715.8 2674.7 2704.9 2719.6 2720.7 2728.8 2644.9 2654.2 2669.3 2671.7 2678.8 2500.8 2520.2 2523.8 2524.9 2526.6 13835.2 13932.7 13947.4 13956.7 13965.7 7317.7 7559.7 7560.7 7580.5 7594.1 4715.7 4768.3 4791.5 4900.6 4913.5 1766.4 1777.4 1793.9 1827.8 1835.3 22872.9 23471.4 23474.3 23495.8 23519.6 6496.6 6518.4 6733.2 6772.3 6813.1 15670.5 15700.8 15790.8 15818.8 15866.1 7294.7 7421.9 7488.5 7509.7 7513.7 6626.5 6632.9 6672.2 6812.7 6942.4 4835.2 4979.3 4988.4 5008.2 5046.9 1304.5 1343.7 1350.2 1446.2 1456.9 865.3 866.5 886.1 894.2 900.4 7705.9 7706.5 7799.6 7933.5 7940.2 933.4 962.9 963.5 981.4 1017.4 4715.6 4798.8 4836.9 5217.1 5519.1 18029.6 19837.2 19850.7 19861.5 19879.2 19169.4 19191.9 19514.1 19517.4 19522.1 9655.4 10281.8 10430.3 10439.4 10456.2 7778.8 7980.2 8023.8 8117.8 8202.0 16206.4 16536.8 16671.4 16782.2 17069.1 16541.8 16952.2 17144.7 17449.8 17451.0 11197.8 11499.0 11519.5 11531.3 11535.9 12629.4 12775.2 12890.2 12914.6 12920.8 10089.5 10426.9 10597.3 10754.4 10768.3 9715.6 10192.7 10241.0 10371.9 10500.6 9391.0 9528.3 9550.0 9551.4 9577.1 6706.9 7039.1 7151.1 7177.4 7208.4 6387.5 6755.7 6948.9 7226.7 7295.6 03:42:45 INFO - PID 1821 | 03:42:45 INFO - PID 1821 | [#4] prototype.html Cycles:180 Average:5434.71 Median:6025.88 stddev:1525.05 (25.3%) stddev-sans-first:1483.53 03:42:45 INFO - PID 1821 | Values: 492.7 503.2 519.2 522.9 530.4 6020.4 6136.7 6160.7 6209.3 6303.4 5840.4 6010.4 6031.4 6032.6 6051.8 4882.8 4906.5 4915.8 4930.8 4939.6 4816.4 4868.1 4930.1 4962.3 4974.6 4847.2 4922.7 4932.0 4935.7 4947.6 4844.1 4867.1 4870.2 4883.8 4914.2 4394.7 4424.9 4442.3 4448.0 4489.9 5985.2 6017.2 6054.2 6069.6 6077.4 5582.6 5583.7 5613.6 5617.7 5684.3 6375.6 6381.5 6428.7 6459.5 6474.5 4792.3 4817.3 4818.1 4836.7 4837.7 6726.6 6746.4 6758.4 6763.7 6859.0 4856.8 4872.8 4885.6 4923.2 4958.2 4952.8 4983.3 5018.3 5024.3 5030.8 5561.9 5595.1 5639.0 5642.5 5648.0 6525.6 6527.8 6532.3 6537.7 6540.9 1669.6 1706.4 1718.2 1750.4 1750.8 1190.6 1200.6 1203.8 1214.2 1220.2 5618.7 5623.5 5658.8 5693.0 5704.0 6409.2 6507.0 6514.6 6522.9 6613.7 5711.1 5717.7 5728.9 5747.5 5770.5 3505.0 3506.8 3536.9 3556.0 3559.6 6471.6 6505.8 6520.7 6529.7 6548.0 6814.3 6831.4 6863.9 6886.3 6891.7 6382.1 6386.3 6387.4 6417.2 6463.5 6612.8 6655.2 6671.3 6672.0 6678.0 6579.5 6597.5 6601.1 6649.5 6656.7 6327.3 6387.8 6429.8 6444.9 6450.9 4866.5 4877.7 4895.1 4911.0 4929.5 6657.2 6718.5 6726.4 6736.2 6756.4 6354.7 6384.3 6388.7 6418.0 6434.9 6346.9 6360.7 6418.2 6451.8 6453.6 5988.7 6211.7 6233.6 6246.7 6382.0 6316.0 6425.0 6443.7 6512.6 6522.3 6228.1 6243.8 6279.5 6324.7 6382.9 03:42:45 INFO - PID 1821 | 03:42:45 INFO - PID 1821 | [#5] yui.html Cycles:180 Average:22954.30 Median:19031.98 stddev:31277.84 (164.3%) stddev-sans-first:31321.63 03:42:45 INFO - PID 1821 | Values: 872.3 911.9 915.6 916.1 927.9 17728.2 18799.9 18933.4 18946.1 18986.2 15663.8 16769.8 16938.5 16966.9 16976.7 1040.4 1042.5 1046.6 1052.0 1058.3 965.3 999.6 1044.7 1048.2 1068.7 1111.0 1111.3 1111.4 1112.7 1121.9 1101.1 1101.9 1104.3 1105.2 1108.7 801.1 804.0 805.8 806.9 817.0 18119.5 18866.6 19077.7 19081.0 19490.5 19770.4 19846.9 20190.6 20322.6 20338.4 15927.4 15937.4 16069.5 16112.0 16144.9 3504.2 3541.9 3567.2 3569.4 3570.9 123047.4 124549.0 127287.4 132188.0 132739.0 15499.8 16352.2 16360.6 16378.9 16391.5 29451.6 29599.4 30181.7 30235.1 30255.2 8369.7 8452.1 8467.4 8543.0 8552.5 3605.9 3942.5 4086.9 4105.3 4108.3 4453.4 5738.5 5904.0 5905.4 5936.9 1080.6 1100.2 1117.5 1121.8 1122.9 683.2 686.3 695.7 699.3 700.0 11740.3 12160.9 12334.1 12374.8 12457.9 655.7 658.1 668.9 673.6 676.1 5391.5 5405.3 5448.9 5600.7 5633.1 106873.5 108026.0 108908.0 110975.0 111440.4 85170.6 87416.0 89855.0 94080.5 95363.0 76495.2 80849.6 82766.6 85786.0 88724.0 12038.2 12235.9 12315.3 12431.9 12668.4 37799.0 37952.6 38137.8 39168.8 39502.2 43392.8 49598.5 66141.0 67877.0 71496.6 17924.1 17965.7 18793.6 19414.4 19444.0 20500.8 21099.8 21180.4 21372.5 21493.5 17150.3 18374.3 18423.4 19358.5 19545.7 17861.9 18135.5 18155.5 18217.3 18594.2 16238.4 16282.3 16527.3 18098.6 18102.4 13225.9 13450.7 14017.8 14286.6 14395.9 12910.2 13046.2 13391.9 13943.3 13996.3 03:42:45 INFO - PID 1821 | -------- Summary: end -------- 03:42:45 INFO - PID 1821 | 03:42:45 INFO - TEST-INFO | 1821: exit 0 03:42:45 INFO - TEST-OK | dromaeo_css | took 1113560ms 03:42:45 INFO - TEST-START | kraken 03:42:45 INFO - Initialising browser for kraken test... 03:42:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33062/getInfo.html -profile /tmp/tmphgJiZL/profile 03:42:45 INFO - TEST-INFO | started process 2195 (/builds/slave/test/build/application/firefox/firefox http://localhost:33062/getInfo.html) 03:42:52 INFO - TEST-INFO | 2195: exit 0 03:42:52 INFO - Browser initialized. 03:42:52 INFO - Running cycle 1/1 for kraken test... 03:42:52 INFO - TEST-INFO | started process 2508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphgJiZL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:03 INFO - PID 2508 | RSS: Main: 176922624 03:43:03 INFO - PID 2508 | 03:43:06 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33062/tests/kraken/driver.html?testName=audio-beat-detection) 03:43:07 INFO - PID 2508 | RSS: Main: 180916224 03:43:07 INFO - PID 2508 | 03:43:09 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33062/tests/kraken/driver.html?testName=audio-dft) 03:43:10 INFO - PID 2508 | RSS: Main: 182018048 03:43:10 INFO - PID 2508 | 03:43:13 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33062/tests/kraken/driver.html?testName=audio-fft) 03:43:14 INFO - PID 2508 | RSS: Main: 175845376 03:43:14 INFO - PID 2508 | 03:43:16 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33062/tests/kraken/driver.html?testName=audio-oscillator) 03:43:16 INFO - PID 2508 | RSS: Main: 177102848 03:43:16 INFO - PID 2508 | 03:43:19 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33062/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:43:19 INFO - PID 2508 | RSS: Main: 177057792 03:43:19 INFO - PID 2508 | 03:43:22 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33062/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:23 INFO - PID 2508 | RSS: Main: 180072448 03:43:23 INFO - PID 2508 | 03:43:27 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33062/tests/kraken/driver.html?testName=imaging-desaturate) 03:43:27 INFO - PID 2508 | RSS: Main: 179466240 03:43:27 INFO - PID 2508 | 03:43:30 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33062/tests/kraken/driver.html?testName=json-parse-financial) 03:43:31 INFO - PID 2508 | RSS: Main: 179576832 03:43:31 INFO - PID 2508 | 03:43:32 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33062/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:43:33 INFO - PID 2508 | RSS: Main: 179970048 03:43:33 INFO - PID 2508 | 03:43:35 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33062/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:43:35 INFO - PID 2508 | RSS: Main: 180150272 03:43:35 INFO - PID 2508 | 03:43:38 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33062/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:43:38 INFO - PID 2508 | RSS: Main: 180195328 03:43:38 INFO - PID 2508 | 03:43:41 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:42 INFO - PID 2508 | RSS: Main: 180592640 03:43:42 INFO - PID 2508 | 03:43:45 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:45 INFO - PID 2508 | RSS: Main: 180441088 03:43:46 INFO - PID 2508 | 03:43:47 INFO - PID 2508 | Cycle 1(1): loaded http://localhost:33062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33062/tests/kraken/driver.html?testName=ai-astar) 03:43:48 INFO - PID 2508 | RSS: Main: 182657024 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | __start_tp_report 03:43:48 INFO - PID 2508 | _x_x_mozilla_page_load 03:43:48 INFO - PID 2508 | _x_x_mozilla_page_load_details 03:43:48 INFO - PID 2508 | |i|pagename|runs| 03:43:48 INFO - PID 2508 | |0;ai-astar;100;110;101;107;110;110;112;99;114;112 03:43:48 INFO - PID 2508 | |1;audio-beat-detection;140;119;153;181;123;148;152;125;169;122 03:43:48 INFO - PID 2508 | |2;audio-dft;165;162;164;165;165;162;167;169;164;165 03:43:48 INFO - PID 2508 | |3;audio-fft;78;74;74;172;76;76;73;76;150;79 03:43:48 INFO - PID 2508 | |4;audio-oscillator;82;80;130;81;82;82;151;81;81;137 03:43:48 INFO - PID 2508 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;114;114;116 03:43:48 INFO - PID 2508 | |6;imaging-darkroom;153;151;152;151;150;151;152;152;149;153 03:43:48 INFO - PID 2508 | |7;imaging-desaturate;94;93;94;94;94;94;94;93;95;94 03:43:48 INFO - PID 2508 | |8;json-parse-financial;53;53;54;54;54;55;53;53;53;53 03:43:48 INFO - PID 2508 | |9;json-stringify-tinderbox;54;55;59;54;55;59;55;54;54;54 03:43:48 INFO - PID 2508 | |10;stanford-crypto-aes;79;90;78;79;80;77;78;80;81;79 03:43:48 INFO - PID 2508 | |11;stanford-crypto-ccm;130;127;140;137;140;138;132;128;140;168 03:43:48 INFO - PID 2508 | |12;stanford-crypto-pbkdf2;181;187;178;184;180;178;186;181;185;179 03:43:48 INFO - PID 2508 | |13;stanford-crypto-sha256-iterative;72;71;68;71;72;68;69;70;72;72 03:43:48 INFO - PID 2508 | __end_tp_report 03:43:48 INFO - PID 2508 | __start_cc_report 03:43:48 INFO - PID 2508 | _x_x_mozilla_cycle_collect,994 03:43:48 INFO - PID 2508 | __end_cc_report 03:43:48 INFO - PID 2508 | __startTimestamp1500720228080__endTimestamp 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | ------- Summary: start ------- 03:43:48 INFO - PID 2508 | Number of tests: 14 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#0] ai-astar Cycles:10 Average:107.50 Median:111.00 stddev:5.50 (5.0%) stddev-sans-first:5.12 03:43:48 INFO - PID 2508 | Values: 100.0 110.0 101.0 107.0 110.0 110.0 112.0 99.0 114.0 112.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:150.00 stddev:21.28 (14.2%) stddev-sans-first:22.54 03:43:48 INFO - PID 2508 | Values: 140.0 119.0 153.0 181.0 123.0 148.0 152.0 125.0 169.0 122.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:2.10 (1.3%) stddev-sans-first:2.22 03:43:48 INFO - PID 2508 | Values: 165.0 162.0 164.0 165.0 165.0 162.0 167.0 169.0 164.0 165.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:36.36 (47.8%) stddev-sans-first:38.17 03:43:48 INFO - PID 2508 | Values: 78.0 74.0 74.0 172.0 76.0 76.0 73.0 76.0 150.0 79.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#4] audio-oscillator Cycles:10 Average:98.70 Median:81.00 stddev:28.50 (35.2%) stddev-sans-first:29.58 03:43:48 INFO - PID 2508 | Values: 82.0 80.0 130.0 81.0 82.0 82.0 151.0 81.0 81.0 137.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 03:43:48 INFO - PID 2508 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 116.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:152.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 03:43:48 INFO - PID 2508 | Values: 153.0 151.0 152.0 151.0 150.0 151.0 152.0 152.0 149.0 153.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:43:48 INFO - PID 2508 | Values: 94.0 93.0 94.0 94.0 94.0 94.0 94.0 93.0 95.0 94.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 03:43:48 INFO - PID 2508 | Values: 53.0 53.0 54.0 54.0 54.0 55.0 53.0 53.0 53.0 53.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:2.00 (3.6%) stddev-sans-first:2.07 03:43:48 INFO - PID 2508 | Values: 54.0 55.0 59.0 54.0 55.0 59.0 55.0 54.0 54.0 54.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.50 stddev:3.67 (4.6%) stddev-sans-first:3.87 03:43:48 INFO - PID 2508 | Values: 79.0 90.0 78.0 79.0 80.0 77.0 78.0 80.0 81.0 79.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:139.00 stddev:11.71 (8.4%) stddev-sans-first:12.06 03:43:48 INFO - PID 2508 | Values: 130.0 127.0 140.0 137.0 140.0 138.0 132.0 128.0 140.0 168.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:182.50 stddev:3.35 (1.8%) stddev-sans-first:3.54 03:43:48 INFO - PID 2508 | Values: 181.0 187.0 178.0 184.0 180.0 178.0 186.0 181.0 185.0 179.0 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.50 stddev:1.65 (2.3%) stddev-sans-first:1.66 03:43:48 INFO - PID 2508 | Values: 72.0 71.0 68.0 71.0 72.0 68.0 69.0 70.0 72.0 72.0 03:43:48 INFO - PID 2508 | -------- Summary: end -------- 03:43:48 INFO - PID 2508 | 03:43:48 INFO - PID 2508 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:43:48 INFO - TEST-INFO | 2508: exit 0 03:43:48 INFO - TEST-OK | kraken | took 62838ms 03:43:48 INFO - SUITE-END | took 1176s 03:43:49 INFO - Completed test suite (00:19:36) 03:43:49 INFO - javascript benchmark 03:43:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8426.585013371887, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.112477943785, 3141.638711548172, 3148.574942382778, 3154.9053528394147, 3180.2685382362056, 6061.969690151549, 6080.361562035989, 6208.3481234470355, 6259.937400625998, 6265.248170219568, 6025.3070896846875, 6054.666993315377, 6069.908951365733, 6141.232345956755, 6146.139540464339, 5584.0, 5601.159826026098, 5622.072358060915, 5623.7469313880765, 5748.942510574903, 5701.173329867167, 5714.371419143891, 5726.856828579298, 5740.79907203248, 5777.393373695764, 5459.781608735646, 5622.0, 5696.487316141525, 5752.079667253241, 5776.59563830532, 5599.7480113394995, 5635.013872572284, 5635.774569017234, 5701.401352857932, 5726.083826587767, 5584.692841893694, 5604.943950560483, 5671.347795003545, 5672.858178545528, 5678.659280443146, 5988.9101663475085, 6004.54965877561, 6092.329843717188, 6155.322914479404, 6155.907661385083, 6548.0, 6595.835104122388, 6629.93370066298, 6673.165854268216, 6683.331666833326, 6628.635425051621, 6630.535862489628, 6709.295523969961, 6726.966365168143, 6736.360045795642, 6045.153678485016, 6139.754409823602, 6152.477039451696, 6252.249730032379, 6264.7807326743805, 6734.966325168441, 6778.796636100925, 6814.795556133225, 6826.795196144124, 6830.863382732317, 6487.0, 6489.675516224264, 6547.5416720830035, 6564.507661925375, 6579.934200657932, 6580.078788969548, 6597.406233439014, 6665.266820649725, 6675.532712710161, 6679.265280819106, 6412.0, 6535.313792051861, 6538.346165383518, 6640.335966403418, 6653.301403352675, 6521.11964884744, 6560.9343906560325, 6571.244306904671, 6590.143281373486, 6617.569857959217, 5281.102212623787, 5315.548178404879, 5341.305630268041, 5355.036093503207, 5358.839234822962, 4488.192125417391, 4542.9772851136195, 4559.361689363492, 4569.588737013684, 4638.0491999140095, 5767.077267637158, 5818.4472475115645, 5820.185174075633, 5820.388859169726, 5821.417858214145, 6609.570377925419, 6636.601803891782, 6703.028060931138, 6713.160854893138, 6717.227518835396, 5636.351819540805, 5723.313202415737, 5733.684647344436, 5749.453801888814, 5789.247397838254, 5777.30672319316, 5793.015187418065, 5817.563682723812, 5848.181254624356, 5856.590038697335, 6455.128557644658, 6473.158489396348, 6513.869722605521, 6521.08704781331, 6525.575837570448, 6574.1453611032175, 6636.402723754885, 6663.933360666525, 6743.494237932273, 6764.154480689914, 6312.905306420315, 6388.329225431263, 6411.134496843053, 6500.772472963424, 6517.348265173445, 6456.967715161582, 6513.609183449008, 6535.183102112236, 6537.607743535403, 6541.574797638138, 6643.036759669917, 6671.83320416974, 6677.998300254806, 6755.729770809113, 6766.086578311865, 6421.935780642134, 6435.935640643534, 6489.837754056186, 6520.771772987922, 6541.901871472027, 6274.1843560336865, 6384.648844313608, 6390.93609063922, 6396.168498095218, 6405.743770249138, 6282.591631543935, 6285.182926219562, 6291.937080629318, 6328.683565821782, 6421.422072013354, 6477.740890364333, 6506.251781045051, 6507.316731743099, 6584.144061272004, 6586.37429444202, 6163.229596300463, 6212.720427580679, 6241.21984751906, 6284.968575157095, 6321.683915804283], "value": 6039.966008367833, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.9189081091891, 848.6393282854785, 873.5806812729892, 875.5315905990296, 1156.491143896685, 32041.83979080104, 32386.83806580967, 42216.788916055455, 42675.35986960198, 42801.78599107, 43013.7849310753, 43359.34960975588, 43380.0, 43440.56559434405, 43449.34825977605, 7614.771556853303, 7622.0, 7782.571958542278, 7797.883031754528, 7810.76567702967, 7670.386369090487, 7723.806904827368, 7778.8444231115345, 7779.0, 7779.727709530168, 7693.653785579662, 7758.844823103563, 7781.22187781223, 7781.688732450723, 7788.104367997667, 7678.884816727754, 7724.729634462767, 7737.497062690907, 7760.534367937942, 7782.961085194566, 7604.125525564576, 7664.0, 7665.4634175607725, 7665.61671916402, 7686.846263074764, 38835.61164388376, 39112.413313800316, 39132.41301380481, 39182.41226381606, 39378.0, 3356.848941797625, 3392.1010932103013, 3394.1684287349512, 3401.6088149862835, 3434.9828250858836, 29833.850830745923, 29883.0, 29986.70013299861, 30032.699673003208, 30209.244768880733, 4769.689970151963, 4770.0, 4832.830850920236, 4889.022195560867, 4889.902201955976, 191386.0, 192587.0, 192957.0, 193728.0, 193838.0, 47180.292295615596, 47322.0, 47385.28922066172, 47617.0, 47712.0, 49301.0, 49809.25286120711, 49978.75010624924, 50074.49925500698, 50180.0, 14286.21425821569, 15790.842091579167, 16025.43910963134, 16026.278817453243, 16026.75959860603, 11886.940565297118, 13349.466021359036, 13507.864921350661, 13509.189448633113, 13516.324183790772, 14238.430462781373, 14420.495282665266, 14435.927820361041, 14473.92763036178, 14598.34307456167, 5787.5080618147085, 5802.738876750472, 5866.70666466675, 5932.228810254639, 6085.148079268906, 966.8308046091905, 970.6990832841842, 998.7203582996773, 1006.8791744990648, 1015.7917626886618, 21964.0, 22149.55522882722, 22398.216062437736, 23054.769452305263, 23097.769022309898, 1010.5553556435145, 1021.4790456867051, 1027.4759872465097, 1055.656911503749, 1085.1806885801327, 12138.543374794905, 15070.472533461276, 16273.51179464618, 16294.42969496062, 16682.416115435903, 232072.0, 232073.0, 233276.0, 233567.0, 234955.0, 57675.423245767844, 58029.709851450476, 58195.418045819846, 58253.4174658248, 58285.125723114186, 1447.1461837515917, 1455.825300963891, 1485.7028594281187, 1493.8132733408324, 1511.7203317386318, 26489.735102648727, 26807.731922680523, 27086.1874143776, 27568.0, 27733.722662773922, 38210.80894595509, 38473.42289865598, 38554.6144538551, 38564.80717596394, 38586.22827543489, 208764.0, 209095.0, 210766.0, 211578.0, 211930.0, 33750.0, 36830.44754328633, 38868.41697374598, 39217.80391098026, 39251.607483924796, 48191.27713084236, 48780.756096219295, 48888.2666760006, 49062.01875962532, 49081.75459122682, 34043.31913361768, 34323.65676343304, 34635.47850866729, 34790.0, 35055.29889402249, 33213.833930831155, 34224.31551369008, 34590.0, 35228.0, 35255.29489410249, 38961.0, 39053.2189356217, 39206.803965981126, 39336.803315983234, 39427.0, 31454.528182077745, 33267.83366083251, 33357.499637504974, 33529.83235083809, 33530.16174595557, 24225.0, 24236.919330046454, 24440.75559244385, 24452.0, 25015.374615634028], "value": 17607.190448827834, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7495489462084, 576.4811669497452, 578.4389142531743, 588.3616276340172, 594.3343455330031, 22398.55202895941, 23260.069597216134, 23290.76709232907, 23296.18463353783, 23385.649215261783, 18850.622987540275, 19724.013799310014, 19740.802591974076, 20142.093605787737, 20449.284275050377, 6427.67861606919, 6674.6662666866705, 6682.498812589051, 6700.262971073178, 6701.597904125743, 6545.181852268466, 6638.701258443381, 6643.667816609174, 6665.866682666344, 6676.232233293161, 6335.936640633604, 6569.802905912807, 6604.174478190226, 6621.73513059477, 6646.734130634769, 6590.50571207159, 6613.735450581971, 6616.338366163393, 6618.371254730793, 6640.601563906157, 6140.907886381708, 6147.815565533041, 6161.4146656067605, 6170.0, 6177.073438984144, 27749.306267343276, 28713.56929646057, 28922.855385722938, 28931.855340723163, 29621.111366659035, 1850.69463538516, 1909.7517322747954, 1920.155131742043, 1922.09661459114, 1949.025487256372, 18359.63280734391, 18739.718904216446, 18857.151428185764, 18929.0, 18946.147423365983, 2290.5189910118893, 2301.102569997702, 2350.400647834791, 2353.611654077092, 2429.4290841652196, 116152.41923790412, 122740.0, 125878.37060814729, 131614.3419282907, 132245.0, 14506.854931450762, 14728.631784205267, 14923.0, 14924.03486924035, 15179.937404381808, 23117.422064448187, 23124.19065332739, 23274.65088023681, 23294.3011709649, 23299.301020969397, 9963.950180249052, 9974.950125249326, 10036.548355324028, 10083.596656133672, 10194.082532572103, 9228.492432916253, 9270.404286799707, 9357.812843743088, 9415.576299066559, 9440.197583205505, 9070.591823367964, 9090.409123406956, 9097.727068187965, 9171.0, 9183.724488265229, 2577.87110644467, 2648.8013398995154, 2738.6165936768866, 2774.2648198227484, 2799.984011511708, 877.4033657113097, 891.0955380289012, 892.5849479991834, 894.4677916639589, 910.5356268303213, 17155.74040932244, 17566.912165439346, 17841.643167136845, 18095.72856407155, 18333.358332458567, 951.6716732727198, 962.6582563190107, 970.6942313171328, 1008.5007921079113, 1051.353417648141, 10285.22860785444, 10298.639547615798, 10351.482425878676, 10573.154147668169, 10895.83656245157, 468261.0, 473125.0, 473754.0, 478416.0, 480807.0, 117866.0, 120405.0, 121375.0, 122915.38542307231, 123250.0, 1227.7605866855877, 1280.539005957873, 1296.695276609996, 1299.7270573179549, 1303.6610481274936, 19454.0, 19594.804051959298, 19905.0, 20013.3995980115, 20153.992300385216, 58034.4196558029, 58413.4158658425, 58993.0, 59377.40622593892, 61213.0, 75151.62424187844, 75812.0, 77811.0, 77972.2202777965, 79250.6037469809, 14549.781753273497, 14823.777643335574, 15027.09837409759, 15036.548903532912, 15116.168610726516, 22860.885695571415, 23030.539389211786, 23179.07283708633, 23237.186698465473, 24148.637770433106, 18416.263349465873, 18593.0, 18606.53483662919, 18636.906815465834, 18658.44024679262, 16201.351945922032, 16313.0, 16637.16814159263, 16880.57798555046, 17337.826621734126, 19082.809171908102, 19326.22695092237, 19372.903135484234, 19408.320708775125, 19540.706889396388, 14011.299435028412, 14552.27238638085, 14779.334929927963, 14812.555623331318, 14883.47907823221, 18071.548211294823, 18211.089445527934, 18215.089245537936, 18248.543786405447, 18286.0], "value": 11862.151524429924, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.3330701302853, 1384.833819941607, 1411.18856657422, 1419.7302512522626, 1425.593705793849, 13476.797848032274, 13851.584452466443, 14118.941079419033, 14123.293835308219, 14145.92927035366, 13864.792028119586, 14144.646383840409, 14147.575572732834, 14156.150630962149, 14173.220472873987, 2615.3461634591304, 2652.1115426332203, 2654.960175597358, 2656.893724251028, 2657.36223306407, 2563.218218443383, 2593.8314009589317, 2636.0378461861474, 2655.74770396812, 2715.8370497770097, 2674.679038515381, 2704.8918043278245, 2719.646445962022, 2720.7415295546894, 2728.822626529279, 2644.93387665308, 2654.190471906068, 2669.3326668332916, 2671.6526851509275, 2678.7589116979466, 2500.7749302562675, 2520.243926821946, 2523.835950663201, 2524.9368765781, 2526.621006848969, 13835.239061851595, 13932.721345573133, 13947.442102315896, 13956.720865582733, 13965.720685586231, 7317.743878964211, 7559.69761209551, 7560.73537426193, 7580.50726702768, 7594.126675432341, 4715.740634265114, 4768.260919557474, 4791.544803243686, 4900.607951363882, 4913.508649135094, 1766.3729376071567, 1777.3512667876132, 1793.8923664580168, 1827.826356496144, 1835.2567210279724, 22872.88563557188, 23471.4132146696, 23474.295771126894, 23495.76504234953, 23519.647205291934, 6496.577722448026, 6518.44593209573, 6733.158355205599, 6772.288909664414, 6813.148356455443, 15670.529884103495, 15700.76448853268, 15790.842091578937, 15818.76271855923, 15866.127362994916, 7294.708211671474, 7421.925780742124, 7488.475806693479, 7509.699612015458, 7513.699452021967, 6626.469882409396, 6632.9336706633285, 6672.232693240242, 6812.6934287957165, 6942.375186233162, 4835.202191638411, 4979.257259958986, 4988.401391832931, 5008.17365134756, 5046.949530504721, 1304.5238487951829, 1343.7043850352907, 1350.2033800057816, 1446.240723620108, 1456.8980171388114, 865.2731705367521, 866.5320726807454, 886.1271647427279, 894.1728900766765, 900.4237288135598, 7705.9229407706325, 7706.499077559941, 7799.571023593757, 7933.523988560705, 7940.205979402013, 933.3513208320288, 962.9133377996014, 963.4634025163009, 981.4062492192121, 1017.4251547875575, 4715.599174070242, 4798.808047678123, 4836.879078023077, 5217.087009773274, 5519.116941289374, 18029.639407211784, 19837.206511739656, 19850.70223946642, 19861.503462413268, 19879.204831806856, 19169.424917252505, 19191.90404047971, 19514.12186451613, 19517.414477565697, 19522.12150453233, 9655.420674759536, 10281.794364112826, 10430.322029068086, 10439.37363758177, 10456.215783816244, 7778.77072783257, 7980.201979801974, 8023.799405014921, 8117.837643246984, 8202.0, 16206.351745930031, 16536.75194872054, 16671.41650042291, 16782.1608919556, 17069.14654267257, 16541.83458165451, 16952.237149328557, 17144.74282885733, 17449.82550174482, 17451.0, 11197.776044479227, 11499.0, 11519.481623327138, 11531.308121512737, 11535.942320288344, 12629.431675574437, 12775.169613975062, 12890.226586404846, 12914.612561623166, 12920.806187907001, 10089.545970431202, 10426.947865260929, 10597.311174773615, 10754.354738715701, 10768.300060496043, 9715.611375544899, 10192.694219173436, 10241.027102425258, 10371.948140259552, 10500.632477863239, 9390.95304523473, 9528.285378596494, 9550.0, 9551.42691438516, 9577.138057574573, 6706.8993965089585, 7039.120109986252, 7151.141862976476, 7177.425805935617, 7208.35124838767, 6387.5209359297305, 6755.695993680394, 6948.887360858017, 7226.740735938664, 7295.635218238961], "value": 6296.833374264405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.72161228905645, 503.22252120473877, 519.158962480781, 522.8666689994051, 530.4430348134458, 6020.367861374552, 6136.723847426871, 6160.691965401735, 6209.348018458059, 6303.432691057804, 5840.386759390267, 6010.429009244126, 6031.3968603139665, 6032.6380417175, 6051.818445446644, 4882.755862206894, 4906.509349065101, 4915.820203151254, 4930.753462326869, 4939.629527785412, 4816.397950256218, 4868.123737727207, 4930.112579735646, 4962.280469331945, 4974.602031837444, 4847.224444088946, 4922.655414121013, 4931.9506804932025, 4935.728534930578, 4947.554720075193, 4844.079624871263, 4867.123917694814, 4870.172070747982, 4883.780229889646, 4914.16459201933, 4394.71434356769, 4424.867253982386, 4442.267025940716, 4448.0, 4489.9102017959785, 5985.221921150266, 6017.247844019497, 6054.244269161938, 6069.605475644069, 6077.361877002895, 5582.581306401996, 5583.6928968906695, 5613.578981576398, 5617.668667503022, 5684.289463817023, 6375.617462952191, 6381.489480841522, 6428.710708018104, 6459.450946669539, 6474.4678724892765, 4792.329073929653, 4817.2898620989745, 4818.132736107499, 4836.661433699643, 4837.661363704542, 6726.596404215763, 6746.392824645805, 6758.425533829631, 6763.719595995938, 6858.965705171492, 4856.8300109495995, 4872.805087796449, 4885.6335774817035, 4923.187674033744, 4958.206686930146, 4952.801887924443, 4983.259207435968, 5018.347614810052, 5024.271480635288, 5030.84907452777, 5561.944380556223, 5595.097666793228, 5638.97180514103, 5642.548596112301, 5648.0, 6525.64108974011, 6527.771527996498, 6532.314107018789, 6537.705803238866, 6540.869182616321, 1669.6410271791624, 1706.385701147586, 1718.1666891557584, 1750.3721538968628, 1750.783205672071, 1190.6190019193775, 1200.6218041316956, 1203.7901908581819, 1214.174361434233, 1220.2434490615874, 5618.719064046782, 5623.465770751772, 5658.773649054074, 5692.971535142381, 5703.999999999917, 6409.198850143732, 6506.967465162738, 6514.6416947068365, 6522.869542609121, 6613.743388756121, 5711.143328500758, 5717.685527296038, 5728.914066289009, 5747.48272655463, 5770.451807078321, 3504.9649503505148, 3506.7895926244505, 3536.858525658945, 3556.0, 3559.5906470755676, 6471.576253224283, 6505.772297969548, 6520.673966301666, 6529.706163222666, 6548.0, 6814.250432452426, 6831.385175334244, 6863.925425998028, 6886.311368863074, 6891.689873955684, 6382.106505089198, 6386.2975072741965, 6387.393197646124, 6417.2299324081405, 6463.547551671338, 6612.768553100618, 6655.169828297257, 6671.299513551201, 6671.966640166768, 6678.0, 6579.506537009839, 6597.538172327891, 6601.108850305147, 6649.501287403367, 6656.667166641551, 6327.335629758809, 6387.808365749035, 6429.839254018687, 6444.9355506444335, 6450.870982580228, 4866.537678920497, 4877.6585639004925, 4895.143349913679, 4910.950890491049, 4929.531694489017, 6657.167854018247, 6718.496112791462, 6726.376713081804, 6736.225334086643, 6756.358145976124, 6354.6822658867795, 6384.329645387167, 6388.712507937061, 6418.0, 6434.903476447764, 6346.904796427965, 6360.745570177326, 6418.1656384669695, 6451.774187903401, 6453.580517266362, 5988.6706231157705, 6211.689415529115, 6233.594816336924, 6246.6876656166105, 6381.968090159519, 6316.0, 6425.0, 6443.7422503101225, 6512.6092434454085, 6522.34776522344, 6228.065790131516, 6243.751249750159, 6279.497640188682, 6324.747010119544, 6382.914934441868], "value": 4987.303856048708, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [872.2716531696034, 911.8768966189566, 915.6291701860747, 916.1113719691897, 927.9118483744041, 17728.20223089961, 18799.906000469997, 18933.431997040076, 18946.147423365946, 18986.240550377985, 15663.765043524356, 16769.83230167698, 16938.49184524466, 16966.915165424187, 16976.660466790687, 1040.365377119958, 1042.5256508288749, 1046.5552140340326, 1051.952662130202, 1058.2856571814034, 965.2519297544424, 999.605155963394, 1044.6813721814844, 1048.1981284317503, 1068.6847380022873, 1110.97222569436, 1111.3332000799537, 1111.4331690837691, 1112.6884472347715, 1121.9495122719457, 1101.1356085472905, 1101.9449027548671, 1104.282216559243, 1105.1545567640762, 1108.717277094344, 801.0707579208091, 803.9598020098972, 805.7904944714357, 806.891069705588, 816.9959150204211, 18119.45641630753, 18866.622667546708, 19077.713834292495, 19081.0, 19490.512737181543, 19770.40688779339, 19846.90076549608, 20190.596188076302, 20322.593548128956, 20338.389848304574, 15927.442539511061, 15937.442189523426, 16069.517914462467, 16112.0, 16144.919275403665, 3504.211552400715, 3541.9291614167573, 3567.161716996504, 3569.428891377393, 3570.9285814283567, 123047.38476307651, 124548.9999999991, 127287.36356318252, 132188.0, 132739.0, 15499.767503487457, 16352.182390880409, 16360.590985225464, 16378.918105409397, 16391.508254752378, 29451.558226626617, 29599.40801183964, 30181.69818301833, 30235.09294721162, 30255.243618909262, 8369.748907532783, 8452.112528184574, 8467.40728149036, 8543.0, 8552.486850788973, 3605.9278814423565, 3942.5071866016747, 4086.8773936781945, 4105.34314509683, 4108.301588729923, 4453.376527286117, 5738.512226460714, 5903.970480147657, 5905.350411454737, 5936.910946335808, 1080.5947769586405, 1100.2298391126083, 1117.5027112934665, 1121.7588218533056, 1122.8764835868049, 683.2381894188044, 686.3479694290444, 695.7390978383106, 699.3216579917472, 699.9930000699928, 11740.295582265091, 12160.87839121615, 12334.074944379208, 12374.75250494985, 12457.875421245853, 655.6582042142472, 658.0622612776774, 668.8628831089615, 673.6328700858044, 676.0737789228788, 5391.4608539145775, 5405.324334458192, 5448.91826622601, 5600.747966341443, 5633.098704207389, 106873.46563267134, 108026.0, 108908.0, 110975.0, 111440.4427977855, 85170.57414712886, 87416.0, 89855.0, 94080.52959735157, 95363.0, 76495.23504764993, 80849.59575202086, 82766.58616706877, 85786.0, 88724.0, 12038.217515861441, 12235.93882030584, 12315.26108433461, 12431.937840311102, 12668.366581670694, 37799.0, 37952.62047379491, 38137.80931095327, 39168.804155979036, 39502.20995580015, 43392.78303608462, 49598.50401495939, 66141.0, 67877.0, 71496.64251678708, 17924.103794810468, 17965.73051404256, 18793.624127517647, 19414.417567473, 19444.0, 20500.794992049887, 21099.78900210978, 21180.364589061737, 21372.465688357915, 21493.46266343354, 17150.313987440863, 18374.265029398674, 18423.35518256908, 19358.516037098623, 19545.70681439808, 17861.910690446464, 18135.546611334823, 18155.54611134732, 18217.271309147487, 18594.163262653485, 16238.350465981228, 16282.348706051625, 16527.33890644361, 18098.638027239645, 18102.36641717586, 13225.933870330588, 13450.663733406744, 14017.808486278373, 14286.642833929234, 14395.928020359832, 12910.22538647684, 13046.217226966412, 13391.933040334736, 13943.302834858014, 13996.27259054947], "value": 9036.609877677518, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 101.0, 107.0, 110.0, 110.0, 112.0, 99.0, 114.0, 112.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 119.0, 153.0, 181.0, 123.0, 148.0, 152.0, 125.0, 169.0, 122.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 164.0, 165.0, 165.0, 162.0, 167.0, 169.0, 164.0, 165.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 74.0, 172.0, 76.0, 76.0, 73.0, 76.0, 150.0, 79.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 130.0, 81.0, 82.0, 82.0, 151.0, 81.0, 81.0, 137.0], "value": 98.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 116.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 152.0, 151.0, 150.0, 151.0, 152.0, 152.0, 149.0, 153.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 54.0, 55.0, 53.0, 53.0, 53.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 59.0, 54.0, 55.0, 59.0, 55.0, 54.0, 54.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 90.0, 78.0, 79.0, 80.0, 77.0, 78.0, 80.0, 81.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 140.0, 137.0, 140.0, 138.0, 132.0, 128.0, 140.0, 168.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 187.0, 178.0, 184.0, 180.0, 178.0, 186.0, 181.0, 185.0, 179.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 68.0, 71.0, 72.0, 68.0, 69.0, 70.0, 72.0, 72.0], "value": 70.5, "unit": "score"}]}]} 03:43:49 INFO - Return code: 0 03:43:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:43:49 INFO - # TBPL SUCCESS # 03:43:49 INFO - Running post-action listener: _package_coverage_data 03:43:49 INFO - Running post-action listener: _resource_record_post_action 03:43:49 INFO - [mozharness: 2017-07-22 10:43:49.340460Z] Finished run-tests step (success) 03:43:49 INFO - Running post-run listener: _resource_record_post_run 03:43:49 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436588544; Read time: 8; Write time: 230736 03:43:49 INFO - TinderboxPrint: CPU usage
13.1% 03:43:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:43:49 INFO - TinderboxPrint: I/O write bytes / time
436,588,544 / 230,736 03:43:49 INFO - TinderboxPrint: CPU idle
8,274.0 (86.8%) 03:43:49 INFO - TinderboxPrint: CPU user
1,204.6 (12.6%) 03:43:49 INFO - TinderboxPrint: Swap in / out
0 / 0 03:43:49 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106438656; Read time: 0; Write time: 57836 03:43:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:43:49 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 330149888; Read time: 0; Write time: 172900 03:43:49 INFO - Running post-run listener: _upload_blobber_files 03:43:49 INFO - Blob upload gear active. 03:43:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:43:49 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'] 03:43:49 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 03:43:50 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:43:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:43:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:51 INFO - (blobuploader) - INFO - Done attempting. 03:43:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:43:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:43:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:51 INFO - (blobuploader) - INFO - Done attempting. 03:43:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:43:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:43:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:52 INFO - (blobuploader) - INFO - Done attempting. 03:43:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:43:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:43:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:55 INFO - (blobuploader) - INFO - Done attempting. 03:43:55 INFO - (blobuploader) - INFO - Iteration through files over. 03:43:55 INFO - Return code: 0 03:43:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:43:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:43:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3592dff08a35db5815047150c359576f1ab26b28ba035a964214d46b0cf72c9459ad25cbf18adeb40dc6215686bee42f42d2283293faadb0aa1098f43f7017a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6430e8c3134df31931f67aa4f9a1e413885edbc3e9de89865b556c6b571af4a8bedbafa3a41a6a39efdfaa6ec453c7df31762aed430319f737f2e0e9bfbfd82a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbb0fb7790ce2038876f0f09e00cf956c950a15265f1d1cc139f363ce3671d477da49cab62d1589fd6b88e3df6b7b29d22f10e1b7bb6c6004dedf657ce049740", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2a487529e912bf0e79203bd633449851fbeaedef687f34e7fbd88640505845a4ece2dbf090cda0be7fd46f18b32024d014041aa957f7d9fa990fe4524be851f"} 03:43:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:43:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:43:55 INFO - Contents: 03:43:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3592dff08a35db5815047150c359576f1ab26b28ba035a964214d46b0cf72c9459ad25cbf18adeb40dc6215686bee42f42d2283293faadb0aa1098f43f7017a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6430e8c3134df31931f67aa4f9a1e413885edbc3e9de89865b556c6b571af4a8bedbafa3a41a6a39efdfaa6ec453c7df31762aed430319f737f2e0e9bfbfd82a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbb0fb7790ce2038876f0f09e00cf956c950a15265f1d1cc139f363ce3671d477da49cab62d1589fd6b88e3df6b7b29d22f10e1b7bb6c6004dedf657ce049740", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2a487529e912bf0e79203bd633449851fbeaedef687f34e7fbd88640505845a4ece2dbf090cda0be7fd46f18b32024d014041aa957f7d9fa990fe4524be851f"} 03:43:55 INFO - Running post-run listener: copy_logs_to_upload_dir 03:43:55 INFO - Copying logs to upload dir... 03:43:55 INFO - mkdir: /builds/slave/test/build/upload/logs 03:43:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1343.611432 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 23 secs) (at 2017-07-22 03:43:54.807548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 03:43:54.811169) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3592dff08a35db5815047150c359576f1ab26b28ba035a964214d46b0cf72c9459ad25cbf18adeb40dc6215686bee42f42d2283293faadb0aa1098f43f7017a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6430e8c3134df31931f67aa4f9a1e413885edbc3e9de89865b556c6b571af4a8bedbafa3a41a6a39efdfaa6ec453c7df31762aed430319f737f2e0e9bfbfd82a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbb0fb7790ce2038876f0f09e00cf956c950a15265f1d1cc139f363ce3671d477da49cab62d1589fd6b88e3df6b7b29d22f10e1b7bb6c6004dedf657ce049740", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2a487529e912bf0e79203bd633449851fbeaedef687f34e7fbd88640505845a4ece2dbf090cda0be7fd46f18b32024d014041aa957f7d9fa990fe4524be851f"} build_url:https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/RwKFdA9lQGydGPWJvR_XgA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3592dff08a35db5815047150c359576f1ab26b28ba035a964214d46b0cf72c9459ad25cbf18adeb40dc6215686bee42f42d2283293faadb0aa1098f43f7017a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6430e8c3134df31931f67aa4f9a1e413885edbc3e9de89865b556c6b571af4a8bedbafa3a41a6a39efdfaa6ec453c7df31762aed430319f737f2e0e9bfbfd82a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbb0fb7790ce2038876f0f09e00cf956c950a15265f1d1cc139f363ce3671d477da49cab62d1589fd6b88e3df6b7b29d22f10e1b7bb6c6004dedf657ce049740", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2a487529e912bf0e79203bd633449851fbeaedef687f34e7fbd88640505845a4ece2dbf090cda0be7fd46f18b32024d014041aa957f7d9fa990fe4524be851f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 03:43:54.838372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:43:54.838923) ========= 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=3297cc2eebb5444a7688c33f000001b5-1500711398.571085-1602034782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 03:43:54.920342) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 03:43:54.920695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 03:43:54.921105) ========= ========= Total master_lag: 0.22 =========