builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1501034714.57 results: success (0) revision: c6d36106525ba7b65a3587d643c3b145de80fb99 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 19:05:14.569688) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 19:05:14.570255) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 19:05:14.570574) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 19:05:14.615351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 19:05:14.615673) ========= 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=337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-25 19:05:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2017-07-25 19:05:14 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.191282 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 19:05:14.824067) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 19:05:14.824420) ========= 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=337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017025 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 19:05:14.877845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-25 19:05:14.878269) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c6d36106525ba7b65a3587d643c3b145de80fb99 --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 c6d36106525ba7b65a3587d643c3b145de80fb99 --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=337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-25 19:05:15,016 truncating revision to first 12 chars 2017-07-25 19:05:15,017 Setting DEBUG logging. 2017-07-25 19:05:15,017 attempt 1/10 2017-07-25 19:05:15,017 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c6d36106525b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-25 19:05:16,448 unpacking tar archive at: mozilla-central-c6d36106525b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.748910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-25 19:05:16.647381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 19:05:16.647728) ========= script_repo_revision: c6d36106525ba7b65a3587d643c3b145de80fb99 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 19:05:16.648109) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 19:05:16.648722) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 19:05:16.657562) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-07-25 19:05:16.657878) ========= /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=337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:05:16 INFO - MultiFileLogger online at 20170725 19:05:16 in /builds/slave/test 19:05:16 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 19:05:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:05:16 INFO - {'append_to_log': False, 19:05:16 INFO - 'base_work_dir': '/builds/slave/test', 19:05:16 INFO - 'blob_upload_branch': 'Firefox', 19:05:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:05:16 INFO - 'branch': 'Firefox', 19:05:16 INFO - 'buildbot_json_path': 'buildprops.json', 19:05:16 INFO - 'code_coverage': False, 19:05:16 INFO - 'config_files': ('talos/linux_config.py',), 19:05:16 INFO - 'default_actions': ('clobber', 19:05:16 INFO - 'read-buildbot-config', 19:05:16 INFO - 'download-and-extract', 19:05:16 INFO - 'populate-webroot', 19:05:16 INFO - 'create-virtualenv', 19:05:16 INFO - 'install', 19:05:16 INFO - 'setup-mitmproxy', 19:05:16 INFO - 'run-tests'), 19:05:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:05:16 INFO - 'disable_ccov_upload': False, 19:05:16 INFO - 'download_minidump_stackwalk': True, 19:05:16 INFO - 'download_symbols': 'ondemand', 19:05:16 INFO - 'enable_stylo': False, 19:05:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:05:16 INFO - 'tooltool.py': '/tools/tooltool.py', 19:05:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:05:16 INFO - '/tools/misc-python/virtualenv.py')}, 19:05:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:05:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:05:16 INFO - 'gecko_profile': False, 19:05:16 INFO - 'gecko_profile_interval': 0, 19:05:16 INFO - 'installer_path': 'installer.exe', 19:05:16 INFO - 'log_level': 'info', 19:05:16 INFO - 'log_name': 'talos', 19:05:16 INFO - 'log_to_console': True, 19:05:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:05:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:05:16 INFO - 'opt_config_files': (), 19:05:16 INFO - 'pip_index': False, 19:05:16 INFO - 'suite': 'dromaeojs-e10s', 19:05:16 INFO - 'system_bits': '32', 19:05:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:05:16 INFO - 'title': 'talos-linux64-ix-060', 19:05:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:05:16 INFO - 'use_talos_json': True, 19:05:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:05:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:05:16 INFO - 'work_dir': 'build'} 19:05:16 INFO - [mozharness: 2017-07-26 02:05:16.976665Z] Running clobber step. 19:05:16 INFO - Running pre-action listener: _resource_record_pre_action 19:05:16 INFO - Running main action method: clobber 19:05:16 INFO - rmtree: /builds/slave/test/build 19:05:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:05:17 INFO - Running post-action listener: _resource_record_post_action 19:05:17 INFO - [mozharness: 2017-07-26 02:05:17.963912Z] Finished clobber step (success) 19:05:17 INFO - [mozharness: 2017-07-26 02:05:17.964015Z] Running read-buildbot-config step. 19:05:17 INFO - Running pre-action listener: _resource_record_pre_action 19:05:17 INFO - Running main action method: read_buildbot_config 19:05:17 INFO - Using buildbot properties: 19:05:17 INFO - { 19:05:17 INFO - "project": "", 19:05:17 INFO - "product": "firefox", 19:05:17 INFO - "who": "kwierso@gmail.com", 19:05:17 INFO - "installer_path": "public/build/target.tar.bz2", 19:05:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 19:05:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:05:17 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 19:05:17 INFO - "stage_platform": "linux64-stylo", 19:05:17 INFO - "basedir": "/builds/slave/test", 19:05:17 INFO - "buildnumber": 2, 19:05:17 INFO - "platform": "ubuntu64_hw_stylo", 19:05:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:05:17 INFO - "slavebuilddir": "test", 19:05:17 INFO - "taskId": "ND_KDM-JTUeed78eEJ0Lcg", 19:05:17 INFO - "branch": "mozilla-central", 19:05:17 INFO - "script_repo_revision": "production", 19:05:17 INFO - "revision": "c6d36106525ba7b65a3587d643c3b145de80fb99", 19:05:17 INFO - "slavename": "talos-linux64-ix-060", 19:05:17 INFO - "repo_path": "mozilla-central" 19:05:17 INFO - } 19:05:17 INFO - Finding installer, test and symbols from parent task. 19:05:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ND_KDM-JTUeed78eEJ0Lcg'}, attempt #1 19:05:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ND_KDM-JTUeed78eEJ0Lcg'}, attempt #1 19:05:18 INFO - Task dependencies: EnS2W1TrQhyyZX2E3Xy6uw 19:05:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw'}, attempt #1 19:05:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.tar.bz2 19:05:19 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/test_packages.json 19:05:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.crashreporter-symbols.zip 19:05:19 INFO - Running post-action listener: _resource_record_post_action 19:05:19 INFO - [mozharness: 2017-07-26 02:05:19.311074Z] Finished read-buildbot-config step (success) 19:05:19 INFO - [mozharness: 2017-07-26 02:05:19.311295Z] Running download-and-extract step. 19:05:19 INFO - Running pre-action listener: _resource_record_pre_action 19:05:19 INFO - Running main action method: download_and_extract 19:05:19 INFO - mkdir: /builds/slave/test/build/tests 19:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:19 INFO - trying https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.test_packages.json 19:05:19 INFO - Downloading https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:05:19 INFO - Downloaded 989 bytes. 19:05:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:05:19 INFO - Using the following test package requirements: 19:05:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:05:19 INFO - u'common': [u'target.common.tests.zip'], 19:05:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:05:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:05:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:05:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:05:19 INFO - u'mozbase': [u'target.common.tests.zip'], 19:05:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:05:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:05:19 INFO - u'web-platform': [u'target.common.tests.zip', 19:05:19 INFO - u'target.web-platform.tests.tar.gz'], 19:05:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:05:19 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:05:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.common.tests.zip 19:05:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:05:19 INFO - Fetch https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.common.tests.zip into memory 19:05:21 INFO - Content-Length response header: 72762034 19:05:21 INFO - Bytes received: 72762034 19:05:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:05:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.common.tests.zip 19:05:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:05:32 INFO - Fetch https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.common.tests.zip into memory 19:05:34 INFO - Content-Length response header: 72762034 19:05:34 INFO - Bytes received: 72762034 19:05:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.talos.tests.zip 19:05:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:05:47 INFO - Fetch https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.talos.tests.zip into memory 19:05:55 INFO - Content-Length response header: 14498866 19:05:55 INFO - Bytes received: 14498866 19:05:55 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')]} 19:05:55 INFO - trying https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.tar.bz2 19:05:55 INFO - Downloading https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:05:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:05:56 INFO - Downloaded 62040209 bytes. 19:05:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.tar.bz2 19:05:56 INFO - mkdir: /builds/slave/test/properties 19:05:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:05:56 INFO - Writing to file /builds/slave/test/properties/build_url 19:05:56 INFO - Contents: 19:05:56 INFO - build_url:https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.tar.bz2 19:05:56 INFO - Running post-action listener: _resource_record_post_action 19:05:56 INFO - Running post-action listener: set_extra_try_arguments 19:05:56 INFO - [mozharness: 2017-07-26 02:05:56.842555Z] Finished download-and-extract step (success) 19:05:56 INFO - [mozharness: 2017-07-26 02:05:56.842653Z] Running populate-webroot step. 19:05:56 INFO - Running pre-action listener: _resource_record_pre_action 19:05:56 INFO - Running main action method: populate_webroot 19:05:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:05:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:05:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:05:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:05:56 INFO - 'tests': ['damp', 'tps']}, 19:05:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:05:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:05:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:05:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:05:56 INFO - 'other-e10s': {'tests': ['a11yr', 19:05:56 INFO - 'ts_paint', 19:05:56 INFO - 'tpaint', 19:05:56 INFO - 'sessionrestore', 19:05:56 INFO - 'sessionrestore_many_windows', 19:05:56 INFO - 'sessionrestore_no_auto_restore', 19:05:56 INFO - 'tabpaint']}, 19:05:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:05:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:05:56 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:05:56 INFO - 'talos_options': ['--mitmproxy', 19:05:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:05:56 INFO - '--firstNonBlankPaint'], 19:05:56 INFO - 'tests': ['quantum_pageload_google', 19:05:56 INFO - 'quantum_pageload_youtube', 19:05:56 INFO - 'quantum_pageload_amazon', 19:05:56 INFO - 'quantum_pageload_facebook']}, 19:05:56 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:05:56 INFO - 'talos_options': ['--stylo', 19:05:56 INFO - '--mitmproxy', 19:05:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:05:56 INFO - '--firstNonBlankPaint'], 19:05:56 INFO - 'tests': ['quantum_pageload_google', 19:05:56 INFO - 'quantum_pageload_youtube', 19:05:56 INFO - 'quantum_pageload_amazon', 19:05:56 INFO - 'quantum_pageload_facebook']}, 19:05:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:05:56 INFO - 'tsvgr_opacity', 19:05:56 INFO - 'tart', 19:05:56 INFO - 'tscrollx', 19:05:56 INFO - 'cart', 19:05:56 INFO - 'tsvg_static']}, 19:05:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:05:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:05:56 INFO - 'talos_options': ['--xperf_path', 19:05:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:56 INFO - 'tests': ['tp5n']}}} 19:05:56 INFO - Running post-action listener: _resource_record_post_action 19:05:56 INFO - [mozharness: 2017-07-26 02:05:56.849942Z] Finished populate-webroot step (success) 19:05:56 INFO - [mozharness: 2017-07-26 02:05:56.850031Z] Running create-virtualenv step. 19:05:56 INFO - Running pre-action listener: _resource_record_pre_action 19:05:56 INFO - Running main action method: create_virtualenv 19:05:56 INFO - Creating virtualenv /builds/slave/test/build/venv 19:05:56 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 19:05:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:05:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:05:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:05:56 INFO - Using real prefix '/usr' 19:05:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:05:57 INFO - Installing distribute.............................................................................................................................................................................................done. 19:05:59 INFO - Installing pip.................done. 19:05:59 INFO - Return code: 0 19:05:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:05:59 INFO - Reading from file tmpfile_stdout 19:05:59 INFO - Output received: 19:05:59 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) 19:05:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:05:59 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')]} 19:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:59 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')]} 19:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:59 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 0x1b3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaaeb0>, '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 0x1eabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac240>, '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': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', '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 19:05:59 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 19:05:59 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 19:05:59 INFO - Using env: {'DISPLAY': ':0', 19:05:59 INFO - 'HOME': '/home/cltbld', 19:05:59 INFO - 'LANG': 'en_US.UTF-8', 19:05:59 INFO - 'LANGUAGE': 'en_US:en', 19:05:59 INFO - 'LOGNAME': 'cltbld', 19:05:59 INFO - 'MAIL': '/var/mail/cltbld', 19:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:59 INFO - 'MOZ_NO_REMOTE': '1', 19:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:59 INFO - 'NO_EM_RESTART': '1', 19:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:59 INFO - 'PWD': '/builds/slave/test', 19:05:59 INFO - 'SHELL': '/bin/bash', 19:05:59 INFO - 'SHLVL': '1', 19:05:59 INFO - 'TERM': 'linux', 19:05:59 INFO - 'TMOUT': '86400', 19:05:59 INFO - 'USER': 'cltbld', 19:05:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', 19:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:59 INFO - '_': '/tools/buildbot/bin/python'} 19:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:00 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 19:06:00 INFO - Cleaning up... 19:06:00 INFO - Return code: 0 19:06:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:06:00 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')]} 19:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:00 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')]} 19:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:00 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 0x1b3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaaeb0>, '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 0x1eabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac240>, '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': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', '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 19:06:00 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 19:06:00 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 19:06:00 INFO - Using env: {'DISPLAY': ':0', 19:06:00 INFO - 'HOME': '/home/cltbld', 19:06:00 INFO - 'LANG': 'en_US.UTF-8', 19:06:00 INFO - 'LANGUAGE': 'en_US:en', 19:06:00 INFO - 'LOGNAME': 'cltbld', 19:06:00 INFO - 'MAIL': '/var/mail/cltbld', 19:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:00 INFO - 'MOZ_NO_REMOTE': '1', 19:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:00 INFO - 'NO_EM_RESTART': '1', 19:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:00 INFO - 'PWD': '/builds/slave/test', 19:06:00 INFO - 'SHELL': '/bin/bash', 19:06:00 INFO - 'SHLVL': '1', 19:06:00 INFO - 'TERM': 'linux', 19:06:00 INFO - 'TMOUT': '86400', 19:06:00 INFO - 'USER': 'cltbld', 19:06:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', 19:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:00 INFO - '_': '/tools/buildbot/bin/python'} 19:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:00 INFO - Downloading/unpacking psutil>=3.1.1 19:06:00 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 19:06:00 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 19:06:00 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 19:06:00 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 19:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:06:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:01 INFO - Installing collected packages: psutil 19:06:01 INFO - Running setup.py install for psutil 19:06:01 INFO - building 'psutil._psutil_linux' extension 19:06:01 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 19:06:02 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 19:06:02 INFO - building 'psutil._psutil_posix' extension 19:06:02 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 19:06:02 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 19:06:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:02 INFO - Successfully installed psutil 19:06:02 INFO - Cleaning up... 19:06:02 INFO - Return code: 0 19:06:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:06:02 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')]} 19:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:02 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')]} 19:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:02 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 0x1b3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaaeb0>, '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 0x1eabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac240>, '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': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', '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 19:06:02 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 19:06:02 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 19:06:02 INFO - Using env: {'DISPLAY': ':0', 19:06:02 INFO - 'HOME': '/home/cltbld', 19:06:02 INFO - 'LANG': 'en_US.UTF-8', 19:06:02 INFO - 'LANGUAGE': 'en_US:en', 19:06:02 INFO - 'LOGNAME': 'cltbld', 19:06:02 INFO - 'MAIL': '/var/mail/cltbld', 19:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:02 INFO - 'MOZ_NO_REMOTE': '1', 19:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:02 INFO - 'NO_EM_RESTART': '1', 19:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:02 INFO - 'PWD': '/builds/slave/test', 19:06:02 INFO - 'SHELL': '/bin/bash', 19:06:02 INFO - 'SHLVL': '1', 19:06:02 INFO - 'TERM': 'linux', 19:06:02 INFO - 'TMOUT': '86400', 19:06:02 INFO - 'USER': 'cltbld', 19:06:02 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', 19:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:02 INFO - '_': '/tools/buildbot/bin/python'} 19:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:06:03 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 19:06:03 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 19:06:03 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 19:06:03 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 19:06:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:06:04 INFO - Installing collected packages: mozsystemmonitor 19:06:04 INFO - Running setup.py install for mozsystemmonitor 19:06:04 INFO - Successfully installed mozsystemmonitor 19:06:04 INFO - Cleaning up... 19:06:04 INFO - Return code: 0 19:06:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:06:04 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')]} 19:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:04 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')]} 19:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:04 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 0x1b3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaaeb0>, '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 0x1eabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac240>, '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': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', '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 19:06:04 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 19:06:04 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 19:06:04 INFO - Using env: {'DISPLAY': ':0', 19:06:04 INFO - 'HOME': '/home/cltbld', 19:06:04 INFO - 'LANG': 'en_US.UTF-8', 19:06:04 INFO - 'LANGUAGE': 'en_US:en', 19:06:04 INFO - 'LOGNAME': 'cltbld', 19:06:04 INFO - 'MAIL': '/var/mail/cltbld', 19:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:04 INFO - 'MOZ_NO_REMOTE': '1', 19:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:04 INFO - 'NO_EM_RESTART': '1', 19:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:04 INFO - 'PWD': '/builds/slave/test', 19:06:04 INFO - 'SHELL': '/bin/bash', 19:06:04 INFO - 'SHLVL': '1', 19:06:04 INFO - 'TERM': 'linux', 19:06:04 INFO - 'TMOUT': '86400', 19:06:04 INFO - 'USER': 'cltbld', 19:06:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', 19:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:04 INFO - '_': '/tools/buildbot/bin/python'} 19:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:04 INFO - Downloading/unpacking jsonschema==2.5.1 19:06:04 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 19:06:04 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 19:06:04 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 19:06:04 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 19:06:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:06:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:06:05 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 19:06:05 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 19:06:05 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 19:06:05 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 19:06:05 INFO - Downloading functools32-3.2.3-2.tar.gz 19:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:06:05 INFO - warning: no files found matching '*.txt' 19:06:05 INFO - no previously-included directories found matching 'build' 19:06:05 INFO - no previously-included directories found matching 'dist' 19:06:05 INFO - no previously-included directories found matching '.git*' 19:06:05 INFO - Installing collected packages: jsonschema, functools32 19:06:05 INFO - Running setup.py install for functools32 19:06:06 INFO - warning: no files found matching '*.txt' 19:06:06 INFO - no previously-included directories found matching 'build' 19:06:06 INFO - no previously-included directories found matching 'dist' 19:06:06 INFO - no previously-included directories found matching '.git*' 19:06:06 INFO - Successfully installed jsonschema functools32 19:06:06 INFO - Cleaning up... 19:06:06 INFO - Return code: 0 19:06:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:06 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 0x1b3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaaeb0>, '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 0x1eabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac240>, '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': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', '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 19:06:06 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 19:06:06 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 19:06:06 INFO - Using env: {'DISPLAY': ':0', 19:06:06 INFO - 'HOME': '/home/cltbld', 19:06:06 INFO - 'LANG': 'en_US.UTF-8', 19:06:06 INFO - 'LANGUAGE': 'en_US:en', 19:06:06 INFO - 'LOGNAME': 'cltbld', 19:06:06 INFO - 'MAIL': '/var/mail/cltbld', 19:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:06 INFO - 'MOZ_NO_REMOTE': '1', 19:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:06 INFO - 'NO_EM_RESTART': '1', 19:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:06 INFO - 'PWD': '/builds/slave/test', 19:06:06 INFO - 'SHELL': '/bin/bash', 19:06:06 INFO - 'SHLVL': '1', 19:06:06 INFO - 'TERM': 'linux', 19:06:06 INFO - 'TMOUT': '86400', 19:06:06 INFO - 'USER': 'cltbld', 19:06:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', 19:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:06 INFO - '_': '/tools/buildbot/bin/python'} 19:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:06:06 INFO - Cleaning up... 19:06:06 INFO - Return code: 0 19:06:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:06 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 0x1b3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaaeb0>, '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 0x1eabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac240>, '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': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', '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 19:06:06 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 19:06:06 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 19:06:06 INFO - Using env: {'DISPLAY': ':0', 19:06:06 INFO - 'HOME': '/home/cltbld', 19:06:06 INFO - 'LANG': 'en_US.UTF-8', 19:06:06 INFO - 'LANGUAGE': 'en_US:en', 19:06:06 INFO - 'LOGNAME': 'cltbld', 19:06:06 INFO - 'MAIL': '/var/mail/cltbld', 19:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:06 INFO - 'MOZ_NO_REMOTE': '1', 19:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:06 INFO - 'NO_EM_RESTART': '1', 19:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:06 INFO - 'PWD': '/builds/slave/test', 19:06:06 INFO - 'SHELL': '/bin/bash', 19:06:06 INFO - 'SHLVL': '1', 19:06:06 INFO - 'TERM': 'linux', 19:06:06 INFO - 'TMOUT': '86400', 19:06:06 INFO - 'USER': 'cltbld', 19:06:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', 19:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:06 INFO - '_': '/tools/buildbot/bin/python'} 19:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:06 INFO - Downloading/unpacking blobuploader==1.2.4 19:06:06 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 19:06:06 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 19:06:06 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 19:06:06 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 19:06:07 INFO - Downloading blobuploader-1.2.4.tar.gz 19:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:06:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:06:07 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 19:06:07 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 19:06:07 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 19:06:07 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 19:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:06:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:06:08 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 19:06:08 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 19:06:08 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 19:06:08 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 19:06:08 INFO - Downloading docopt-0.6.1.tar.gz 19:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:06:08 INFO - Installing collected packages: blobuploader, requests, docopt 19:06:08 INFO - Running setup.py install for blobuploader 19:06:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:06:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:06:08 INFO - Running setup.py install for requests 19:06:08 INFO - Running setup.py install for docopt 19:06:08 INFO - Successfully installed blobuploader requests docopt 19:06:08 INFO - Cleaning up... 19:06:08 INFO - Return code: 0 19:06:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:08 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')]} 19:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:08 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')]} 19:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:08 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 0x1b3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaaeb0>, '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 0x1eabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac240>, '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': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', '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 19:06:08 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 19:06:08 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 19:06:08 INFO - Using env: {'DISPLAY': ':0', 19:06:08 INFO - 'HOME': '/home/cltbld', 19:06:08 INFO - 'LANG': 'en_US.UTF-8', 19:06:08 INFO - 'LANGUAGE': 'en_US:en', 19:06:08 INFO - 'LOGNAME': 'cltbld', 19:06:08 INFO - 'MAIL': '/var/mail/cltbld', 19:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:08 INFO - 'MOZ_NO_REMOTE': '1', 19:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:08 INFO - 'NO_EM_RESTART': '1', 19:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:08 INFO - 'PWD': '/builds/slave/test', 19:06:08 INFO - 'SHELL': '/bin/bash', 19:06:08 INFO - 'SHLVL': '1', 19:06:08 INFO - 'TERM': 'linux', 19:06:08 INFO - 'TMOUT': '86400', 19:06:08 INFO - 'USER': 'cltbld', 19:06:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', 19:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:08 INFO - '_': '/tools/buildbot/bin/python'} 19:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:06:09 INFO - Running setup.py (path:/tmp/pip-srNstZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:06:09 INFO - Running setup.py (path:/tmp/pip-ux4fI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:06:09 INFO - Running setup.py (path:/tmp/pip-uGTv69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:06:09 INFO - Running setup.py (path:/tmp/pip-tcSJEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:06:09 INFO - Running setup.py (path:/tmp/pip-h4wijd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:06:09 INFO - Running setup.py (path:/tmp/pip-5VCbzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:06:09 INFO - Running setup.py (path:/tmp/pip-LVWyP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:06:09 INFO - Running setup.py (path:/tmp/pip-qpZOrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:06:09 INFO - Running setup.py (path:/tmp/pip-IHrGQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:06:09 INFO - Running setup.py (path:/tmp/pip-DsZnaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:06:09 INFO - Running setup.py (path:/tmp/pip-7ulCPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:06:09 INFO - Running setup.py (path:/tmp/pip-n6wKTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:06:09 INFO - Running setup.py (path:/tmp/pip-Amwv5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:06:09 INFO - Running setup.py (path:/tmp/pip-2AYxeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:10 INFO - Running setup.py (path:/tmp/pip-cO9NKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:06:10 INFO - Running setup.py (path:/tmp/pip-Fxv5bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:06:10 INFO - Running setup.py (path:/tmp/pip-WfhPsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:06:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:06:10 INFO - Running setup.py install for manifestparser 19:06:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:06:10 INFO - Running setup.py install for mozcrash 19:06:10 INFO - Running setup.py install for mozdebug 19:06:10 INFO - Running setup.py install for mozdevice 19:06:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:06:10 INFO - Running setup.py install for mozfile 19:06:10 INFO - Running setup.py install for mozhttpd 19:06:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:06:10 INFO - Running setup.py install for mozinfo 19:06:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:06:10 INFO - Running setup.py install for mozInstall 19:06:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:06:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:06:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:06:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:06:11 INFO - Running setup.py install for mozleak 19:06:11 INFO - Running setup.py install for mozlog 19:06:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:06:11 INFO - Running setup.py install for moznetwork 19:06:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:06:11 INFO - Running setup.py install for mozprocess 19:06:11 INFO - Running setup.py install for mozprofile 19:06:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:06:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:06:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:06:11 INFO - Running setup.py install for mozrunner 19:06:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:06:11 INFO - Running setup.py install for mozscreenshot 19:06:11 INFO - Running setup.py install for moztest 19:06:11 INFO - Running setup.py install for mozversion 19:06:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:06:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:06:12 INFO - Cleaning up... 19:06:12 INFO - Return code: 0 19:06:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06: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')]} 19:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06: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')]} 19:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:12 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 0x1b3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaaeb0>, '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 0x1eabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac240>, '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': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', '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 19:06:12 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 19:06:12 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 19:06:12 INFO - Using env: {'DISPLAY': ':0', 19:06:12 INFO - 'HOME': '/home/cltbld', 19:06:12 INFO - 'LANG': 'en_US.UTF-8', 19:06:12 INFO - 'LANGUAGE': 'en_US:en', 19:06:12 INFO - 'LOGNAME': 'cltbld', 19:06:12 INFO - 'MAIL': '/var/mail/cltbld', 19:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:12 INFO - 'MOZ_NO_REMOTE': '1', 19:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:12 INFO - 'NO_EM_RESTART': '1', 19:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:12 INFO - 'PWD': '/builds/slave/test', 19:06:12 INFO - 'SHELL': '/bin/bash', 19:06:12 INFO - 'SHLVL': '1', 19:06:12 INFO - 'TERM': 'linux', 19:06:12 INFO - 'TMOUT': '86400', 19:06:12 INFO - 'USER': 'cltbld', 19:06:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', 19:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:12 INFO - '_': '/tools/buildbot/bin/python'} 19:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:06:12 INFO - Running setup.py (path:/tmp/pip-pVRJdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:06:12 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)) 19:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:06:12 INFO - Running setup.py (path:/tmp/pip-Z11FyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:06:12 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)) 19:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:06:12 INFO - Running setup.py (path:/tmp/pip-8gPhd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:06:12 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)) 19:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:06:12 INFO - Running setup.py (path:/tmp/pip-1i553Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:06:12 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)) 19:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:06:12 INFO - Running setup.py (path:/tmp/pip-4Ew85D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:06:12 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)) 19:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:06:12 INFO - Running setup.py (path:/tmp/pip-AybmA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:06:12 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)) 19:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:06:12 INFO - Running setup.py (path:/tmp/pip-0FOUec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:06:12 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)) 19:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:06:12 INFO - Running setup.py (path:/tmp/pip-DZbO2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:06:12 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)) 19:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:06:12 INFO - Running setup.py (path:/tmp/pip-GUezOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:06:12 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)) 19:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:06:12 INFO - Running setup.py (path:/tmp/pip-is1TqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:06:13 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)) 19:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:06:13 INFO - Running setup.py (path:/tmp/pip-43lZxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:06:13 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)) 19:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:06:13 INFO - Running setup.py (path:/tmp/pip-oYDB4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:06:13 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)) 19:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:06:13 INFO - Running setup.py (path:/tmp/pip-go1fui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:06:13 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)) 19:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:06:13 INFO - Running setup.py (path:/tmp/pip-8Aj6kJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:06:13 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)) 19:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:13 INFO - Running setup.py (path:/tmp/pip-kC9lLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:13 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)) 19:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:06:13 INFO - Running setup.py (path:/tmp/pip-gk118O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:06:13 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)) 19:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:06:13 INFO - Running setup.py (path:/tmp/pip-AgcvJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:06:13 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)) 19:06:13 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)) 19:06:13 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)) 19:06:13 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)) 19:06:13 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)) 19:06:13 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)) 19:06:13 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)) 19:06:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:14 INFO - Downloading blessings-1.6.tar.gz 19:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:06:14 INFO - Installing collected packages: blessings 19:06:14 INFO - Running setup.py install for blessings 19:06:14 INFO - Successfully installed blessings 19:06:14 INFO - Cleaning up... 19:06:14 INFO - Return code: 0 19:06:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:06:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:06:15 INFO - Reading from file tmpfile_stdout 19:06:15 INFO - Current package versions: 19:06:15 INFO - argparse == 1.2.1 19:06:15 INFO - blessings == 1.6 19:06:15 INFO - blobuploader == 1.2.4 19:06:15 INFO - docopt == 0.6.1 19:06:15 INFO - functools32 == 3.2.3-2 19:06:15 INFO - jsonschema == 2.5.1 19:06:15 INFO - manifestparser == 1.1 19:06:15 INFO - mozInstall == 1.13 19:06:15 INFO - mozcrash == 1.0 19:06:15 INFO - mozdebug == 0.1 19:06:15 INFO - mozdevice == 0.51 19:06:15 INFO - mozfile == 1.2 19:06:15 INFO - mozhttpd == 0.7 19:06:15 INFO - mozinfo == 0.10 19:06:15 INFO - mozleak == 0.1 19:06:15 INFO - mozlog == 3.5 19:06:15 INFO - moznetwork == 0.27 19:06:15 INFO - mozprocess == 0.25 19:06:15 INFO - mozprofile == 0.28 19:06:15 INFO - mozrunner == 6.13 19:06:15 INFO - mozscreenshot == 0.1 19:06:15 INFO - mozsystemmonitor == 0.3 19:06:15 INFO - moztest == 0.8 19:06:15 INFO - mozversion == 1.4 19:06:15 INFO - psutil == 3.1.1 19:06:15 INFO - requests == 1.2.3 19:06:15 INFO - wsgiref == 0.1.2 19:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:15 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 0x1b3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaaeb0>, '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 0x1eabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac240>, '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': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', '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 19:06:15 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 19:06:15 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 19:06:15 INFO - Using env: {'DISPLAY': ':0', 19:06:15 INFO - 'HOME': '/home/cltbld', 19:06:15 INFO - 'LANG': 'en_US.UTF-8', 19:06:15 INFO - 'LANGUAGE': 'en_US:en', 19:06:15 INFO - 'LOGNAME': 'cltbld', 19:06:15 INFO - 'MAIL': '/var/mail/cltbld', 19:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:15 INFO - 'MOZ_NO_REMOTE': '1', 19:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:15 INFO - 'NO_EM_RESTART': '1', 19:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:15 INFO - 'PWD': '/builds/slave/test', 19:06:15 INFO - 'SHELL': '/bin/bash', 19:06:15 INFO - 'SHLVL': '1', 19:06:15 INFO - 'TERM': 'linux', 19:06:15 INFO - 'TMOUT': '86400', 19:06:15 INFO - 'USER': 'cltbld', 19:06:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', 19:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:15 INFO - '_': '/tools/buildbot/bin/python'} 19:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:15 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)) 19:06:15 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)) 19:06:15 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)) 19:06:15 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)) 19:06:15 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)) 19:06:15 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)) 19:06:15 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)) 19:06:15 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)) 19:06:15 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)) 19:06:15 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:16 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:06:16 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 19:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:06:16 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)) 19:06:16 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)) 19:06:16 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)) 19:06:16 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)) 19:06:16 INFO - Installing collected packages: marionette-driver, simplejson 19:06:16 INFO - Running setup.py install for marionette-driver 19:06:16 INFO - Running setup.py install for simplejson 19:06:16 INFO - building 'simplejson._speedups' extension 19:06:16 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 19:06:17 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 19:06:17 INFO - Successfully installed marionette-driver simplejson 19:06:17 INFO - Cleaning up... 19:06:17 INFO - Return code: 0 19:06:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eadd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaaeb0>, '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 0x1eabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac240>, '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': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', '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 19:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:06:17 INFO - Using env: {'DISPLAY': ':0', 19:06:17 INFO - 'HOME': '/home/cltbld', 19:06:17 INFO - 'LANG': 'en_US.UTF-8', 19:06:17 INFO - 'LANGUAGE': 'en_US:en', 19:06:17 INFO - 'LOGNAME': 'cltbld', 19:06:17 INFO - 'MAIL': '/var/mail/cltbld', 19:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:17 INFO - 'MOZ_NO_REMOTE': '1', 19:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:17 INFO - 'NO_EM_RESTART': '1', 19:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:17 INFO - 'PWD': '/builds/slave/test', 19:06:17 INFO - 'SHELL': '/bin/bash', 19:06:17 INFO - 'SHLVL': '1', 19:06:17 INFO - 'TERM': 'linux', 19:06:17 INFO - 'TMOUT': '86400', 19:06:17 INFO - 'USER': 'cltbld', 19:06:17 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', 19:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:17 INFO - '_': '/tools/buildbot/bin/python'} 19:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:06:18 INFO - Cleaning up... 19:06:18 INFO - Return code: 0 19:06:18 INFO - Running post-action listener: _resource_record_post_action 19:06:18 INFO - Running post-action listener: _start_resource_monitoring 19:06:18 INFO - Starting resource monitoring. 19:06:18 INFO - [mozharness: 2017-07-26 02:06:18.209839Z] Finished create-virtualenv step (success) 19:06:18 INFO - [mozharness: 2017-07-26 02:06:18.210781Z] Running install step. 19:06:18 INFO - Running pre-action listener: _resource_record_pre_action 19:06:18 INFO - Running main action method: install 19:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:06:18 INFO - Reading from file tmpfile_stdout 19:06:18 INFO - Detecting whether we're running mozinstall >=1.0... 19:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:06:18 INFO - Reading from file tmpfile_stdout 19:06:18 INFO - Output received: 19:06:18 INFO - Usage: mozinstall [options] installer 19:06:18 INFO - Options: 19:06:18 INFO - -h, --help show this help message and exit 19:06:18 INFO - -d DEST, --destination=DEST 19:06:18 INFO - Directory to install application into. [default: 19:06:18 INFO - "/builds/slave/test"] 19:06:18 INFO - --app=APP Application being installed. [default: firefox] 19:06:18 INFO - mkdir: /builds/slave/test/build/application 19:06:18 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'] 19:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:06:36 INFO - Reading from file tmpfile_stdout 19:06:36 INFO - Output received: 19:06:36 INFO - /builds/slave/test/build/application/firefox/firefox 19:06:36 INFO - Running post-action listener: _resource_record_post_action 19:06:36 INFO - [mozharness: 2017-07-26 02:06:36.519357Z] Finished install step (success) 19:06:36 INFO - [mozharness: 2017-07-26 02:06:36.519614Z] Running setup-mitmproxy step. 19:06:36 INFO - Running pre-action listener: _resource_record_pre_action 19:06:36 INFO - Running main action method: setup_mitmproxy 19:06:36 INFO - Skipping: mitmproxy is not required 19:06:36 INFO - Running post-action listener: _resource_record_post_action 19:06:36 INFO - [mozharness: 2017-07-26 02:06:36.520740Z] Finished setup-mitmproxy step (success) 19:06:36 INFO - [mozharness: 2017-07-26 02:06:36.520960Z] Running run-tests step. 19:06:36 INFO - Running pre-action listener: _resource_record_pre_action 19:06:36 INFO - Running pre-action listener: _set_gcov_prefix 19:06:36 INFO - Running main action method: run_tests 19:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:06:36 INFO - Python 2.7.3 19:06:36 INFO - Return code: 0 19:06:36 INFO - grabbing minidump binary from tooltool 19:06: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')]} 19:06:36 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 0x1eaaeb0>, '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 0x1eabdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:06:36 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 19:06:36 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 19:06:36 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 19:06:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:06:36 INFO - Return code: 0 19:06:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:06:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:06:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:06:36 INFO - ENV: RUST_BACKTRACE is now 1 19:06:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:06:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:06:36 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/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 19:06:36 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/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 19:06:36 INFO - Using env: {'DISPLAY': ':0', 19:06:36 INFO - 'HOME': '/home/cltbld', 19:06:36 INFO - 'LANG': 'en_US.UTF-8', 19:06:36 INFO - 'LANGUAGE': 'en_US:en', 19:06:36 INFO - 'LOGNAME': 'cltbld', 19:06:36 INFO - 'MAIL': '/var/mail/cltbld', 19:06:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:06:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:36 INFO - 'MOZ_NO_REMOTE': '1', 19:06:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:36 INFO - 'NO_EM_RESTART': '1', 19:06:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:36 INFO - 'PWD': '/builds/slave/test', 19:06:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:06:36 INFO - 'RUST_BACKTRACE': '1', 19:06:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:06:36 INFO - 'SHELL': '/bin/bash', 19:06:36 INFO - 'SHLVL': '1', 19:06:36 INFO - 'STYLO_FORCE_ENABLED': '1', 19:06:36 INFO - 'TERM': 'linux', 19:06:36 INFO - 'TMOUT': '86400', 19:06:36 INFO - 'USER': 'cltbld', 19:06:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393', 19:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:36 INFO - '_': '/tools/buildbot/bin/python'} 19:06:36 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/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 19:06:37 INFO - mozversion application_buildid: 20170726012405 19:06:37 INFO - mozversion application_changeset: c6d36106525ba7b65a3587d643c3b145de80fb99 19:06:37 INFO - mozversion application_display_name: Nightly 19:06:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:06:37 INFO - mozversion application_name: Firefox 19:06:37 INFO - mozversion application_remotingname: firefox 19:06:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:06:37 INFO - mozversion application_vendor: Mozilla 19:06:37 INFO - mozversion application_version: 56.0a1 19:06:37 INFO - mozversion platform_buildid: 20170726012405 19:06:37 INFO - mozversion platform_changeset: c6d36106525ba7b65a3587d643c3b145de80fb99 19:06:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:06:37 INFO - mozversion platform_version: 56.0a1 19:06:37 INFO - using testdate: 1501034797 19:06:37 INFO - actual date: 1501034797 19:06:37 INFO - starting webserver on 'localhost:56676' 19:06:37 INFO - SUITE-START | Running 2 tests 19:06:37 INFO - TEST-START | dromaeo_css 19:06:37 INFO - Initialising browser for dromaeo_css test... 19:06:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56676/getInfo.html -profile /tmp/tmpJ6zAUk/profile 19:06:37 INFO - TEST-INFO | started process 3311 (/builds/slave/test/build/application/firefox/firefox http://localhost:56676/getInfo.html) 19:06:44 INFO - TEST-INFO | 3311: exit 0 19:06:45 INFO - Browser initialized. 19:06:45 INFO - Running cycle 1/1 for dromaeo_css test... 19:06:45 INFO - TEST-INFO | started process 3542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ6zAUk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:45 INFO - PID 3542 | 19:06:45 INFO - PID 3542 | (/builds/slave/test/build/application/firefox/firefox:3597): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:06:45 INFO - PID 3542 | 19:06:56 INFO - PID 3542 | RSS: Main: 174546944 19:06:56 INFO - PID 3542 | 19:09:55 INFO - PID 3542 | Cycle 1(1): loaded http://localhost:56676/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56676/tests/dromaeo/cssquery-ext.html) 19:09:57 INFO - PID 3542 | RSS: Main: 175001600 19:09:57 INFO - PID 3542 | 19:12:59 INFO - PID 3542 | Cycle 1(1): loaded http://localhost:56676/tests/dromaeo/cssquery-ext.html (next: http://localhost:56676/tests/dromaeo/cssquery-jquery.html) 19:12:59 INFO - PID 3542 | RSS: Main: 173637632 19:12:59 INFO - PID 3542 | 19:16:01 INFO - PID 3542 | Cycle 1(1): loaded http://localhost:56676/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56676/tests/dromaeo/cssquery-mootools.html) 19:16:02 INFO - PID 3542 | RSS: Main: 175489024 19:16:02 INFO - PID 3542 | 19:19:04 INFO - PID 3542 | Cycle 1(1): loaded http://localhost:56676/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56676/tests/dromaeo/cssquery-prototype.html) 19:19:04 INFO - PID 3542 | RSS: Main: 173977600 19:19:04 INFO - PID 3542 | 19:22:08 INFO - PID 3542 | Cycle 1(1): loaded http://localhost:56676/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56676/tests/dromaeo/cssquery-yui.html) 19:22:09 INFO - PID 3542 | RSS: Main: 175599616 19:22:09 INFO - PID 3542 | 19:25:11 INFO - PID 3542 | Cycle 1(1): loaded http://localhost:56676/tests/dromaeo/cssquery-yui.html (next: http://localhost:56676/tests/dromaeo/cssquery-dojo.html) 19:25:11 INFO - PID 3542 | RSS: Main: 178061312 19:25:11 INFO - PID 3542 | 19:25:11 INFO - PID 3542 | __start_tp_report 19:25:11 INFO - PID 3542 | _x_x_mozilla_page_load 19:25:11 INFO - PID 3542 | _x_x_mozilla_page_load_details 19:25:11 INFO - PID 3542 | |i|pagename|runs| 19:25:11 INFO - PID 3542 | |0;dojo.html;3105.3323535439877;3119.0486901495033;3126.5622812806205;3130.2487403023265;3198.184462961946;6019.578629495937;6074.544409169308;6107.969460152704;6119.051547010215;6312.274088479826;6251.59364641298;6270.592411493261;6292;6334.968325158367;6339.492840572755;5506.64206826555;5664.915026274589;5693.089105743082;5712.971435142829;5802.738876750556;5554;5586.525145362649;5604.523615492688;5630.662160270397;5644.689542075184;5684.2326285951285;5761.135829625548;5772.5670574707065;5778.768849246047;5784.739686714108;5673.574481913873;5733.369329373765;5771.307443106854;5785.27684039495;5788.710564471759;5560.471755183251;5608.046632072557;5653.378128405872;5697.943020569783;5715.171300161495;6095.359987201368;6139.508839292846;6198.132261483396;6217.285012223561;6233.688315584202;6667;6681.732730690766;6739.831504212385;6773.525853190229;6782.898256526156;6511.762765074668;6669.833254168685;6698.531102822804;6714.597124172566;6784.626845523494;6203.16257305267;6230.937690623081;6232.719527621268;6241;6244.157038799749;6861.759838405632;6873.690683919235;6878.828029299208;6886.208086070166;6887.345702158287;6478.028295755675;6512.479001679854;6556.475481961432;6573.671316434159;6590.505712071614;6614.768483103068;6644.60132392058;6705.966470167716;6714.194296684429;6755.763548275787;6479.514036447285;6486.091947127406;6554.082428460019;6623.867522649616;6639.734410623618;6662.133922590032;6679.833004174838;6745.628990405575;6746.932530674729;6748.055272261888;5458.263134476795;5463.590230732711;5475.945240547623;5477.04151773446;5478.260434841325;4643.164230438486;4652.697574657636;4667.603253723471;4712.31671407644;4717.457492388351;5722.341930677942;5757.193992841006;5783.016887129198;5807.738651760681;5886.911696324559;6719.966400167968;6722.865542689119;6726.159230096238;6731.091302674076;6742.157230346207;5743.827685169452;5780.479756821906;5793.507551858055;5823.388544202798;5839.941600584025;5826.271716035496;5851.853703657443;5919.082542205965;5920.703964801743;5922.111683247461;6321.146645202931;6419.422251997343;6445.677716114175;6504.5446818723185;6522.5760325578685;6656.134702488839;6661.467082633475;6680;6705.564138331188;6770.356816102462;6446.323136070645;6476.255230648348;6488.416042556192;6525.249596296487;6526.641034742945;6537.673116344259;6563.835904102436;6572.638504882278;6639.966800165968;6683.264840867403;6493.837654058686;6653.201615806134;6653.600783952978;6656.434203092791;6765.797026089225;6419.358064193543;6449.419552240133;6450.387213214737;6452.806415807533;6458.3864532871185;6447.580907241015;6512.772052978123;6542.443892269211;6548.8362790930605;6552.049952756919;6382.521310901794;6392.552521323462;6488.383603557654;6500.414962653194;6503.51223658237;6432.842088424129;6451.290358060516;6553.868922621426;6586.604803711793;6597.80206593803;6314.463270622048;6377.4579160771855;6388.329225431263;6403.391677790602;6407.9038814418755 19:25:11 INFO - PID 3542 | |1;ext.html;811.3509192645881;858.2318824651936;873.5326600268855;874.5539774714897;1180.4451907603423;31972.200694982606;43201.135977280435;44055.33916991248;44111.11777764443;44310.778446107724;43337;43489.347659785126;43513.34729979045;43671.78164109183;43784.562154378444;7780.999999999985;7915.089764677049;7918.802029949268;7927.28654421102;7934.365250779923;7707.96146019272;7844.9215507844765;7848.058233012047;7852;7867.213278672116;5888.32284287306;6014.2181516403025;6082.787102451415;7867.331276841475;7870;7588.506747061451;7797.103333116679;7823.2176782321885;7832.68669253232;7833.96083019587;7690.769276921701;7769.689212431496;7770.689172433153;7771;7774.494657847222;38340.616593833984;38728.80635596832;38759;38835.41746873799;38841.61158388436;3563.2695297463956;3583.283343331318;3593.3711600470074;3603.063203567065;3609.873654422083;31175;31177.532337014734;31213;31237.687623123933;31281.217969550715;4809.951900480985;4861.440934292566;4880.194767863299;4958.057968985917;4961.9255711164;183823;184235;185715;186794.06602967033;186931;47630;47711;47809.282860757114;47816.76091619589;48022.75988620034;48958.5104148954;49549.25676114861;49741.25388119181;49783.751081245086;49792.75103624459;15225.162616056223;15431.382744690087;15476.303566339542;15480.5355839325;15487.380504779909;12462.75074498505;12502.312372819582;12519.186252893533;12538.059645526622;12538.498460061677;13363.799543006862;13585.252811095485;13643.181409115485;13675.384607692678;13801.378937947817;5362.758675859518;5495.148252020943;5892.410758924159;5973;5996.16053752475;991.5984026469291;1001.2540657210279;1006.1648831470009;1007.5566750629699;1013.8023085498404;23395;23470.295891123293;23617.763822361558;23930;24176.87911560466;1083.182197440927;1083.1930211992117;1116.2019156303281;1122.6688127002553;1126.6507382711386;12005.279683219034;12048.913205967609;12212.450439730055;12250.326232057145;12290.446929888176;225729;228067;229476;229694;229916;54916.45083549193;55306;55575.44424555784;55588.72205638946;55963.16055259174;1442.1131004432198;1446.5751235033274;1478.1426772471941;1478.290420598119;1508.5561390547384;22190.779507127263;22427.551448971255;22562.887185563966;23105.729184894994;23185.76814231836;38051.42922856215;38127.80936095302;38158.236835262585;38187.2362552753;38217.80891095527;201871.99064004587;203239;204618;205013;205780;35012.64987350094;35303.47044794279;35331.29337413289;35585.82207088948;35622.109447264025;43031.7848410756;44519;44572.55427445684;44761.328580071975;44788.32817507805;31248;31575.84212078925;32385;32663;32751.508727368633;29894.551581726726;31621.84189079132;32072.51891221587;32291.677083228868;32311.192220194684;35386;35612.64387356093;35623.28753424969;35704.28591428209;36096;29703.40593188081;30427.54358684577;30828.383432331677;31254.53118203183;31448.52827207548;22530.098796047976;30653.386932260782;31129.37741245208;31675.84162079267;31956 19:25:11 INFO - PID 3542 | |2;jquery.html;569.8603842058697;577.6707276852196;584.0742423259134;586.7066466766616;597.2981746447923;22288.331350059485;22840.31479055631;23242.88378558107;23248.535029299404;23283.301500954978;26068.869655651743;26439.86780066097;26521;26529;26594;6504.772332968335;6607.867842643144;6652.733890644368;6655.8336041599105;6701.765438209663;6336.841578960517;6466.256380516254;6559.212894452672;6610.933890661104;6639.701213445406;6589.736410543573;6607.108040414555;6612.206535215781;6613.2064152301555;6613.437857782094;6541.084248205255;6579.638119903403;6583.9012414813815;6586.143801305848;6614.7684831031165;6104.26748790148;6153.692315384257;6160.1991741073825;6167.907481387782;6180.505559555225;29218.123456296344;29640.8517957411;29844.403111937856;29943.70056299431;30354.392912141855;1929.5272658198692;1993.9900300498405;1999.8900060496667;2003.0685731135093;2003.7495313085865;18470.907645461823;18989.715154272697;20365.694514582294;20368.185272589228;20400.79599204004;2334.26470661741;2358.7287461941924;2408.6146216605434;2435.172041505879;2436.561418944589;143696;145260;154620;154742;154818;21200.78799212019;21494.355169344944;21784.80183589886;22363;22533.549329013327;44843;44992.77503612526;45019.324710129375;45074;45185.77407112943;11182.440877956069;11472.827907581393;11570.479328430241;11631.127665425127;11706.473208705458;9409.952950235342;9410.764730881783;9499.28755343352;9589.184919281939;9632.422054676601;11724.779079531361;12064.75870482603;12300.138990270774;12314.692132696575;12337.69155771095;3809.885703428846;3850.2492014057552;4103.561807841951;4173.24881521323;4236.068065025689;939.3143005605946;949.8100379923904;953.5137080089066;978.9608415663436;1013.2096964367805;23843.7615623845;25278.74721252764;25375.36561585975;25398.746012540007;25549.87225063863;949.9335046546813;963.4700914496999;969.699393188114;1002.1481740520645;1006.4011912911806;10424.895751042544;10501.894981050245;10582.153427725763;10614.681559553226;11069.391183484986;470857.3999716306;480578;488770;489964;511824;119774;122517;124742;125469;125552.37223813822;1273.1279073834453;1289.4004288006122;1300.9284489353176;1321.187469706124;1324.7019420630281;17102.828971710125;18027.459176224733;18052.909735451238;18611.906940465753;18648;54298;56209.43790562042;58530;58787.118193227994;60667.08999365101;73657.6317118411;74146.62926685331;74679;75699.62150189214;75703.24296756962;14714.117152970855;15094.245287735788;15118;15150.24248787534;15152.469663561722;23724.762752372946;24100.035998559862;24122.51754964926;24330.14844480435;24352.63471047971;17987.820121798613;18700.81299186991;18939.71590426117;19357.4192774217;19385.806141938963;16027.679446411239;16455.341786328412;17128.143592820557;17340.82659173392;17580.73628895593;20121.295754648516;20207.4948126298;20348.59302813965;20490.795092048887;20495.18019279272;14409.567712968628;14663;14883.10701357922;14946.327415266122;15005.849941500444;19051.809481905002;19080.90459547749;19209.90395048016;19214.615707685487;19225 19:25:11 INFO - PID 3542 | |3;mootools.html;1343.0799902067085;1377.449020391843;1395.3999780094555;1400.6428360768002;1411.1180512179888;13386.129901556404;13638.863611363884;13936.721265574683;13952.162870227794;13953.302334883241;14145.92927035366;14378.712425751504;14385.92807035966;14407.27963601821;14421.206833624146;2412.867292298923;2439.6340548917715;2448.8040956723507;2449.09383528094;2449.6815413996155;2542.8092893033004;2615.934601634965;2633.4206474575562;2666.1601595497355;2669.639598654176;2583.547879121156;2584.25056733548;2614.6078088286718;2659.0693257359962;2674.023981246841;2598.337423956879;2601.8048646351504;2611.308003379087;2614.7646711795837;2616.9476610467777;2513.4847356291916;2549.7705206531314;2556.6676332076895;2557.1433569754154;2566.0890383913816;13472.663183420394;13510.662233444242;13519.52681656147;13613.795793063113;13641.727165456734;7353.852922941511;7673.9616301918695;7701.345385642171;7713.65288562016;7726.806829829243;4786.976065119687;4957.776900039471;5011.323471331397;5018.247262910556;5039.042581909425;1897.1313256442393;1915.8754680945833;1920.807919208082;1943.1450161928847;1975.3580086471954;21803.563928721494;21967.121315147535;21990.780092199035;22004.449888752748;22026.559468810694;6085.391460853879;6266.683996360724;6305;6401.3278605746655;6433.453156481752;14787.852121478863;15439.691206176038;15462.768058479132;15577.454789082327;15601.531954041397;7266.237045110293;7437.925620743723;7467.887981680279;7479.439042071757;7480.925190748132;6605.966970165118;6785.796426107225;6836.658167091626;6886.586804791728;6896.862062758717;4811.542903424169;4876.097921884463;4929.704217746947;4978.1288274552535;5000.074986127505;1314.5070598525554;1325.1121748428577;1334.7597432462055;1348.110247236819;1349.5209200733598;839.7606682095574;850.7873031742065;851.9829603408022;888.3337496877342;898.9460632362079;6874.793756187322;6903.5167538271835;6949.82625434358;6991.405730512862;7049.612271325126;691.7129391302653;705.693023534764;714.5783987447431;725.3906718356606;731.572030362244;4073.857414990461;4470.374147619336;4812.879678008007;4857.732824694675;4914.533119353656;17777.822221777875;18142.365017224332;18705;18726;18861.434156975312;18277.543061423305;18452.077396130408;18470.984095874588;18585.163667634988;18644.906775466035;10116.494175291205;10265.948670256601;10520.316179448311;10649.094826939798;10718;6591.8709574383365;7037.331453511908;7140.107486564179;7149.606771627402;7253.492255542273;15869.285882135562;16303.510894673178;16388.426405075767;16440.177991100638;16536.66926661484;16040.43858464948;16244.51266462008;16523.917380413503;16655.91672041632;16786;10853.565857365616;11020.559177632806;11184.496697648789;11254.606088786853;11319.943400282946;12687.429065691882;12886.48454061827;12903;12908.354582271037;12925.224486530838;10078.6472473466;10693.251472396858;10780.730481737706;10891.128709703364;11009.394483303175;9997.950010249902;10235.7441063974;10267.794644107225;10733.355998640107;10850.94574527154;9101.180893719596;9261.16649501548;9278.536073196448;9305.674301399418;9309.581068851783;5962.791302304398;6100;6379.170707807955;6390.456811170917;6440.67796610177;6131.816045518642;6242.625442473466;6264.342244064308;6364.917963946233;6557.9344206559235 19:25:11 INFO - PID 3542 | |4;prototype.html;488.2694473853413;504.8338338438208;516.9069567477854;523.3588853654271;526.9631125821194;6107.877842443154;6147.108669242957;6168.691565421722;6203.968980155104;6223.502119830414;5842.853928651786;5978.252718410199;6006.579539432241;6071.817845464632;6076.453119219269;4797.352357431737;4815.301781241717;4834.87912802181;4847.860752723107;4863.95713800203;4859.198232291667;4882.975585122087;4902.436219834729;4918.729469879156;4956.107900577895;4555.316702494619;4593.655475839309;4712.929306060412;4786.473487916326;4823.180059389894;4820.975895120519;4832.371791667096;4869.391326084239;4879.4876537963355;4879.585235255007;4342.218400687875;4346.739195648272;4363.476382834048;4370.562943705636;4375.737455752633;5983.222181116471;5994.400559944014;6014.428629280255;6029.879402411971;6041;5540.307461567304;5563.638363506359;5564.749586268627;5565.30433695788;5578.828446026339;6288.717007734663;6298.118263443122;6399.704152361537;6476.4171224589545;6563.212414510242;4691.741954192518;4701.764911754399;4744.16977029022;4755.571998520115;4811.831585894512;6704.2625311215725;6718.8320291993095;6732.528722989393;6829.829254268633;6856.114568493655;4827.782749776268;4866.31871537985;4871.8294859679745;4879.829205977774;4883.4628190898975;4942.874563937541;4960;4980.526849949249;4986.401631804134;5001.0998020355955;5476.698781567052;5561.304836895388;5569.248151499577;5581.330240371181;5605.487582496048;6399.328070552618;6463.15978922737;6472.935270647234;6477.838054048687;6567.934320656828;1698.5923378389346;1707.897526148435;1724.534375718549;1726.5424662464457;1736.9565760855826;1109.7503061811028;1158.4092113022418;1195.7967145585271;1198.161287099034;1204.3556697166973;5599.160125981135;5650.519705825051;5667.546596272288;5679.6876171810945;5685.403032681592;6422.74309027643;6500.992346186349;6534.575252608565;6564.8358791030605;6581.3747693969;5631.903127669466;5678.063119585222;5682.772689092472;5688.544916406678;5753.280839895013;3443.8450269737923;3528.9117772055906;3535.2575959048886;3548.254866478017;3554.893353199408;6416.807495775134;6429.6142231466265;6449.3873082057125;6452.257990331172;6474.482041436674;6794.252632210453;6829.658517074126;6860.5540639858245;6891.620960847101;6891.862162756717;6450.5484616077365;6454.709538070704;6464.159659244268;6472.805815825439;6497;6596.241432235162;6620.3710647488415;6681.76613818514;6707.765228216989;6748.257691654012;6532.150820393318;6586.736530538725;6607.339266073354;6610.050035239519;6630.077277589445;6432.35676432353;6435.903461447989;6466.353364663496;6494.415502604599;6502.902456463063;4860.222364421676;4884.267359896044;4884.975575122102;4892.608591312615;4912.435069966857;6608.471322294301;6652.869012267829;6700.329967003261;6702.262751097278;6736.292689267556;6355.157004468652;6441.774537891339;6450.258220304725;6460.45086167681;6472.288048314776;6404.4876409886165;6459.386358295955;6496.545241833215;6538.869222615616;6560.40956313934;5839.328477225174;6150.692465376803;6251.437370636664;6374.776882809079;6513.8697226056165;6339.9683001586545;6388.616682999035;6412.326705695835;6527.477801775942;6547.312532184052;6176.197094377702;6264.68676566179;6265.592736472115;6285.120083188449;6345.302016778243 19:25:11 INFO - PID 3542 | |5;yui.html;896.780288829237;906.922911552518;918.9862152067716;924.0943875002497;929.7350255177274;18333.633327333446;19208.23167073319;19224.231030758754;19274.807251927476;19294.903525482387;16944.83055169451;17132.972021678677;19165.841524379917;21161.259355922546;21524.354269371943;1026.2508368890697;1046.011519114437;1047.7014050995467;1048.4128887822806;1050.1074087026043;982.6609819612222;1052.8631277933857;1054.562356622001;1055.0609957138154;1055.2244100586101;1059.1526778577108;1109.8224284114544;1114.57646094484;1115.9944200279028;1116.3636727065575;1112.9499172537173;1114.7157474843864;1114.8327750837439;1114.8383484394758;1115.9442027898613;818.8771684247351;819.5123901278789;819.5902048975512;820.0077905734069;821.3552361396276;19329.226830926746;19430.51423714404;19796.307129250406;19995.300164494172;19997.9000105;20284.188632454683;20406.69389959137;20846.270380536607;21178.15287388518;21181.682274765735;16023.519294421187;16391.262393192334;16416.83583164165;16485.752713709306;16801.411950581794;3496.1958749487508;3514.789112653249;3525.788452692821;3529.047157267549;3529.9294014119832;109411.45294273557;110683.44658276737;112860;127145.36427317804;127953;16254.43109491162;16779.91610041942;16780;16787.664246714998;16793.244304006348;27827.721722782917;28988.27529311784;29387.265318367212;29591.112266632037;29726.851365743034;9045.231155351737;9124.49815260167;9127.22418594427;9130;9146.314026448043;4272.401863739079;4452.243118669834;4455.710378825366;4464.508904020555;4471.888202794956;5100.617453690988;5245.134552798745;5284.3658760948165;5286.286351342596;5297.046531624344;1065.1478816946567;1106.468894930438;1108.4014632098576;1115.7935781880378;1118.6028959719183;658.3712554510431;668.8361351468922;680.931906809325;701.382783150824;702.5293053654065;12020.699482512833;12638.368081595883;13246.536371226961;13371.598852034454;13886.23625700576;688.4801974509213;697.2086681616402;716.0905649824693;716.5915428205977;720.8450183210634;4779.498152693986;5399.919001214985;5433.864153396196;5486.588505862076;5497.257870187554;99688.50155749175;102223.93328200166;102442.48778756059;102511.48744256231;106511;85932;87828.12171878327;88201.5371981291;88357;91424;69714.3028569718;76428.61785691036;77796;78736.60631696804;82548.17451825525;12066.75866482683;12145.45345459474;12302.938485307874;12615.81076283838;12815.61553153407;34599;36174.457383138746;36344;37259.06852328713;38189.2362152761;45377.546224537335;66942.66528667326;67606.66196668985;68280;71897;17263.654726905643;17306.653866922843;17308.22113004943;17552.210150543;17623.20695568677;19050.333238336592;21083.578328433654;21824.781752182276;22266.77733222647;22271.77728222762;18064.909675451538;18494;18570.164342604345;18698.439046828073;18950.715739264197;18678.906605466887;19262.4221273362;19337.51656208606;19458.416247512596;19548.902255488632;18182.36361727333;18539.536511587317;18555.072246387896;18787.6242475147;18854.905725471286;12646.30445325516;13116.934415327862;13209.537666182023;13763.174209547458;13799.2410417428;13321.26733029654;14688.632784180481;14693.191874447008;14864.62838429048;15314.157721325435 19:25:11 INFO - PID 3542 | __end_tp_report 19:25:11 INFO - PID 3542 | __start_cc_report 19:25:11 INFO - PID 3542 | _x_x_mozilla_cycle_collect,348 19:25:11 INFO - PID 3542 | __end_cc_report 19:25:11 INFO - PID 3542 | __startTimestamp1501035911385__endTimestamp 19:25:11 INFO - PID 3542 | 19:25:11 INFO - PID 3542 | ------- Summary: start ------- 19:25:11 INFO - PID 3542 | Number of tests: 6 19:25:11 INFO - PID 3542 | 19:25:11 INFO - PID 3542 | [#0] dojo.html Cycles:165 Average:6143.54 Median:6407.90 stddev:722.05 (11.3%) stddev-sans-first:683.80 19:25:11 INFO - PID 3542 | Values: 3105.3 3119.0 3126.6 3130.2 3198.2 6019.6 6074.5 6108.0 6119.1 6312.3 6251.6 6270.6 6292.0 6335.0 6339.5 5506.6 5664.9 5693.1 5713.0 5802.7 5554.0 5586.5 5604.5 5630.7 5644.7 5684.2 5761.1 5772.6 5778.8 5784.7 5673.6 5733.4 5771.3 5785.3 5788.7 5560.5 5608.0 5653.4 5697.9 5715.2 6095.4 6139.5 6198.1 6217.3 6233.7 6667.0 6681.7 6739.8 6773.5 6782.9 6511.8 6669.8 6698.5 6714.6 6784.6 6203.2 6230.9 6232.7 6241.0 6244.2 6861.8 6873.7 6878.8 6886.2 6887.3 6478.0 6512.5 6556.5 6573.7 6590.5 6614.8 6644.6 6706.0 6714.2 6755.8 6479.5 6486.1 6554.1 6623.9 6639.7 6662.1 6679.8 6745.6 6746.9 6748.1 5458.3 5463.6 5475.9 5477.0 5478.3 4643.2 4652.7 4667.6 4712.3 4717.5 5722.3 5757.2 5783.0 5807.7 5886.9 6720.0 6722.9 6726.2 6731.1 6742.2 5743.8 5780.5 5793.5 5823.4 5839.9 5826.3 5851.9 5919.1 5920.7 5922.1 6321.1 6419.4 6445.7 6504.5 6522.6 6656.1 6661.5 6680.0 6705.6 6770.4 6446.3 6476.3 6488.4 6525.2 6526.6 6537.7 6563.8 6572.6 6640.0 6683.3 6493.8 6653.2 6653.6 6656.4 6765.8 6419.4 6449.4 6450.4 6452.8 6458.4 6447.6 6512.8 6542.4 6548.8 6552.0 6382.5 6392.6 6488.4 6500.4 6503.5 6432.8 6451.3 6553.9 6586.6 6597.8 6314.5 6377.5 6388.3 6403.4 6407.9 19:25:11 INFO - PID 3542 | 19:25:11 INFO - PID 3542 | [#1] ext.html Cycles:180 Average:37791.33 Median:35599.23 stddev:53593.60 (150.5%) stddev-sans-first:53672.01 19:25:11 INFO - PID 3542 | Values: 811.4 858.2 873.5 874.6 1180.4 31972.2 43201.1 44055.3 44111.1 44310.8 43337.0 43489.3 43513.3 43671.8 43784.6 7781.0 7915.1 7918.8 7927.3 7934.4 7708.0 7844.9 7848.1 7852.0 7867.2 5888.3 6014.2 6082.8 7867.3 7870.0 7588.5 7797.1 7823.2 7832.7 7834.0 7690.8 7769.7 7770.7 7771.0 7774.5 38340.6 38728.8 38759.0 38835.4 38841.6 3563.3 3583.3 3593.4 3603.1 3609.9 31175.0 31177.5 31213.0 31237.7 31281.2 4810.0 4861.4 4880.2 4958.1 4961.9 183823.0 184235.0 185715.0 186794.1 186931.0 47630.0 47711.0 47809.3 47816.8 48022.8 48958.5 49549.3 49741.3 49783.8 49792.8 15225.2 15431.4 15476.3 15480.5 15487.4 12462.8 12502.3 12519.2 12538.1 12538.5 13363.8 13585.3 13643.2 13675.4 13801.4 5362.8 5495.1 5892.4 5973.0 5996.2 991.6 1001.3 1006.2 1007.6 1013.8 23395.0 23470.3 23617.8 23930.0 24176.9 1083.2 1083.2 1116.2 1122.7 1126.7 12005.3 12048.9 12212.5 12250.3 12290.4 225729.0 228067.0 229476.0 229694.0 229916.0 54916.5 55306.0 55575.4 55588.7 55963.2 1442.1 1446.6 1478.1 1478.3 1508.6 22190.8 22427.6 22562.9 23105.7 23185.8 38051.4 38127.8 38158.2 38187.2 38217.8 201872.0 203239.0 204618.0 205013.0 205780.0 35012.6 35303.5 35331.3 35585.8 35622.1 43031.8 44519.0 44572.6 44761.3 44788.3 31248.0 31575.8 32385.0 32663.0 32751.5 29894.6 31621.8 32072.5 32291.7 32311.2 35386.0 35612.6 35623.3 35704.3 36096.0 29703.4 30427.5 30828.4 31254.5 31448.5 22530.1 30653.4 31129.4 31675.8 31956.0 19:25:11 INFO - PID 3542 | 19:25:11 INFO - PID 3542 | [#2] jquery.html Cycles:180 Average:36719.02 Median:23784.26 stddev:82936.14 (348.7%) stddev-sans-first:83124.39 19:25:11 INFO - PID 3542 | Values: 569.9 577.7 584.1 586.7 597.3 22288.3 22840.3 23242.9 23248.5 23283.3 26068.9 26439.9 26521.0 26529.0 26594.0 6504.8 6607.9 6652.7 6655.8 6701.8 6336.8 6466.3 6559.2 6610.9 6639.7 6589.7 6607.1 6612.2 6613.2 6613.4 6541.1 6579.6 6583.9 6586.1 6614.8 6104.3 6153.7 6160.2 6167.9 6180.5 29218.1 29640.9 29844.4 29943.7 30354.4 1929.5 1994.0 1999.9 2003.1 2003.7 18470.9 18989.7 20365.7 20368.2 20400.8 2334.3 2358.7 2408.6 2435.2 2436.6 143696.0 145260.0 154620.0 154742.0 154818.0 21200.8 21494.4 21784.8 22363.0 22533.5 44843.0 44992.8 45019.3 45074.0 45185.8 11182.4 11472.8 11570.5 11631.1 11706.5 9410.0 9410.8 9499.3 9589.2 9632.4 11724.8 12064.8 12300.1 12314.7 12337.7 3809.9 3850.2 4103.6 4173.2 4236.1 939.3 949.8 953.5 979.0 1013.2 23843.8 25278.7 25375.4 25398.7 25549.9 949.9 963.5 969.7 1002.1 1006.4 10424.9 10501.9 10582.2 10614.7 11069.4 470857.4 480578.0 488770.0 489964.0 511824.0 119774.0 122517.0 124742.0 125469.0 125552.4 1273.1 1289.4 1300.9 1321.2 1324.7 17102.8 18027.5 18052.9 18611.9 18648.0 54298.0 56209.4 58530.0 58787.1 60667.1 73657.6 74146.6 74679.0 75699.6 75703.2 14714.1 15094.2 15118.0 15150.2 15152.5 23724.8 24100.0 24122.5 24330.1 24352.6 17987.8 18700.8 18939.7 19357.4 19385.8 16027.7 16455.3 17128.1 17340.8 17580.7 20121.3 20207.5 20348.6 20490.8 20495.2 14409.6 14663.0 14883.1 14946.3 15005.8 19051.8 19080.9 19209.9 19214.6 19225.0 19:25:11 INFO - PID 3542 | 19:25:11 INFO - PID 3542 | [#3] mootools.html Cycles:180 Average:8383.16 Median:2546.29 stddev:5746.68 (225.7%) stddev-sans-first:5738.45 19:25:11 INFO - PID 3542 | Values: 1343.1 1377.4 1395.4 1400.6 1411.1 13386.1 13638.9 13936.7 13952.2 13953.3 14145.9 14378.7 14385.9 14407.3 14421.2 2412.9 2439.6 2448.8 2449.1 2449.7 2542.8 2615.9 2633.4 2666.2 2669.6 2583.5 2584.3 2614.6 2659.1 2674.0 2598.3 2601.8 2611.3 2614.8 2616.9 2513.5 2549.8 2556.7 2557.1 2566.1 13472.7 13510.7 13519.5 13613.8 13641.7 7353.9 7674.0 7701.3 7713.7 7726.8 4787.0 4957.8 5011.3 5018.2 5039.0 1897.1 1915.9 1920.8 1943.1 1975.4 21803.6 21967.1 21990.8 22004.4 22026.6 6085.4 6266.7 6305.0 6401.3 6433.5 14787.9 15439.7 15462.8 15577.5 15601.5 7266.2 7437.9 7467.9 7479.4 7480.9 6606.0 6785.8 6836.7 6886.6 6896.9 4811.5 4876.1 4929.7 4978.1 5000.1 1314.5 1325.1 1334.8 1348.1 1349.5 839.8 850.8 852.0 888.3 898.9 6874.8 6903.5 6949.8 6991.4 7049.6 691.7 705.7 714.6 725.4 731.6 4073.9 4470.4 4812.9 4857.7 4914.5 17777.8 18142.4 18705.0 18726.0 18861.4 18277.5 18452.1 18471.0 18585.2 18644.9 10116.5 10265.9 10520.3 10649.1 10718.0 6591.9 7037.3 7140.1 7149.6 7253.5 15869.3 16303.5 16388.4 16440.2 16536.7 16040.4 16244.5 16523.9 16655.9 16786.0 10853.6 11020.6 11184.5 11254.6 11319.9 12687.4 12886.5 12903.0 12908.4 12925.2 10078.6 10693.3 10780.7 10891.1 11009.4 9998.0 10235.7 10267.8 10733.4 10850.9 9101.2 9261.2 9278.5 9305.7 9309.6 5962.8 6100.0 6379.2 6390.5 6440.7 6131.8 6242.6 6264.3 6364.9 6557.9 19:25:11 INFO - PID 3542 | 19:25:11 INFO - PID 3542 | [#4] prototype.html Cycles:180 Average:5413.75 Median:6010.50 stddev:1534.82 (25.5%) stddev-sans-first:1493.94 19:25:11 INFO - PID 3542 | Values: 488.3 504.8 516.9 523.4 527.0 6107.9 6147.1 6168.7 6204.0 6223.5 5842.9 5978.3 6006.6 6071.8 6076.5 4797.4 4815.3 4834.9 4847.9 4864.0 4859.2 4883.0 4902.4 4918.7 4956.1 4555.3 4593.7 4712.9 4786.5 4823.2 4821.0 4832.4 4869.4 4879.5 4879.6 4342.2 4346.7 4363.5 4370.6 4375.7 5983.2 5994.4 6014.4 6029.9 6041.0 5540.3 5563.6 5564.7 5565.3 5578.8 6288.7 6298.1 6399.7 6476.4 6563.2 4691.7 4701.8 4744.2 4755.6 4811.8 6704.3 6718.8 6732.5 6829.8 6856.1 4827.8 4866.3 4871.8 4879.8 4883.5 4942.9 4960.0 4980.5 4986.4 5001.1 5476.7 5561.3 5569.2 5581.3 5605.5 6399.3 6463.2 6472.9 6477.8 6567.9 1698.6 1707.9 1724.5 1726.5 1737.0 1109.8 1158.4 1195.8 1198.2 1204.4 5599.2 5650.5 5667.5 5679.7 5685.4 6422.7 6501.0 6534.6 6564.8 6581.4 5631.9 5678.1 5682.8 5688.5 5753.3 3443.8 3528.9 3535.3 3548.3 3554.9 6416.8 6429.6 6449.4 6452.3 6474.5 6794.3 6829.7 6860.6 6891.6 6891.9 6450.5 6454.7 6464.2 6472.8 6497.0 6596.2 6620.4 6681.8 6707.8 6748.3 6532.2 6586.7 6607.3 6610.1 6630.1 6432.4 6435.9 6466.4 6494.4 6502.9 4860.2 4884.3 4885.0 4892.6 4912.4 6608.5 6652.9 6700.3 6702.3 6736.3 6355.2 6441.8 6450.3 6460.5 6472.3 6404.5 6459.4 6496.5 6538.9 6560.4 5839.3 6150.7 6251.4 6374.8 6513.9 6340.0 6388.6 6412.3 6527.5 6547.3 6176.2 6264.7 6265.6 6285.1 6345.3 19:25:11 INFO - PID 3542 | 19:25:11 INFO - PID 3542 | [#5] yui.html Cycles:180 Average:22547.90 Median:19384.02 stddev:29470.54 (152.0%) stddev-sans-first:29508.37 19:25:11 INFO - PID 3542 | Values: 896.8 906.9 919.0 924.1 929.7 18333.6 19208.2 19224.2 19274.8 19294.9 16944.8 17133.0 19165.8 21161.3 21524.4 1026.3 1046.0 1047.7 1048.4 1050.1 982.7 1052.9 1054.6 1055.1 1055.2 1059.2 1109.8 1114.6 1116.0 1116.4 1112.9 1114.7 1114.8 1114.8 1115.9 818.9 819.5 819.6 820.0 821.4 19329.2 19430.5 19796.3 19995.3 19997.9 20284.2 20406.7 20846.3 21178.2 21181.7 16023.5 16391.3 16416.8 16485.8 16801.4 3496.2 3514.8 3525.8 3529.0 3529.9 109411.5 110683.4 112860.0 127145.4 127953.0 16254.4 16779.9 16780.0 16787.7 16793.2 27827.7 28988.3 29387.3 29591.1 29726.9 9045.2 9124.5 9127.2 9130.0 9146.3 4272.4 4452.2 4455.7 4464.5 4471.9 5100.6 5245.1 5284.4 5286.3 5297.0 1065.1 1106.5 1108.4 1115.8 1118.6 658.4 668.8 680.9 701.4 702.5 12020.7 12638.4 13246.5 13371.6 13886.2 688.5 697.2 716.1 716.6 720.8 4779.5 5399.9 5433.9 5486.6 5497.3 99688.5 102223.9 102442.5 102511.5 106511.0 85932.0 87828.1 88201.5 88357.0 91424.0 69714.3 76428.6 77796.0 78736.6 82548.2 12066.8 12145.5 12302.9 12615.8 12815.6 34599.0 36174.5 36344.0 37259.1 38189.2 45377.5 66942.7 67606.7 68280.0 71897.0 17263.7 17306.7 17308.2 17552.2 17623.2 19050.3 21083.6 21824.8 22266.8 22271.8 18064.9 18494.0 18570.2 18698.4 18950.7 18678.9 19262.4 19337.5 19458.4 19548.9 18182.4 18539.5 18555.1 18787.6 18854.9 12646.3 13116.9 13209.5 13763.2 13799.2 13321.3 14688.6 14693.2 14864.6 15314.2 19:25:11 INFO - PID 3542 | -------- Summary: end -------- 19:25:11 INFO - PID 3542 | 19:25:12 INFO - TEST-INFO | 3542: exit 0 19:25:12 INFO - TEST-OK | dromaeo_css | took 1114886ms 19:25:12 INFO - TEST-START | kraken 19:25:12 INFO - Initialising browser for kraken test... 19:25:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56676/getInfo.html -profile /tmp/tmpbbUUYy/profile 19:25:12 INFO - TEST-INFO | started process 3916 (/builds/slave/test/build/application/firefox/firefox http://localhost:56676/getInfo.html) 19:25:17 INFO - TEST-INFO | 3916: exit 0 19:25:17 INFO - Browser initialized. 19:25:17 INFO - Running cycle 1/1 for kraken test... 19:25:17 INFO - TEST-INFO | started process 4145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbbUUYy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:18 INFO - PID 4145 | 19:25:18 INFO - PID 4145 | (/builds/slave/test/build/application/firefox/firefox:4199): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:25:18 INFO - PID 4145 | 19:25:29 INFO - PID 4145 | RSS: Main: 173993984 19:25:29 INFO - PID 4145 | 19:25:31 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56676/tests/kraken/driver.html?testName=audio-beat-detection) 19:25:32 INFO - PID 4145 | RSS: Main: 178475008 19:25:32 INFO - PID 4145 | 19:25:35 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56676/tests/kraken/driver.html?testName=audio-dft) 19:25:36 INFO - PID 4145 | RSS: Main: 179175424 19:25:36 INFO - PID 4145 | 19:25:39 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56676/tests/kraken/driver.html?testName=audio-fft) 19:25:39 INFO - PID 4145 | RSS: Main: 174051328 19:25:39 INFO - PID 4145 | 19:25:42 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56676/tests/kraken/driver.html?testName=audio-oscillator) 19:25:42 INFO - PID 4145 | RSS: Main: 174153728 19:25:42 INFO - PID 4145 | 19:25:44 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56676/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:25:45 INFO - PID 4145 | RSS: Main: 173993984 19:25:45 INFO - PID 4145 | 19:25:48 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56676/tests/kraken/driver.html?testName=imaging-darkroom) 19:25:49 INFO - PID 4145 | RSS: Main: 177057792 19:25:49 INFO - PID 4145 | 19:25:52 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56676/tests/kraken/driver.html?testName=imaging-desaturate) 19:25:53 INFO - PID 4145 | RSS: Main: 176799744 19:25:53 INFO - PID 4145 | 19:25:56 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56676/tests/kraken/driver.html?testName=json-parse-financial) 19:25:56 INFO - PID 4145 | RSS: Main: 177405952 19:25:56 INFO - PID 4145 | 19:25:58 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56676/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:25:59 INFO - PID 4145 | RSS: Main: 178163712 19:25:59 INFO - PID 4145 | 19:26:00 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56676/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:26:01 INFO - PID 4145 | RSS: Main: 175271936 19:26:01 INFO - PID 4145 | 19:26:03 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56676/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:26:04 INFO - PID 4145 | RSS: Main: 175394816 19:26:04 INFO - PID 4145 | 19:26:07 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:26:07 INFO - PID 4145 | RSS: Main: 175955968 19:26:07 INFO - PID 4145 | 19:26:10 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:26:11 INFO - PID 4145 | RSS: Main: 175431680 19:26:11 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | Cycle 1(1): loaded http://localhost:56676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56676/tests/kraken/driver.html?testName=ai-astar) 19:26:13 INFO - PID 4145 | RSS: Main: 177676288 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | __start_tp_report 19:26:13 INFO - PID 4145 | _x_x_mozilla_page_load 19:26:13 INFO - PID 4145 | _x_x_mozilla_page_load_details 19:26:13 INFO - PID 4145 | |i|pagename|runs| 19:26:13 INFO - PID 4145 | |0;ai-astar;105;110;96;109;111;110;112;108;112;110 19:26:13 INFO - PID 4145 | |1;audio-beat-detection;149;121;151;168;118;143;149;118;170;120 19:26:13 INFO - PID 4145 | |2;audio-dft;165;162;162;163;164;166;165;176;170;166 19:26:13 INFO - PID 4145 | |3;audio-fft;74;77;76;175;75;76;75;74;165;75 19:26:13 INFO - PID 4145 | |4;audio-oscillator;81;81;136;80;80;82;126;81;81;146 19:26:13 INFO - PID 4145 | |5;imaging-gaussian-blur;114;114;114;115;114;114;114;114;114;117 19:26:13 INFO - PID 4145 | |6;imaging-darkroom;150;151;153;152;149;152;150;151;151;152 19:26:13 INFO - PID 4145 | |7;imaging-desaturate;94;94;94;94;93;94;95;94;94;94 19:26:13 INFO - PID 4145 | |8;json-parse-financial;53;52;64;53;55;55;54;52;53;53 19:26:13 INFO - PID 4145 | |9;json-stringify-tinderbox;55;56;54;55;55;55;54;54;54;55 19:26:13 INFO - PID 4145 | |10;stanford-crypto-aes;77;79;86;88;76;77;77;86;87;86 19:26:13 INFO - PID 4145 | |11;stanford-crypto-ccm;123;129;139;126;139;123;127;122;131;170 19:26:13 INFO - PID 4145 | |12;stanford-crypto-pbkdf2;176;174;174;176;178;174;178;180;178;171 19:26:13 INFO - PID 4145 | |13;stanford-crypto-sha256-iterative;68;69;68;69;70;67;66;68;68;65 19:26:13 INFO - PID 4145 | __end_tp_report 19:26:13 INFO - PID 4145 | __start_cc_report 19:26:13 INFO - PID 4145 | _x_x_mozilla_cycle_collect,959 19:26:13 INFO - PID 4145 | __end_cc_report 19:26:13 INFO - PID 4145 | __startTimestamp1501035973476__endTimestamp 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | ------- Summary: start ------- 19:26:13 INFO - PID 4145 | Number of tests: 14 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.50 stddev:4.79 (4.3%) stddev-sans-first:4.92 19:26:13 INFO - PID 4145 | Values: 105.0 110.0 96.0 109.0 111.0 110.0 112.0 108.0 112.0 110.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:149.00 stddev:20.28 (13.6%) stddev-sans-first:21.28 19:26:13 INFO - PID 4145 | Values: 149.0 121.0 151.0 168.0 118.0 143.0 149.0 118.0 170.0 120.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.50 stddev:4.25 (2.6%) stddev-sans-first:4.50 19:26:13 INFO - PID 4145 | Values: 165.0 162.0 162.0 163.0 164.0 166.0 165.0 176.0 170.0 166.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.00 stddev:40.03 (53.4%) stddev-sans-first:41.79 19:26:13 INFO - PID 4145 | Values: 74.0 77.0 76.0 175.0 75.0 76.0 75.0 74.0 165.0 75.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:81.00 stddev:27.06 (33.4%) stddev-sans-first:28.04 19:26:13 INFO - PID 4145 | Values: 81.0 81.0 136.0 80.0 80.0 82.0 126.0 81.0 81.0 146.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 19:26:13 INFO - PID 4145 | Values: 114.0 114.0 114.0 115.0 114.0 114.0 114.0 114.0 114.0 117.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.50 stddev:1.20 (0.8%) stddev-sans-first:1.20 19:26:13 INFO - PID 4145 | Values: 150.0 151.0 153.0 152.0 149.0 152.0 150.0 151.0 151.0 152.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:26:13 INFO - PID 4145 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 95.0 94.0 94.0 94.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:53.50 stddev:3.53 (6.6%) stddev-sans-first:3.71 19:26:13 INFO - PID 4145 | Values: 53.0 52.0 64.0 53.0 55.0 55.0 54.0 52.0 53.0 53.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 19:26:13 INFO - PID 4145 | Values: 55.0 56.0 54.0 55.0 55.0 55.0 54.0 54.0 54.0 55.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:86.00 stddev:5.04 (5.9%) stddev-sans-first:5.03 19:26:13 INFO - PID 4145 | Values: 77.0 79.0 86.0 88.0 76.0 77.0 77.0 86.0 87.0 86.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:130.00 stddev:14.40 (11.1%) stddev-sans-first:14.82 19:26:13 INFO - PID 4145 | Values: 123.0 129.0 139.0 126.0 139.0 123.0 127.0 122.0 131.0 170.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:177.00 stddev:2.69 (1.5%) stddev-sans-first:2.85 19:26:13 INFO - PID 4145 | Values: 176.0 174.0 174.0 176.0 178.0 174.0 178.0 180.0 178.0 171.0 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:1.56 19:26:13 INFO - PID 4145 | Values: 68.0 69.0 68.0 69.0 70.0 67.0 66.0 68.0 68.0 65.0 19:26:13 INFO - PID 4145 | -------- Summary: end -------- 19:26:13 INFO - PID 4145 | 19:26:13 INFO - PID 4145 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:26:14 INFO - TEST-INFO | 4145: exit 0 19:26:14 INFO - TEST-OK | kraken | took 62056ms 19:26:14 INFO - SUITE-END | took 1176s 19:26:14 INFO - Completed test suite (00:19:36) 19:26:14 INFO - javascript benchmark 19:26:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8483.687251261708, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.3323535439877, 3119.0486901495033, 3126.5622812806205, 3130.2487403023265, 3198.184462961946, 6019.578629495937, 6074.544409169308, 6107.969460152704, 6119.051547010215, 6312.274088479826, 6251.59364641298, 6270.592411493261, 6292.0, 6334.968325158367, 6339.492840572755, 5506.64206826555, 5664.915026274589, 5693.089105743082, 5712.971435142829, 5802.738876750556, 5554.0, 5586.525145362649, 5604.523615492688, 5630.662160270397, 5644.689542075184, 5684.2326285951285, 5761.135829625548, 5772.5670574707065, 5778.768849246047, 5784.739686714108, 5673.574481913873, 5733.369329373765, 5771.307443106854, 5785.27684039495, 5788.710564471759, 5560.471755183251, 5608.046632072557, 5653.378128405872, 5697.943020569783, 5715.171300161495, 6095.359987201368, 6139.508839292846, 6198.132261483396, 6217.285012223561, 6233.688315584202, 6667.0, 6681.732730690766, 6739.831504212385, 6773.525853190229, 6782.898256526156, 6511.762765074668, 6669.833254168685, 6698.531102822804, 6714.597124172566, 6784.626845523494, 6203.16257305267, 6230.937690623081, 6232.719527621268, 6241.0, 6244.157038799749, 6861.759838405632, 6873.690683919235, 6878.828029299208, 6886.208086070166, 6887.345702158287, 6478.028295755675, 6512.479001679854, 6556.475481961432, 6573.671316434159, 6590.505712071614, 6614.768483103068, 6644.60132392058, 6705.966470167716, 6714.194296684429, 6755.763548275787, 6479.514036447285, 6486.091947127406, 6554.082428460019, 6623.867522649616, 6639.734410623618, 6662.133922590032, 6679.833004174838, 6745.628990405575, 6746.932530674729, 6748.055272261888, 5458.263134476795, 5463.590230732711, 5475.945240547623, 5477.04151773446, 5478.260434841325, 4643.164230438486, 4652.697574657636, 4667.603253723471, 4712.31671407644, 4717.457492388351, 5722.341930677942, 5757.193992841006, 5783.016887129198, 5807.738651760681, 5886.911696324559, 6719.966400167968, 6722.865542689119, 6726.159230096238, 6731.091302674076, 6742.157230346207, 5743.827685169452, 5780.479756821906, 5793.507551858055, 5823.388544202798, 5839.941600584025, 5826.271716035496, 5851.853703657443, 5919.082542205965, 5920.703964801743, 5922.111683247461, 6321.146645202931, 6419.422251997343, 6445.677716114175, 6504.5446818723185, 6522.5760325578685, 6656.134702488839, 6661.467082633475, 6680.0, 6705.564138331188, 6770.356816102462, 6446.323136070645, 6476.255230648348, 6488.416042556192, 6525.249596296487, 6526.641034742945, 6537.673116344259, 6563.835904102436, 6572.638504882278, 6639.966800165968, 6683.264840867403, 6493.837654058686, 6653.201615806134, 6653.600783952978, 6656.434203092791, 6765.797026089225, 6419.358064193543, 6449.419552240133, 6450.387213214737, 6452.806415807533, 6458.3864532871185, 6447.580907241015, 6512.772052978123, 6542.443892269211, 6548.8362790930605, 6552.049952756919, 6382.521310901794, 6392.552521323462, 6488.383603557654, 6500.414962653194, 6503.51223658237, 6432.842088424129, 6451.290358060516, 6553.868922621426, 6586.604803711793, 6597.80206593803, 6314.463270622048, 6377.4579160771855, 6388.329225431263, 6403.391677790602, 6407.9038814418755], "value": 6089.320277725037, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.3509192645881, 858.2318824651936, 873.5326600268855, 874.5539774714897, 1180.4451907603423, 31972.200694982606, 43201.135977280435, 44055.33916991248, 44111.11777764443, 44310.778446107724, 43337.0, 43489.347659785126, 43513.34729979045, 43671.78164109183, 43784.562154378444, 7780.999999999985, 7915.089764677049, 7918.802029949268, 7927.28654421102, 7934.365250779923, 7707.96146019272, 7844.9215507844765, 7848.058233012047, 7852.0, 7867.213278672116, 5888.32284287306, 6014.2181516403025, 6082.787102451415, 7867.331276841475, 7870.0, 7588.506747061451, 7797.103333116679, 7823.2176782321885, 7832.68669253232, 7833.96083019587, 7690.769276921701, 7769.689212431496, 7770.689172433153, 7771.0, 7774.494657847222, 38340.616593833984, 38728.80635596832, 38759.0, 38835.41746873799, 38841.61158388436, 3563.2695297463956, 3583.283343331318, 3593.3711600470074, 3603.063203567065, 3609.873654422083, 31175.0, 31177.532337014734, 31213.0, 31237.687623123933, 31281.217969550715, 4809.951900480985, 4861.440934292566, 4880.194767863299, 4958.057968985917, 4961.9255711164, 183823.0, 184235.0, 185715.0, 186794.06602967033, 186931.0, 47630.0, 47711.0, 47809.282860757114, 47816.76091619589, 48022.75988620034, 48958.5104148954, 49549.25676114861, 49741.25388119181, 49783.751081245086, 49792.75103624459, 15225.162616056223, 15431.382744690087, 15476.303566339542, 15480.5355839325, 15487.380504779909, 12462.75074498505, 12502.312372819582, 12519.186252893533, 12538.059645526622, 12538.498460061677, 13363.799543006862, 13585.252811095485, 13643.181409115485, 13675.384607692678, 13801.378937947817, 5362.758675859518, 5495.148252020943, 5892.410758924159, 5973.0, 5996.16053752475, 991.5984026469291, 1001.2540657210279, 1006.1648831470009, 1007.5566750629699, 1013.8023085498404, 23395.0, 23470.295891123293, 23617.763822361558, 23930.0, 24176.87911560466, 1083.182197440927, 1083.1930211992117, 1116.2019156303281, 1122.6688127002553, 1126.6507382711386, 12005.279683219034, 12048.913205967609, 12212.450439730055, 12250.326232057145, 12290.446929888176, 225729.0, 228067.0, 229476.0, 229694.0, 229916.0, 54916.45083549193, 55306.0, 55575.44424555784, 55588.72205638946, 55963.16055259174, 1442.1131004432198, 1446.5751235033274, 1478.1426772471941, 1478.290420598119, 1508.5561390547384, 22190.779507127263, 22427.551448971255, 22562.887185563966, 23105.729184894994, 23185.76814231836, 38051.42922856215, 38127.80936095302, 38158.236835262585, 38187.2362552753, 38217.80891095527, 201871.99064004587, 203239.0, 204618.0, 205013.0, 205780.0, 35012.64987350094, 35303.47044794279, 35331.29337413289, 35585.82207088948, 35622.109447264025, 43031.7848410756, 44519.0, 44572.55427445684, 44761.328580071975, 44788.32817507805, 31248.0, 31575.84212078925, 32385.0, 32663.0, 32751.508727368633, 29894.551581726726, 31621.84189079132, 32072.51891221587, 32291.677083228868, 32311.192220194684, 35386.0, 35612.64387356093, 35623.28753424969, 35704.28591428209, 36096.0, 29703.40593188081, 30427.54358684577, 30828.383432331677, 31254.53118203183, 31448.52827207548, 22530.098796047976, 30653.386932260782, 31129.37741245208, 31675.84162079267, 31956.0], "value": 17232.432455926817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.8603842058697, 577.6707276852196, 584.0742423259134, 586.7066466766616, 597.2981746447923, 22288.331350059485, 22840.31479055631, 23242.88378558107, 23248.535029299404, 23283.301500954978, 26068.869655651743, 26439.86780066097, 26521.0, 26529.0, 26594.0, 6504.772332968335, 6607.867842643144, 6652.733890644368, 6655.8336041599105, 6701.765438209663, 6336.841578960517, 6466.256380516254, 6559.212894452672, 6610.933890661104, 6639.701213445406, 6589.736410543573, 6607.108040414555, 6612.206535215781, 6613.2064152301555, 6613.437857782094, 6541.084248205255, 6579.638119903403, 6583.9012414813815, 6586.143801305848, 6614.7684831031165, 6104.26748790148, 6153.692315384257, 6160.1991741073825, 6167.907481387782, 6180.505559555225, 29218.123456296344, 29640.8517957411, 29844.403111937856, 29943.70056299431, 30354.392912141855, 1929.5272658198692, 1993.9900300498405, 1999.8900060496667, 2003.0685731135093, 2003.7495313085865, 18470.907645461823, 18989.715154272697, 20365.694514582294, 20368.185272589228, 20400.79599204004, 2334.26470661741, 2358.7287461941924, 2408.6146216605434, 2435.172041505879, 2436.561418944589, 143696.0, 145260.0, 154620.0, 154742.0, 154818.0, 21200.78799212019, 21494.355169344944, 21784.80183589886, 22363.0, 22533.549329013327, 44843.0, 44992.77503612526, 45019.324710129375, 45074.0, 45185.77407112943, 11182.440877956069, 11472.827907581393, 11570.479328430241, 11631.127665425127, 11706.473208705458, 9409.952950235342, 9410.764730881783, 9499.28755343352, 9589.184919281939, 9632.422054676601, 11724.779079531361, 12064.75870482603, 12300.138990270774, 12314.692132696575, 12337.69155771095, 3809.885703428846, 3850.2492014057552, 4103.561807841951, 4173.24881521323, 4236.068065025689, 939.3143005605946, 949.8100379923904, 953.5137080089066, 978.9608415663436, 1013.2096964367805, 23843.7615623845, 25278.74721252764, 25375.36561585975, 25398.746012540007, 25549.87225063863, 949.9335046546813, 963.4700914496999, 969.699393188114, 1002.1481740520645, 1006.4011912911806, 10424.895751042544, 10501.894981050245, 10582.153427725763, 10614.681559553226, 11069.391183484986, 470857.3999716306, 480578.0, 488770.0, 489964.0, 511824.0, 119774.0, 122517.0, 124742.0, 125469.0, 125552.37223813822, 1273.1279073834453, 1289.4004288006122, 1300.9284489353176, 1321.187469706124, 1324.7019420630281, 17102.828971710125, 18027.459176224733, 18052.909735451238, 18611.906940465753, 18648.0, 54298.0, 56209.43790562042, 58530.0, 58787.118193227994, 60667.08999365101, 73657.6317118411, 74146.62926685331, 74679.0, 75699.62150189214, 75703.24296756962, 14714.117152970855, 15094.245287735788, 15118.0, 15150.24248787534, 15152.469663561722, 23724.762752372946, 24100.035998559862, 24122.51754964926, 24330.14844480435, 24352.63471047971, 17987.820121798613, 18700.81299186991, 18939.71590426117, 19357.4192774217, 19385.806141938963, 16027.679446411239, 16455.341786328412, 17128.143592820557, 17340.82659173392, 17580.73628895593, 20121.295754648516, 20207.4948126298, 20348.59302813965, 20490.795092048887, 20495.18019279272, 14409.567712968628, 14663.0, 14883.10701357922, 14946.327415266122, 15005.849941500444, 19051.809481905002, 19080.90459547749, 19209.90395048016, 19214.615707685487, 19225.0], "value": 12895.369426638053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.0799902067085, 1377.449020391843, 1395.3999780094555, 1400.6428360768002, 1411.1180512179888, 13386.129901556404, 13638.863611363884, 13936.721265574683, 13952.162870227794, 13953.302334883241, 14145.92927035366, 14378.712425751504, 14385.92807035966, 14407.27963601821, 14421.206833624146, 2412.867292298923, 2439.6340548917715, 2448.8040956723507, 2449.09383528094, 2449.6815413996155, 2542.8092893033004, 2615.934601634965, 2633.4206474575562, 2666.1601595497355, 2669.639598654176, 2583.547879121156, 2584.25056733548, 2614.6078088286718, 2659.0693257359962, 2674.023981246841, 2598.337423956879, 2601.8048646351504, 2611.308003379087, 2614.7646711795837, 2616.9476610467777, 2513.4847356291916, 2549.7705206531314, 2556.6676332076895, 2557.1433569754154, 2566.0890383913816, 13472.663183420394, 13510.662233444242, 13519.52681656147, 13613.795793063113, 13641.727165456734, 7353.852922941511, 7673.9616301918695, 7701.345385642171, 7713.65288562016, 7726.806829829243, 4786.976065119687, 4957.776900039471, 5011.323471331397, 5018.247262910556, 5039.042581909425, 1897.1313256442393, 1915.8754680945833, 1920.807919208082, 1943.1450161928847, 1975.3580086471954, 21803.563928721494, 21967.121315147535, 21990.780092199035, 22004.449888752748, 22026.559468810694, 6085.391460853879, 6266.683996360724, 6305.0, 6401.3278605746655, 6433.453156481752, 14787.852121478863, 15439.691206176038, 15462.768058479132, 15577.454789082327, 15601.531954041397, 7266.237045110293, 7437.925620743723, 7467.887981680279, 7479.439042071757, 7480.925190748132, 6605.966970165118, 6785.796426107225, 6836.658167091626, 6886.586804791728, 6896.862062758717, 4811.542903424169, 4876.097921884463, 4929.704217746947, 4978.1288274552535, 5000.074986127505, 1314.5070598525554, 1325.1121748428577, 1334.7597432462055, 1348.110247236819, 1349.5209200733598, 839.7606682095574, 850.7873031742065, 851.9829603408022, 888.3337496877342, 898.9460632362079, 6874.793756187322, 6903.5167538271835, 6949.82625434358, 6991.405730512862, 7049.612271325126, 691.7129391302653, 705.693023534764, 714.5783987447431, 725.3906718356606, 731.572030362244, 4073.857414990461, 4470.374147619336, 4812.879678008007, 4857.732824694675, 4914.533119353656, 17777.822221777875, 18142.365017224332, 18705.0, 18726.0, 18861.434156975312, 18277.543061423305, 18452.077396130408, 18470.984095874588, 18585.163667634988, 18644.906775466035, 10116.494175291205, 10265.948670256601, 10520.316179448311, 10649.094826939798, 10718.0, 6591.8709574383365, 7037.331453511908, 7140.107486564179, 7149.606771627402, 7253.492255542273, 15869.285882135562, 16303.510894673178, 16388.426405075767, 16440.177991100638, 16536.66926661484, 16040.43858464948, 16244.51266462008, 16523.917380413503, 16655.91672041632, 16786.0, 10853.565857365616, 11020.559177632806, 11184.496697648789, 11254.606088786853, 11319.943400282946, 12687.429065691882, 12886.48454061827, 12903.0, 12908.354582271037, 12925.224486530838, 10078.6472473466, 10693.251472396858, 10780.730481737706, 10891.128709703364, 11009.394483303175, 9997.950010249902, 10235.7441063974, 10267.794644107225, 10733.355998640107, 10850.94574527154, 9101.180893719596, 9261.16649501548, 9278.536073196448, 9305.674301399418, 9309.581068851783, 5962.791302304398, 6100.0, 6379.170707807955, 6390.456811170917, 6440.67796610177, 6131.816045518642, 6242.625442473466, 6264.342244064308, 6364.917963946233, 6557.9344206559235], "value": 6080.847745299155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.2694473853413, 504.8338338438208, 516.9069567477854, 523.3588853654271, 526.9631125821194, 6107.877842443154, 6147.108669242957, 6168.691565421722, 6203.968980155104, 6223.502119830414, 5842.853928651786, 5978.252718410199, 6006.579539432241, 6071.817845464632, 6076.453119219269, 4797.352357431737, 4815.301781241717, 4834.87912802181, 4847.860752723107, 4863.95713800203, 4859.198232291667, 4882.975585122087, 4902.436219834729, 4918.729469879156, 4956.107900577895, 4555.316702494619, 4593.655475839309, 4712.929306060412, 4786.473487916326, 4823.180059389894, 4820.975895120519, 4832.371791667096, 4869.391326084239, 4879.4876537963355, 4879.585235255007, 4342.218400687875, 4346.739195648272, 4363.476382834048, 4370.562943705636, 4375.737455752633, 5983.222181116471, 5994.400559944014, 6014.428629280255, 6029.879402411971, 6041.0, 5540.307461567304, 5563.638363506359, 5564.749586268627, 5565.30433695788, 5578.828446026339, 6288.717007734663, 6298.118263443122, 6399.704152361537, 6476.4171224589545, 6563.212414510242, 4691.741954192518, 4701.764911754399, 4744.16977029022, 4755.571998520115, 4811.831585894512, 6704.2625311215725, 6718.8320291993095, 6732.528722989393, 6829.829254268633, 6856.114568493655, 4827.782749776268, 4866.31871537985, 4871.8294859679745, 4879.829205977774, 4883.4628190898975, 4942.874563937541, 4960.0, 4980.526849949249, 4986.401631804134, 5001.0998020355955, 5476.698781567052, 5561.304836895388, 5569.248151499577, 5581.330240371181, 5605.487582496048, 6399.328070552618, 6463.15978922737, 6472.935270647234, 6477.838054048687, 6567.934320656828, 1698.5923378389346, 1707.897526148435, 1724.534375718549, 1726.5424662464457, 1736.9565760855826, 1109.7503061811028, 1158.4092113022418, 1195.7967145585271, 1198.161287099034, 1204.3556697166973, 5599.160125981135, 5650.519705825051, 5667.546596272288, 5679.6876171810945, 5685.403032681592, 6422.74309027643, 6500.992346186349, 6534.575252608565, 6564.8358791030605, 6581.3747693969, 5631.903127669466, 5678.063119585222, 5682.772689092472, 5688.544916406678, 5753.280839895013, 3443.8450269737923, 3528.9117772055906, 3535.2575959048886, 3548.254866478017, 3554.893353199408, 6416.807495775134, 6429.6142231466265, 6449.3873082057125, 6452.257990331172, 6474.482041436674, 6794.252632210453, 6829.658517074126, 6860.5540639858245, 6891.620960847101, 6891.862162756717, 6450.5484616077365, 6454.709538070704, 6464.159659244268, 6472.805815825439, 6497.0, 6596.241432235162, 6620.3710647488415, 6681.76613818514, 6707.765228216989, 6748.257691654012, 6532.150820393318, 6586.736530538725, 6607.339266073354, 6610.050035239519, 6630.077277589445, 6432.35676432353, 6435.903461447989, 6466.353364663496, 6494.415502604599, 6502.902456463063, 4860.222364421676, 4884.267359896044, 4884.975575122102, 4892.608591312615, 4912.435069966857, 6608.471322294301, 6652.869012267829, 6700.329967003261, 6702.262751097278, 6736.292689267556, 6355.157004468652, 6441.774537891339, 6450.258220304725, 6460.45086167681, 6472.288048314776, 6404.4876409886165, 6459.386358295955, 6496.545241833215, 6538.869222615616, 6560.40956313934, 5839.328477225174, 6150.692465376803, 6251.437370636664, 6374.776882809079, 6513.8697226056165, 6339.9683001586545, 6388.616682999035, 6412.326705695835, 6527.477801775942, 6547.312532184052, 6176.197094377702, 6264.68676566179, 6265.592736472115, 6285.120083188449, 6345.302016778243], "value": 4962.7185018331975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.780288829237, 906.922911552518, 918.9862152067716, 924.0943875002497, 929.7350255177274, 18333.633327333446, 19208.23167073319, 19224.231030758754, 19274.807251927476, 19294.903525482387, 16944.83055169451, 17132.972021678677, 19165.841524379917, 21161.259355922546, 21524.354269371943, 1026.2508368890697, 1046.011519114437, 1047.7014050995467, 1048.4128887822806, 1050.1074087026043, 982.6609819612222, 1052.8631277933857, 1054.562356622001, 1055.0609957138154, 1055.2244100586101, 1059.1526778577108, 1109.8224284114544, 1114.57646094484, 1115.9944200279028, 1116.3636727065575, 1112.9499172537173, 1114.7157474843864, 1114.8327750837439, 1114.8383484394758, 1115.9442027898613, 818.8771684247351, 819.5123901278789, 819.5902048975512, 820.0077905734069, 821.3552361396276, 19329.226830926746, 19430.51423714404, 19796.307129250406, 19995.300164494172, 19997.9000105, 20284.188632454683, 20406.69389959137, 20846.270380536607, 21178.15287388518, 21181.682274765735, 16023.519294421187, 16391.262393192334, 16416.83583164165, 16485.752713709306, 16801.411950581794, 3496.1958749487508, 3514.789112653249, 3525.788452692821, 3529.047157267549, 3529.9294014119832, 109411.45294273557, 110683.44658276737, 112860.0, 127145.36427317804, 127953.0, 16254.43109491162, 16779.91610041942, 16780.0, 16787.664246714998, 16793.244304006348, 27827.721722782917, 28988.27529311784, 29387.265318367212, 29591.112266632037, 29726.851365743034, 9045.231155351737, 9124.49815260167, 9127.22418594427, 9130.0, 9146.314026448043, 4272.401863739079, 4452.243118669834, 4455.710378825366, 4464.508904020555, 4471.888202794956, 5100.617453690988, 5245.134552798745, 5284.3658760948165, 5286.286351342596, 5297.046531624344, 1065.1478816946567, 1106.468894930438, 1108.4014632098576, 1115.7935781880378, 1118.6028959719183, 658.3712554510431, 668.8361351468922, 680.931906809325, 701.382783150824, 702.5293053654065, 12020.699482512833, 12638.368081595883, 13246.536371226961, 13371.598852034454, 13886.23625700576, 688.4801974509213, 697.2086681616402, 716.0905649824693, 716.5915428205977, 720.8450183210634, 4779.498152693986, 5399.919001214985, 5433.864153396196, 5486.588505862076, 5497.257870187554, 99688.50155749175, 102223.93328200166, 102442.48778756059, 102511.48744256231, 106511.0, 85932.0, 87828.12171878327, 88201.5371981291, 88357.0, 91424.0, 69714.3028569718, 76428.61785691036, 77796.0, 78736.60631696804, 82548.17451825525, 12066.75866482683, 12145.45345459474, 12302.938485307874, 12615.81076283838, 12815.61553153407, 34599.0, 36174.457383138746, 36344.0, 37259.06852328713, 38189.2362152761, 45377.546224537335, 66942.66528667326, 67606.66196668985, 68280.0, 71897.0, 17263.654726905643, 17306.653866922843, 17308.22113004943, 17552.210150543, 17623.20695568677, 19050.333238336592, 21083.578328433654, 21824.781752182276, 22266.77733222647, 22271.77728222762, 18064.909675451538, 18494.0, 18570.164342604345, 18698.439046828073, 18950.715739264197, 18678.906605466887, 19262.4221273362, 19337.51656208606, 19458.416247512596, 19548.902255488632, 18182.36361727333, 18539.536511587317, 18555.072246387896, 18787.6242475147, 18854.905725471286, 12646.30445325516, 13116.934415327862, 13209.537666182023, 13763.174209547458, 13799.2410417428, 13321.26733029654, 14688.632784180481, 14693.191874447008, 14864.62838429048, 15314.157721325435], "value": 9129.46635930034, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 96.0, 109.0, 111.0, 110.0, 112.0, 108.0, 112.0, 110.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 151.0, 168.0, 118.0, 143.0, 149.0, 118.0, 170.0, 120.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 163.0, 164.0, 166.0, 165.0, 176.0, 170.0, 166.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 175.0, 75.0, 76.0, 75.0, 74.0, 165.0, 75.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 136.0, 80.0, 80.0, 82.0, 126.0, 81.0, 81.0, 146.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 117.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 153.0, 152.0, 149.0, 152.0, 150.0, 151.0, 151.0, 152.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 64.0, 53.0, 55.0, 55.0, 54.0, 52.0, 53.0, 53.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 86.0, 88.0, 76.0, 77.0, 77.0, 86.0, 87.0, 86.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 129.0, 139.0, 126.0, 139.0, 123.0, 127.0, 122.0, 131.0, 170.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 174.0, 176.0, 178.0, 174.0, 178.0, 180.0, 178.0, 171.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 69.0, 70.0, 67.0, 66.0, 68.0, 68.0, 65.0], "value": 67.8, "unit": "score"}]}]} 19:26:14 INFO - Return code: 0 19:26:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:26:14 INFO - # TBPL SUCCESS # 19:26:14 INFO - Running post-action listener: _package_coverage_data 19:26:14 INFO - Running post-action listener: _resource_record_post_action 19:26:14 INFO - [mozharness: 2017-07-26 02:26:14.265272Z] Finished run-tests step (success) 19:26:14 INFO - Running post-run listener: _resource_record_post_run 19:26:14 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 6057984; Write bytes: 433217536; Read time: 3116; Write time: 281492 19:26:14 INFO - TinderboxPrint: CPU usage
13.2% 19:26:14 INFO - TinderboxPrint: I/O read bytes / time
6,057,984 / 3,116 19:26:14 INFO - TinderboxPrint: I/O write bytes / time
433,217,536 / 281,492 19:26:14 INFO - TinderboxPrint: CPU idle
8,271.5 (86.8%) 19:26:14 INFO - TinderboxPrint: CPU user
1,202.0 (12.6%) 19:26:14 INFO - TinderboxPrint: Swap in / out
0 / 0 19:26:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 125001728; Read time: 168; Write time: 59400 19:26:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:26:14 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3862528; Write bytes: 201203712; Read time: 2468; Write time: 131208 19:26:14 INFO - Running post-run listener: _upload_blobber_files 19:26:14 INFO - Blob upload gear active. 19:26:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:26:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:26:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:26:15 INFO - (blobuploader) - INFO - Open directory for files ... 19:26:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:26:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:26:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:16 INFO - (blobuploader) - INFO - Done attempting. 19:26:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:26:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:17 INFO - (blobuploader) - INFO - Done attempting. 19:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:23 INFO - (blobuploader) - INFO - Done attempting. 19:26:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:26:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:26:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:24 INFO - (blobuploader) - INFO - Done attempting. 19:26:24 INFO - (blobuploader) - INFO - Iteration through files over. 19:26:24 INFO - Return code: 0 19:26:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:26:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:26:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a41ff33009ef78ba06125ee2e2000abcbb42648109be3202e0cbc38efacba97a54358e05f66e714874423af97fc711cf9e6e2bc0e05951289e2603f76ce0308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5132c572bffde2c6dbb025a08b8204f3c588ba2e740710b05d826f1e4394efec6a3b512c5fac5346e642cf520124c6f5b3dbcf494b91df7efdbd07016cd1c0b1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4edba48192d72a0e92e16323818c13e9119455446d4f4dc3f27a51a7eb6779a728da30075c440b1a408c3ed6856b11746f667fc1784663dd015819d50344849", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27da12a659cb61678ef277be8a7dff48f2b6cbc362b8ded24e3c27587867f3c3ebc17bf3a9ce76999a2ce3a3b2b0c1e4b483d44131c76570aafa0032883925c6"} 19:26:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:26:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:26:24 INFO - Contents: 19:26:24 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a41ff33009ef78ba06125ee2e2000abcbb42648109be3202e0cbc38efacba97a54358e05f66e714874423af97fc711cf9e6e2bc0e05951289e2603f76ce0308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5132c572bffde2c6dbb025a08b8204f3c588ba2e740710b05d826f1e4394efec6a3b512c5fac5346e642cf520124c6f5b3dbcf494b91df7efdbd07016cd1c0b1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4edba48192d72a0e92e16323818c13e9119455446d4f4dc3f27a51a7eb6779a728da30075c440b1a408c3ed6856b11746f667fc1784663dd015819d50344849", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27da12a659cb61678ef277be8a7dff48f2b6cbc362b8ded24e3c27587867f3c3ebc17bf3a9ce76999a2ce3a3b2b0c1e4b483d44131c76570aafa0032883925c6"} 19:26:24 INFO - Running post-run listener: copy_logs_to_upload_dir 19:26:24 INFO - Copying logs to upload dir... 19:26:24 INFO - mkdir: /builds/slave/test/build/upload/logs 19:26:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.643842 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-07-25 19:26:24.403306) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 19:26:24.410489) ========= 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=337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a41ff33009ef78ba06125ee2e2000abcbb42648109be3202e0cbc38efacba97a54358e05f66e714874423af97fc711cf9e6e2bc0e05951289e2603f76ce0308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5132c572bffde2c6dbb025a08b8204f3c588ba2e740710b05d826f1e4394efec6a3b512c5fac5346e642cf520124c6f5b3dbcf494b91df7efdbd07016cd1c0b1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4edba48192d72a0e92e16323818c13e9119455446d4f4dc3f27a51a7eb6779a728da30075c440b1a408c3ed6856b11746f667fc1784663dd015819d50344849", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27da12a659cb61678ef277be8a7dff48f2b6cbc362b8ded24e3c27587867f3c3ebc17bf3a9ce76999a2ce3a3b2b0c1e4b483d44131c76570aafa0032883925c6"} build_url:https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/EnS2W1TrQhyyZX2E3Xy6uw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a41ff33009ef78ba06125ee2e2000abcbb42648109be3202e0cbc38efacba97a54358e05f66e714874423af97fc711cf9e6e2bc0e05951289e2603f76ce0308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5132c572bffde2c6dbb025a08b8204f3c588ba2e740710b05d826f1e4394efec6a3b512c5fac5346e642cf520124c6f5b3dbcf494b91df7efdbd07016cd1c0b1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4edba48192d72a0e92e16323818c13e9119455446d4f4dc3f27a51a7eb6779a728da30075c440b1a408c3ed6856b11746f667fc1784663dd015819d50344849", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27da12a659cb61678ef277be8a7dff48f2b6cbc362b8ded24e3c27587867f3c3ebc17bf3a9ce76999a2ce3a3b2b0c1e4b483d44131c76570aafa0032883925c6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 19:26:24.437849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 19:26:24.438382) ========= 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=337fe3f4b1febe37b85fccc40000019e-1501032666.615929-185742393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 19:26:24.493228) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 19:26:24.493559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 19:26:24.493851) ========= ========= Total master_lag: 0.24 =========