builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1501229343.01 results: success (0) revision: 5845151f1a2cd00957fdd48e204542ccbdfaba1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.006975) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.007435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.007724) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.027031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.027398) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-28 01:09:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 100M=0s 2017-07-28 01:09:03 (100 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132023 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.176262) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.176597) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016960 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.229208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.229578) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5845151f1a2cd00957fdd48e204542ccbdfaba1e --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 5845151f1a2cd00957fdd48e204542ccbdfaba1e --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=9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-28 01:09:03,391 truncating revision to first 12 chars 2017-07-28 01:09:03,391 Setting DEBUG logging. 2017-07-28 01:09:03,391 attempt 1/10 2017-07-28 01:09:03,391 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5845151f1a2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-28 01:09:03,718 unpacking tar archive at: mozilla-central-5845151f1a2c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659866 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.905394) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.905753) ========= script_repo_revision: 5845151f1a2cd00957fdd48e204542ccbdfaba1e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.906178) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.906460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 01:09:03.915599) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-28 01:09:03.915979) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:09:04 INFO - MultiFileLogger online at 20170728 01:09:04 in /builds/slave/test 01:09:04 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 01:09:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:09:04 INFO - {'append_to_log': False, 01:09:04 INFO - 'base_work_dir': '/builds/slave/test', 01:09:04 INFO - 'blob_upload_branch': 'Firefox', 01:09:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:09:04 INFO - 'branch': 'Firefox', 01:09:04 INFO - 'buildbot_json_path': 'buildprops.json', 01:09:04 INFO - 'code_coverage': False, 01:09:04 INFO - 'config_files': ('talos/linux_config.py',), 01:09:04 INFO - 'default_actions': ('clobber', 01:09:04 INFO - 'read-buildbot-config', 01:09:04 INFO - 'download-and-extract', 01:09:04 INFO - 'populate-webroot', 01:09:04 INFO - 'create-virtualenv', 01:09:04 INFO - 'install', 01:09:04 INFO - 'setup-mitmproxy', 01:09:04 INFO - 'run-tests'), 01:09:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:09:04 INFO - 'disable_ccov_upload': False, 01:09:04 INFO - 'download_minidump_stackwalk': True, 01:09:04 INFO - 'download_symbols': 'ondemand', 01:09:04 INFO - 'enable_stylo': False, 01:09:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:09:04 INFO - 'tooltool.py': '/tools/tooltool.py', 01:09:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:09:04 INFO - '/tools/misc-python/virtualenv.py')}, 01:09:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:09:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:09:04 INFO - 'gecko_profile': False, 01:09:04 INFO - 'gecko_profile_interval': 0, 01:09:04 INFO - 'installer_path': 'installer.exe', 01:09:04 INFO - 'log_level': 'info', 01:09:04 INFO - 'log_name': 'talos', 01:09:04 INFO - 'log_to_console': True, 01:09:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:09:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:09:04 INFO - 'opt_config_files': (), 01:09:04 INFO - 'pip_index': False, 01:09:04 INFO - 'suite': 'dromaeojs-e10s', 01:09:04 INFO - 'system_bits': '32', 01:09:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:09:04 INFO - 'title': 'talos-linux64-ix-040', 01:09:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:09:04 INFO - 'use_talos_json': True, 01:09:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:09:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:09:04 INFO - 'work_dir': 'build'} 01:09:04 INFO - [mozharness: 2017-07-28 08:09:04.185977Z] Running clobber step. 01:09:04 INFO - Running pre-action listener: _resource_record_pre_action 01:09:04 INFO - Running main action method: clobber 01:09:04 INFO - rmtree: /builds/slave/test/build 01:09:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:09:05 INFO - Running post-action listener: _resource_record_post_action 01:09:05 INFO - [mozharness: 2017-07-28 08:09:05.219288Z] Finished clobber step (success) 01:09:05 INFO - [mozharness: 2017-07-28 08:09:05.219392Z] Running read-buildbot-config step. 01:09:05 INFO - Running pre-action listener: _resource_record_pre_action 01:09:05 INFO - Running main action method: read_buildbot_config 01:09:05 INFO - Using buildbot properties: 01:09:05 INFO - { 01:09:05 INFO - "project": "", 01:09:05 INFO - "product": "firefox", 01:09:05 INFO - "who": "cbook@mozilla.com", 01:09:05 INFO - "installer_path": "public/build/target.tar.bz2", 01:09:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 01:09:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 01:09:05 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 01:09:05 INFO - "stage_platform": "linux64-stylo", 01:09:05 INFO - "basedir": "/builds/slave/test", 01:09:05 INFO - "buildnumber": 7, 01:09:05 INFO - "platform": "ubuntu64_hw_stylo", 01:09:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:09:05 INFO - "slavebuilddir": "test", 01:09:05 INFO - "taskId": "fQqKYB1wQbuGQD_wt_W71g", 01:09:05 INFO - "branch": "mozilla-central", 01:09:05 INFO - "script_repo_revision": "production", 01:09:05 INFO - "revision": "5845151f1a2cd00957fdd48e204542ccbdfaba1e", 01:09:05 INFO - "slavename": "talos-linux64-ix-040", 01:09:05 INFO - "repo_path": "mozilla-central" 01:09:05 INFO - } 01:09:05 INFO - Finding installer, test and symbols from parent task. 01:09:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fQqKYB1wQbuGQD_wt_W71g'}, attempt #1 01:09:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fQqKYB1wQbuGQD_wt_W71g'}, attempt #1 01:09:06 INFO - Task dependencies: Q_0oAkbmSxa4brTQ_KIZPg 01:09:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg'}, attempt #1 01:09:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 01:09:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/test_packages.json 01:09:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.crashreporter-symbols.zip 01:09:06 INFO - Running post-action listener: _resource_record_post_action 01:09:06 INFO - [mozharness: 2017-07-28 08:09:06.610841Z] Finished read-buildbot-config step (success) 01:09:06 INFO - [mozharness: 2017-07-28 08:09:06.611064Z] Running download-and-extract step. 01:09:06 INFO - Running pre-action listener: _resource_record_pre_action 01:09:06 INFO - Running main action method: download_and_extract 01:09:06 INFO - mkdir: /builds/slave/test/build/tests 01:09: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')]} 01:09:06 INFO - trying https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.test_packages.json 01:09:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:09:07 INFO - Downloaded 989 bytes. 01:09:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:09:07 INFO - Using the following test package requirements: 01:09:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 01:09:07 INFO - u'common': [u'target.common.tests.zip'], 01:09:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:09:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:09:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:09:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:09:07 INFO - u'mozbase': [u'target.common.tests.zip'], 01:09:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:09:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:09:07 INFO - u'web-platform': [u'target.common.tests.zip', 01:09:07 INFO - u'target.web-platform.tests.tar.gz'], 01:09:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:09:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:09:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip 01:09:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:09:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip into memory 01:09:08 INFO - Content-Length response header: 72561179 01:09:08 INFO - Bytes received: 72561179 01:09:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:09:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip 01:09:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:09:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip into memory 01:09:20 INFO - Content-Length response header: 72561179 01:09:20 INFO - Bytes received: 72561179 01:09:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.talos.tests.zip 01:09:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:09:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.talos.tests.zip into memory 01:09:33 INFO - Content-Length response header: 14496465 01:09:33 INFO - Bytes received: 14496465 01:09:33 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')]} 01:09:33 INFO - trying https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 01:09:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:09:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:09:35 INFO - Downloaded 62069301 bytes. 01:09:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 01:09:35 INFO - mkdir: /builds/slave/test/properties 01:09:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:09:35 INFO - Writing to file /builds/slave/test/properties/build_url 01:09:35 INFO - Contents: 01:09:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 01:09:35 INFO - Running post-action listener: _resource_record_post_action 01:09:35 INFO - Running post-action listener: set_extra_try_arguments 01:09:35 INFO - [mozharness: 2017-07-28 08:09:35.083804Z] Finished download-and-extract step (success) 01:09:35 INFO - [mozharness: 2017-07-28 08:09:35.083902Z] Running populate-webroot step. 01:09:35 INFO - Running pre-action listener: _resource_record_pre_action 01:09:35 INFO - Running main action method: populate_webroot 01:09:35 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:09:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:09:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:09:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:09:35 INFO - 'tests': ['damp', 'tps']}, 01:09:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:09:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:09:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 01:09:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 01:09:35 INFO - 'other-e10s': {'tests': ['a11yr', 01:09:35 INFO - 'ts_paint', 01:09:35 INFO - 'tpaint', 01:09:35 INFO - 'sessionrestore', 01:09:35 INFO - 'sessionrestore_many_windows', 01:09:35 INFO - 'sessionrestore_no_auto_restore', 01:09:35 INFO - 'tabpaint']}, 01:09:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 01:09:35 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 01:09:35 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:09:35 INFO - 'talos_options': ['--mitmproxy', 01:09:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:09:35 INFO - '--firstNonBlankPaint'], 01:09:35 INFO - 'tests': ['quantum_pageload_google', 01:09:35 INFO - 'quantum_pageload_youtube', 01:09:35 INFO - 'quantum_pageload_amazon', 01:09:35 INFO - 'quantum_pageload_facebook']}, 01:09:35 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:09:35 INFO - 'talos_options': ['--stylo', 01:09:35 INFO - '--mitmproxy', 01:09:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:09:35 INFO - '--firstNonBlankPaint'], 01:09:35 INFO - 'tests': ['quantum_pageload_google', 01:09:35 INFO - 'quantum_pageload_youtube', 01:09:35 INFO - 'quantum_pageload_amazon', 01:09:35 INFO - 'quantum_pageload_facebook']}, 01:09:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:09:35 INFO - 'tsvgr_opacity', 01:09:35 INFO - 'tart', 01:09:35 INFO - 'tscrollx', 01:09:35 INFO - 'cart', 01:09:35 INFO - 'tsvg_static']}, 01:09:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:09:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:09:35 INFO - 'talos_options': ['--xperf_path', 01:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:09:35 INFO - 'tests': ['tp5n']}}} 01:09:35 INFO - Running post-action listener: _resource_record_post_action 01:09:35 INFO - [mozharness: 2017-07-28 08:09:35.091387Z] Finished populate-webroot step (success) 01:09:35 INFO - [mozharness: 2017-07-28 08:09:35.091478Z] Running create-virtualenv step. 01:09:35 INFO - Running pre-action listener: _resource_record_pre_action 01:09:35 INFO - Running main action method: create_virtualenv 01:09:35 INFO - Creating virtualenv /builds/slave/test/build/venv 01:09:35 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 01:09:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:09:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 01:09:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:09:35 INFO - Using real prefix '/usr' 01:09:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:09:35 INFO - Installing distribute.............................................................................................................................................................................................done. 01:09:37 INFO - Installing pip.................done. 01:09:37 INFO - Return code: 0 01:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:09:37 INFO - Reading from file tmpfile_stdout 01:09:37 INFO - Output received: 01:09:37 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) 01:09:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:09:37 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')]} 01:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:37 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')]} 01:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:37 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1357eb0>, '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 0x1358db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359240>, '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': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', '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 01:09:37 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 01:09:37 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 01:09:37 INFO - Using env: {'DISPLAY': ':0', 01:09:37 INFO - 'HOME': '/home/cltbld', 01:09:37 INFO - 'LANG': 'en_US.UTF-8', 01:09:37 INFO - 'LANGUAGE': 'en_US:en', 01:09:37 INFO - 'LOGNAME': 'cltbld', 01:09:37 INFO - 'MAIL': '/var/mail/cltbld', 01:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:37 INFO - 'MOZ_NO_REMOTE': '1', 01:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:37 INFO - 'NO_EM_RESTART': '1', 01:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:37 INFO - 'PWD': '/builds/slave/test', 01:09:37 INFO - 'SHELL': '/bin/bash', 01:09:37 INFO - 'SHLVL': '1', 01:09:37 INFO - 'TERM': 'linux', 01:09:37 INFO - 'TMOUT': '86400', 01:09:37 INFO - 'USER': 'cltbld', 01:09:37 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', 01:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:37 INFO - '_': '/tools/buildbot/bin/python'} 01:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:38 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 01:09:38 INFO - Cleaning up... 01:09:38 INFO - Return code: 0 01:09:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1357eb0>, '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 0x1358db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359240>, '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': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', '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 01:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:09:38 INFO - Using env: {'DISPLAY': ':0', 01:09:38 INFO - 'HOME': '/home/cltbld', 01:09:38 INFO - 'LANG': 'en_US.UTF-8', 01:09:38 INFO - 'LANGUAGE': 'en_US:en', 01:09:38 INFO - 'LOGNAME': 'cltbld', 01:09:38 INFO - 'MAIL': '/var/mail/cltbld', 01:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:38 INFO - 'MOZ_NO_REMOTE': '1', 01:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:38 INFO - 'NO_EM_RESTART': '1', 01:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:38 INFO - 'PWD': '/builds/slave/test', 01:09:38 INFO - 'SHELL': '/bin/bash', 01:09:38 INFO - 'SHLVL': '1', 01:09:38 INFO - 'TERM': 'linux', 01:09:38 INFO - 'TMOUT': '86400', 01:09:38 INFO - 'USER': 'cltbld', 01:09:38 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', 01:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:38 INFO - '_': '/tools/buildbot/bin/python'} 01:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:38 INFO - Downloading/unpacking psutil>=3.1.1 01:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:09:39 INFO - Installing collected packages: psutil 01:09:39 INFO - Running setup.py install for psutil 01:09:39 INFO - building 'psutil._psutil_linux' extension 01:09:39 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 01:09:39 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 01:09:39 INFO - building 'psutil._psutil_posix' extension 01:09:39 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 01:09:39 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 01:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:09:40 INFO - Successfully installed psutil 01:09:40 INFO - Cleaning up... 01:09:40 INFO - Return code: 0 01:09:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1357eb0>, '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 0x1358db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359240>, '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': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', '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 01:09:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:09:40 INFO - Using env: {'DISPLAY': ':0', 01:09:40 INFO - 'HOME': '/home/cltbld', 01:09:40 INFO - 'LANG': 'en_US.UTF-8', 01:09:40 INFO - 'LANGUAGE': 'en_US:en', 01:09:40 INFO - 'LOGNAME': 'cltbld', 01:09:40 INFO - 'MAIL': '/var/mail/cltbld', 01:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:40 INFO - 'MOZ_NO_REMOTE': '1', 01:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:40 INFO - 'NO_EM_RESTART': '1', 01:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:40 INFO - 'PWD': '/builds/slave/test', 01:09:40 INFO - 'SHELL': '/bin/bash', 01:09:40 INFO - 'SHLVL': '1', 01:09:40 INFO - 'TERM': 'linux', 01:09:40 INFO - 'TMOUT': '86400', 01:09:40 INFO - 'USER': 'cltbld', 01:09:40 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', 01:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:40 INFO - '_': '/tools/buildbot/bin/python'} 01:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:09:41 INFO - Installing collected packages: mozsystemmonitor 01:09:41 INFO - Running setup.py install for mozsystemmonitor 01:09:41 INFO - Successfully installed mozsystemmonitor 01:09:41 INFO - Cleaning up... 01:09:41 INFO - Return code: 0 01:09:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1357eb0>, '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 0x1358db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359240>, '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': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', '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 01:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:09:41 INFO - Using env: {'DISPLAY': ':0', 01:09:41 INFO - 'HOME': '/home/cltbld', 01:09:41 INFO - 'LANG': 'en_US.UTF-8', 01:09:41 INFO - 'LANGUAGE': 'en_US:en', 01:09:41 INFO - 'LOGNAME': 'cltbld', 01:09:41 INFO - 'MAIL': '/var/mail/cltbld', 01:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:41 INFO - 'MOZ_NO_REMOTE': '1', 01:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:41 INFO - 'NO_EM_RESTART': '1', 01:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:41 INFO - 'PWD': '/builds/slave/test', 01:09:41 INFO - 'SHELL': '/bin/bash', 01:09:41 INFO - 'SHLVL': '1', 01:09:41 INFO - 'TERM': 'linux', 01:09:41 INFO - 'TMOUT': '86400', 01:09:41 INFO - 'USER': 'cltbld', 01:09:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', 01:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:41 INFO - '_': '/tools/buildbot/bin/python'} 01:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:41 INFO - Downloading/unpacking jsonschema==2.5.1 01:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:09:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:42 INFO - Downloading functools32-3.2.3-2.tar.gz 01:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:09:43 INFO - warning: no files found matching '*.txt' 01:09:43 INFO - no previously-included directories found matching 'build' 01:09:43 INFO - no previously-included directories found matching 'dist' 01:09:43 INFO - no previously-included directories found matching '.git*' 01:09:43 INFO - Installing collected packages: jsonschema, functools32 01:09:43 INFO - Running setup.py install for functools32 01:09:43 INFO - warning: no files found matching '*.txt' 01:09:43 INFO - no previously-included directories found matching 'build' 01:09:43 INFO - no previously-included directories found matching 'dist' 01:09:43 INFO - no previously-included directories found matching '.git*' 01:09:43 INFO - Successfully installed jsonschema functools32 01:09:43 INFO - Cleaning up... 01:09:43 INFO - Return code: 0 01:09:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:09:43 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')]} 01:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:43 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')]} 01:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:43 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1357eb0>, '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 0x1358db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359240>, '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': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', '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 01:09:43 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 01:09:43 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 01:09:43 INFO - Using env: {'DISPLAY': ':0', 01:09:43 INFO - 'HOME': '/home/cltbld', 01:09:43 INFO - 'LANG': 'en_US.UTF-8', 01:09:43 INFO - 'LANGUAGE': 'en_US:en', 01:09:43 INFO - 'LOGNAME': 'cltbld', 01:09:43 INFO - 'MAIL': '/var/mail/cltbld', 01:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:43 INFO - 'MOZ_NO_REMOTE': '1', 01:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:43 INFO - 'NO_EM_RESTART': '1', 01:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:43 INFO - 'PWD': '/builds/slave/test', 01:09:43 INFO - 'SHELL': '/bin/bash', 01:09:43 INFO - 'SHLVL': '1', 01:09:43 INFO - 'TERM': 'linux', 01:09:43 INFO - 'TMOUT': '86400', 01:09:43 INFO - 'USER': 'cltbld', 01:09:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', 01:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:43 INFO - '_': '/tools/buildbot/bin/python'} 01:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:09:43 INFO - Cleaning up... 01:09:43 INFO - Return code: 0 01:09:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:09:43 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')]} 01:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:43 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')]} 01:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:43 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1357eb0>, '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 0x1358db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359240>, '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': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', '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 01:09:43 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 01:09:43 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 01:09:43 INFO - Using env: {'DISPLAY': ':0', 01:09:43 INFO - 'HOME': '/home/cltbld', 01:09:43 INFO - 'LANG': 'en_US.UTF-8', 01:09:43 INFO - 'LANGUAGE': 'en_US:en', 01:09:43 INFO - 'LOGNAME': 'cltbld', 01:09:43 INFO - 'MAIL': '/var/mail/cltbld', 01:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:43 INFO - 'MOZ_NO_REMOTE': '1', 01:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:43 INFO - 'NO_EM_RESTART': '1', 01:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:43 INFO - 'PWD': '/builds/slave/test', 01:09:43 INFO - 'SHELL': '/bin/bash', 01:09:43 INFO - 'SHLVL': '1', 01:09:43 INFO - 'TERM': 'linux', 01:09:43 INFO - 'TMOUT': '86400', 01:09:43 INFO - 'USER': 'cltbld', 01:09:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', 01:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:43 INFO - '_': '/tools/buildbot/bin/python'} 01:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:43 INFO - Downloading/unpacking blobuploader==1.2.4 01:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:44 INFO - Downloading blobuploader-1.2.4.tar.gz 01:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:09:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:09:44 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 01:09:44 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 01:09:44 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 01:09:44 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 01:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:09:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:09:45 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 01:09:45 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 01:09:45 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 01:09:45 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 01:09:45 INFO - Downloading docopt-0.6.1.tar.gz 01:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:09:45 INFO - Installing collected packages: blobuploader, requests, docopt 01:09:45 INFO - Running setup.py install for blobuploader 01:09:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:09:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:09:45 INFO - Running setup.py install for requests 01:09:45 INFO - Running setup.py install for docopt 01:09:46 INFO - Successfully installed blobuploader requests docopt 01:09:46 INFO - Cleaning up... 01:09:46 INFO - Return code: 0 01:09:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:46 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')]} 01:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:46 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')]} 01:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:46 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1357eb0>, '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 0x1358db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359240>, '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': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', '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 01:09:46 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 01:09:46 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 01:09:46 INFO - Using env: {'DISPLAY': ':0', 01:09:46 INFO - 'HOME': '/home/cltbld', 01:09:46 INFO - 'LANG': 'en_US.UTF-8', 01:09:46 INFO - 'LANGUAGE': 'en_US:en', 01:09:46 INFO - 'LOGNAME': 'cltbld', 01:09:46 INFO - 'MAIL': '/var/mail/cltbld', 01:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:46 INFO - 'MOZ_NO_REMOTE': '1', 01:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:46 INFO - 'NO_EM_RESTART': '1', 01:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:46 INFO - 'PWD': '/builds/slave/test', 01:09:46 INFO - 'SHELL': '/bin/bash', 01:09:46 INFO - 'SHLVL': '1', 01:09:46 INFO - 'TERM': 'linux', 01:09:46 INFO - 'TMOUT': '86400', 01:09:46 INFO - 'USER': 'cltbld', 01:09:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', 01:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:46 INFO - '_': '/tools/buildbot/bin/python'} 01:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:46 INFO - Running setup.py (path:/tmp/pip-_XNV7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:46 INFO - Running setup.py (path:/tmp/pip-dy3Uyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:46 INFO - Running setup.py (path:/tmp/pip-KRNYtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:46 INFO - Running setup.py (path:/tmp/pip-VBPfd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:46 INFO - Running setup.py (path:/tmp/pip-yBL5EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:46 INFO - Running setup.py (path:/tmp/pip-qrjs_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:46 INFO - Running setup.py (path:/tmp/pip-JOVon7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:46 INFO - Running setup.py (path:/tmp/pip-38KFZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:46 INFO - Running setup.py (path:/tmp/pip-LXxdwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:46 INFO - Running setup.py (path:/tmp/pip-l9O00m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:47 INFO - Running setup.py (path:/tmp/pip-wft1_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:47 INFO - Running setup.py (path:/tmp/pip-f3dl5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:47 INFO - Running setup.py (path:/tmp/pip-gsSegp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:47 INFO - Running setup.py (path:/tmp/pip-t3DW_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:47 INFO - Running setup.py (path:/tmp/pip-lIqT7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:47 INFO - Running setup.py (path:/tmp/pip-ykBSGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:47 INFO - Running setup.py (path:/tmp/pip-teaZeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:09:47 INFO - Running setup.py install for manifestparser 01:09:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:09:47 INFO - Running setup.py install for mozcrash 01:09:47 INFO - Running setup.py install for mozdebug 01:09:47 INFO - Running setup.py install for mozdevice 01:09:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:09:47 INFO - Running setup.py install for mozfile 01:09:48 INFO - Running setup.py install for mozhttpd 01:09:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:09:48 INFO - Running setup.py install for mozinfo 01:09:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:09:48 INFO - Running setup.py install for mozInstall 01:09:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:09:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:09:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:09:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:09:48 INFO - Running setup.py install for mozleak 01:09:48 INFO - Running setup.py install for mozlog 01:09:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:09:48 INFO - Running setup.py install for moznetwork 01:09:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:09:48 INFO - Running setup.py install for mozprocess 01:09:48 INFO - Running setup.py install for mozprofile 01:09:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:09:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:09:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:09:48 INFO - Running setup.py install for mozrunner 01:09:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:09:49 INFO - Running setup.py install for mozscreenshot 01:09:49 INFO - Running setup.py install for moztest 01:09:49 INFO - Running setup.py install for mozversion 01:09:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:09:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:09:49 INFO - Cleaning up... 01:09:49 INFO - Return code: 0 01:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:49 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')]} 01:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:49 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')]} 01:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:49 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1357eb0>, '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 0x1358db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359240>, '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': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', '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 01:09:49 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 01:09:49 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 01:09:49 INFO - Using env: {'DISPLAY': ':0', 01:09:49 INFO - 'HOME': '/home/cltbld', 01:09:49 INFO - 'LANG': 'en_US.UTF-8', 01:09:49 INFO - 'LANGUAGE': 'en_US:en', 01:09:49 INFO - 'LOGNAME': 'cltbld', 01:09:49 INFO - 'MAIL': '/var/mail/cltbld', 01:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:49 INFO - 'MOZ_NO_REMOTE': '1', 01:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:49 INFO - 'NO_EM_RESTART': '1', 01:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:49 INFO - 'PWD': '/builds/slave/test', 01:09:49 INFO - 'SHELL': '/bin/bash', 01:09:49 INFO - 'SHLVL': '1', 01:09:49 INFO - 'TERM': 'linux', 01:09:49 INFO - 'TMOUT': '86400', 01:09:49 INFO - 'USER': 'cltbld', 01:09:49 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', 01:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:49 INFO - '_': '/tools/buildbot/bin/python'} 01:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:49 INFO - Running setup.py (path:/tmp/pip-jwAyTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:49 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)) 01:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:49 INFO - Running setup.py (path:/tmp/pip-iN6cdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:49 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)) 01:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:49 INFO - Running setup.py (path:/tmp/pip-N8H9jT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:49 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)) 01:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:49 INFO - Running setup.py (path:/tmp/pip-4x5ril-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:49 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)) 01:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:49 INFO - Running setup.py (path:/tmp/pip-FrIi4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:49 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)) 01:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:49 INFO - Running setup.py (path:/tmp/pip-7itY3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:49 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)) 01:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:49 INFO - Running setup.py (path:/tmp/pip-jrROgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:50 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)) 01:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:50 INFO - Running setup.py (path:/tmp/pip-p9MkhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:50 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)) 01:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:50 INFO - Running setup.py (path:/tmp/pip-KAOipS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:50 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)) 01:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:50 INFO - Running setup.py (path:/tmp/pip-_fxsEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:50 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)) 01:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:50 INFO - Running setup.py (path:/tmp/pip-azwSzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:50 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)) 01:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:50 INFO - Running setup.py (path:/tmp/pip-CKKcLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:50 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)) 01:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:50 INFO - Running setup.py (path:/tmp/pip-jP26Wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:50 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)) 01:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:50 INFO - Running setup.py (path:/tmp/pip-ZRQrZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:50 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)) 01:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:50 INFO - Running setup.py (path:/tmp/pip-EkDG_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:50 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)) 01:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:50 INFO - Running setup.py (path:/tmp/pip-RFoJ0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:50 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)) 01:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:50 INFO - Running setup.py (path:/tmp/pip-YeWNkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:50 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)) 01:09:50 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)) 01:09:50 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)) 01:09:50 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)) 01:09:50 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)) 01:09:50 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)) 01:09:50 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)) 01:09:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:51 INFO - Downloading blessings-1.6.tar.gz 01:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:09:51 INFO - Installing collected packages: blessings 01:09:51 INFO - Running setup.py install for blessings 01:09:52 INFO - Successfully installed blessings 01:09:52 INFO - Cleaning up... 01:09:52 INFO - Return code: 0 01:09:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:52 INFO - Reading from file tmpfile_stdout 01:09:52 INFO - Current package versions: 01:09:52 INFO - argparse == 1.2.1 01:09:52 INFO - blessings == 1.6 01:09:52 INFO - blobuploader == 1.2.4 01:09:52 INFO - docopt == 0.6.1 01:09:52 INFO - functools32 == 3.2.3-2 01:09:52 INFO - jsonschema == 2.5.1 01:09:52 INFO - manifestparser == 1.1 01:09:52 INFO - mozInstall == 1.13 01:09:52 INFO - mozcrash == 1.0 01:09:52 INFO - mozdebug == 0.1 01:09:52 INFO - mozdevice == 0.51 01:09:52 INFO - mozfile == 1.2 01:09:52 INFO - mozhttpd == 0.7 01:09:52 INFO - mozinfo == 0.10 01:09:52 INFO - mozleak == 0.1 01:09:52 INFO - mozlog == 3.5 01:09:52 INFO - moznetwork == 0.27 01:09:52 INFO - mozprocess == 0.25 01:09:52 INFO - mozprofile == 0.28 01:09:52 INFO - mozrunner == 6.13 01:09:52 INFO - mozscreenshot == 0.1 01:09:52 INFO - mozsystemmonitor == 0.3 01:09:52 INFO - moztest == 0.8 01:09:52 INFO - mozversion == 1.4 01:09:52 INFO - psutil == 3.1.1 01:09:52 INFO - requests == 1.2.3 01:09:52 INFO - wsgiref == 0.1.2 01:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:52 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')]} 01:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:52 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')]} 01:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:52 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1357eb0>, '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 0x1358db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359240>, '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': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', '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 01:09:52 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 01:09:52 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 01:09:52 INFO - Using env: {'DISPLAY': ':0', 01:09:52 INFO - 'HOME': '/home/cltbld', 01:09:52 INFO - 'LANG': 'en_US.UTF-8', 01:09:52 INFO - 'LANGUAGE': 'en_US:en', 01:09:52 INFO - 'LOGNAME': 'cltbld', 01:09:52 INFO - 'MAIL': '/var/mail/cltbld', 01:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:52 INFO - 'MOZ_NO_REMOTE': '1', 01:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:52 INFO - 'NO_EM_RESTART': '1', 01:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:52 INFO - 'PWD': '/builds/slave/test', 01:09:52 INFO - 'SHELL': '/bin/bash', 01:09:52 INFO - 'SHLVL': '1', 01:09:52 INFO - 'TERM': 'linux', 01:09:52 INFO - 'TMOUT': '86400', 01:09:52 INFO - 'USER': 'cltbld', 01:09:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', 01:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:52 INFO - '_': '/tools/buildbot/bin/python'} 01:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:52 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)) 01:09:52 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)) 01:09:52 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)) 01:09:52 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)) 01:09:52 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)) 01:09:52 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)) 01:09:52 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)) 01:09:52 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)) 01:09:52 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)) 01:09:52 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:53 INFO - Downloading marionette_driver-1.4.0.tar.gz 01:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 01:09:53 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 01:09:53 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 01:09:53 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 01:09:53 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 01:09:53 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 01:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 01:09:53 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)) 01:09:53 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)) 01:09:53 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)) 01:09:53 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)) 01:09:53 INFO - Installing collected packages: marionette-driver, simplejson 01:09:53 INFO - Running setup.py install for marionette-driver 01:09:54 INFO - Running setup.py install for simplejson 01:09:54 INFO - building 'simplejson._speedups' extension 01:09:54 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 01:09:54 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 01:09:55 INFO - Successfully installed marionette-driver simplejson 01:09:55 INFO - Cleaning up... 01:09:55 INFO - Return code: 0 01:09:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:09: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')]} 01:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09: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')]} 01:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:55 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1357eb0>, '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 0x1358db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359240>, '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': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', '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 01:09:55 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 01:09:55 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 01:09:55 INFO - Using env: {'DISPLAY': ':0', 01:09:55 INFO - 'HOME': '/home/cltbld', 01:09:55 INFO - 'LANG': 'en_US.UTF-8', 01:09:55 INFO - 'LANGUAGE': 'en_US:en', 01:09:55 INFO - 'LOGNAME': 'cltbld', 01:09:55 INFO - 'MAIL': '/var/mail/cltbld', 01:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:55 INFO - 'MOZ_NO_REMOTE': '1', 01:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:55 INFO - 'NO_EM_RESTART': '1', 01:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:55 INFO - 'PWD': '/builds/slave/test', 01:09:55 INFO - 'SHELL': '/bin/bash', 01:09:55 INFO - 'SHLVL': '1', 01:09:55 INFO - 'TERM': 'linux', 01:09:55 INFO - 'TMOUT': '86400', 01:09:55 INFO - 'USER': 'cltbld', 01:09:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', 01:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:55 INFO - '_': '/tools/buildbot/bin/python'} 01:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:09:55 INFO - Cleaning up... 01:09:55 INFO - Return code: 0 01:09:55 INFO - Running post-action listener: _resource_record_post_action 01:09:55 INFO - Running post-action listener: _start_resource_monitoring 01:09:55 INFO - Starting resource monitoring. 01:09:55 INFO - [mozharness: 2017-07-28 08:09:55.342945Z] Finished create-virtualenv step (success) 01:09:55 INFO - [mozharness: 2017-07-28 08:09:55.343455Z] Running install step. 01:09:55 INFO - Running pre-action listener: _resource_record_pre_action 01:09:55 INFO - Running main action method: install 01:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:55 INFO - Reading from file tmpfile_stdout 01:09:55 INFO - Detecting whether we're running mozinstall >=1.0... 01:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:09:55 INFO - Reading from file tmpfile_stdout 01:09:55 INFO - Output received: 01:09:55 INFO - Usage: mozinstall [options] installer 01:09:55 INFO - Options: 01:09:55 INFO - -h, --help show this help message and exit 01:09:55 INFO - -d DEST, --destination=DEST 01:09:55 INFO - Directory to install application into. [default: 01:09:55 INFO - "/builds/slave/test"] 01:09:55 INFO - --app=APP Application being installed. [default: firefox] 01:09:55 INFO - mkdir: /builds/slave/test/build/application 01:09:55 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'] 01:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:10:13 INFO - Reading from file tmpfile_stdout 01:10:13 INFO - Output received: 01:10:13 INFO - /builds/slave/test/build/application/firefox/firefox 01:10:13 INFO - Running post-action listener: _resource_record_post_action 01:10:13 INFO - [mozharness: 2017-07-28 08:10:13.696171Z] Finished install step (success) 01:10:13 INFO - [mozharness: 2017-07-28 08:10:13.696426Z] Running setup-mitmproxy step. 01:10:13 INFO - Running pre-action listener: _resource_record_pre_action 01:10:13 INFO - Running main action method: setup_mitmproxy 01:10:13 INFO - Skipping: mitmproxy is not required 01:10:13 INFO - Running post-action listener: _resource_record_post_action 01:10:13 INFO - [mozharness: 2017-07-28 08:10:13.697612Z] Finished setup-mitmproxy step (success) 01:10:13 INFO - [mozharness: 2017-07-28 08:10:13.697838Z] Running run-tests step. 01:10:13 INFO - Running pre-action listener: _resource_record_pre_action 01:10:13 INFO - Running pre-action listener: _set_gcov_prefix 01:10:13 INFO - Running main action method: run_tests 01:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:10:13 INFO - Python 2.7.3 01:10:13 INFO - Return code: 0 01:10:13 INFO - grabbing minidump binary from tooltool 01:10:13 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')]} 01:10:13 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 0x1357eb0>, '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 0x1358db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:10:13 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 01:10:13 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 01:10:13 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 01:10:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:10:13 INFO - Return code: 0 01:10:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:10:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:10:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:10:13 INFO - ENV: RUST_BACKTRACE is now 1 01:10:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:10:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:10:13 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/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 01:10:13 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/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 01:10:13 INFO - Using env: {'DISPLAY': ':0', 01:10:13 INFO - 'HOME': '/home/cltbld', 01:10:13 INFO - 'LANG': 'en_US.UTF-8', 01:10:13 INFO - 'LANGUAGE': 'en_US:en', 01:10:13 INFO - 'LOGNAME': 'cltbld', 01:10:13 INFO - 'MAIL': '/var/mail/cltbld', 01:10:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:10:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:13 INFO - 'MOZ_NO_REMOTE': '1', 01:10:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:13 INFO - 'NO_EM_RESTART': '1', 01:10:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:13 INFO - 'PWD': '/builds/slave/test', 01:10:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:10:13 INFO - 'RUST_BACKTRACE': '1', 01:10:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:10:13 INFO - 'SHELL': '/bin/bash', 01:10:13 INFO - 'SHLVL': '1', 01:10:13 INFO - 'STYLO_FORCE_ENABLED': '1', 01:10:13 INFO - 'TERM': 'linux', 01:10:13 INFO - 'TMOUT': '86400', 01:10:13 INFO - 'USER': 'cltbld', 01:10:13 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498', 01:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:13 INFO - '_': '/tools/buildbot/bin/python'} 01:10:13 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/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 01:10:14 INFO - mozversion application_buildid: 20170728072256 01:10:14 INFO - mozversion application_changeset: 5845151f1a2cd00957fdd48e204542ccbdfaba1e 01:10:14 INFO - mozversion application_display_name: Nightly 01:10:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:10:14 INFO - mozversion application_name: Firefox 01:10:14 INFO - mozversion application_remotingname: firefox 01:10:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:10:14 INFO - mozversion application_vendor: Mozilla 01:10:14 INFO - mozversion application_version: 56.0a1 01:10:14 INFO - mozversion platform_buildid: 20170728072256 01:10:14 INFO - mozversion platform_changeset: 5845151f1a2cd00957fdd48e204542ccbdfaba1e 01:10:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:10:14 INFO - mozversion platform_version: 56.0a1 01:10:14 INFO - using testdate: 1501229414 01:10:14 INFO - actual date: 1501229414 01:10:14 INFO - starting webserver on 'localhost:56078' 01:10:14 INFO - SUITE-START | Running 2 tests 01:10:14 INFO - TEST-START | dromaeo_css 01:10:14 INFO - Initialising browser for dromaeo_css test... 01:10:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56078/getInfo.html -profile /tmp/tmpw1cSXs/profile 01:10:14 INFO - TEST-INFO | started process 26051 (/builds/slave/test/build/application/firefox/firefox http://localhost:56078/getInfo.html) 01:10:20 INFO - TEST-INFO | 26051: exit 0 01:10:20 INFO - Browser initialized. 01:10:20 INFO - Running cycle 1/1 for dromaeo_css test... 01:10:20 INFO - TEST-INFO | started process 26279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw1cSXs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:10:21 INFO - PID 26279 | 01:10:21 INFO - PID 26279 | (/builds/slave/test/build/application/firefox/firefox:26334): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 01:10:21 INFO - PID 26279 | 01:10:31 INFO - PID 26279 | RSS: Main: 173465600 01:10:31 INFO - PID 26279 | 01:13:30 INFO - PID 26279 | Cycle 1(1): loaded http://localhost:56078/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56078/tests/dromaeo/cssquery-ext.html) 01:13:32 INFO - PID 26279 | RSS: Main: 175833088 01:13:32 INFO - PID 26279 | 01:16:34 INFO - PID 26279 | Cycle 1(1): loaded http://localhost:56078/tests/dromaeo/cssquery-ext.html (next: http://localhost:56078/tests/dromaeo/cssquery-jquery.html) 01:16:35 INFO - PID 26279 | RSS: Main: 173088768 01:16:35 INFO - PID 26279 | 01:19:37 INFO - PID 26279 | Cycle 1(1): loaded http://localhost:56078/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56078/tests/dromaeo/cssquery-mootools.html) 01:19:38 INFO - PID 26279 | RSS: Main: 175120384 01:19:38 INFO - PID 26279 | 01:22:39 INFO - PID 26279 | Cycle 1(1): loaded http://localhost:56078/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56078/tests/dromaeo/cssquery-prototype.html) 01:22:40 INFO - PID 26279 | RSS: Main: 173670400 01:22:40 INFO - PID 26279 | 01:25:44 INFO - PID 26279 | Cycle 1(1): loaded http://localhost:56078/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56078/tests/dromaeo/cssquery-yui.html) 01:25:45 INFO - PID 26279 | RSS: Main: 174809088 01:25:45 INFO - PID 26279 | 01:28:47 INFO - PID 26279 | Cycle 1(1): loaded http://localhost:56078/tests/dromaeo/cssquery-yui.html (next: http://localhost:56078/tests/dromaeo/cssquery-dojo.html) 01:28:47 INFO - PID 26279 | RSS: Main: 177319936 01:28:47 INFO - PID 26279 | 01:28:47 INFO - PID 26279 | __start_tp_report 01:28:47 INFO - PID 26279 | _x_x_mozilla_page_load 01:28:47 INFO - PID 26279 | _x_x_mozilla_page_load_details 01:28:47 INFO - PID 26279 | |i|pagename|runs| 01:28:47 INFO - PID 26279 | |0;dojo.html;3113.3461972985674;3146.0719087869074;3153.6530981592036;3155.7633177511684;3199.920001999951;6142.1708069410615;6160.291566469858;6181.1964444622245;6196.070589411591;6219.7512099516025;6334.018227174795;6381.042843573467;6399.872002559958;6412.871742565146;6428.2928877823515;5765.596408251424;5838.124281357809;5870.501007414375;5871.88256234875;5967.16459695643;5645.576581756384;5727.57043221758;5813.244278243822;5840.970795146019;5856.004479238519;5715.371309155989;5715.914261286063;5727.541796656299;5738.110592858114;5745.166950792132;5752.2234498342605;5790.536757059425;5811.244538210048;5828.5628577856405;5829.5919285650025;5697.145428185764;5745.741441635137;5750.137479378085;5783.537317014629;5805.274340707411;6122.326544080148;6132.478739307165;6211.378862113797;6241.781537646206;6305.716242769086;6796.4562834973085;6800.625965571891;6808.8978665320055;6814.761483348108;6817.113775209241;6822;6825.1809782825885;6827.180738311385;6836.350546698056;6846.315368463163;6299.716512756937;6302.55882088254;6387.1377364055725;6394.13679153313;6407.871842563122;6868.313168683092;6992.0910281663055;7001.054857594261;7097.787066388017;7100.3609675128455;6562;6602.075709400688;6602.504812139109;6617.371349721769;6637.900431493435;6688.33116688337;6707.5975441473665;6713.160854893138;6715.429188518933;6729.663516824139;6682.5322227444585;6690.966545167243;6696.5647232929705;6700.162479690039;6704.296048914891;6420;6669.366410191024;6712.228093769279;6714.597124172566;6835.965820170967;5418.864528386743;5429.918551221735;5490.0941344677685;5505.229267902497;5512.862178445571;4615.538446155358;4658.67389282747;4689.132510485571;4703.929441058387;4725.149473094876;5732.140178973104;5740.13897915316;5753.913691294634;5756.079027355687;5756.7121643917635;6838.247792742794;6869.519133660596;6876.621785801829;6882.174139103239;6892.310768923167;5807.88384232313;5833.241678581842;5845.240118784531;5848.327442344185;5853.9414605854245;5942.049272116527;5949.494292985145;6006.948783962789;6032.819015429544;6037.698115094227;6437.130987316652;6550.737970481127;6558.672066396756;6636.303188165173;6641.535092543476;6736.056952026622;6749.493787965824;6828.9658551706925;6840.965795170992;6870.106886104974;6640.634765087773;6642.202935647753;6644.966775166094;6651.667416629246;6658.766943156967;6295.716692748746;6695.296993815774;6720.529562930548;6754.5947243165565;6780.32196780318;6823.215330237086;6830.077939478107;6839.6580170990255;6940.063091482787;6949.096617439903;6501.609903405811;6610.338966103352;6625.17185351831;6625.966870165618;6633.535652504278;6519.282878883224;6537.28089910119;6538.313477085027;6569.737210511526;6574.967125164344;6485.805425837232;6492.902606461002;6503.284638689645;6571.901421478778;6581.539292249497;6175.84560385994;6599.175103112111;6669.7665581704405;6672.5329226953645;6741.764038258638;6456.160699109086;6472.805815825533;6509.576877502947;6514.771982980573;6520.119783829123 01:28:47 INFO - PID 26279 | |1;ext.html;753.8002429356221;811.5982588618627;864.5417928497895;885.4952676974124;891.3537685178245;41054.38418423722;41832.37251441227;42059.15881682365;42107.78946105273;42299.3655095173;37686.811565942204;38038.61961380385;38194.42708359377;38253.61746382535;38346.616533834655;6873.828154296145;6960.234374218832;6998.510104292702;6999;7029.191642961048;6840.521163518531;6901.689423975908;6916.2737912519215;6919.342662447059;6949.339812717783;6898.172219333687;7643.961780191091;7811.921880781177;7820.45256832022;7831.843363132734;7745.922540774576;7812.984312039427;7816.41376896735;7820.374370050411;7822.335101516378;7535.623218839091;7702.191269916634;7726.459147859652;7788.922110778876;7791.298783109491;40598.18803623911;40966.590334096574;40989.180216395805;41089.79455102735;41111;3479.356319080978;3508.912277193065;3515.9472607910648;3519.996800911728;3524.1718196223865;31500.36999260025;31528;31568.052958411285;31577.684223157703;31593;4877;4896.02079584081;4927.728974906378;4935.7532123393685;5020.974895125501;181330.0933495324;181937;182572;183063;189582.05208974006;49538.25692614614;50062;50069.24896126561;50108.498915011114;50279.74860125676;51642;51699.74150129225;51817;51842.74078629583;51983;16496;16782.328706851833;16789.832101679072;16812.495625131265;16939.830601694073;13977.091489053179;13984.091034082956;14019.439222431192;14021.158730476203;14035.50875719345;14481.131132131895;14551.181102362205;14574.854251457562;14698;14880.702385952436;5979.491743201789;6005.888910551562;6009.939900601025;6037.170263788951;6105.839890420806;936.990630093704;973.1144658361;981.3817295104038;1007.2646967713611;1021.5709402051157;22044.908288991075;22231.221907233168;22481.213157539736;23030.424239393815;23048.76951230466;1047.8218702820539;1072.973175670599;1082.1396989393452;1091.5633746501305;1096.8025755363951;12155.392230388445;12355.38223088842;12363.567275145328;12385.009199264037;12408.069394795426;242857;243558;244404;244859;245421;52502.737486312326;52893.7355313221;53135.73432132815;53178.73410632922;53182;1429.8570142985618;1461.298576683198;1494.8355680875095;1500.3323521033035;1520.7718842173542;21889.890550547145;22052.79814283892;22314.21900233484;22935.54128917379;23160.768392315862;51519.74240128775;52389;52869.471305287996;53428.73285633547;53580.196297056355;209219;210931;211064;211459;211901;31515.527267090554;32234.194145146557;32410;33743;36229;44929.32606010978;45162.77418613018;45307.32039019484;45634.54365456436;46189.53810461852;29719.702802971693;31424.842875785474;31875;31975.36049278955;32262.516062258615;30064.549031764105;31725.41372931298;31978.20054498563;32076.839615802706;32438.35123297568;36453.27093458169;39159;40292.39561406522;40411;40522;31960.36079278448;33658.663413366536;33894;34480;34817.30365392729;24744.133955311478;25005.374865628506;25049.499010020063;25277.87361063183;25419.237422876602 01:28:47 INFO - PID 26279 | |2;jquery.html;573.7418161827179;577.2564916516391;584.2288179602921;589.9469047785699;593.7506247376101;22202.555948881032;22933.655995160087;23014;23025.53948921025;23044.88477557614;23673.5265294694;24757.257282281516;25816.35459113523;25830.74169258307;25863;6469.288378278397;6639.302873198317;6644.43522300605;6645.734170633169;6651.035599838021;6584.176977877765;6644.003399490091;6649.202095748493;6655.800325990203;6657.900131498031;5839.18251444796;6337.493000559944;6376.394242546974;6398.840028999289;6584.045313429549;6360.395762402564;6379.106925030453;6398.616083035033;6405.519586031066;6405.583637063599;5945.732442040118;5947.851303717398;5950.315713692938;5952.7321270542925;5973.910391344133;24787.752122478905;28231;28398.858005710044;28620.856895715595;28731.28171795722;1794.156746329223;1820.827021432975;1820.954476138094;1821.662992346407;1828.2869680824356;19015.14431850556;19331.226750930087;19332.516687082796;19346;19364.225430982744;2267.183813827021;2292.4383526036063;2357.9528409431887;2367.633016882386;2372.5966585680303;128245.7175428243;128603;131794.3410282952;131979.34010329886;132731;14351.928240358731;14434.350454229585;14578.125312481285;14738.63153421173;14827.629309267355;23213;23218;23222.767772322397;23309.300720978397;23372.64941025886;9395.57719902606;9683.176929961031;9846.212303015742;9893.15908147801;9908.306418550632;8784.736457906272;8796.560171991376;8856.690015849543;8872.33457490678;8973.955130224307;8711.651533938699;8886.911130888608;9059.954700226457;9116.27069834425;9344.990826972233;2734.2754170144926;2757.9172624821285;2775.4881831942125;2828.3918957424253;2894.942101157965;916.3448134583805;920.8857282688023;934.3086116273909;966.2318456826839;968.6319198704588;19238.903805480884;19565.804341956682;19677;19683.606327873364;19795.901020494806;981.3719219699398;1003.5935446144323;1007.7732510185297;1028.881678606955;1035.7876635289747;10316.1747060235;10438.63464778729;10642.946785266024;10927.836082458769;11094.167937404565;471539;473089;477544;496241;502611;118295;122283;124620;124917;125954;1261.8359613250218;1297.4485843516468;1298.6493646715523;1302.9218246905027;1320.5378117658934;19340.323088692392;19918.90040549788;20640.27759028427;20902.895485522477;21148.365549033555;55057.17414238709;55194.72402638122;56466.435335646114;57747.71126144342;59553.40446595479;65845.67077164583;66669.33330666825;66733.33266667271;72984;76066.61966690353;14598.416063357772;14980.40078396852;15040.774388383965;15115.168665723491;15300.15849128264;18618.720719188954;19674.11466483983;23252;23930.76069239355;24463.38841528976;19484.415467535997;19502.8049719501;19540.8045919539;19581.314653987043;19594.216231350587;16384.098874562012;16714.832851671326;16753.91623041877;16789.496315110566;16931.830681693027;19000;20137.697934531287;20169.899150504152;20321.288754893507;20363.389098326483;14417.495387661802;14483.420663173356;14865;14886.627834304229;14896.255187240811;19512.31706890252;19632.90183549073;19637.803621963598;19671.901640492277;19739.60520789605 01:28:47 INFO - PID 26279 | |3;mootools.html;1320.5906169087582;1370.4860677246033;1388.6597783543027;1394.630422937921;1396.7346204221196;13526.661833454169;13926.30368481577;14005.089669171497;14016.78974815376;14029.438822447102;11799.823002654946;12138.575149869755;12151.331676757774;13789.172649641003;14152.92923535381;2611.804114691401;2649.695285042216;2651.3106592285953;2651.721569235222;2665.7067722550505;2534.771870531652;2620.6724159480063;2640.1155612869616;2640.1287575100173;2672.3319170207446;2492.1775813981344;2598.870056497177;2617.463419998905;2662.9733702663016;2669.3326668332916;2678.5312570300216;2684.81206315558;2704.580789977557;2712.281245469962;2714.4164004739077;2596.6364708940764;2615.1239334822667;2641.7886569074426;2644.6429731986127;2645.378336091017;13716;13865.4453821847;13866.098703584235;13874.236916969563;13877.861221387859;6954.3045695430055;7571.545707257582;7592.696292148307;7596.658150383246;7603.771886843404;4878.951210487885;5083.517065878736;5120.92318615221;5158.664686795346;5161.329027226437;1789.7762779652544;1797.811229820863;1827.2051657528884;1884.6701827180189;1884.9057547122588;22315.55368892629;22484.662730059063;22529.43676408103;22560.435989100402;22617.54764904709;6216.689165541705;6337.366263373626;6340.461060809791;6379.138816259746;6488.967555162194;15789.763153552705;15790.131542765028;15795.68408631821;15802.762958555631;15810.762838557432;7425.331720145213;7496.400287976949;7530.6611202496015;7534.321911028033;7542.698292068366;6799.762008329783;6929.549579277331;6955.6869940852785;6967.79096627102;7030.9296907030275;5019;5179.404368497596;5180.818671346485;5209.244659524347;5255.47445255479;1500.8199016117917;1503.7518809396545;1512.8260250071382;1555.354527870921;1558.3688606114542;714.9249328820399;816.2327412232482;834.2241715204797;877.4077497689034;890.6081324217324;7116.964415177995;7200.243974382614;7248.818779530448;7320.816979575553;7349.265073492608;702.7434986230091;707.8938159276149;718.0270733156602;726.9636518174176;782.460102529253;4359.9782001090425;4564.6348292136545;4597.586217240464;4640.883977900512;4669.649776266793;18254.726179107325;18259.178336974866;19052.904735476233;19098.14058367377;19104.2358305669;19020;19375.8062419374;19386.612267754565;19393.806061939482;19447.124879380463;10461.3200141989;10777.946110269399;10936.234463587632;10937.125029997582;10946.562137514411;7096.787096387116;7129.3583577478275;7419.258074192538;7546.547207167588;7851.2148785121035;16180.595485112966;16556.254968526206;16670.666586667958;16839;16882.831171688616;16906.154692265583;17065.488035358958;17184.570385740455;17398.304067837144;17493;11323.547058117912;11589.6523104307;11618.825717614412;11632.12759043092;11641.6507504775;12903.096783225084;13089.149205301625;13170.47318107265;13170.802437963246;13251.86748132545;9942.652007179713;10128.898711013091;10276.434796085989;10391.636292729718;10431.895681043092;9695;10221.795564088825;10223.233257505866;10323.845142323022;10504.317219380715;9065.320100992583;9125.5437228137;9166.129217724305;9169.954150229207;9180.540972951192;6491.253505846699;6518.087467754613;6691.966540167268;6722.428593569602;6839;6068.605540639845;6544.640044797582;6641.634710090992;6642.933570664231;6677.899831502628 01:28:47 INFO - PID 26279 | |4;prototype.html;495.3230453486994;500.44213819976864;514.3647595219905;516.2024671881942;520.287206527058;6237.844053898649;6284.685765711708;6288.717007734657;6291.112666200144;6368.395002474757;5992.280926288851;6055;6068.33248342682;6147.46520750568;6164.013757798753;4873.634477414191;4896.2410826321975;4912.877178070541;4921.926171107419;4933.679310844802;4885.242787367946;4918.237548275572;4933.136701077297;4939.753012349386;4983.700977941317;4734.011715079675;4845.830395936143;4867;4882.414110306768;4928.98287895366;4832.251001094836;4896.216605343128;4914.287428322891;4915.606751459911;4922.310876477296;4383.583559561836;4391.5169331373845;4416.183006143874;4419.977900110511;4430.31330143825;6013.098035294697;6025.855087533399;6051.727672254759;6107.4808641265545;6107.511399088106;5667.263255776764;5668.384510414512;5682.147677848315;5706.629069110494;5718.370979192286;6566.244881838602;6566.770163044318;6590.670466476705;6595.505337099737;6613.93386066138;4793.63381436289;4795.856124316276;4813.735244561548;4833.2266837306215;4861.611071114302;6821.055999040299;6940.514164008521;6952.270011648755;6954.791356259269;6986.021956926034;4950.5544500994365;4963.677360971526;4967.925481117786;4987.60099192071;4993.650444468925;5009;5040.546350828443;5066.493350664904;5071;5074.949250507521;5621.971890140523;5632.52123569493;5636.549076073904;5660.235868157746;5664.819044667833;6441.162648855712;6499.350064993463;6529.575577587537;6529.596136830604;6583.308752581006;1656.4947690954134;1693.8390852868959;1702.3105642214923;1703.7274036154156;1748.7409065473094;1178.9174757767046;1200.0699457920007;1210.4794938176492;1212.8302037714727;1216.6958260434892;5609.467100625434;5653.886922261532;5713.143028545752;5713.571482138773;5723.313202415737;6588.96705516479;6604.966975165094;6645.235797883209;6674.666266686743;6681.732730690718;5640.915386269209;5732.71336433185;5740.971295143498;5747.511461525817;5756;3515.2793677296095;3558.822058897045;3562.340966921128;3587.8385472653795;3622.587190995514;6479.870402591921;6522.315156908551;6522.836929076716;6612.677464507118;6666.533382648451;6891.071294699733;6973.4072603829245;6976.5814051157095;6988.930110698828;7016.19313778922;6583.703733332011;6616.536842420985;6664.266930637626;6675.23234828001;6698.799036028927;6691.5315927884585;6701.865962680817;6785.1518560179975;6801.319868013159;6819;6623.735050597922;6691.698873550605;6710.6309152997055;6766;6775.288594697486;6591.736330546916;6595.736170553124;6614.750984665045;6639.074668346126;6688.531802773759;4849.248366503198;4896.069746748107;4915.26271059344;4970.65205435616;4979.950200497949;6741.224914048149;6801.489888258499;6812.8978065328065;6814.2163651180745;6831.521793474409;6637.2699003108655;6651.73393064272;6661.866762664623;6672.59964402118;6678.699458524281;6432.517561182836;6476.287608362982;6485.383888530582;6631.900521492085;6686.99085411557;6454.19322584677;6487.772927947499;6495.707693153725;6542.672866356758;6551.0173473979285;6270.9372906270355;6358.713857876314;6538.313477085027;6551.167566973374;6653.933460665525;6299.244090709144;6403.815294170593;6456.644884531396;6462;6469 01:28:47 INFO - PID 26279 | |5;yui.html;900.7477906186266;923.4551614547415;932.3380399916059;933.1834644685899;947.5877993073011;18348.633027339445;19143.521411964706;19161.42515724527;19172.328968486105;20716.48208794781;19600;20547.897260513677;20625.587488250225;20658.17367305306;20774;805.7059173401695;1043.3583346242083;1044.9634262800803;1045.1534257251612;1046.4140081554315;1043.2697112021576;1046.398320965444;1049.3127001813825;1050.10216265093;1060.6075751971744;1110.4336788237977;1113.2263077161376;1123.606737641827;1124.274842726441;1125.7917285302244;1107.6898468428813;1110.8944650258213;1111.372074777748;1112.6606385052555;1113.5378817790647;822.1655020154548;822.5887056471764;825.1212458731432;825.1707034430419;826.8553003224472;18035.819641803544;18524.536886577807;18541.814581854145;19996.300129495397;20242.49393765153;20292.695609565868;20328.085236164407;20649.27727529529;20721.68917466239;20957.5808483831;14229.217393043378;14666.486672966501;14782.334794934253;14862.777058344134;14865.554033379016;3430.9142271443416;3462.567179102612;3467.6358982306747;3468.150303175713;3477.3219222251673;115068;117531.4123429386;118967.4051629745;121233;122460.38769806184;16355;16883.91558042202;16900.492985210465;16951.321947122222;16964.491065268063;28746;29704.702952970627;29758.404831903674;29784.40431191364;29791;7445.9627701861145;8547.82904341922;8687.52218627969;8752.431091979;8755.124487551195;3561.198730285665;3650.908727281786;4069.8168582413864;4196.853110141131;4234.724742891703;4908.2637604358915;5039.521245481674;5076.13705670037;5078.263651770472;5092.898142037138;973.2311473935512;1081.086481922774;1090.6564432203832;1092.9344239345664;1099.4502748625687;648.6432462145801;665.0788657709107;672.5359501943741;688.0161369241932;690.2372877969872;11303;11466.426678666034;11579.247348922294;11680.766384672259;12035.638930832089;538.760251687995;562.6792728144918;563.5913962377243;572.7079189613244;591.7514643849594;5023.648344615842;5095.515925987025;5116.130257856099;5162.915787684628;5287.286216360819;92938.53530732304;98762.0247595044;99803;103122;104127.4793626027;93672.53163734138;94073;94086.52956735172;96673.0332696664;97948;80375.59812201018;80608.19391806124;82363;84805.57597211974;86385.56807216049;9824;9964.551595178089;10185.949070254897;10241.43672098012;10301.690949271533;34483.82758086294;36326.818365908;36334;36706.63293367032;38331.42502862515;43354.56645433505;45094.32358514691;45362.77318613386;45617.77191114023;47018.529814702786;14396.35216415243;14546.41814327415;14654.85345146535;14687.485937992118;14728.337224824694;13927.234002129575;14031.929840350733;16580.336786528405;16610.169491525132;16768.161591920598;14662.853371466148;15261.542153735405;15399.538013859603;15800.683986319978;15816.288267027781;16791.992480451212;18942.905285473484;19399.3210237641;19560;19583.70624440663;18168.364107256184;18329;18840.246390144788;18949.242030318634;19148.71276930875;11152.49813758399;11572.24780389272;11613.709657258636;12055.69860753453;12679.492820287085;13518.391672374963;13547.187168769906;13652.180869147884;13680.452781888613;14029.508967186099 01:28:47 INFO - PID 26279 | __end_tp_report 01:28:47 INFO - PID 26279 | __start_cc_report 01:28:47 INFO - PID 26279 | _x_x_mozilla_cycle_collect,362 01:28:47 INFO - PID 26279 | __end_cc_report 01:28:47 INFO - PID 26279 | __startTimestamp1501230527288__endTimestamp 01:28:47 INFO - PID 26279 | 01:28:47 INFO - PID 26279 | ------- Summary: start ------- 01:28:47 INFO - PID 26279 | Number of tests: 6 01:28:47 INFO - PID 26279 | 01:28:47 INFO - PID 26279 | [#0] dojo.html Cycles:165 Average:6225.12 Median:6492.90 stddev:746.96 (11.5%) stddev-sans-first:708.24 01:28:47 INFO - PID 26279 | Values: 3113.3 3146.1 3153.7 3155.8 3199.9 6142.2 6160.3 6181.2 6196.1 6219.8 6334.0 6381.0 6399.9 6412.9 6428.3 5765.6 5838.1 5870.5 5871.9 5967.2 5645.6 5727.6 5813.2 5841.0 5856.0 5715.4 5715.9 5727.5 5738.1 5745.2 5752.2 5790.5 5811.2 5828.6 5829.6 5697.1 5745.7 5750.1 5783.5 5805.3 6122.3 6132.5 6211.4 6241.8 6305.7 6796.5 6800.6 6808.9 6814.8 6817.1 6822.0 6825.2 6827.2 6836.4 6846.3 6299.7 6302.6 6387.1 6394.1 6407.9 6868.3 6992.1 7001.1 7097.8 7100.4 6562.0 6602.1 6602.5 6617.4 6637.9 6688.3 6707.6 6713.2 6715.4 6729.7 6682.5 6691.0 6696.6 6700.2 6704.3 6420.0 6669.4 6712.2 6714.6 6836.0 5418.9 5429.9 5490.1 5505.2 5512.9 4615.5 4658.7 4689.1 4703.9 4725.1 5732.1 5740.1 5753.9 5756.1 5756.7 6838.2 6869.5 6876.6 6882.2 6892.3 5807.9 5833.2 5845.2 5848.3 5853.9 5942.0 5949.5 6006.9 6032.8 6037.7 6437.1 6550.7 6558.7 6636.3 6641.5 6736.1 6749.5 6829.0 6841.0 6870.1 6640.6 6642.2 6645.0 6651.7 6658.8 6295.7 6695.3 6720.5 6754.6 6780.3 6823.2 6830.1 6839.7 6940.1 6949.1 6501.6 6610.3 6625.2 6626.0 6633.5 6519.3 6537.3 6538.3 6569.7 6575.0 6485.8 6492.9 6503.3 6571.9 6581.5 6175.8 6599.2 6669.8 6672.5 6741.8 6456.2 6472.8 6509.6 6514.8 6520.1 01:28:47 INFO - PID 26279 | 01:28:47 INFO - PID 26279 | [#1] ext.html Cycles:180 Average:38819.12 Median:19876.59 stddev:55679.15 (280.1%) stddev-sans-first:55761.98 01:28:47 INFO - PID 26279 | Values: 753.8 811.6 864.5 885.5 891.4 41054.4 41832.4 42059.2 42107.8 42299.4 37686.8 38038.6 38194.4 38253.6 38346.6 6873.8 6960.2 6998.5 6999.0 7029.2 6840.5 6901.7 6916.3 6919.3 6949.3 6898.2 7644.0 7811.9 7820.5 7831.8 7745.9 7813.0 7816.4 7820.4 7822.3 7535.6 7702.2 7726.5 7788.9 7791.3 40598.2 40966.6 40989.2 41089.8 41111.0 3479.4 3508.9 3515.9 3520.0 3524.2 31500.4 31528.0 31568.1 31577.7 31593.0 4877.0 4896.0 4927.7 4935.8 5021.0 181330.1 181937.0 182572.0 183063.0 189582.1 49538.3 50062.0 50069.2 50108.5 50279.7 51642.0 51699.7 51817.0 51842.7 51983.0 16496.0 16782.3 16789.8 16812.5 16939.8 13977.1 13984.1 14019.4 14021.2 14035.5 14481.1 14551.2 14574.9 14698.0 14880.7 5979.5 6005.9 6009.9 6037.2 6105.8 937.0 973.1 981.4 1007.3 1021.6 22044.9 22231.2 22481.2 23030.4 23048.8 1047.8 1073.0 1082.1 1091.6 1096.8 12155.4 12355.4 12363.6 12385.0 12408.1 242857.0 243558.0 244404.0 244859.0 245421.0 52502.7 52893.7 53135.7 53178.7 53182.0 1429.9 1461.3 1494.8 1500.3 1520.8 21889.9 22052.8 22314.2 22935.5 23160.8 51519.7 52389.0 52869.5 53428.7 53580.2 209219.0 210931.0 211064.0 211459.0 211901.0 31515.5 32234.2 32410.0 33743.0 36229.0 44929.3 45162.8 45307.3 45634.5 46189.5 29719.7 31424.8 31875.0 31975.4 32262.5 30064.5 31725.4 31978.2 32076.8 32438.4 36453.3 39159.0 40292.4 40411.0 40522.0 31960.4 33658.7 33894.0 34480.0 34817.3 24744.1 25005.4 25049.5 25277.9 25419.2 01:28:47 INFO - PID 26279 | 01:28:47 INFO - PID 26279 | [#2] jquery.html Cycles:180 Average:34612.20 Median:23237.38 stddev:81652.26 (351.4%) stddev-sans-first:81841.32 01:28:47 INFO - PID 26279 | Values: 573.7 577.3 584.2 589.9 593.8 22202.6 22933.7 23014.0 23025.5 23044.9 23673.5 24757.3 25816.4 25830.7 25863.0 6469.3 6639.3 6644.4 6645.7 6651.0 6584.2 6644.0 6649.2 6655.8 6657.9 5839.2 6337.5 6376.4 6398.8 6584.0 6360.4 6379.1 6398.6 6405.5 6405.6 5945.7 5947.9 5950.3 5952.7 5973.9 24787.8 28231.0 28398.9 28620.9 28731.3 1794.2 1820.8 1821.0 1821.7 1828.3 19015.1 19331.2 19332.5 19346.0 19364.2 2267.2 2292.4 2358.0 2367.6 2372.6 128245.7 128603.0 131794.3 131979.3 132731.0 14351.9 14434.4 14578.1 14738.6 14827.6 23213.0 23218.0 23222.8 23309.3 23372.6 9395.6 9683.2 9846.2 9893.2 9908.3 8784.7 8796.6 8856.7 8872.3 8974.0 8711.7 8886.9 9060.0 9116.3 9345.0 2734.3 2757.9 2775.5 2828.4 2894.9 916.3 920.9 934.3 966.2 968.6 19238.9 19565.8 19677.0 19683.6 19795.9 981.4 1003.6 1007.8 1028.9 1035.8 10316.2 10438.6 10642.9 10927.8 11094.2 471539.0 473089.0 477544.0 496241.0 502611.0 118295.0 122283.0 124620.0 124917.0 125954.0 1261.8 1297.4 1298.6 1302.9 1320.5 19340.3 19918.9 20640.3 20902.9 21148.4 55057.2 55194.7 56466.4 57747.7 59553.4 65845.7 66669.3 66733.3 72984.0 76066.6 14598.4 14980.4 15040.8 15115.2 15300.2 18618.7 19674.1 23252.0 23930.8 24463.4 19484.4 19502.8 19540.8 19581.3 19594.2 16384.1 16714.8 16753.9 16789.5 16931.8 19000.0 20137.7 20169.9 20321.3 20363.4 14417.5 14483.4 14865.0 14886.6 14896.3 19512.3 19632.9 19637.8 19671.9 19739.6 01:28:47 INFO - PID 26279 | 01:28:47 INFO - PID 26279 | [#3] mootools.html Cycles:180 Average:8505.93 Median:2630.39 stddev:5852.07 (222.5%) stddev-sans-first:5843.58 01:28:47 INFO - PID 26279 | Values: 1320.6 1370.5 1388.7 1394.6 1396.7 13526.7 13926.3 14005.1 14016.8 14029.4 11799.8 12138.6 12151.3 13789.2 14152.9 2611.8 2649.7 2651.3 2651.7 2665.7 2534.8 2620.7 2640.1 2640.1 2672.3 2492.2 2598.9 2617.5 2663.0 2669.3 2678.5 2684.8 2704.6 2712.3 2714.4 2596.6 2615.1 2641.8 2644.6 2645.4 13716.0 13865.4 13866.1 13874.2 13877.9 6954.3 7571.5 7592.7 7596.7 7603.8 4879.0 5083.5 5120.9 5158.7 5161.3 1789.8 1797.8 1827.2 1884.7 1884.9 22315.6 22484.7 22529.4 22560.4 22617.5 6216.7 6337.4 6340.5 6379.1 6489.0 15789.8 15790.1 15795.7 15802.8 15810.8 7425.3 7496.4 7530.7 7534.3 7542.7 6799.8 6929.5 6955.7 6967.8 7030.9 5019.0 5179.4 5180.8 5209.2 5255.5 1500.8 1503.8 1512.8 1555.4 1558.4 714.9 816.2 834.2 877.4 890.6 7117.0 7200.2 7248.8 7320.8 7349.3 702.7 707.9 718.0 727.0 782.5 4360.0 4564.6 4597.6 4640.9 4669.6 18254.7 18259.2 19052.9 19098.1 19104.2 19020.0 19375.8 19386.6 19393.8 19447.1 10461.3 10777.9 10936.2 10937.1 10946.6 7096.8 7129.4 7419.3 7546.5 7851.2 16180.6 16556.3 16670.7 16839.0 16882.8 16906.2 17065.5 17184.6 17398.3 17493.0 11323.5 11589.7 11618.8 11632.1 11641.7 12903.1 13089.1 13170.5 13170.8 13251.9 9942.7 10128.9 10276.4 10391.6 10431.9 9695.0 10221.8 10223.2 10323.8 10504.3 9065.3 9125.5 9166.1 9170.0 9180.5 6491.3 6518.1 6692.0 6722.4 6839.0 6068.6 6544.6 6641.6 6642.9 6677.9 01:28:47 INFO - PID 26279 | 01:28:47 INFO - PID 26279 | [#4] prototype.html Cycles:180 Average:5507.71 Median:6087.91 stddev:1571.18 (25.8%) stddev-sans-first:1529.88 01:28:47 INFO - PID 26279 | Values: 495.3 500.4 514.4 516.2 520.3 6237.8 6284.7 6288.7 6291.1 6368.4 5992.3 6055.0 6068.3 6147.5 6164.0 4873.6 4896.2 4912.9 4921.9 4933.7 4885.2 4918.2 4933.1 4939.8 4983.7 4734.0 4845.8 4867.0 4882.4 4929.0 4832.3 4896.2 4914.3 4915.6 4922.3 4383.6 4391.5 4416.2 4420.0 4430.3 6013.1 6025.9 6051.7 6107.5 6107.5 5667.3 5668.4 5682.1 5706.6 5718.4 6566.2 6566.8 6590.7 6595.5 6613.9 4793.6 4795.9 4813.7 4833.2 4861.6 6821.1 6940.5 6952.3 6954.8 6986.0 4950.6 4963.7 4967.9 4987.6 4993.7 5009.0 5040.5 5066.5 5071.0 5074.9 5622.0 5632.5 5636.5 5660.2 5664.8 6441.2 6499.4 6529.6 6529.6 6583.3 1656.5 1693.8 1702.3 1703.7 1748.7 1178.9 1200.1 1210.5 1212.8 1216.7 5609.5 5653.9 5713.1 5713.6 5723.3 6589.0 6605.0 6645.2 6674.7 6681.7 5640.9 5732.7 5741.0 5747.5 5756.0 3515.3 3558.8 3562.3 3587.8 3622.6 6479.9 6522.3 6522.8 6612.7 6666.5 6891.1 6973.4 6976.6 6988.9 7016.2 6583.7 6616.5 6664.3 6675.2 6698.8 6691.5 6701.9 6785.2 6801.3 6819.0 6623.7 6691.7 6710.6 6766.0 6775.3 6591.7 6595.7 6614.8 6639.1 6688.5 4849.2 4896.1 4915.3 4970.7 4980.0 6741.2 6801.5 6812.9 6814.2 6831.5 6637.3 6651.7 6661.9 6672.6 6678.7 6432.5 6476.3 6485.4 6631.9 6687.0 6454.2 6487.8 6495.7 6542.7 6551.0 6270.9 6358.7 6538.3 6551.2 6653.9 6299.2 6403.8 6456.6 6462.0 6469.0 01:28:47 INFO - PID 26279 | 01:28:47 INFO - PID 26279 | [#5] yui.html Cycles:180 Average:21774.21 Median:19798.15 stddev:29661.83 (149.8%) stddev-sans-first:29703.63 01:28:47 INFO - PID 26279 | Values: 900.7 923.5 932.3 933.2 947.6 18348.6 19143.5 19161.4 19172.3 20716.5 19600.0 20547.9 20625.6 20658.2 20774.0 805.7 1043.4 1045.0 1045.2 1046.4 1043.3 1046.4 1049.3 1050.1 1060.6 1110.4 1113.2 1123.6 1124.3 1125.8 1107.7 1110.9 1111.4 1112.7 1113.5 822.2 822.6 825.1 825.2 826.9 18035.8 18524.5 18541.8 19996.3 20242.5 20292.7 20328.1 20649.3 20721.7 20957.6 14229.2 14666.5 14782.3 14862.8 14865.6 3430.9 3462.6 3467.6 3468.2 3477.3 115068.0 117531.4 118967.4 121233.0 122460.4 16355.0 16883.9 16900.5 16951.3 16964.5 28746.0 29704.7 29758.4 29784.4 29791.0 7446.0 8547.8 8687.5 8752.4 8755.1 3561.2 3650.9 4069.8 4196.9 4234.7 4908.3 5039.5 5076.1 5078.3 5092.9 973.2 1081.1 1090.7 1092.9 1099.5 648.6 665.1 672.5 688.0 690.2 11303.0 11466.4 11579.2 11680.8 12035.6 538.8 562.7 563.6 572.7 591.8 5023.6 5095.5 5116.1 5162.9 5287.3 92938.5 98762.0 99803.0 103122.0 104127.5 93672.5 94073.0 94086.5 96673.0 97948.0 80375.6 80608.2 82363.0 84805.6 86385.6 9824.0 9964.6 10185.9 10241.4 10301.7 34483.8 36326.8 36334.0 36706.6 38331.4 43354.6 45094.3 45362.8 45617.8 47018.5 14396.4 14546.4 14654.9 14687.5 14728.3 13927.2 14031.9 16580.3 16610.2 16768.2 14662.9 15261.5 15399.5 15800.7 15816.3 16792.0 18942.9 19399.3 19560.0 19583.7 18168.4 18329.0 18840.2 18949.2 19148.7 11152.5 11572.2 11613.7 12055.7 12679.5 13518.4 13547.2 13652.2 13680.5 14029.5 01:28:47 INFO - PID 26279 | -------- Summary: end -------- 01:28:47 INFO - PID 26279 | 01:28:47 INFO - TEST-INFO | 26279: exit 0 01:28:47 INFO - TEST-OK | dromaeo_css | took 1113927ms 01:28:47 INFO - TEST-START | kraken 01:28:47 INFO - Initialising browser for kraken test... 01:28:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56078/getInfo.html -profile /tmp/tmpmTZHE3/profile 01:28:48 INFO - TEST-INFO | started process 26655 (/builds/slave/test/build/application/firefox/firefox http://localhost:56078/getInfo.html) 01:28:53 INFO - TEST-INFO | 26655: exit 0 01:28:54 INFO - Browser initialized. 01:28:54 INFO - Running cycle 1/1 for kraken test... 01:28:54 INFO - TEST-INFO | started process 26881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTZHE3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:28:54 INFO - PID 26881 | 01:28:54 INFO - PID 26881 | (/builds/slave/test/build/application/firefox/firefox:26936): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 01:28:54 INFO - PID 26881 | 01:29:05 INFO - PID 26881 | RSS: Main: 173838336 01:29:05 INFO - PID 26881 | 01:29:08 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56078/tests/kraken/driver.html?testName=audio-beat-detection) 01:29:08 INFO - PID 26881 | RSS: Main: 178860032 01:29:08 INFO - PID 26881 | 01:29:11 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56078/tests/kraken/driver.html?testName=audio-dft) 01:29:12 INFO - PID 26881 | RSS: Main: 178929664 01:29:12 INFO - PID 26881 | 01:29:15 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56078/tests/kraken/driver.html?testName=audio-fft) 01:29:16 INFO - PID 26881 | RSS: Main: 174227456 01:29:16 INFO - PID 26881 | 01:29:18 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56078/tests/kraken/driver.html?testName=audio-oscillator) 01:29:18 INFO - PID 26881 | RSS: Main: 174411776 01:29:18 INFO - PID 26881 | 01:29:21 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56078/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:29:21 INFO - PID 26881 | RSS: Main: 174755840 01:29:21 INFO - PID 26881 | 01:29:24 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56078/tests/kraken/driver.html?testName=imaging-darkroom) 01:29:25 INFO - PID 26881 | RSS: Main: 177516544 01:29:25 INFO - PID 26881 | 01:29:29 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56078/tests/kraken/driver.html?testName=imaging-desaturate) 01:29:29 INFO - PID 26881 | RSS: Main: 176832512 01:29:29 INFO - PID 26881 | 01:29:32 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56078/tests/kraken/driver.html?testName=json-parse-financial) 01:29:33 INFO - PID 26881 | RSS: Main: 177737728 01:29:33 INFO - PID 26881 | 01:29:34 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56078/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:29:35 INFO - PID 26881 | RSS: Main: 177594368 01:29:35 INFO - PID 26881 | 01:29:37 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56078/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:29:38 INFO - PID 26881 | RSS: Main: 175054848 01:29:38 INFO - PID 26881 | 01:29:40 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56078/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:29:41 INFO - PID 26881 | RSS: Main: 175177728 01:29:41 INFO - PID 26881 | 01:29:43 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:29:44 INFO - PID 26881 | RSS: Main: 175857664 01:29:44 INFO - PID 26881 | 01:29:47 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:29:48 INFO - PID 26881 | RSS: Main: 175697920 01:29:48 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | Cycle 1(1): loaded http://localhost:56078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56078/tests/kraken/driver.html?testName=ai-astar) 01:29:50 INFO - PID 26881 | RSS: Main: 177057792 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | __start_tp_report 01:29:50 INFO - PID 26881 | _x_x_mozilla_page_load 01:29:50 INFO - PID 26881 | _x_x_mozilla_page_load_details 01:29:50 INFO - PID 26881 | |i|pagename|runs| 01:29:50 INFO - PID 26881 | |0;ai-astar;103;108;106;111;116;109;109;103;112;107 01:29:50 INFO - PID 26881 | |1;audio-beat-detection;160;127;143;195;119;151;144;118;180;120 01:29:50 INFO - PID 26881 | |2;audio-dft;163;162;163;167;173;169;171;163;165;167 01:29:50 INFO - PID 26881 | |3;audio-fft;76;81;77;179;76;87;74;76;179;77 01:29:50 INFO - PID 26881 | |4;audio-oscillator;82;79;124;79;80;80;132;80;80;131 01:29:50 INFO - PID 26881 | |5;imaging-gaussian-blur;113;121;114;116;114;114;121;122;115;114 01:29:50 INFO - PID 26881 | |6;imaging-darkroom;152;153;152;153;152;151;152;151;150;150 01:29:50 INFO - PID 26881 | |7;imaging-desaturate;94;93;93;94;96;95;96;94;98;95 01:29:50 INFO - PID 26881 | |8;json-parse-financial;56;58;64;58;56;56;57;57;57;57 01:29:50 INFO - PID 26881 | |9;json-stringify-tinderbox;54;60;61;58;55;54;56;57;54;53 01:29:50 INFO - PID 26881 | |10;stanford-crypto-aes;80;80;83;88;81;83;81;81;89;80 01:29:50 INFO - PID 26881 | |11;stanford-crypto-ccm;139;142;137;124;133;125;126;126;124;164 01:29:50 INFO - PID 26881 | |12;stanford-crypto-pbkdf2;185;190;189;189;184;181;176;177;173;178 01:29:50 INFO - PID 26881 | |13;stanford-crypto-sha256-iterative;73;78;72;69;70;75;72;68;72;70 01:29:50 INFO - PID 26881 | __end_tp_report 01:29:50 INFO - PID 26881 | __start_cc_report 01:29:50 INFO - PID 26881 | _x_x_mozilla_cycle_collect,949 01:29:50 INFO - PID 26881 | __end_cc_report 01:29:50 INFO - PID 26881 | __startTimestamp1501230590430__endTimestamp 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | ------- Summary: start ------- 01:29:50 INFO - PID 26881 | Number of tests: 14 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:4.01 (3.7%) stddev-sans-first:3.74 01:29:50 INFO - PID 26881 | Values: 103.0 108.0 106.0 111.0 116.0 109.0 109.0 103.0 112.0 107.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:147.50 stddev:26.54 (18.0%) stddev-sans-first:27.64 01:29:50 INFO - PID 26881 | Values: 160.0 127.0 143.0 195.0 119.0 151.0 144.0 118.0 180.0 120.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#2] audio-dft Cycles:10 Average:166.30 Median:167.00 stddev:3.77 (2.3%) stddev-sans-first:3.81 01:29:50 INFO - PID 26881 | Values: 163.0 162.0 163.0 167.0 173.0 169.0 171.0 163.0 165.0 167.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#3] audio-fft Cycles:10 Average:98.20 Median:76.50 stddev:42.74 (55.9%) stddev-sans-first:44.57 01:29:50 INFO - PID 26881 | Values: 76.0 81.0 77.0 179.0 76.0 87.0 74.0 76.0 179.0 77.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:80.00 stddev:23.77 (29.7%) stddev-sans-first:24.77 01:29:50 INFO - PID 26881 | Values: 82.0 79.0 124.0 79.0 80.0 80.0 132.0 80.0 80.0 131.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:115.50 stddev:3.50 (3.0%) stddev-sans-first:3.49 01:29:50 INFO - PID 26881 | Values: 113.0 121.0 114.0 116.0 114.0 114.0 121.0 122.0 115.0 114.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 01:29:50 INFO - PID 26881 | Values: 152.0 153.0 152.0 153.0 152.0 151.0 152.0 151.0 150.0 150.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:1.55 (1.6%) stddev-sans-first:1.62 01:29:50 INFO - PID 26881 | Values: 94.0 93.0 93.0 94.0 96.0 95.0 96.0 94.0 98.0 95.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:2.37 (4.2%) stddev-sans-first:2.44 01:29:50 INFO - PID 26881 | Values: 56.0 58.0 64.0 58.0 56.0 56.0 57.0 57.0 57.0 57.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.50 stddev:2.74 (4.9%) stddev-sans-first:2.79 01:29:50 INFO - PID 26881 | Values: 54.0 60.0 61.0 58.0 55.0 54.0 56.0 57.0 54.0 53.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:3.31 (4.0%) stddev-sans-first:3.37 01:29:50 INFO - PID 26881 | Values: 80.0 80.0 83.0 88.0 81.0 83.0 81.0 81.0 89.0 80.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:135.00 stddev:12.51 (9.3%) stddev-sans-first:13.13 01:29:50 INFO - PID 26881 | Values: 139.0 142.0 137.0 124.0 133.0 125.0 126.0 126.0 124.0 164.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:184.50 stddev:6.09 (3.3%) stddev-sans-first:6.37 01:29:50 INFO - PID 26881 | Values: 185.0 190.0 189.0 189.0 184.0 181.0 176.0 177.0 173.0 178.0 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:2.96 (4.1%) stddev-sans-first:3.11 01:29:50 INFO - PID 26881 | Values: 73.0 78.0 72.0 69.0 70.0 75.0 72.0 68.0 72.0 70.0 01:29:50 INFO - PID 26881 | -------- Summary: end -------- 01:29:50 INFO - PID 26881 | 01:29:50 INFO - PID 26881 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 01:29:51 INFO - TEST-INFO | 26881: exit 0 01:29:51 INFO - TEST-OK | kraken | took 63094ms 01:29:51 INFO - SUITE-END | took 1177s 01:29:51 INFO - Completed test suite (00:19:37) 01:29:51 INFO - javascript benchmark 01:29:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8373.869752457433, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.3461972985674, 3146.0719087869074, 3153.6530981592036, 3155.7633177511684, 3199.920001999951, 6142.1708069410615, 6160.291566469858, 6181.1964444622245, 6196.070589411591, 6219.7512099516025, 6334.018227174795, 6381.042843573467, 6399.872002559958, 6412.871742565146, 6428.2928877823515, 5765.596408251424, 5838.124281357809, 5870.501007414375, 5871.88256234875, 5967.16459695643, 5645.576581756384, 5727.57043221758, 5813.244278243822, 5840.970795146019, 5856.004479238519, 5715.371309155989, 5715.914261286063, 5727.541796656299, 5738.110592858114, 5745.166950792132, 5752.2234498342605, 5790.536757059425, 5811.244538210048, 5828.5628577856405, 5829.5919285650025, 5697.145428185764, 5745.741441635137, 5750.137479378085, 5783.537317014629, 5805.274340707411, 6122.326544080148, 6132.478739307165, 6211.378862113797, 6241.781537646206, 6305.716242769086, 6796.4562834973085, 6800.625965571891, 6808.8978665320055, 6814.761483348108, 6817.113775209241, 6822.0, 6825.1809782825885, 6827.180738311385, 6836.350546698056, 6846.315368463163, 6299.716512756937, 6302.55882088254, 6387.1377364055725, 6394.13679153313, 6407.871842563122, 6868.313168683092, 6992.0910281663055, 7001.054857594261, 7097.787066388017, 7100.3609675128455, 6562.0, 6602.075709400688, 6602.504812139109, 6617.371349721769, 6637.900431493435, 6688.33116688337, 6707.5975441473665, 6713.160854893138, 6715.429188518933, 6729.663516824139, 6682.5322227444585, 6690.966545167243, 6696.5647232929705, 6700.162479690039, 6704.296048914891, 6420.0, 6669.366410191024, 6712.228093769279, 6714.597124172566, 6835.965820170967, 5418.864528386743, 5429.918551221735, 5490.0941344677685, 5505.229267902497, 5512.862178445571, 4615.538446155358, 4658.67389282747, 4689.132510485571, 4703.929441058387, 4725.149473094876, 5732.140178973104, 5740.13897915316, 5753.913691294634, 5756.079027355687, 5756.7121643917635, 6838.247792742794, 6869.519133660596, 6876.621785801829, 6882.174139103239, 6892.310768923167, 5807.88384232313, 5833.241678581842, 5845.240118784531, 5848.327442344185, 5853.9414605854245, 5942.049272116527, 5949.494292985145, 6006.948783962789, 6032.819015429544, 6037.698115094227, 6437.130987316652, 6550.737970481127, 6558.672066396756, 6636.303188165173, 6641.535092543476, 6736.056952026622, 6749.493787965824, 6828.9658551706925, 6840.965795170992, 6870.106886104974, 6640.634765087773, 6642.202935647753, 6644.966775166094, 6651.667416629246, 6658.766943156967, 6295.716692748746, 6695.296993815774, 6720.529562930548, 6754.5947243165565, 6780.32196780318, 6823.215330237086, 6830.077939478107, 6839.6580170990255, 6940.063091482787, 6949.096617439903, 6501.609903405811, 6610.338966103352, 6625.17185351831, 6625.966870165618, 6633.535652504278, 6519.282878883224, 6537.28089910119, 6538.313477085027, 6569.737210511526, 6574.967125164344, 6485.805425837232, 6492.902606461002, 6503.284638689645, 6571.901421478778, 6581.539292249497, 6175.84560385994, 6599.175103112111, 6669.7665581704405, 6672.5329226953645, 6741.764038258638, 6456.160699109086, 6472.805815825533, 6509.576877502947, 6514.771982980573, 6520.119783829123], "value": 6168.062498271421, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.8002429356221, 811.5982588618627, 864.5417928497895, 885.4952676974124, 891.3537685178245, 41054.38418423722, 41832.37251441227, 42059.15881682365, 42107.78946105273, 42299.3655095173, 37686.811565942204, 38038.61961380385, 38194.42708359377, 38253.61746382535, 38346.616533834655, 6873.828154296145, 6960.234374218832, 6998.510104292702, 6999.0, 7029.191642961048, 6840.521163518531, 6901.689423975908, 6916.2737912519215, 6919.342662447059, 6949.339812717783, 6898.172219333687, 7643.961780191091, 7811.921880781177, 7820.45256832022, 7831.843363132734, 7745.922540774576, 7812.984312039427, 7816.41376896735, 7820.374370050411, 7822.335101516378, 7535.623218839091, 7702.191269916634, 7726.459147859652, 7788.922110778876, 7791.298783109491, 40598.18803623911, 40966.590334096574, 40989.180216395805, 41089.79455102735, 41111.0, 3479.356319080978, 3508.912277193065, 3515.9472607910648, 3519.996800911728, 3524.1718196223865, 31500.36999260025, 31528.0, 31568.052958411285, 31577.684223157703, 31593.0, 4877.0, 4896.02079584081, 4927.728974906378, 4935.7532123393685, 5020.974895125501, 181330.0933495324, 181937.0, 182572.0, 183063.0, 189582.05208974006, 49538.25692614614, 50062.0, 50069.24896126561, 50108.498915011114, 50279.74860125676, 51642.0, 51699.74150129225, 51817.0, 51842.74078629583, 51983.0, 16496.0, 16782.328706851833, 16789.832101679072, 16812.495625131265, 16939.830601694073, 13977.091489053179, 13984.091034082956, 14019.439222431192, 14021.158730476203, 14035.50875719345, 14481.131132131895, 14551.181102362205, 14574.854251457562, 14698.0, 14880.702385952436, 5979.491743201789, 6005.888910551562, 6009.939900601025, 6037.170263788951, 6105.839890420806, 936.990630093704, 973.1144658361, 981.3817295104038, 1007.2646967713611, 1021.5709402051157, 22044.908288991075, 22231.221907233168, 22481.213157539736, 23030.424239393815, 23048.76951230466, 1047.8218702820539, 1072.973175670599, 1082.1396989393452, 1091.5633746501305, 1096.8025755363951, 12155.392230388445, 12355.38223088842, 12363.567275145328, 12385.009199264037, 12408.069394795426, 242857.0, 243558.0, 244404.0, 244859.0, 245421.0, 52502.737486312326, 52893.7355313221, 53135.73432132815, 53178.73410632922, 53182.0, 1429.8570142985618, 1461.298576683198, 1494.8355680875095, 1500.3323521033035, 1520.7718842173542, 21889.890550547145, 22052.79814283892, 22314.21900233484, 22935.54128917379, 23160.768392315862, 51519.74240128775, 52389.0, 52869.471305287996, 53428.73285633547, 53580.196297056355, 209219.0, 210931.0, 211064.0, 211459.0, 211901.0, 31515.527267090554, 32234.194145146557, 32410.0, 33743.0, 36229.0, 44929.32606010978, 45162.77418613018, 45307.32039019484, 45634.54365456436, 46189.53810461852, 29719.702802971693, 31424.842875785474, 31875.0, 31975.36049278955, 32262.516062258615, 30064.549031764105, 31725.41372931298, 31978.20054498563, 32076.839615802706, 32438.35123297568, 36453.27093458169, 39159.0, 40292.39561406522, 40411.0, 40522.0, 31960.36079278448, 33658.663413366536, 33894.0, 34480.0, 34817.30365392729, 24744.133955311478, 25005.374865628506, 25049.499010020063, 25277.87361063183, 25419.237422876602], "value": 17407.84268944478, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.7418161827179, 577.2564916516391, 584.2288179602921, 589.9469047785699, 593.7506247376101, 22202.555948881032, 22933.655995160087, 23014.0, 23025.53948921025, 23044.88477557614, 23673.5265294694, 24757.257282281516, 25816.35459113523, 25830.74169258307, 25863.0, 6469.288378278397, 6639.302873198317, 6644.43522300605, 6645.734170633169, 6651.035599838021, 6584.176977877765, 6644.003399490091, 6649.202095748493, 6655.800325990203, 6657.900131498031, 5839.18251444796, 6337.493000559944, 6376.394242546974, 6398.840028999289, 6584.045313429549, 6360.395762402564, 6379.106925030453, 6398.616083035033, 6405.519586031066, 6405.583637063599, 5945.732442040118, 5947.851303717398, 5950.315713692938, 5952.7321270542925, 5973.910391344133, 24787.752122478905, 28231.0, 28398.858005710044, 28620.856895715595, 28731.28171795722, 1794.156746329223, 1820.827021432975, 1820.954476138094, 1821.662992346407, 1828.2869680824356, 19015.14431850556, 19331.226750930087, 19332.516687082796, 19346.0, 19364.225430982744, 2267.183813827021, 2292.4383526036063, 2357.9528409431887, 2367.633016882386, 2372.5966585680303, 128245.7175428243, 128603.0, 131794.3410282952, 131979.34010329886, 132731.0, 14351.928240358731, 14434.350454229585, 14578.125312481285, 14738.63153421173, 14827.629309267355, 23213.0, 23218.0, 23222.767772322397, 23309.300720978397, 23372.64941025886, 9395.57719902606, 9683.176929961031, 9846.212303015742, 9893.15908147801, 9908.306418550632, 8784.736457906272, 8796.560171991376, 8856.690015849543, 8872.33457490678, 8973.955130224307, 8711.651533938699, 8886.911130888608, 9059.954700226457, 9116.27069834425, 9344.990826972233, 2734.2754170144926, 2757.9172624821285, 2775.4881831942125, 2828.3918957424253, 2894.942101157965, 916.3448134583805, 920.8857282688023, 934.3086116273909, 966.2318456826839, 968.6319198704588, 19238.903805480884, 19565.804341956682, 19677.0, 19683.606327873364, 19795.901020494806, 981.3719219699398, 1003.5935446144323, 1007.7732510185297, 1028.881678606955, 1035.7876635289747, 10316.1747060235, 10438.63464778729, 10642.946785266024, 10927.836082458769, 11094.167937404565, 471539.0, 473089.0, 477544.0, 496241.0, 502611.0, 118295.0, 122283.0, 124620.0, 124917.0, 125954.0, 1261.8359613250218, 1297.4485843516468, 1298.6493646715523, 1302.9218246905027, 1320.5378117658934, 19340.323088692392, 19918.90040549788, 20640.27759028427, 20902.895485522477, 21148.365549033555, 55057.17414238709, 55194.72402638122, 56466.435335646114, 57747.71126144342, 59553.40446595479, 65845.67077164583, 66669.33330666825, 66733.33266667271, 72984.0, 76066.61966690353, 14598.416063357772, 14980.40078396852, 15040.774388383965, 15115.168665723491, 15300.15849128264, 18618.720719188954, 19674.11466483983, 23252.0, 23930.76069239355, 24463.38841528976, 19484.415467535997, 19502.8049719501, 19540.8045919539, 19581.314653987043, 19594.216231350587, 16384.098874562012, 16714.832851671326, 16753.91623041877, 16789.496315110566, 16931.830681693027, 19000.0, 20137.697934531287, 20169.899150504152, 20321.288754893507, 20363.389098326483, 14417.495387661802, 14483.420663173356, 14865.0, 14886.627834304229, 14896.255187240811, 19512.31706890252, 19632.90183549073, 19637.803621963598, 19671.901640492277, 19739.60520789605], "value": 11946.202358988427, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.5906169087582, 1370.4860677246033, 1388.6597783543027, 1394.630422937921, 1396.7346204221196, 13526.661833454169, 13926.30368481577, 14005.089669171497, 14016.78974815376, 14029.438822447102, 11799.823002654946, 12138.575149869755, 12151.331676757774, 13789.172649641003, 14152.92923535381, 2611.804114691401, 2649.695285042216, 2651.3106592285953, 2651.721569235222, 2665.7067722550505, 2534.771870531652, 2620.6724159480063, 2640.1155612869616, 2640.1287575100173, 2672.3319170207446, 2492.1775813981344, 2598.870056497177, 2617.463419998905, 2662.9733702663016, 2669.3326668332916, 2678.5312570300216, 2684.81206315558, 2704.580789977557, 2712.281245469962, 2714.4164004739077, 2596.6364708940764, 2615.1239334822667, 2641.7886569074426, 2644.6429731986127, 2645.378336091017, 13716.0, 13865.4453821847, 13866.098703584235, 13874.236916969563, 13877.861221387859, 6954.3045695430055, 7571.545707257582, 7592.696292148307, 7596.658150383246, 7603.771886843404, 4878.951210487885, 5083.517065878736, 5120.92318615221, 5158.664686795346, 5161.329027226437, 1789.7762779652544, 1797.811229820863, 1827.2051657528884, 1884.6701827180189, 1884.9057547122588, 22315.55368892629, 22484.662730059063, 22529.43676408103, 22560.435989100402, 22617.54764904709, 6216.689165541705, 6337.366263373626, 6340.461060809791, 6379.138816259746, 6488.967555162194, 15789.763153552705, 15790.131542765028, 15795.68408631821, 15802.762958555631, 15810.762838557432, 7425.331720145213, 7496.400287976949, 7530.6611202496015, 7534.321911028033, 7542.698292068366, 6799.762008329783, 6929.549579277331, 6955.6869940852785, 6967.79096627102, 7030.9296907030275, 5019.0, 5179.404368497596, 5180.818671346485, 5209.244659524347, 5255.47445255479, 1500.8199016117917, 1503.7518809396545, 1512.8260250071382, 1555.354527870921, 1558.3688606114542, 714.9249328820399, 816.2327412232482, 834.2241715204797, 877.4077497689034, 890.6081324217324, 7116.964415177995, 7200.243974382614, 7248.818779530448, 7320.816979575553, 7349.265073492608, 702.7434986230091, 707.8938159276149, 718.0270733156602, 726.9636518174176, 782.460102529253, 4359.9782001090425, 4564.6348292136545, 4597.586217240464, 4640.883977900512, 4669.649776266793, 18254.726179107325, 18259.178336974866, 19052.904735476233, 19098.14058367377, 19104.2358305669, 19020.0, 19375.8062419374, 19386.612267754565, 19393.806061939482, 19447.124879380463, 10461.3200141989, 10777.946110269399, 10936.234463587632, 10937.125029997582, 10946.562137514411, 7096.787096387116, 7129.3583577478275, 7419.258074192538, 7546.547207167588, 7851.2148785121035, 16180.595485112966, 16556.254968526206, 16670.666586667958, 16839.0, 16882.831171688616, 16906.154692265583, 17065.488035358958, 17184.570385740455, 17398.304067837144, 17493.0, 11323.547058117912, 11589.6523104307, 11618.825717614412, 11632.12759043092, 11641.6507504775, 12903.096783225084, 13089.149205301625, 13170.47318107265, 13170.802437963246, 13251.86748132545, 9942.652007179713, 10128.898711013091, 10276.434796085989, 10391.636292729718, 10431.895681043092, 9695.0, 10221.795564088825, 10223.233257505866, 10323.845142323022, 10504.317219380715, 9065.320100992583, 9125.5437228137, 9166.129217724305, 9169.954150229207, 9180.540972951192, 6491.253505846699, 6518.087467754613, 6691.966540167268, 6722.428593569602, 6839.0, 6068.605540639845, 6544.640044797582, 6641.634710090992, 6642.933570664231, 6677.899831502628], "value": 6175.981150601435, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.3230453486994, 500.44213819976864, 514.3647595219905, 516.2024671881942, 520.287206527058, 6237.844053898649, 6284.685765711708, 6288.717007734657, 6291.112666200144, 6368.395002474757, 5992.280926288851, 6055.0, 6068.33248342682, 6147.46520750568, 6164.013757798753, 4873.634477414191, 4896.2410826321975, 4912.877178070541, 4921.926171107419, 4933.679310844802, 4885.242787367946, 4918.237548275572, 4933.136701077297, 4939.753012349386, 4983.700977941317, 4734.011715079675, 4845.830395936143, 4867.0, 4882.414110306768, 4928.98287895366, 4832.251001094836, 4896.216605343128, 4914.287428322891, 4915.606751459911, 4922.310876477296, 4383.583559561836, 4391.5169331373845, 4416.183006143874, 4419.977900110511, 4430.31330143825, 6013.098035294697, 6025.855087533399, 6051.727672254759, 6107.4808641265545, 6107.511399088106, 5667.263255776764, 5668.384510414512, 5682.147677848315, 5706.629069110494, 5718.370979192286, 6566.244881838602, 6566.770163044318, 6590.670466476705, 6595.505337099737, 6613.93386066138, 4793.63381436289, 4795.856124316276, 4813.735244561548, 4833.2266837306215, 4861.611071114302, 6821.055999040299, 6940.514164008521, 6952.270011648755, 6954.791356259269, 6986.021956926034, 4950.5544500994365, 4963.677360971526, 4967.925481117786, 4987.60099192071, 4993.650444468925, 5009.0, 5040.546350828443, 5066.493350664904, 5071.0, 5074.949250507521, 5621.971890140523, 5632.52123569493, 5636.549076073904, 5660.235868157746, 5664.819044667833, 6441.162648855712, 6499.350064993463, 6529.575577587537, 6529.596136830604, 6583.308752581006, 1656.4947690954134, 1693.8390852868959, 1702.3105642214923, 1703.7274036154156, 1748.7409065473094, 1178.9174757767046, 1200.0699457920007, 1210.4794938176492, 1212.8302037714727, 1216.6958260434892, 5609.467100625434, 5653.886922261532, 5713.143028545752, 5713.571482138773, 5723.313202415737, 6588.96705516479, 6604.966975165094, 6645.235797883209, 6674.666266686743, 6681.732730690718, 5640.915386269209, 5732.71336433185, 5740.971295143498, 5747.511461525817, 5756.0, 3515.2793677296095, 3558.822058897045, 3562.340966921128, 3587.8385472653795, 3622.587190995514, 6479.870402591921, 6522.315156908551, 6522.836929076716, 6612.677464507118, 6666.533382648451, 6891.071294699733, 6973.4072603829245, 6976.5814051157095, 6988.930110698828, 7016.19313778922, 6583.703733332011, 6616.536842420985, 6664.266930637626, 6675.23234828001, 6698.799036028927, 6691.5315927884585, 6701.865962680817, 6785.1518560179975, 6801.319868013159, 6819.0, 6623.735050597922, 6691.698873550605, 6710.6309152997055, 6766.0, 6775.288594697486, 6591.736330546916, 6595.736170553124, 6614.750984665045, 6639.074668346126, 6688.531802773759, 4849.248366503198, 4896.069746748107, 4915.26271059344, 4970.65205435616, 4979.950200497949, 6741.224914048149, 6801.489888258499, 6812.8978065328065, 6814.2163651180745, 6831.521793474409, 6637.2699003108655, 6651.73393064272, 6661.866762664623, 6672.59964402118, 6678.699458524281, 6432.517561182836, 6476.287608362982, 6485.383888530582, 6631.900521492085, 6686.99085411557, 6454.19322584677, 6487.772927947499, 6495.707693153725, 6542.672866356758, 6551.0173473979285, 6270.9372906270355, 6358.713857876314, 6538.313477085027, 6551.167566973374, 6653.933460665525, 6299.244090709144, 6403.815294170593, 6456.644884531396, 6462.0, 6469.0], "value": 5042.639912914263, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.7477906186266, 923.4551614547415, 932.3380399916059, 933.1834644685899, 947.5877993073011, 18348.633027339445, 19143.521411964706, 19161.42515724527, 19172.328968486105, 20716.48208794781, 19600.0, 20547.897260513677, 20625.587488250225, 20658.17367305306, 20774.0, 805.7059173401695, 1043.3583346242083, 1044.9634262800803, 1045.1534257251612, 1046.4140081554315, 1043.2697112021576, 1046.398320965444, 1049.3127001813825, 1050.10216265093, 1060.6075751971744, 1110.4336788237977, 1113.2263077161376, 1123.606737641827, 1124.274842726441, 1125.7917285302244, 1107.6898468428813, 1110.8944650258213, 1111.372074777748, 1112.6606385052555, 1113.5378817790647, 822.1655020154548, 822.5887056471764, 825.1212458731432, 825.1707034430419, 826.8553003224472, 18035.819641803544, 18524.536886577807, 18541.814581854145, 19996.300129495397, 20242.49393765153, 20292.695609565868, 20328.085236164407, 20649.27727529529, 20721.68917466239, 20957.5808483831, 14229.217393043378, 14666.486672966501, 14782.334794934253, 14862.777058344134, 14865.554033379016, 3430.9142271443416, 3462.567179102612, 3467.6358982306747, 3468.150303175713, 3477.3219222251673, 115068.0, 117531.4123429386, 118967.4051629745, 121233.0, 122460.38769806184, 16355.0, 16883.91558042202, 16900.492985210465, 16951.321947122222, 16964.491065268063, 28746.0, 29704.702952970627, 29758.404831903674, 29784.40431191364, 29791.0, 7445.9627701861145, 8547.82904341922, 8687.52218627969, 8752.431091979, 8755.124487551195, 3561.198730285665, 3650.908727281786, 4069.8168582413864, 4196.853110141131, 4234.724742891703, 4908.2637604358915, 5039.521245481674, 5076.13705670037, 5078.263651770472, 5092.898142037138, 973.2311473935512, 1081.086481922774, 1090.6564432203832, 1092.9344239345664, 1099.4502748625687, 648.6432462145801, 665.0788657709107, 672.5359501943741, 688.0161369241932, 690.2372877969872, 11303.0, 11466.426678666034, 11579.247348922294, 11680.766384672259, 12035.638930832089, 538.760251687995, 562.6792728144918, 563.5913962377243, 572.7079189613244, 591.7514643849594, 5023.648344615842, 5095.515925987025, 5116.130257856099, 5162.915787684628, 5287.286216360819, 92938.53530732304, 98762.0247595044, 99803.0, 103122.0, 104127.4793626027, 93672.53163734138, 94073.0, 94086.52956735172, 96673.0332696664, 97948.0, 80375.59812201018, 80608.19391806124, 82363.0, 84805.57597211974, 86385.56807216049, 9824.0, 9964.551595178089, 10185.949070254897, 10241.43672098012, 10301.690949271533, 34483.82758086294, 36326.818365908, 36334.0, 36706.63293367032, 38331.42502862515, 43354.56645433505, 45094.32358514691, 45362.77318613386, 45617.77191114023, 47018.529814702786, 14396.35216415243, 14546.41814327415, 14654.85345146535, 14687.485937992118, 14728.337224824694, 13927.234002129575, 14031.929840350733, 16580.336786528405, 16610.169491525132, 16768.161591920598, 14662.853371466148, 15261.542153735405, 15399.538013859603, 15800.683986319978, 15816.288267027781, 16791.992480451212, 18942.905285473484, 19399.3210237641, 19560.0, 19583.70624440663, 18168.364107256184, 18329.0, 18840.246390144788, 18949.242030318634, 19148.71276930875, 11152.49813758399, 11572.24780389272, 11613.709657258636, 12055.69860753453, 12679.492820287085, 13518.391672374963, 13547.187168769906, 13652.180869147884, 13680.452781888613, 14029.508967186099], "value": 8630.628286171948, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1560.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 108.0, 106.0, 111.0, 116.0, 109.0, 109.0, 103.0, 112.0, 107.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 127.0, 143.0, 195.0, 119.0, 151.0, 144.0, 118.0, 180.0, 120.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 167.0, 173.0, 169.0, 171.0, 163.0, 165.0, 167.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 77.0, 179.0, 76.0, 87.0, 74.0, 76.0, 179.0, 77.0], "value": 98.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 124.0, 79.0, 80.0, 80.0, 132.0, 80.0, 80.0, 131.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 121.0, 114.0, 116.0, 114.0, 114.0, 121.0, 122.0, 115.0, 114.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 152.0, 153.0, 152.0, 151.0, 152.0, 151.0, 150.0, 150.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 96.0, 95.0, 96.0, 94.0, 98.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 64.0, 58.0, 56.0, 56.0, 57.0, 57.0, 57.0, 57.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 61.0, 58.0, 55.0, 54.0, 56.0, 57.0, 54.0, 53.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 83.0, 88.0, 81.0, 83.0, 81.0, 81.0, 89.0, 80.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 137.0, 124.0, 133.0, 125.0, 126.0, 126.0, 124.0, 164.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 190.0, 189.0, 189.0, 184.0, 181.0, 176.0, 177.0, 173.0, 178.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 72.0, 69.0, 70.0, 75.0, 72.0, 68.0, 72.0, 70.0], "value": 71.9, "unit": "score"}]}]} 01:29:51 INFO - Return code: 0 01:29:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:29:51 INFO - # TBPL SUCCESS # 01:29:51 INFO - Running post-action listener: _package_coverage_data 01:29:51 INFO - Running post-action listener: _resource_record_post_action 01:29:51 INFO - [mozharness: 2017-07-28 08:29:51.736001Z] Finished run-tests step (success) 01:29:51 INFO - Running post-run listener: _resource_record_post_run 01:29:51 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432189440; Read time: 8; Write time: 331236 01:29:51 INFO - TinderboxPrint: CPU usage
13.1% 01:29:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 01:29:51 INFO - TinderboxPrint: I/O write bytes / time
432,189,440 / 331,236 01:29:51 INFO - TinderboxPrint: CPU idle
8,280.5 (86.8%) 01:29:51 INFO - TinderboxPrint: CPU user
1,204.2 (12.6%) 01:29:51 INFO - TinderboxPrint: Swap in / out
0 / 0 01:29:51 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106926080; Read time: 0; Write time: 105316 01:29:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 01:29:51 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 324141056; Read time: 0; Write time: 225884 01:29:52 INFO - Running post-run listener: _upload_blobber_files 01:29:52 INFO - Blob upload gear active. 01:29:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:29:52 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 01:29:52 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'] 01:29:52 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 01:29:52 INFO - (blobuploader) - INFO - Open directory for files ... 01:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:29:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:53 INFO - (blobuploader) - INFO - Done attempting. 01:29:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:29:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:29:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:54 INFO - (blobuploader) - INFO - Done attempting. 01:29:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:29:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:30:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:00 INFO - (blobuploader) - INFO - Done attempting. 01:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:30:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:00 INFO - (blobuploader) - INFO - Done attempting. 01:30:00 INFO - (blobuploader) - INFO - Iteration through files over. 01:30:00 INFO - Return code: 0 01:30:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:30:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:30:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c2be690f4d122e7d62418997024fad213d8ed8a1083ac14ab82d86550d5a3de2ba20515369cbf1774b9a41d4bdf4781f4a707e1d7e6ff1efa6d52b485b73904", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d19e1145ea64daa1d86a09554c03d9aa1f92035518be7757d3d038960d4a3721806ae1dcd0e1871b71b4eac2b2e457e9ad389bf16e21b6fc67ec9dbb9954ead", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec0e8a3b31bf009b96fa7b9b205bf02b8204b3767f9150735d0a4d917f6d02347797a3a28bedab5647178cba08066da337b5691551a9daf03f7ca732526a405", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/216c39f6a4b905371b82e0d46f34eadd93e79119fe5f33301b8556e6d50907ab92f861991af7398bd73c313b0bc277a110090638d72e56a8a2e5997fb174f56b"} 01:30:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:30:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:30:00 INFO - Contents: 01:30:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c2be690f4d122e7d62418997024fad213d8ed8a1083ac14ab82d86550d5a3de2ba20515369cbf1774b9a41d4bdf4781f4a707e1d7e6ff1efa6d52b485b73904", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d19e1145ea64daa1d86a09554c03d9aa1f92035518be7757d3d038960d4a3721806ae1dcd0e1871b71b4eac2b2e457e9ad389bf16e21b6fc67ec9dbb9954ead", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec0e8a3b31bf009b96fa7b9b205bf02b8204b3767f9150735d0a4d917f6d02347797a3a28bedab5647178cba08066da337b5691551a9daf03f7ca732526a405", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/216c39f6a4b905371b82e0d46f34eadd93e79119fe5f33301b8556e6d50907ab92f861991af7398bd73c313b0bc277a110090638d72e56a8a2e5997fb174f56b"} 01:30:00 INFO - Running post-run listener: copy_logs_to_upload_dir 01:30:00 INFO - Copying logs to upload dir... 01:30:00 INFO - mkdir: /builds/slave/test/build/upload/logs 01:30:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.845762 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-28 01:30:00.821778) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 01:30:00.826473) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c2be690f4d122e7d62418997024fad213d8ed8a1083ac14ab82d86550d5a3de2ba20515369cbf1774b9a41d4bdf4781f4a707e1d7e6ff1efa6d52b485b73904", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d19e1145ea64daa1d86a09554c03d9aa1f92035518be7757d3d038960d4a3721806ae1dcd0e1871b71b4eac2b2e457e9ad389bf16e21b6fc67ec9dbb9954ead", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec0e8a3b31bf009b96fa7b9b205bf02b8204b3767f9150735d0a4d917f6d02347797a3a28bedab5647178cba08066da337b5691551a9daf03f7ca732526a405", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/216c39f6a4b905371b82e0d46f34eadd93e79119fe5f33301b8556e6d50907ab92f861991af7398bd73c313b0bc277a110090638d72e56a8a2e5997fb174f56b"} build_url:https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011131 build_url: 'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c2be690f4d122e7d62418997024fad213d8ed8a1083ac14ab82d86550d5a3de2ba20515369cbf1774b9a41d4bdf4781f4a707e1d7e6ff1efa6d52b485b73904", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d19e1145ea64daa1d86a09554c03d9aa1f92035518be7757d3d038960d4a3721806ae1dcd0e1871b71b4eac2b2e457e9ad389bf16e21b6fc67ec9dbb9954ead", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec0e8a3b31bf009b96fa7b9b205bf02b8204b3767f9150735d0a4d917f6d02347797a3a28bedab5647178cba08066da337b5691551a9daf03f7ca732526a405", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/216c39f6a4b905371b82e0d46f34eadd93e79119fe5f33301b8556e6d50907ab92f861991af7398bd73c313b0bc277a110090638d72e56a8a2e5997fb174f56b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 01:30:00.853976) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:30:00.854321) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1501223560.580237-1145450498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:30:00.940507) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 01:30:00.940836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 01:30:00.941176) ========= ========= Total master_lag: 0.23 =========