builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1500724352.47 results: success (0) revision: 7ce557b85b611536b69539a7c18d4834ffc92eea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:32.474972) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:32.475475) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:32.475809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:32.504055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:32.504369) ========= 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=14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-22 04:52:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-07-22 04:52:32 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131155 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:32.649414) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:32.649788) ========= 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=14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017019 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:32.700814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:32.701170) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7ce557b85b611536b69539a7c18d4834ffc92eea --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 7ce557b85b611536b69539a7c18d4834ffc92eea --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=14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-22 04:52:32,721 truncating revision to first 12 chars 2017-07-22 04:52:32,722 Setting DEBUG logging. 2017-07-22 04:52:32,722 attempt 1/10 2017-07-22 04:52:32,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7ce557b85b61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-22 04:52:33,324 unpacking tar archive at: mozilla-central-7ce557b85b61/testing/mozharness/ program finished with exit code 0 elapsedTime=0.939283 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:33.655836) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:33.656252) ========= script_repo_revision: 7ce557b85b611536b69539a7c18d4834ffc92eea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:33.656714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:33.657086) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:33.666197) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-07-22 04:52:33.666557) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:52:33 INFO - MultiFileLogger online at 20170722 04:52:33 in /builds/slave/test 04:52:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:52:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:33 INFO - {'append_to_log': False, 04:52:33 INFO - 'base_work_dir': '/builds/slave/test', 04:52:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:52:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:33 INFO - 'branch': 'Firefox-Non-PGO', 04:52:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:33 INFO - 'code_coverage': False, 04:52:33 INFO - 'config_files': ('talos/linux_config.py',), 04:52:33 INFO - 'default_actions': ('clobber', 04:52:33 INFO - 'read-buildbot-config', 04:52:33 INFO - 'download-and-extract', 04:52:33 INFO - 'populate-webroot', 04:52:33 INFO - 'create-virtualenv', 04:52:33 INFO - 'install', 04:52:33 INFO - 'setup-mitmproxy', 04:52:33 INFO - 'run-tests'), 04:52:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:33 INFO - 'disable_ccov_upload': False, 04:52:33 INFO - 'download_minidump_stackwalk': True, 04:52:33 INFO - 'download_symbols': 'ondemand', 04:52:33 INFO - 'enable_stylo': False, 04:52:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:33 INFO - 'gecko_profile': False, 04:52:33 INFO - 'gecko_profile_interval': 0, 04:52:33 INFO - 'installer_path': 'installer.exe', 04:52:33 INFO - 'log_level': 'info', 04:52:33 INFO - 'log_name': 'talos', 04:52:33 INFO - 'log_to_console': True, 04:52:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:52:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:52:33 INFO - 'opt_config_files': (), 04:52:33 INFO - 'pip_index': False, 04:52:33 INFO - 'suite': 'dromaeojs-e10s', 04:52:33 INFO - 'system_bits': '32', 04:52:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:33 INFO - 'title': 'talos-linux64-ix-036', 04:52:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:33 INFO - 'use_talos_json': True, 04:52:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:33 INFO - 'work_dir': 'build'} 04:52:33 INFO - [mozharness: 2017-07-22 11:52:33.793723Z] Running clobber step. 04:52:33 INFO - Running pre-action listener: _resource_record_pre_action 04:52:33 INFO - Running main action method: clobber 04:52:33 INFO - rmtree: /builds/slave/test/build 04:52:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:34 INFO - Running post-action listener: _resource_record_post_action 04:52:34 INFO - [mozharness: 2017-07-22 11:52:34.823745Z] Finished clobber step (success) 04:52:34 INFO - [mozharness: 2017-07-22 11:52:34.823848Z] Running read-buildbot-config step. 04:52:34 INFO - Running pre-action listener: _resource_record_pre_action 04:52:34 INFO - Running main action method: read_buildbot_config 04:52:34 INFO - Using buildbot properties: 04:52:34 INFO - { 04:52:34 INFO - "project": "", 04:52:34 INFO - "product": "firefox", 04:52:34 INFO - "who": "archaeopteryx@coole-files.de", 04:52:34 INFO - "installer_path": "public/build/target.tar.bz2", 04:52:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:52:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:52:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:52:34 INFO - "stage_platform": "linux64", 04:52:34 INFO - "basedir": "/builds/slave/test", 04:52:34 INFO - "buildnumber": 1028, 04:52:34 INFO - "platform": "ubuntu64_hw", 04:52:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:52:34 INFO - "slavebuilddir": "test", 04:52:34 INFO - "taskId": "THqx9lvoQ_-rHp_XWqUIDA", 04:52:34 INFO - "branch": "mozilla-central", 04:52:34 INFO - "script_repo_revision": "production", 04:52:34 INFO - "revision": "7ce557b85b611536b69539a7c18d4834ffc92eea", 04:52:34 INFO - "slavename": "talos-linux64-ix-036", 04:52:34 INFO - "repo_path": "mozilla-central" 04:52:34 INFO - } 04:52:34 INFO - Finding installer, test and symbols from parent task. 04:52:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THqx9lvoQ_-rHp_XWqUIDA'}, attempt #1 04:52:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THqx9lvoQ_-rHp_XWqUIDA'}, attempt #1 04:52:35 INFO - Task dependencies: XkiOXKQhR4m2VKusltKq-Q 04:52:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q'}, attempt #1 04:52:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2 04:52:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/test_packages.json 04:52:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.crashreporter-symbols.zip 04:52:36 INFO - Running post-action listener: _resource_record_post_action 04:52:36 INFO - [mozharness: 2017-07-22 11:52:36.165330Z] Finished read-buildbot-config step (success) 04:52:36 INFO - [mozharness: 2017-07-22 11:52:36.165556Z] Running download-and-extract step. 04:52:36 INFO - Running pre-action listener: _resource_record_pre_action 04:52:36 INFO - Running main action method: download_and_extract 04:52:36 INFO - mkdir: /builds/slave/test/build/tests 04:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:36 INFO - trying https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.test_packages.json 04:52:36 INFO - Downloading https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:52:36 INFO - Downloaded 989 bytes. 04:52:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:52:36 INFO - Using the following test package requirements: 04:52:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:52:36 INFO - u'common': [u'target.common.tests.zip'], 04:52:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:52:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:52:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:52:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:52:36 INFO - u'mozbase': [u'target.common.tests.zip'], 04:52:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:52:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:52:36 INFO - u'web-platform': [u'target.common.tests.zip', 04:52:36 INFO - u'target.web-platform.tests.tar.gz'], 04:52:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:52:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:52:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.common.tests.zip 04:52:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:52:36 INFO - Fetch https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.common.tests.zip into memory 04:52:37 INFO - Content-Length response header: 72760941 04:52:37 INFO - Bytes received: 72760941 04:52:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:52:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.common.tests.zip 04:52:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:52:49 INFO - Fetch https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.common.tests.zip into memory 04:52:50 INFO - Content-Length response header: 72760941 04:52:50 INFO - Bytes received: 72760941 04:53:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.talos.tests.zip 04:53:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:53:03 INFO - Fetch https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.talos.tests.zip into memory 04:53:04 INFO - Content-Length response header: 14498826 04:53:04 INFO - Bytes received: 14498826 04:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:04 INFO - trying https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2 04:53:04 INFO - Downloading https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:53:05 INFO - Downloaded 62028878 bytes. 04:53:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2 04:53:05 INFO - mkdir: /builds/slave/test/properties 04:53:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:05 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:05 INFO - Contents: 04:53:05 INFO - build_url:https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2 04:53:05 INFO - Running post-action listener: _resource_record_post_action 04:53:05 INFO - Running post-action listener: set_extra_try_arguments 04:53:05 INFO - [mozharness: 2017-07-22 11:53:05.721154Z] Finished download-and-extract step (success) 04:53:05 INFO - [mozharness: 2017-07-22 11:53:05.721272Z] Running populate-webroot step. 04:53:05 INFO - Running pre-action listener: _resource_record_pre_action 04:53:05 INFO - Running main action method: populate_webroot 04:53:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:53:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:53:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:53:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:53:05 INFO - 'tests': ['damp', 'tps']}, 04:53:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:53:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:53:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:53:05 INFO - 'other-e10s': {'tests': ['a11yr', 04:53:05 INFO - 'ts_paint', 04:53:05 INFO - 'tpaint', 04:53:05 INFO - 'sessionrestore', 04:53:05 INFO - 'sessionrestore_many_windows', 04:53:05 INFO - 'sessionrestore_no_auto_restore', 04:53:05 INFO - 'tabpaint']}, 04:53:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:53:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:53:05 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:53:05 INFO - 'talos_options': ['--mitmproxy', 04:53:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:53:05 INFO - '--firstNonBlankPaint'], 04:53:05 INFO - 'tests': ['quantum_pageload_google', 04:53:05 INFO - 'quantum_pageload_youtube', 04:53:05 INFO - 'quantum_pageload_amazon', 04:53:05 INFO - 'quantum_pageload_facebook']}, 04:53:05 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:53:05 INFO - 'talos_options': ['--stylo', 04:53:05 INFO - '--mitmproxy', 04:53:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:53:05 INFO - '--firstNonBlankPaint'], 04:53:05 INFO - 'tests': ['quantum_pageload_google', 04:53:05 INFO - 'quantum_pageload_youtube', 04:53:05 INFO - 'quantum_pageload_amazon', 04:53:05 INFO - 'quantum_pageload_facebook']}, 04:53:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:53:05 INFO - 'tsvgr_opacity', 04:53:05 INFO - 'tart', 04:53:05 INFO - 'tscrollx', 04:53:05 INFO - 'cart', 04:53:05 INFO - 'tsvg_static']}, 04:53:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:53:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:53:05 INFO - 'talos_options': ['--xperf_path', 04:53:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:05 INFO - 'tests': ['tp5n']}}} 04:53:05 INFO - Running post-action listener: _resource_record_post_action 04:53:05 INFO - [mozharness: 2017-07-22 11:53:05.728574Z] Finished populate-webroot step (success) 04:53:05 INFO - [mozharness: 2017-07-22 11:53:05.728666Z] Running create-virtualenv step. 04:53:05 INFO - Running pre-action listener: _resource_record_pre_action 04:53:05 INFO - Running main action method: create_virtualenv 04:53:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:05 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 04:53:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:53:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:05 INFO - Using real prefix '/usr' 04:53:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:08 INFO - Installing pip.................done. 04:53:08 INFO - Return code: 0 04:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:53:08 INFO - Reading from file tmpfile_stdout 04:53:08 INFO - Output received: 04:53:08 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) 04:53:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:08 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 0xc5e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfced10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcbeb0>, '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 0xfccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcd240>, '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': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', '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 04:53:08 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 04:53:08 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 04:53:08 INFO - Using env: {'DISPLAY': ':0', 04:53:08 INFO - 'HOME': '/home/cltbld', 04:53:08 INFO - 'LANG': 'en_US.UTF-8', 04:53:08 INFO - 'LANGUAGE': 'en_US:en', 04:53:08 INFO - 'LOGNAME': 'cltbld', 04:53:08 INFO - 'MAIL': '/var/mail/cltbld', 04:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:08 INFO - 'MOZ_NO_REMOTE': '1', 04:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:08 INFO - 'NO_EM_RESTART': '1', 04:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:08 INFO - 'PWD': '/builds/slave/test', 04:53:08 INFO - 'SHELL': '/bin/bash', 04:53:08 INFO - 'SHLVL': '1', 04:53:08 INFO - 'TERM': 'linux', 04:53:08 INFO - 'TMOUT': '86400', 04:53:08 INFO - 'USER': 'cltbld', 04:53:08 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', 04:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:08 INFO - '_': '/tools/buildbot/bin/python'} 04:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:08 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 04:53:08 INFO - Cleaning up... 04:53:08 INFO - Return code: 0 04:53:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:08 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 0xc5e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfced10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcbeb0>, '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 0xfccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcd240>, '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': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', '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 04:53:08 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 04:53:08 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 04:53:08 INFO - Using env: {'DISPLAY': ':0', 04:53:08 INFO - 'HOME': '/home/cltbld', 04:53:08 INFO - 'LANG': 'en_US.UTF-8', 04:53:08 INFO - 'LANGUAGE': 'en_US:en', 04:53:08 INFO - 'LOGNAME': 'cltbld', 04:53:08 INFO - 'MAIL': '/var/mail/cltbld', 04:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:08 INFO - 'MOZ_NO_REMOTE': '1', 04:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:08 INFO - 'NO_EM_RESTART': '1', 04:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:08 INFO - 'PWD': '/builds/slave/test', 04:53:08 INFO - 'SHELL': '/bin/bash', 04:53:08 INFO - 'SHLVL': '1', 04:53:08 INFO - 'TERM': 'linux', 04:53:08 INFO - 'TMOUT': '86400', 04:53:08 INFO - 'USER': 'cltbld', 04:53:08 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', 04:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:08 INFO - '_': '/tools/buildbot/bin/python'} 04:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:09 INFO - Downloading/unpacking psutil>=3.1.1 04:53:09 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 04:53:09 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 04:53:09 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 04:53:09 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 04:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:12 INFO - Installing collected packages: psutil 04:53:12 INFO - Running setup.py install for psutil 04:53:12 INFO - building 'psutil._psutil_linux' extension 04:53:12 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 04:53:12 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 04:53:12 INFO - building 'psutil._psutil_posix' extension 04:53:12 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 04:53:12 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 04:53:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:13 INFO - Successfully installed psutil 04:53:13 INFO - Cleaning up... 04:53:13 INFO - Return code: 0 04:53:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53: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')]} 04:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:13 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 0xc5e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfced10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcbeb0>, '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 0xfccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcd240>, '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': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', '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 04:53:13 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 04:53:13 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 04:53:13 INFO - Using env: {'DISPLAY': ':0', 04:53:13 INFO - 'HOME': '/home/cltbld', 04:53:13 INFO - 'LANG': 'en_US.UTF-8', 04:53:13 INFO - 'LANGUAGE': 'en_US:en', 04:53:13 INFO - 'LOGNAME': 'cltbld', 04:53:13 INFO - 'MAIL': '/var/mail/cltbld', 04:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:13 INFO - 'MOZ_NO_REMOTE': '1', 04:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:13 INFO - 'NO_EM_RESTART': '1', 04:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:13 INFO - 'PWD': '/builds/slave/test', 04:53:13 INFO - 'SHELL': '/bin/bash', 04:53:13 INFO - 'SHLVL': '1', 04:53:13 INFO - 'TERM': 'linux', 04:53:13 INFO - 'TMOUT': '86400', 04:53:13 INFO - 'USER': 'cltbld', 04:53:13 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', 04:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:13 INFO - '_': '/tools/buildbot/bin/python'} 04:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:53:14 INFO - Installing collected packages: mozsystemmonitor 04:53:14 INFO - Running setup.py install for mozsystemmonitor 04:53:14 INFO - Successfully installed mozsystemmonitor 04:53:14 INFO - Cleaning up... 04:53:14 INFO - Return code: 0 04:53:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc5e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfced10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcbeb0>, '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 0xfccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcd240>, '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': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', '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 04:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:53:14 INFO - Using env: {'DISPLAY': ':0', 04:53:14 INFO - 'HOME': '/home/cltbld', 04:53:14 INFO - 'LANG': 'en_US.UTF-8', 04:53:14 INFO - 'LANGUAGE': 'en_US:en', 04:53:14 INFO - 'LOGNAME': 'cltbld', 04:53:14 INFO - 'MAIL': '/var/mail/cltbld', 04:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:14 INFO - 'MOZ_NO_REMOTE': '1', 04:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:14 INFO - 'NO_EM_RESTART': '1', 04:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:14 INFO - 'PWD': '/builds/slave/test', 04:53:14 INFO - 'SHELL': '/bin/bash', 04:53:14 INFO - 'SHLVL': '1', 04:53:14 INFO - 'TERM': 'linux', 04:53:14 INFO - 'TMOUT': '86400', 04:53:14 INFO - 'USER': 'cltbld', 04:53:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', 04:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:14 INFO - '_': '/tools/buildbot/bin/python'} 04:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:14 INFO - Downloading/unpacking jsonschema==2.5.1 04:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:15 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:16 INFO - warning: no files found matching '*.txt' 04:53:16 INFO - no previously-included directories found matching 'build' 04:53:16 INFO - no previously-included directories found matching 'dist' 04:53:16 INFO - no previously-included directories found matching '.git*' 04:53:16 INFO - Installing collected packages: jsonschema, functools32 04:53:16 INFO - Running setup.py install for functools32 04:53:16 INFO - warning: no files found matching '*.txt' 04:53:16 INFO - no previously-included directories found matching 'build' 04:53:16 INFO - no previously-included directories found matching 'dist' 04:53:16 INFO - no previously-included directories found matching '.git*' 04:53:16 INFO - Successfully installed jsonschema functools32 04:53:16 INFO - Cleaning up... 04:53:16 INFO - Return code: 0 04:53:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc5e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfced10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcbeb0>, '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 0xfccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcd240>, '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': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', '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 04:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:53:16 INFO - Using env: {'DISPLAY': ':0', 04:53:16 INFO - 'HOME': '/home/cltbld', 04:53:16 INFO - 'LANG': 'en_US.UTF-8', 04:53:16 INFO - 'LANGUAGE': 'en_US:en', 04:53:16 INFO - 'LOGNAME': 'cltbld', 04:53:16 INFO - 'MAIL': '/var/mail/cltbld', 04:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:16 INFO - 'MOZ_NO_REMOTE': '1', 04:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:16 INFO - 'NO_EM_RESTART': '1', 04:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:16 INFO - 'PWD': '/builds/slave/test', 04:53:16 INFO - 'SHELL': '/bin/bash', 04:53:16 INFO - 'SHLVL': '1', 04:53:16 INFO - 'TERM': 'linux', 04:53:16 INFO - 'TMOUT': '86400', 04:53:16 INFO - 'USER': 'cltbld', 04:53:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', 04:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:16 INFO - '_': '/tools/buildbot/bin/python'} 04:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:53:16 INFO - Cleaning up... 04:53:16 INFO - Return code: 0 04:53:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc5e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfced10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcbeb0>, '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 0xfccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcd240>, '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': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', '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 04:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:53:16 INFO - Using env: {'DISPLAY': ':0', 04:53:16 INFO - 'HOME': '/home/cltbld', 04:53:16 INFO - 'LANG': 'en_US.UTF-8', 04:53:16 INFO - 'LANGUAGE': 'en_US:en', 04:53:16 INFO - 'LOGNAME': 'cltbld', 04:53:16 INFO - 'MAIL': '/var/mail/cltbld', 04:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:16 INFO - 'MOZ_NO_REMOTE': '1', 04:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:16 INFO - 'NO_EM_RESTART': '1', 04:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:16 INFO - 'PWD': '/builds/slave/test', 04:53:16 INFO - 'SHELL': '/bin/bash', 04:53:16 INFO - 'SHLVL': '1', 04:53:16 INFO - 'TERM': 'linux', 04:53:16 INFO - 'TMOUT': '86400', 04:53:16 INFO - 'USER': 'cltbld', 04:53:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', 04:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:16 INFO - '_': '/tools/buildbot/bin/python'} 04:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:16 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:17 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:18 INFO - Downloading docopt-0.6.1.tar.gz 04:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:18 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:18 INFO - Running setup.py install for blobuploader 04:53:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:18 INFO - Running setup.py install for requests 04:53:18 INFO - Running setup.py install for docopt 04:53:18 INFO - Successfully installed blobuploader requests docopt 04:53:18 INFO - Cleaning up... 04:53:18 INFO - Return code: 0 04:53:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:18 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 0xc5e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfced10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcbeb0>, '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 0xfccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcd240>, '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': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', '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 04:53:18 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 04:53:18 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 04:53:18 INFO - Using env: {'DISPLAY': ':0', 04:53:18 INFO - 'HOME': '/home/cltbld', 04:53:18 INFO - 'LANG': 'en_US.UTF-8', 04:53:18 INFO - 'LANGUAGE': 'en_US:en', 04:53:18 INFO - 'LOGNAME': 'cltbld', 04:53:18 INFO - 'MAIL': '/var/mail/cltbld', 04:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:18 INFO - 'MOZ_NO_REMOTE': '1', 04:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:18 INFO - 'NO_EM_RESTART': '1', 04:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:18 INFO - 'PWD': '/builds/slave/test', 04:53:18 INFO - 'SHELL': '/bin/bash', 04:53:18 INFO - 'SHLVL': '1', 04:53:18 INFO - 'TERM': 'linux', 04:53:18 INFO - 'TMOUT': '86400', 04:53:18 INFO - 'USER': 'cltbld', 04:53:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', 04:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:18 INFO - '_': '/tools/buildbot/bin/python'} 04:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:19 INFO - Running setup.py (path:/tmp/pip-I_TSpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:19 INFO - Running setup.py (path:/tmp/pip-fqLBsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:19 INFO - Running setup.py (path:/tmp/pip-d0hIYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:19 INFO - Running setup.py (path:/tmp/pip-1WHweZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:19 INFO - Running setup.py (path:/tmp/pip-LkJv2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:19 INFO - Running setup.py (path:/tmp/pip-5pKcS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:19 INFO - Running setup.py (path:/tmp/pip-bvlg1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:19 INFO - Running setup.py (path:/tmp/pip-Mx2w2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:19 INFO - Running setup.py (path:/tmp/pip-prfHAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:19 INFO - Running setup.py (path:/tmp/pip-IwAsr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:19 INFO - Running setup.py (path:/tmp/pip-6Lud14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:19 INFO - Running setup.py (path:/tmp/pip-6_J396-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:20 INFO - Running setup.py (path:/tmp/pip-iXNf6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:20 INFO - Running setup.py (path:/tmp/pip-ofjYWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:20 INFO - Running setup.py (path:/tmp/pip-d6Tja0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:20 INFO - Running setup.py (path:/tmp/pip-OD_WoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:20 INFO - Running setup.py (path:/tmp/pip-Q9oaK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:20 INFO - Running setup.py install for manifestparser 04:53:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for mozcrash 04:53:20 INFO - Running setup.py install for mozdebug 04:53:20 INFO - Running setup.py install for mozdevice 04:53:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for mozfile 04:53:20 INFO - Running setup.py install for mozhttpd 04:53:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for mozinfo 04:53:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Running setup.py install for mozInstall 04:53:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Running setup.py install for mozleak 04:53:21 INFO - Running setup.py install for mozlog 04:53:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Running setup.py install for moznetwork 04:53:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Running setup.py install for mozprocess 04:53:21 INFO - Running setup.py install for mozprofile 04:53:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Running setup.py install for mozrunner 04:53:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Running setup.py install for mozscreenshot 04:53:21 INFO - Running setup.py install for moztest 04:53:22 INFO - Running setup.py install for mozversion 04:53:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:22 INFO - Cleaning up... 04:53:22 INFO - Return code: 0 04:53:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:22 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 0xc5e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfced10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcbeb0>, '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 0xfccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcd240>, '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': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', '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 04:53:22 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 04:53:22 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 04:53:22 INFO - Using env: {'DISPLAY': ':0', 04:53:22 INFO - 'HOME': '/home/cltbld', 04:53:22 INFO - 'LANG': 'en_US.UTF-8', 04:53:22 INFO - 'LANGUAGE': 'en_US:en', 04:53:22 INFO - 'LOGNAME': 'cltbld', 04:53:22 INFO - 'MAIL': '/var/mail/cltbld', 04:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:22 INFO - 'MOZ_NO_REMOTE': '1', 04:53:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:22 INFO - 'NO_EM_RESTART': '1', 04:53:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:22 INFO - 'PWD': '/builds/slave/test', 04:53:22 INFO - 'SHELL': '/bin/bash', 04:53:22 INFO - 'SHLVL': '1', 04:53:22 INFO - 'TERM': 'linux', 04:53:22 INFO - 'TMOUT': '86400', 04:53:22 INFO - 'USER': 'cltbld', 04:53:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', 04:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:22 INFO - '_': '/tools/buildbot/bin/python'} 04:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:22 INFO - Running setup.py (path:/tmp/pip-iwhI5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:22 INFO - Running setup.py (path:/tmp/pip-twezkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:22 INFO - Running setup.py (path:/tmp/pip-pOeB0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:22 INFO - Running setup.py (path:/tmp/pip-2qoGLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:22 INFO - Running setup.py (path:/tmp/pip-Q3XWr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:22 INFO - Running setup.py (path:/tmp/pip-alobmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:22 INFO - Running setup.py (path:/tmp/pip-yTbc1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:22 INFO - Running setup.py (path:/tmp/pip-e38hS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:22 INFO - Running setup.py (path:/tmp/pip-jcQ5iY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:22 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)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:23 INFO - Running setup.py (path:/tmp/pip-f9SVlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:23 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)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:23 INFO - Running setup.py (path:/tmp/pip-yK9bPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:23 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)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:23 INFO - Running setup.py (path:/tmp/pip-hG3M8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:23 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)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:23 INFO - Running setup.py (path:/tmp/pip-0ukK1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:23 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)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:23 INFO - Running setup.py (path:/tmp/pip-_eTsFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:23 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)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:23 INFO - Running setup.py (path:/tmp/pip-GtJ_YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:23 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)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:23 INFO - Running setup.py (path:/tmp/pip-0Cf3j_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:23 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)) 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:23 INFO - Running setup.py (path:/tmp/pip-yTaEHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:23 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)) 04:53:23 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)) 04:53:23 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)) 04:53:23 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)) 04:53:23 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)) 04:53:23 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)) 04:53:23 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)) 04:53:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:23 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 04:53:23 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 04:53:23 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 04:53:23 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 04:53:24 INFO - Downloading blessings-1.6.tar.gz 04:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:24 INFO - Installing collected packages: blessings 04:53:24 INFO - Running setup.py install for blessings 04:53:25 INFO - Successfully installed blessings 04:53:25 INFO - Cleaning up... 04:53:25 INFO - Return code: 0 04:53:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:25 INFO - Reading from file tmpfile_stdout 04:53:25 INFO - Current package versions: 04:53:25 INFO - argparse == 1.2.1 04:53:25 INFO - blessings == 1.6 04:53:25 INFO - blobuploader == 1.2.4 04:53:25 INFO - docopt == 0.6.1 04:53:25 INFO - functools32 == 3.2.3-2 04:53:25 INFO - jsonschema == 2.5.1 04:53:25 INFO - manifestparser == 1.1 04:53:25 INFO - mozInstall == 1.13 04:53:25 INFO - mozcrash == 1.0 04:53:25 INFO - mozdebug == 0.1 04:53:25 INFO - mozdevice == 0.51 04:53:25 INFO - mozfile == 1.2 04:53:25 INFO - mozhttpd == 0.7 04:53:25 INFO - mozinfo == 0.10 04:53:25 INFO - mozleak == 0.1 04:53:25 INFO - mozlog == 3.5 04:53:25 INFO - moznetwork == 0.27 04:53:25 INFO - mozprocess == 0.25 04:53:25 INFO - mozprofile == 0.28 04:53:25 INFO - mozrunner == 6.13 04:53:25 INFO - mozscreenshot == 0.1 04:53:25 INFO - mozsystemmonitor == 0.3 04:53:25 INFO - moztest == 0.8 04:53:25 INFO - mozversion == 1.4 04:53:25 INFO - psutil == 3.1.1 04:53:25 INFO - requests == 1.2.3 04:53:25 INFO - wsgiref == 0.1.2 04:53:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:25 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 0xc5e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfced10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcbeb0>, '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 0xfccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcd240>, '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': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', '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 04:53:25 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 04:53:25 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 04:53:25 INFO - Using env: {'DISPLAY': ':0', 04:53:25 INFO - 'HOME': '/home/cltbld', 04:53:25 INFO - 'LANG': 'en_US.UTF-8', 04:53:25 INFO - 'LANGUAGE': 'en_US:en', 04:53:25 INFO - 'LOGNAME': 'cltbld', 04:53:25 INFO - 'MAIL': '/var/mail/cltbld', 04:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:25 INFO - 'MOZ_NO_REMOTE': '1', 04:53:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:25 INFO - 'NO_EM_RESTART': '1', 04:53:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:25 INFO - 'PWD': '/builds/slave/test', 04:53:25 INFO - 'SHELL': '/bin/bash', 04:53:25 INFO - 'SHLVL': '1', 04:53:25 INFO - 'TERM': 'linux', 04:53:25 INFO - 'TMOUT': '86400', 04:53:25 INFO - 'USER': 'cltbld', 04:53:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', 04:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:25 INFO - '_': '/tools/buildbot/bin/python'} 04:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:53:25 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 04:53:25 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 04:53:25 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 04:53:25 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 04:53:26 INFO - Downloading marionette_driver-1.4.0.tar.gz 04:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 04:53:26 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 04:53:26 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 04:53:26 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 04:53:26 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 04:53:26 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 04:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:53:26 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)) 04:53:26 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)) 04:53:26 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)) 04:53:26 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)) 04:53:26 INFO - Installing collected packages: marionette-driver, simplejson 04:53:26 INFO - Running setup.py install for marionette-driver 04:53:27 INFO - Running setup.py install for simplejson 04:53:27 INFO - building 'simplejson._speedups' extension 04:53:27 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 04:53:27 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 04:53:28 INFO - Successfully installed marionette-driver simplejson 04:53:28 INFO - Cleaning up... 04:53:28 INFO - Return code: 0 04:53:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:28 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 0xc5e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfced10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcbeb0>, '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 0xfccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcd240>, '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': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', '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 04:53:28 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 04:53:28 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 04:53:28 INFO - Using env: {'DISPLAY': ':0', 04:53:28 INFO - 'HOME': '/home/cltbld', 04:53:28 INFO - 'LANG': 'en_US.UTF-8', 04:53:28 INFO - 'LANGUAGE': 'en_US:en', 04:53:28 INFO - 'LOGNAME': 'cltbld', 04:53:28 INFO - 'MAIL': '/var/mail/cltbld', 04:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:28 INFO - 'MOZ_NO_REMOTE': '1', 04:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:28 INFO - 'NO_EM_RESTART': '1', 04:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:28 INFO - 'PWD': '/builds/slave/test', 04:53:28 INFO - 'SHELL': '/bin/bash', 04:53:28 INFO - 'SHLVL': '1', 04:53:28 INFO - 'TERM': 'linux', 04:53:28 INFO - 'TMOUT': '86400', 04:53:28 INFO - 'USER': 'cltbld', 04:53:28 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', 04:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:28 INFO - '_': '/tools/buildbot/bin/python'} 04:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:53:28 INFO - Cleaning up... 04:53:28 INFO - Return code: 0 04:53:28 INFO - Running post-action listener: _resource_record_post_action 04:53:28 INFO - Running post-action listener: _start_resource_monitoring 04:53:28 INFO - Starting resource monitoring. 04:53:28 INFO - [mozharness: 2017-07-22 11:53:28.328321Z] Finished create-virtualenv step (success) 04:53:28 INFO - [mozharness: 2017-07-22 11:53:28.328787Z] Running install step. 04:53:28 INFO - Running pre-action listener: _resource_record_pre_action 04:53:28 INFO - Running main action method: install 04:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:28 INFO - Reading from file tmpfile_stdout 04:53:28 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:28 INFO - Reading from file tmpfile_stdout 04:53:28 INFO - Output received: 04:53:28 INFO - Usage: mozinstall [options] installer 04:53:28 INFO - Options: 04:53:28 INFO - -h, --help show this help message and exit 04:53:28 INFO - -d DEST, --destination=DEST 04:53:28 INFO - Directory to install application into. [default: 04:53:28 INFO - "/builds/slave/test"] 04:53:28 INFO - --app=APP Application being installed. [default: firefox] 04:53:28 INFO - mkdir: /builds/slave/test/build/application 04:53:28 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'] 04:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:53:46 INFO - Reading from file tmpfile_stdout 04:53:46 INFO - Output received: 04:53:46 INFO - /builds/slave/test/build/application/firefox/firefox 04:53:46 INFO - Running post-action listener: _resource_record_post_action 04:53:46 INFO - [mozharness: 2017-07-22 11:53:46.806771Z] Finished install step (success) 04:53:46 INFO - [mozharness: 2017-07-22 11:53:46.807023Z] Running setup-mitmproxy step. 04:53:46 INFO - Running pre-action listener: _resource_record_pre_action 04:53:46 INFO - Running main action method: setup_mitmproxy 04:53:46 INFO - Skipping: mitmproxy is not required 04:53:46 INFO - Running post-action listener: _resource_record_post_action 04:53:46 INFO - [mozharness: 2017-07-22 11:53:46.808147Z] Finished setup-mitmproxy step (success) 04:53:46 INFO - [mozharness: 2017-07-22 11:53:46.808368Z] Running run-tests step. 04:53:46 INFO - Running pre-action listener: _resource_record_pre_action 04:53:46 INFO - Running pre-action listener: _set_gcov_prefix 04:53:46 INFO - Running main action method: run_tests 04:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:53:46 INFO - Python 2.7.3 04:53:46 INFO - Return code: 0 04:53:46 INFO - grabbing minidump binary from tooltool 04:53: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')]} 04:53:46 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 0xfcbeb0>, '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 0xfccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcd240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:53:46 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 04:53:46 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 04:53:46 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 04:53:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:46 INFO - Return code: 0 04:53:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:53:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:53:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:53:46 INFO - ENV: RUST_BACKTRACE is now 1 04:53:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:53:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 04:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 04:53:46 INFO - Using env: {'DISPLAY': ':0', 04:53:46 INFO - 'HOME': '/home/cltbld', 04:53:46 INFO - 'LANG': 'en_US.UTF-8', 04:53:46 INFO - 'LANGUAGE': 'en_US:en', 04:53:46 INFO - 'LOGNAME': 'cltbld', 04:53:46 INFO - 'MAIL': '/var/mail/cltbld', 04:53:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:53:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:46 INFO - 'MOZ_NO_REMOTE': '1', 04:53:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:46 INFO - 'NO_EM_RESTART': '1', 04:53:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:46 INFO - 'PWD': '/builds/slave/test', 04:53:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:53:46 INFO - 'RUST_BACKTRACE': '1', 04:53:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:53:46 INFO - 'SHELL': '/bin/bash', 04:53:46 INFO - 'SHLVL': '1', 04:53:46 INFO - 'TERM': 'linux', 04:53:46 INFO - 'TMOUT': '86400', 04:53:46 INFO - 'USER': 'cltbld', 04:53:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802', 04:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:46 INFO - '_': '/tools/buildbot/bin/python'} 04:53:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 04:53:47 INFO - mozversion application_buildid: 20170722111228 04:53:47 INFO - mozversion application_changeset: 7ce557b85b611536b69539a7c18d4834ffc92eea 04:53:47 INFO - mozversion application_display_name: Nightly 04:53:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:47 INFO - mozversion application_name: Firefox 04:53:47 INFO - mozversion application_remotingname: firefox 04:53:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:53:47 INFO - mozversion application_vendor: Mozilla 04:53:47 INFO - mozversion application_version: 56.0a1 04:53:47 INFO - mozversion platform_buildid: 20170722111228 04:53:47 INFO - mozversion platform_changeset: 7ce557b85b611536b69539a7c18d4834ffc92eea 04:53:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:53:47 INFO - mozversion platform_version: 56.0a1 04:53:47 INFO - using testdate: 1500724427 04:53:47 INFO - actual date: 1500724427 04:53:47 INFO - starting webserver on 'localhost:56860' 04:53:47 INFO - SUITE-START | Running 2 tests 04:53:47 INFO - TEST-START | dromaeo_css 04:53:47 INFO - Initialising browser for dromaeo_css test... 04:53:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56860/getInfo.html -profile /tmp/tmpeFgvNA/profile 04:53:47 INFO - TEST-INFO | started process 6869 (/builds/slave/test/build/application/firefox/firefox http://localhost:56860/getInfo.html) 04:53:53 INFO - TEST-INFO | 6869: exit 0 04:53:53 INFO - Browser initialized. 04:53:53 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:53 INFO - TEST-INFO | started process 7086 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeFgvNA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:05 INFO - PID 7086 | RSS: Main: 174419968 04:54:05 INFO - PID 7086 | 04:57:04 INFO - PID 7086 | Cycle 1(1): loaded http://localhost:56860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56860/tests/dromaeo/cssquery-ext.html) 04:57:06 INFO - PID 7086 | RSS: Main: 180662272 04:57:06 INFO - PID 7086 | 05:00:07 INFO - PID 7086 | Cycle 1(1): loaded http://localhost:56860/tests/dromaeo/cssquery-ext.html (next: http://localhost:56860/tests/dromaeo/cssquery-jquery.html) 05:00:08 INFO - PID 7086 | RSS: Main: 177991680 05:00:08 INFO - PID 7086 | 05:03:10 INFO - PID 7086 | Cycle 1(1): loaded http://localhost:56860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56860/tests/dromaeo/cssquery-mootools.html) 05:03:10 INFO - PID 7086 | RSS: Main: 178888704 05:03:10 INFO - PID 7086 | 05:06:12 INFO - PID 7086 | Cycle 1(1): loaded http://localhost:56860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56860/tests/dromaeo/cssquery-prototype.html) 05:06:13 INFO - PID 7086 | RSS: Main: 177410048 05:06:13 INFO - PID 7086 | 05:09:17 INFO - PID 7086 | Cycle 1(1): loaded http://localhost:56860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56860/tests/dromaeo/cssquery-yui.html) 05:09:17 INFO - PID 7086 | RSS: Main: 179699712 05:09:17 INFO - PID 7086 | 05:12:19 INFO - PID 7086 | Cycle 1(1): loaded http://localhost:56860/tests/dromaeo/cssquery-yui.html (next: http://localhost:56860/tests/dromaeo/cssquery-dojo.html) 05:12:20 INFO - PID 7086 | RSS: Main: 180342784 05:12:20 INFO - PID 7086 | 05:12:20 INFO - PID 7086 | __start_tp_report 05:12:20 INFO - PID 7086 | _x_x_mozilla_page_load 05:12:20 INFO - PID 7086 | _x_x_mozilla_page_load_details 05:12:20 INFO - PID 7086 | |i|pagename|runs| 05:12:20 INFO - PID 7086 | |0;dojo.html;3112.782105252632;3149.59055322808;3152.684731526849;3158.984205078975;3167.968320316796;6048.939510604892;6073.574849760518;6079.118527813464;6105.511559075275;6130.203073600432;6106.877862442749;6130.87738245236;6253.624782513052;6310.96844515778;6325.4307112359875;5588.91616625751;5634.7182640867795;5641.464060914206;5673.375928647845;5705.828825135252;5491.313585801775;5506.91739623906;5604.1593760935775;5615.213870058195;5616.663000219979;5595.4124816894255;5690.715464226813;5702.059160238556;5724.141378793172;5725.341585717654;5577.330720313547;5597.6641401516035;5664.915026274609;5665.1502274658715;5675.801346952837;5513.228148059275;5532.529734972532;5556.86107847303;5570.275864137677;5581.023320918823;6053.364396738323;6057.3336932937345;6064.878702425971;6091.14723938649;6100.115483254947;6540.018997150418;6565.54041217115;6570.277269500399;6570.671466426659;6580.736770529173;6590.110335104748;6590.538662293641;6596.86806263872;6659.966700166468;6661;6009.549283803689;6201;6229.159063526411;6240.750369985195;6261.749530018839;6825.624590647462;6829.863402731918;6903.344182302673;6918.411934985583;6933.064036355128;6340.651264180515;6436.3241859605005;6467.159269294962;6482.870342593122;6512.674366281667;6545.639989800511;6588.912829383194;6607.933920660732;6612.206535215805;6658.966705166443;6511.2512061113575;6548.476121910236;6586.80239592813;6636.900446493307;6650.401463868275;6564.737410503526;6612.173478315211;6678.6326752028135;6696.8995465068065;6697.062411262427;5284.101702710548;5293.57651387888;5342.385625653022;5362.249285100089;5366.490183432567;4492.146492166478;4539;4550.067236216568;4656.883577910512;4675.2052151134385;5745.368009518949;5779.162021506858;5782.913256301159;5800.5939584229545;5801.158831969341;6599.967000164968;6617.239017512951;6710.396064354231;6717.395434410926;6726.932730672631;5671.262735844396;5712.343080545707;5761.827145185651;5797.565182611321;5804.303483581997;5771.624844385102;5796.536277097822;5863.853403664943;5869;5887.322957859816;6446.033095035782;6533.24867640218;6535;6536.509761767887;6537.477001839747;6575.473962083118;6638.668066596554;6647.734090636513;6749.628770417477;6751.156105486814;6229.2524897012645;6326.557141000086;6410.358964103552;6500.414962653384;6520.119783829123;6559.901601476077;6585;6600.933990660032;6603.9009414859775;6631.801045968628;6444.581102228528;6560.048792924904;6566.9343306566325;6649.900251496329;6654.13496245485;6309.652969086561;6361.236651601837;6399.392057754506;6422.32565580626;6525.119108920425;6434.388733070351;6474.2878283387845;6497.350264973465;6502.934970650233;6506.154199953976;6323.1463752394675;6399.328070552711;6409.839754006187;6417.8716425672155;6442.130312407952;6331.778387756406;6453.354664533509;6456.451201647725;6476.190476190476;6479.352064793671;6233.470155036691;6259.092431597484;6272.8118156455375;6288.811335659938;6364 05:12:20 INFO - PID 7086 | |1;ext.html;784.3372350363944;843.4559708987703;846.2383854530922;853.1127627267638;1162.6628277799439;32015.199620009513;43326;44202.778986105026;44242.778786106064;44298.33552496715;43938.7803060985;44158.77920610392;44303.77848110755;44342.33486497705;44370.33444498335;7550.244975502461;7660.387169026479;7724.459287849852;7734.613269336511;7831.569263690495;7653.579053152074;7769.0677118745825;7778.4166187535875;7793.532388056735;7799.298063174313;7772.3393511551585;7829.17793631669;7832.530048197098;7837.804054898645;7842.686292548291;7743.341815945651;7777.805554861117;7790.610469476532;7813.648385822652;7818.06183258007;7657.310842024189;7690.807729806799;7736.883946740803;7739.729109481197;7740.26467485588;38501;38811.22377552462;38822.41766373507;38850.61149388498;38897.22205555901;3641.8725344613076;3689.6679298863232;3691.151035261878;3691.372466680644;3692.7045836333027;32317.6768232317;32381.35237295241;32429.6757032429;32439.837800810845;32531.837340813145;4712.835050773207;4859.465458799529;4893.608511319086;4896.657233993622;4930.408350997904;193056;194231;194585;195073;195093.02453487783;49281.50718492841;49501.52492375367;49507.50492495101;49509.75245123752;49595.50404495981;51696;52273.215901761505;52822;52826.471735282925;52897.413077607736;14163;16092.436764713178;16149.596260093356;16322.428714994918;16337.673246535003;11811.291322520676;13384.866151338361;13668.111572747739;13686.178829270275;13695.178289302674;14318.785218221736;14326.426942922375;14337.139771613736;14387.856121438861;14480.493182738554;5738.196652468658;5877.118432235114;5936.673482958478;5944.583879128506;5962.880742385215;1002.1932344462778;1015.8120747661707;1017.5217647705566;1022.9693109206736;1045.8744950605976;22125.446863828212;28491.857540712164;29265;29795.10614681563;30195.245118871764;1077.7305673581604;1105.5909313554037;1106.076426184129;1109.589451902801;1112.010310823368;12154.939225303993;16084.276207570687;16137.67724645524;16434.076026193983;16534.338626455046;238067;238427;240072;240369;240379;59635;59887.10169347463;59891;59970.70014649899;60023.69988150118;1469.7648376259747;1512.470635277644;1518.1574226304508;1518.5140754958306;1523.2079318754186;27308;27355.72644273532;27812.721872781014;27980.86009569939;28010.85994570014;52841.735791320796;54151;54278.45721542734;54359.184612230056;54363.18455223096;150595.24702376418;152411;152986;153650.23174884054;154055.22972385515;33291.334173316885;33847.83076084604;33937.66062339345;36831.263374732895;37454.250914981;46086.078278433575;46311.76844115893;46465.303020455394;46598.53401465942;46608.30087548622;31052.534211986385;33100.66899330976;33451.665483344856;33466.330673385906;33764;31796.36407271795;32779.508307374934;33088.83455582707;33514.329713406085;33634;36631.08422289464;37503.624963750015;37577.060573485884;37614.811925940194;37616.059598510255;31689.36621267608;32138.517922231655;32335.353292933538;32581;32707.509387358732;22669.88665056664;23498.177563785186;24984.750152498244;25019.249422517354;25920.22239332823 05:12:20 INFO - PID 7086 | |2;jquery.html;571.611304313067;581.2734082397006;587.3979171349368;596.561527277451;608.677400977482;21893.781062189373;22133.335999920007;23583;23592.29223123305;23636.763632363673;25589.616155757678;25898.48203035938;26156.869215653896;26192;26299.3425164371;6436.549441539082;6604.867902641944;6617.503687223453;6620.470362370998;6620.702068406933;5983;6467.644279564622;6542.50931180161;6548.312427195124;6550.8689826203445;6516.967415162918;6517.967410162966;6527;6533.281339052701;6548.345165483461;6507.772227971998;6509.446697030734;6511.902321465182;6523.608583485006;6540.4440622547145;6063.818085457443;6069.15031895535;6079.240094988127;6084.756609735606;6089.360617135226;28066.43867122646;29118;29582.408351832844;29610.851945740134;29841.104766857028;1932.5361913140885;1960.1669290551458;1964.803519648038;1968.0258272155231;1970.8226259636701;18694;19396.321128760424;19421.4173574793;19425.708614370797;19438.611227775364;2225.0654725015534;2239.6080685879906;2296.873671948042;2300.344401845483;2397.3407312988893;123499.3825030878;130022;130116;130334.3483282587;131040;13911.373988170557;15082.622934426727;15118.168500732565;15123.773143402857;15404.768928466083;23178.072877084727;23205;23214.41963950881;23291.650625240636;23370.532589348117;9898.950505247427;10076.748081298027;10095;10102.595896164217;10122.898771012344;9177.587008584629;9198.770030749285;9301.255899528156;9352.859707104399;9406.95296523513;7663.961680191564;8966.327525435618;9133.812604361523;9399.201067909304;9431.6698915539;2640.6567146270863;2690.125709144536;2813.324802047494;2817;2924.2543151496234;951.1344676344631;971;975.8487434447673;995.4475266227313;1009.5204777730667;18914.148863301183;19552.706709399372;19632.70550941737;19659.41021769349;19949.401517954484;989.8069876374182;1042.8748550173875;1044.9791004180026;1059.3432072115338;1066.4347895615335;10500.212484063726;10592.364458132382;10711.517981690842;11010.50452729613;11145.331280123219;476293;477134;493706;498039;502083;118643;120585;123573.76426235623;123747;125930.37034814767;1224.5836415618733;1254.736505333872;1292.6186774901428;1293.4373547506864;1297.474522818279;16540.421085261958;17450.798124881287;17527.386541470987;17590.94454332744;17964.73052904181;53576.73211633917;53719.46280537145;54255;54593.1811022827;55846;73576;74439.62780186064;74489.62755186406;74543;74560;11683.824742628698;12321.44553495077;13847.30763461843;14303.570892873231;14598.197099159648;23103.88448057749;23109.422264443525;23126.768732312463;23151.536969260185;23190.884045579664;17636.73544896853;18126.72809907826;19462.513437164183;19792.505187370432;19848.90075549613;16975.490735277963;17337.479875603247;17530.649387011934;18084.276628935222;18337.266509339475;17221.39725109615;18868.43394698161;18932.716009259595;20094;20141.295054673017;14749.336279867646;15069.773953390928;15097.094174349575;15099.169545675093;15135.470258540898;18012;18122.546936326697;18182.36361727333;18201.362952296608;18233.179506921955 05:12:20 INFO - PID 7086 | |3;mootools.html;1356.559118286557;1385.570473153322;1420.9289535523221;1422.082756621979;1424.3448013913599;13010.349482525871;13864.168149911;13883.028188026818;13885.861141388583;13925.721485570282;14710;14939.253037348144;14976.925115374435;15004.474843380483;15006.174660393674;2595.1306312385373;2648.0202325139726;2666.1868130220273;2666.5733482642686;2667.719889411613;2571.0872640212738;2655.5485567453484;2701.4326991331845;2711.4577084583066;2712.742289482496;2526.494701059786;2678.9464210715773;2706.2287248134285;2707.3637695141624;2707.390837061665;2638.4459263554677;2639.907603233887;2647.6690413698384;2671.2654020144423;2676.1035053256987;2487.3657217409445;2539.606361014046;2596.31197732601;2599.0643368387364;2601.206631977246;14230.501932432418;14295.28523573817;14298.499552515612;14304.713905721932;14321.78517322241;7504.249575042507;7842.372610191171;7856.450048496607;7887.566183859885;7899.881501777478;4945.67853089548;4997.100521906055;5061.822836200715;5120.820771272987;5152.742362881879;1887.5186827359073;1897.2031746666296;1901.6767149584605;1946.240966023252;1961.7743959444704;23107.76892231073;23312.650310245528;23346.766532334797;23442.53114937692;23444.88277558601;6094.786682466092;6476.902846457307;6523.510736694767;6565.80302590923;6730.899036514456;14475.203863787592;16023.679526409407;16029.19854007295;16064.518064458085;16064.839351606568;7296.270372962767;7450.143233528213;7484.176740558534;7504.099508059068;7582.886256706154;6784.8303792404595;6987.406070484066;6990.965045174741;7179.928200717926;7274.781756547312;4858.149823780825;5042.42012168598;5096.108181068298;5096.413912400048;5121.74391280442;1446.4503488674236;1452.1650051220379;1456.978145327821;1470.2942587557818;1475.6753514226853;812.5165526511717;814.9266566009088;826.8387664405383;849.2781136034322;880.2649787427441;6769.613800053362;6794.558353706993;6901.999210114605;6935.6878940447805;6995.825104372431;690.5511417578614;710.4139085254583;716.9677364518609;728.8505856299446;730.9707611695579;3882.437046628223;4118.382242663624;4159.480064991876;4180.163967206571;4191.413202151702;18659.626807464047;18967.336143235196;19381.806181938002;19422.417327480198;19501;18295.26818927228;19488;19596.804031959782;19632.509187270432;19649.508762281057;10085.193184545218;10352.844707329396;10375.533101010473;10381.377117372982;10385.948070259752;7494.662740176815;8274.13121622221;8456.830863382575;8710.21608055278;8712.651493940171;16301.26644301033;16730.832691672927;16760.832391675925;17393.478195654152;17605.64788704193;17591.472255832345;17768.28926842912;17956.281748729903;17960.371387001393;17967.460976170736;12531.624051278477;12767.87232127704;12815.359232038174;12817.038722095693;12831.871681283068;13270.33648317561;13596;13611.31943402806;13612.25132617676;13624.65938351549;10308.32995855267;10879.673609791718;11017.559297628006;11143.164262680493;11338;10011;10340.844887326546;10658.62694805678;10742.785144297226;11060.557577697124;9164.725058248263;9219.723408297761;9257.907420925705;9263.351565390358;9264.629414823332;6678.465722742266;6849.520533562602;6916.688749006407;7020.543664661985;7033.788986330418;6944.722211111701;6946.2011868635755;7024.26245244242;7071.36357727807;7195.46034047459 05:12:20 INFO - PID 7086 | |4;prototype.html;495.13185576593776;497.46850347344855;516.9948300516995;524.984250472486;526.5340173946057;5952.70236488176;6069.5144388448925;6116.7553297868035;6120.296165940918;6148.63108213507;5955.910661340084;5967.612105213158;6001.849953751158;6061.696915154235;6123.326434092246;4887.682300650446;4889.486603906592;4953.777080031389;4971.304017437562;4979.10376132296;4743.035602748282;4898.387701537308;4933.901321973558;4959.6528243023;4965.925511117336;4825.252085926687;4827.58965487934;4838.870896805394;4868.245421959602;4882.340883980671;4876;4892.3639926809465;4901.926471102936;4903.950960490385;4920.729359885205;4372.693911426201;4415.845445409427;4428.40216570762;4449.888752781207;4469.150861336336;5896.882062358772;5953.2856057272975;5968.552358573124;6006.249218847644;6012.617098067425;5586.469285417878;5602.887942241173;5619.915701264485;5620.971895140539;5649.830505084854;6387.668500997149;6407.967960160216;6439.581427207217;6457.354264573552;6527.640979746112;4792.424909010906;4805.303231031516;4806.975965120187;4844.636652251095;4855.902881942377;6576.172245934295;6646.700898459581;6703.966480167568;6768.593884366954;6808.97865320201;4854.514548545118;4895.408992077589;4914.729689867092;4920.876978075506;4951.430585482643;4986.002799440126;5011.1481048221885;5038.722870242099;5047.924281135786;5078.111330517218;5527.806526771544;5593.300837395325;5617.9438205618235;5629.577781666391;5671.347795003628;6410.455111315498;6478.4169424752;6491.67541622917;6501.187351581052;6510.470039540704;1648.4807285704965;1657.693326734558;1687.05524906053;1705.6440130096603;1731.437282883068;1196.1686627793774;1207.7342984543386;1220.951161953512;1233.7039110613389;1235.4502246500401;5590.301212348457;5621.297337832771;5642.6864985355805;5668.319801623831;5723.599348045597;6404.48764098871;6445.742170313229;6522.217333919865;6563.737450502022;6580.243272023683;5567.387587365387;5667.234923285386;5678.943210567924;5682.7442765075675;5740.13897915316;3486.91282717929;3502.772319799256;3504.123969007748;3533.3993221152464;3546.3793836078585;6217.813465596039;6274.780382686584;6332.366763323723;6420.390062944013;6445.967770161119;6665.300143484961;6680.799576012728;6683.732650693918;6792.694328755218;6797.388235058868;6333.46165575922;6368.235811702625;6380.457661098859;6407.590330127365;6415.839604009937;6584.637844918576;6595.558664102231;6596.30738772422;6614.570052946543;6641.933580664131;6490.415862572391;6495.213816200583;6498.610083395011;6504.089427480251;6534.477241820738;6282.780102696383;6359.841003974938;6369.45859601939;6381;6392.264889537762;4924.8276310328965;4933.777979990838;4959.925601116059;4963.478834722447;4983;6498.805035848932;6610.10763546915;6623.602583844985;6665.433438157811;6707.396334329934;6206.348333424925;6236.438720515175;6292.937070629235;6322.936770632235;6348.4925702749715;6131.172291740558;6284.151639528788;6331.398517140864;6361.522885783492;6367.713452894538;6005.8349819156365;6158.414950579688;6267.1539342188225;6331.746730130743;6342.524310676626;6384.457321127757;6412.35876412355;6461.838454038687;6465.224173099258;6481;6097.420745029215;6211;6239.4696450800375;6253.874922501615;6291.842703932438 05:12:20 INFO - PID 7086 | |5;yui.html;908.2960705453277;911.6717981526651;915.6245939164944;926.7080869526096;926.7683079230193;18343.908280458596;19294.903525482354;19306.227750889982;19319.903400483014;19341.419757407282;16910.408135715254;17354;18103;18108.275668973227;18116.72824907624;1030.5877648940427;1066.5733706517417;1066.898644628763;1067.1036329483234;1067.2209287220335;1013.513513513514;1054.3568423261804;1056.9471526423686;1057.0961827637375;1057.148995058977;1110.1396417776248;1125.4935279124386;1126.8366086917392;1127.4362818590705;1130.146739211898;1105.8285965675293;1118.3234143343282;1120.176670147441;1120.8991190792826;1123.5056575107008;812.6383759227147;813.0487329824061;818.3902992270796;819.6393586821779;821.0434843407423;18952.336668216685;19428.320008799623;19532.609347812962;19640.821550707;19643.82137071766;20362.898185509126;20568.588628227353;20795.16819327225;20897.79102208989;20898.37304880856;16067.116308603023;16227.350905963747;16347.100909449975;16480.505584832474;16770.496885093467;3503.3518799022263;3520;3537.9823100884587;3540.3627347077518;3542.6103128655827;117915;120768;122444.38777806143;123125;125716.37141814324;16235.675286494205;16741.07924064188;16745.665086698198;16749.66500670004;16770;28279;29778.10665680033;30429.239269018453;30434.239144021132;30509;8653.307735381155;8728;8761.080086590944;8828.8675669865;8838.29293656506;3995.400689896481;4008.7394319369146;4011.398290256485;4024.7987600619854;4033.515978082649;5051.444341122474;5096.464871188472;5105.821296254613;5165.302684137593;5223.895522089537;982.8574856645746;1011.5397494140149;1017.99491002546;1023.2428003277521;1025.0569476082023;652.4269612328011;668.5220067651652;677.11298199359;697.7976386847859;698.1622053535777;11592.246503977214;11898.702532436759;12041.33772642513;12215.694607634703;12422.440990155465;665.1486097794831;673.0543586261213;689.6000319814495;699.8005568412977;700.9905735740517;5168.328117344721;5641.830745077655;5665.150227465913;5706.144078388275;6004.819855404345;95678.52160739152;99469.50265248628;99825.50087249518;100337.49831250797;102631.48684256531;82851.58574207211;87216.12783872207;87504.56247718721;91180.54409728042;91231.5438422817;74970;76893.23106768973;77676.22323776803;77936.61031694805;78937.81593276105;10918.617848375268;11018.50416731233;11087.889121108685;11625.360605166798;11743.530258789895;34453.82773086119;36602.8169859149;37172;37175.25649487049;38001.23997519979;43681.34477982896;45501;46572;47064;48296.5170348292;18076.819231807513;18466.169022393755;18522.16650250715;18678.25286988505;18734.812651873308;19714.112864920826;19910.70133948021;19960.101795418952;19992.400227993185;20307.59384812266;17233.138343083046;18083.36708215206;18851.528711782314;19175.52061198481;19185.8081419184;18857.528561786065;18996.905015474833;19098.331558395388;19625.70561441551;19765.604687905874;17738.5565360867;18347.35784247545;18530.351437699617;18639.72040419422;18709.25162993465;13348.93325533366;13752.31238438054;13963.58109256724;14203.715925681221;14234.14595124296;14500.129992200502;14675.266236688336;15208.935374523677;15398.846011539741;15622.140782257085 05:12:20 INFO - PID 7086 | __end_tp_report 05:12:20 INFO - PID 7086 | __start_cc_report 05:12:20 INFO - PID 7086 | _x_x_mozilla_cycle_collect,405 05:12:20 INFO - PID 7086 | __end_cc_report 05:12:20 INFO - PID 7086 | __startTimestamp1500725540027__endTimestamp 05:12:20 INFO - PID 7086 | 05:12:20 INFO - PID 7086 | ------- Summary: start ------- 05:12:20 INFO - PID 7086 | Number of tests: 6 05:12:20 INFO - PID 7086 | 05:12:20 INFO - PID 7086 | [#0] dojo.html Cycles:165 Average:6087.60 Median:6326.56 stddev:721.35 (11.4%) stddev-sans-first:684.77 05:12:20 INFO - PID 7086 | Values: 3112.8 3149.6 3152.7 3159.0 3168.0 6048.9 6073.6 6079.1 6105.5 6130.2 6106.9 6130.9 6253.6 6311.0 6325.4 5588.9 5634.7 5641.5 5673.4 5705.8 5491.3 5506.9 5604.2 5615.2 5616.7 5595.4 5690.7 5702.1 5724.1 5725.3 5577.3 5597.7 5664.9 5665.2 5675.8 5513.2 5532.5 5556.9 5570.3 5581.0 6053.4 6057.3 6064.9 6091.1 6100.1 6540.0 6565.5 6570.3 6570.7 6580.7 6590.1 6590.5 6596.9 6660.0 6661.0 6009.5 6201.0 6229.2 6240.8 6261.7 6825.6 6829.9 6903.3 6918.4 6933.1 6340.7 6436.3 6467.2 6482.9 6512.7 6545.6 6588.9 6607.9 6612.2 6659.0 6511.3 6548.5 6586.8 6636.9 6650.4 6564.7 6612.2 6678.6 6696.9 6697.1 5284.1 5293.6 5342.4 5362.2 5366.5 4492.1 4539.0 4550.1 4656.9 4675.2 5745.4 5779.2 5782.9 5800.6 5801.2 6600.0 6617.2 6710.4 6717.4 6726.9 5671.3 5712.3 5761.8 5797.6 5804.3 5771.6 5796.5 5863.9 5869.0 5887.3 6446.0 6533.2 6535.0 6536.5 6537.5 6575.5 6638.7 6647.7 6749.6 6751.2 6229.3 6326.6 6410.4 6500.4 6520.1 6559.9 6585.0 6600.9 6603.9 6631.8 6444.6 6560.0 6566.9 6649.9 6654.1 6309.7 6361.2 6399.4 6422.3 6525.1 6434.4 6474.3 6497.4 6502.9 6506.2 6323.1 6399.3 6409.8 6417.9 6442.1 6331.8 6453.4 6456.5 6476.2 6479.4 6233.5 6259.1 6272.8 6288.8 6364.0 05:12:20 INFO - PID 7086 | 05:12:20 INFO - PID 7086 | [#1] ext.html Cycles:180 Average:38148.24 Median:20136.48 stddev:51639.01 (256.4%) stddev-sans-first:51707.65 05:12:20 INFO - PID 7086 | Values: 784.3 843.5 846.2 853.1 1162.7 32015.2 43326.0 44202.8 44242.8 44298.3 43938.8 44158.8 44303.8 44342.3 44370.3 7550.2 7660.4 7724.5 7734.6 7831.6 7653.6 7769.1 7778.4 7793.5 7799.3 7772.3 7829.2 7832.5 7837.8 7842.7 7743.3 7777.8 7790.6 7813.6 7818.1 7657.3 7690.8 7736.9 7739.7 7740.3 38501.0 38811.2 38822.4 38850.6 38897.2 3641.9 3689.7 3691.2 3691.4 3692.7 32317.7 32381.4 32429.7 32439.8 32531.8 4712.8 4859.5 4893.6 4896.7 4930.4 193056.0 194231.0 194585.0 195073.0 195093.0 49281.5 49501.5 49507.5 49509.8 49595.5 51696.0 52273.2 52822.0 52826.5 52897.4 14163.0 16092.4 16149.6 16322.4 16337.7 11811.3 13384.9 13668.1 13686.2 13695.2 14318.8 14326.4 14337.1 14387.9 14480.5 5738.2 5877.1 5936.7 5944.6 5962.9 1002.2 1015.8 1017.5 1023.0 1045.9 22125.4 28491.9 29265.0 29795.1 30195.2 1077.7 1105.6 1106.1 1109.6 1112.0 12154.9 16084.3 16137.7 16434.1 16534.3 238067.0 238427.0 240072.0 240369.0 240379.0 59635.0 59887.1 59891.0 59970.7 60023.7 1469.8 1512.5 1518.2 1518.5 1523.2 27308.0 27355.7 27812.7 27980.9 28010.9 52841.7 54151.0 54278.5 54359.2 54363.2 150595.2 152411.0 152986.0 153650.2 154055.2 33291.3 33847.8 33937.7 36831.3 37454.3 46086.1 46311.8 46465.3 46598.5 46608.3 31052.5 33100.7 33451.7 33466.3 33764.0 31796.4 32779.5 33088.8 33514.3 33634.0 36631.1 37503.6 37577.1 37614.8 37616.1 31689.4 32138.5 32335.4 32581.0 32707.5 22669.9 23498.2 24984.8 25019.2 25920.2 05:12:20 INFO - PID 7086 | 05:12:20 INFO - PID 7086 | [#2] jquery.html Cycles:180 Average:34715.48 Median:23106.65 stddev:82427.71 (356.7%) stddev-sans-first:82619.07 05:12:20 INFO - PID 7086 | Values: 571.6 581.3 587.4 596.6 608.7 21893.8 22133.3 23583.0 23592.3 23636.8 25589.6 25898.5 26156.9 26192.0 26299.3 6436.5 6604.9 6617.5 6620.5 6620.7 5983.0 6467.6 6542.5 6548.3 6550.9 6517.0 6518.0 6527.0 6533.3 6548.3 6507.8 6509.4 6511.9 6523.6 6540.4 6063.8 6069.2 6079.2 6084.8 6089.4 28066.4 29118.0 29582.4 29610.9 29841.1 1932.5 1960.2 1964.8 1968.0 1970.8 18694.0 19396.3 19421.4 19425.7 19438.6 2225.1 2239.6 2296.9 2300.3 2397.3 123499.4 130022.0 130116.0 130334.3 131040.0 13911.4 15082.6 15118.2 15123.8 15404.8 23178.1 23205.0 23214.4 23291.7 23370.5 9899.0 10076.7 10095.0 10102.6 10122.9 9177.6 9198.8 9301.3 9352.9 9407.0 7664.0 8966.3 9133.8 9399.2 9431.7 2640.7 2690.1 2813.3 2817.0 2924.3 951.1 971.0 975.8 995.4 1009.5 18914.1 19552.7 19632.7 19659.4 19949.4 989.8 1042.9 1045.0 1059.3 1066.4 10500.2 10592.4 10711.5 11010.5 11145.3 476293.0 477134.0 493706.0 498039.0 502083.0 118643.0 120585.0 123573.8 123747.0 125930.4 1224.6 1254.7 1292.6 1293.4 1297.5 16540.4 17450.8 17527.4 17590.9 17964.7 53576.7 53719.5 54255.0 54593.2 55846.0 73576.0 74439.6 74489.6 74543.0 74560.0 11683.8 12321.4 13847.3 14303.6 14598.2 23103.9 23109.4 23126.8 23151.5 23190.9 17636.7 18126.7 19462.5 19792.5 19848.9 16975.5 17337.5 17530.6 18084.3 18337.3 17221.4 18868.4 18932.7 20094.0 20141.3 14749.3 15069.8 15097.1 15099.2 15135.5 18012.0 18122.5 18182.4 18201.4 18233.2 05:12:20 INFO - PID 7086 | 05:12:20 INFO - PID 7086 | [#3] mootools.html Cycles:180 Average:8731.59 Median:2597.69 stddev:6060.01 (233.3%) stddev-sans-first:6051.68 05:12:20 INFO - PID 7086 | Values: 1356.6 1385.6 1420.9 1422.1 1424.3 13010.3 13864.2 13883.0 13885.9 13925.7 14710.0 14939.3 14976.9 15004.5 15006.2 2595.1 2648.0 2666.2 2666.6 2667.7 2571.1 2655.5 2701.4 2711.5 2712.7 2526.5 2678.9 2706.2 2707.4 2707.4 2638.4 2639.9 2647.7 2671.3 2676.1 2487.4 2539.6 2596.3 2599.1 2601.2 14230.5 14295.3 14298.5 14304.7 14321.8 7504.2 7842.4 7856.5 7887.6 7899.9 4945.7 4997.1 5061.8 5120.8 5152.7 1887.5 1897.2 1901.7 1946.2 1961.8 23107.8 23312.7 23346.8 23442.5 23444.9 6094.8 6476.9 6523.5 6565.8 6730.9 14475.2 16023.7 16029.2 16064.5 16064.8 7296.3 7450.1 7484.2 7504.1 7582.9 6784.8 6987.4 6991.0 7179.9 7274.8 4858.1 5042.4 5096.1 5096.4 5121.7 1446.5 1452.2 1457.0 1470.3 1475.7 812.5 814.9 826.8 849.3 880.3 6769.6 6794.6 6902.0 6935.7 6995.8 690.6 710.4 717.0 728.9 731.0 3882.4 4118.4 4159.5 4180.2 4191.4 18659.6 18967.3 19381.8 19422.4 19501.0 18295.3 19488.0 19596.8 19632.5 19649.5 10085.2 10352.8 10375.5 10381.4 10385.9 7494.7 8274.1 8456.8 8710.2 8712.7 16301.3 16730.8 16760.8 17393.5 17605.6 17591.5 17768.3 17956.3 17960.4 17967.5 12531.6 12767.9 12815.4 12817.0 12831.9 13270.3 13596.0 13611.3 13612.3 13624.7 10308.3 10879.7 11017.6 11143.2 11338.0 10011.0 10340.8 10658.6 10742.8 11060.6 9164.7 9219.7 9257.9 9263.4 9264.6 6678.5 6849.5 6916.7 7020.5 7033.8 6944.7 6946.2 7024.3 7071.4 7195.5 05:12:20 INFO - PID 7086 | 05:12:20 INFO - PID 7086 | [#4] prototype.html Cycles:180 Average:5399.59 Median:5985.20 stddev:1503.66 (25.1%) stddev-sans-first:1462.13 05:12:20 INFO - PID 7086 | Values: 495.1 497.5 517.0 525.0 526.5 5952.7 6069.5 6116.8 6120.3 6148.6 5955.9 5967.6 6001.8 6061.7 6123.3 4887.7 4889.5 4953.8 4971.3 4979.1 4743.0 4898.4 4933.9 4959.7 4965.9 4825.3 4827.6 4838.9 4868.2 4882.3 4876.0 4892.4 4901.9 4904.0 4920.7 4372.7 4415.8 4428.4 4449.9 4469.2 5896.9 5953.3 5968.6 6006.2 6012.6 5586.5 5602.9 5619.9 5621.0 5649.8 6387.7 6408.0 6439.6 6457.4 6527.6 4792.4 4805.3 4807.0 4844.6 4855.9 6576.2 6646.7 6704.0 6768.6 6809.0 4854.5 4895.4 4914.7 4920.9 4951.4 4986.0 5011.1 5038.7 5047.9 5078.1 5527.8 5593.3 5617.9 5629.6 5671.3 6410.5 6478.4 6491.7 6501.2 6510.5 1648.5 1657.7 1687.1 1705.6 1731.4 1196.2 1207.7 1221.0 1233.7 1235.5 5590.3 5621.3 5642.7 5668.3 5723.6 6404.5 6445.7 6522.2 6563.7 6580.2 5567.4 5667.2 5678.9 5682.7 5740.1 3486.9 3502.8 3504.1 3533.4 3546.4 6217.8 6274.8 6332.4 6420.4 6446.0 6665.3 6680.8 6683.7 6792.7 6797.4 6333.5 6368.2 6380.5 6407.6 6415.8 6584.6 6595.6 6596.3 6614.6 6641.9 6490.4 6495.2 6498.6 6504.1 6534.5 6282.8 6359.8 6369.5 6381.0 6392.3 4924.8 4933.8 4959.9 4963.5 4983.0 6498.8 6610.1 6623.6 6665.4 6707.4 6206.3 6236.4 6292.9 6322.9 6348.5 6131.2 6284.2 6331.4 6361.5 6367.7 6005.8 6158.4 6267.2 6331.7 6342.5 6384.5 6412.4 6461.8 6465.2 6481.0 6097.4 6211.0 6239.5 6253.9 6291.8 05:12:20 INFO - PID 7086 | 05:12:20 INFO - PID 7086 | [#5] yui.html Cycles:180 Average:22003.60 Median:19480.46 stddev:29035.14 (149.0%) stddev-sans-first:29073.38 05:12:20 INFO - PID 7086 | Values: 908.3 911.7 915.6 926.7 926.8 18343.9 19294.9 19306.2 19319.9 19341.4 16910.4 17354.0 18103.0 18108.3 18116.7 1030.6 1066.6 1066.9 1067.1 1067.2 1013.5 1054.4 1056.9 1057.1 1057.1 1110.1 1125.5 1126.8 1127.4 1130.1 1105.8 1118.3 1120.2 1120.9 1123.5 812.6 813.0 818.4 819.6 821.0 18952.3 19428.3 19532.6 19640.8 19643.8 20362.9 20568.6 20795.2 20897.8 20898.4 16067.1 16227.4 16347.1 16480.5 16770.5 3503.4 3520.0 3538.0 3540.4 3542.6 117915.0 120768.0 122444.4 123125.0 125716.4 16235.7 16741.1 16745.7 16749.7 16770.0 28279.0 29778.1 30429.2 30434.2 30509.0 8653.3 8728.0 8761.1 8828.9 8838.3 3995.4 4008.7 4011.4 4024.8 4033.5 5051.4 5096.5 5105.8 5165.3 5223.9 982.9 1011.5 1018.0 1023.2 1025.1 652.4 668.5 677.1 697.8 698.2 11592.2 11898.7 12041.3 12215.7 12422.4 665.1 673.1 689.6 699.8 701.0 5168.3 5641.8 5665.2 5706.1 6004.8 95678.5 99469.5 99825.5 100337.5 102631.5 82851.6 87216.1 87504.6 91180.5 91231.5 74970.0 76893.2 77676.2 77936.6 78937.8 10918.6 11018.5 11087.9 11625.4 11743.5 34453.8 36602.8 37172.0 37175.3 38001.2 43681.3 45501.0 46572.0 47064.0 48296.5 18076.8 18466.2 18522.2 18678.3 18734.8 19714.1 19910.7 19960.1 19992.4 20307.6 17233.1 18083.4 18851.5 19175.5 19185.8 18857.5 18996.9 19098.3 19625.7 19765.6 17738.6 18347.4 18530.4 18639.7 18709.3 13348.9 13752.3 13963.6 14203.7 14234.1 14500.1 14675.3 15208.9 15398.8 15622.1 05:12:20 INFO - PID 7086 | -------- Summary: end -------- 05:12:20 INFO - PID 7086 | 05:12:20 INFO - TEST-INFO | 7086: exit 0 05:12:20 INFO - TEST-OK | dromaeo_css | took 1113611ms 05:12:20 INFO - TEST-START | kraken 05:12:20 INFO - Initialising browser for kraken test... 05:12:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56860/getInfo.html -profile /tmp/tmplOaM6l/profile 05:12:20 INFO - TEST-INFO | started process 7447 (/builds/slave/test/build/application/firefox/firefox http://localhost:56860/getInfo.html) 05:12:27 INFO - TEST-INFO | 7447: exit 0 05:12:27 INFO - Browser initialized. 05:12:27 INFO - Running cycle 1/1 for kraken test... 05:12:27 INFO - TEST-INFO | started process 7665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplOaM6l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:38 INFO - PID 7665 | RSS: Main: 174759936 05:12:38 INFO - PID 7665 | 05:12:41 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56860/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:42 INFO - PID 7665 | RSS: Main: 179367936 05:12:42 INFO - PID 7665 | 05:12:45 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56860/tests/kraken/driver.html?testName=audio-dft) 05:12:45 INFO - PID 7665 | RSS: Main: 180056064 05:12:45 INFO - PID 7665 | 05:12:48 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56860/tests/kraken/driver.html?testName=audio-fft) 05:12:49 INFO - PID 7665 | RSS: Main: 173953024 05:12:49 INFO - PID 7665 | 05:12:51 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56860/tests/kraken/driver.html?testName=audio-oscillator) 05:12:52 INFO - PID 7665 | RSS: Main: 174837760 05:12:52 INFO - PID 7665 | 05:12:54 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:12:54 INFO - PID 7665 | RSS: Main: 174989312 05:12:54 INFO - PID 7665 | 05:12:57 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56860/tests/kraken/driver.html?testName=imaging-darkroom) 05:12:58 INFO - PID 7665 | RSS: Main: 177496064 05:12:58 INFO - PID 7665 | 05:13:02 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56860/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:02 INFO - PID 7665 | RSS: Main: 177688576 05:13:02 INFO - PID 7665 | 05:13:05 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56860/tests/kraken/driver.html?testName=json-parse-financial) 05:13:06 INFO - PID 7665 | RSS: Main: 177983488 05:13:06 INFO - PID 7665 | 05:13:07 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:08 INFO - PID 7665 | RSS: Main: 178343936 05:13:08 INFO - PID 7665 | 05:13:10 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:10 INFO - PID 7665 | RSS: Main: 178655232 05:13:10 INFO - PID 7665 | 05:13:12 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:13 INFO - PID 7665 | RSS: Main: 178532352 05:13:13 INFO - PID 7665 | 05:13:16 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:17 INFO - PID 7665 | RSS: Main: 178733056 05:13:17 INFO - PID 7665 | 05:13:20 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:20 INFO - PID 7665 | RSS: Main: 178941952 05:13:20 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56860/tests/kraken/driver.html?testName=ai-astar) 05:13:22 INFO - PID 7665 | RSS: Main: 180621312 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | __start_tp_report 05:13:22 INFO - PID 7665 | _x_x_mozilla_page_load 05:13:22 INFO - PID 7665 | _x_x_mozilla_page_load_details 05:13:22 INFO - PID 7665 | |i|pagename|runs| 05:13:22 INFO - PID 7665 | |0;ai-astar;99;110;104;109;111;111;111;102;112;115 05:13:22 INFO - PID 7665 | |1;audio-beat-detection;158;121;156;177;124;156;145;123;175;121 05:13:22 INFO - PID 7665 | |2;audio-dft;164;162;164;164;161;163;164;163;165;168 05:13:22 INFO - PID 7665 | |3;audio-fft;76;76;75;167;76;74;75;77;155;76 05:13:22 INFO - PID 7665 | |4;audio-oscillator;81;80;130;82;82;83;136;82;81;129 05:13:22 INFO - PID 7665 | |5;imaging-gaussian-blur;114;115;116;115;115;113;115;115;115;120 05:13:22 INFO - PID 7665 | |6;imaging-darkroom;153;150;150;150;151;151;151;153;151;151 05:13:22 INFO - PID 7665 | |7;imaging-desaturate;94;94;94;93;94;93;94;95;94;93 05:13:22 INFO - PID 7665 | |8;json-parse-financial;55;54;53;55;55;54;59;54;54;54 05:13:22 INFO - PID 7665 | |9;json-stringify-tinderbox;54;54;55;54;54;54;54;55;56;55 05:13:22 INFO - PID 7665 | |10;stanford-crypto-aes;85;88;79;91;78;78;77;87;78;78 05:13:22 INFO - PID 7665 | |11;stanford-crypto-ccm;134;141;134;128;126;136;127;127;142;161 05:13:22 INFO - PID 7665 | |12;stanford-crypto-pbkdf2;188;179;184;190;178;176;179;176;189;178 05:13:22 INFO - PID 7665 | |13;stanford-crypto-sha256-iterative;72;71;77;68;77;69;68;73;75;68 05:13:22 INFO - PID 7665 | __end_tp_report 05:13:22 INFO - PID 7665 | __start_cc_report 05:13:22 INFO - PID 7665 | _x_x_mozilla_cycle_collect,1010 05:13:22 INFO - PID 7665 | __end_cc_report 05:13:22 INFO - PID 7665 | __startTimestamp1500725602837__endTimestamp 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | ------- Summary: start ------- 05:13:22 INFO - PID 7665 | Number of tests: 14 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#0] ai-astar Cycles:10 Average:108.40 Median:111.00 stddev:5.04 (4.5%) stddev-sans-first:4.03 05:13:22 INFO - PID 7665 | Values: 99.0 110.0 104.0 109.0 111.0 111.0 111.0 102.0 112.0 115.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:156.00 stddev:22.13 (14.2%) stddev-sans-first:23.02 05:13:22 INFO - PID 7665 | Values: 158.0 121.0 156.0 177.0 124.0 156.0 145.0 123.0 175.0 121.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.87 (1.1%) stddev-sans-first:1.99 05:13:22 INFO - PID 7665 | Values: 164.0 162.0 164.0 164.0 161.0 163.0 164.0 163.0 165.0 168.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#3] audio-fft Cycles:10 Average:92.70 Median:76.00 stddev:36.12 (47.5%) stddev-sans-first:37.80 05:13:22 INFO - PID 7665 | Values: 76.0 76.0 75.0 167.0 76.0 74.0 75.0 77.0 155.0 76.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:81.50 stddev:24.28 (29.8%) stddev-sans-first:25.08 05:13:22 INFO - PID 7665 | Values: 81.0 80.0 130.0 82.0 82.0 83.0 136.0 82.0 81.0 129.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.83 (1.6%) stddev-sans-first:1.88 05:13:22 INFO - PID 7665 | Values: 114.0 115.0 116.0 115.0 115.0 113.0 115.0 115.0 115.0 120.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.10 (0.7%) stddev-sans-first:0.93 05:13:22 INFO - PID 7665 | Values: 153.0 150.0 150.0 150.0 151.0 151.0 151.0 153.0 151.0 151.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 05:13:22 INFO - PID 7665 | Values: 94.0 94.0 94.0 93.0 94.0 93.0 94.0 95.0 94.0 93.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.50 stddev:1.64 (3.0%) stddev-sans-first:1.73 05:13:22 INFO - PID 7665 | Values: 55.0 54.0 53.0 55.0 55.0 54.0 59.0 54.0 54.0 54.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 05:13:22 INFO - PID 7665 | Values: 54.0 54.0 55.0 54.0 54.0 54.0 54.0 55.0 56.0 55.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:5.26 (6.4%) stddev-sans-first:5.46 05:13:22 INFO - PID 7665 | Values: 85.0 88.0 79.0 91.0 78.0 78.0 77.0 87.0 78.0 78.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:135.00 stddev:10.64 (7.9%) stddev-sans-first:11.27 05:13:22 INFO - PID 7665 | Values: 134.0 141.0 134.0 128.0 126.0 136.0 127.0 127.0 142.0 161.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.70 Median:181.50 stddev:5.52 (3.0%) stddev-sans-first:5.36 05:13:22 INFO - PID 7665 | Values: 188.0 179.0 184.0 190.0 178.0 176.0 179.0 176.0 189.0 178.0 05:13:22 INFO - PID 7665 | 05:13:22 INFO - PID 7665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.50 stddev:3.61 (5.0%) stddev-sans-first:3.83 05:13:22 INFO - PID 7665 | Values: 72.0 71.0 77.0 68.0 77.0 69.0 68.0 73.0 75.0 68.0 05:13:22 INFO - PID 7665 | -------- Summary: end -------- 05:13:22 INFO - PID 7665 | 05:13:23 INFO - PID 7665 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:13:23 INFO - TEST-INFO | 7665: exit 0 05:13:23 INFO - TEST-OK | kraken | took 62766ms 05:13:23 INFO - SUITE-END | took 1176s 05:13:23 INFO - Completed test suite (00:19:36) 05:13:23 INFO - javascript benchmark 05:13:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8433.480015826113, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.782105252632, 3149.59055322808, 3152.684731526849, 3158.984205078975, 3167.968320316796, 6048.939510604892, 6073.574849760518, 6079.118527813464, 6105.511559075275, 6130.203073600432, 6106.877862442749, 6130.87738245236, 6253.624782513052, 6310.96844515778, 6325.4307112359875, 5588.91616625751, 5634.7182640867795, 5641.464060914206, 5673.375928647845, 5705.828825135252, 5491.313585801775, 5506.91739623906, 5604.1593760935775, 5615.213870058195, 5616.663000219979, 5595.4124816894255, 5690.715464226813, 5702.059160238556, 5724.141378793172, 5725.341585717654, 5577.330720313547, 5597.6641401516035, 5664.915026274609, 5665.1502274658715, 5675.801346952837, 5513.228148059275, 5532.529734972532, 5556.86107847303, 5570.275864137677, 5581.023320918823, 6053.364396738323, 6057.3336932937345, 6064.878702425971, 6091.14723938649, 6100.115483254947, 6540.018997150418, 6565.54041217115, 6570.277269500399, 6570.671466426659, 6580.736770529173, 6590.110335104748, 6590.538662293641, 6596.86806263872, 6659.966700166468, 6661.0, 6009.549283803689, 6201.0, 6229.159063526411, 6240.750369985195, 6261.749530018839, 6825.624590647462, 6829.863402731918, 6903.344182302673, 6918.411934985583, 6933.064036355128, 6340.651264180515, 6436.3241859605005, 6467.159269294962, 6482.870342593122, 6512.674366281667, 6545.639989800511, 6588.912829383194, 6607.933920660732, 6612.206535215805, 6658.966705166443, 6511.2512061113575, 6548.476121910236, 6586.80239592813, 6636.900446493307, 6650.401463868275, 6564.737410503526, 6612.173478315211, 6678.6326752028135, 6696.8995465068065, 6697.062411262427, 5284.101702710548, 5293.57651387888, 5342.385625653022, 5362.249285100089, 5366.490183432567, 4492.146492166478, 4539.0, 4550.067236216568, 4656.883577910512, 4675.2052151134385, 5745.368009518949, 5779.162021506858, 5782.913256301159, 5800.5939584229545, 5801.158831969341, 6599.967000164968, 6617.239017512951, 6710.396064354231, 6717.395434410926, 6726.932730672631, 5671.262735844396, 5712.343080545707, 5761.827145185651, 5797.565182611321, 5804.303483581997, 5771.624844385102, 5796.536277097822, 5863.853403664943, 5869.0, 5887.322957859816, 6446.033095035782, 6533.24867640218, 6535.0, 6536.509761767887, 6537.477001839747, 6575.473962083118, 6638.668066596554, 6647.734090636513, 6749.628770417477, 6751.156105486814, 6229.2524897012645, 6326.557141000086, 6410.358964103552, 6500.414962653384, 6520.119783829123, 6559.901601476077, 6585.0, 6600.933990660032, 6603.9009414859775, 6631.801045968628, 6444.581102228528, 6560.048792924904, 6566.9343306566325, 6649.900251496329, 6654.13496245485, 6309.652969086561, 6361.236651601837, 6399.392057754506, 6422.32565580626, 6525.119108920425, 6434.388733070351, 6474.2878283387845, 6497.350264973465, 6502.934970650233, 6506.154199953976, 6323.1463752394675, 6399.328070552711, 6409.839754006187, 6417.8716425672155, 6442.130312407952, 6331.778387756406, 6453.354664533509, 6456.451201647725, 6476.190476190476, 6479.352064793671, 6233.470155036691, 6259.092431597484, 6272.8118156455375, 6288.811335659938, 6364.0], "value": 6033.638964471517, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.3372350363944, 843.4559708987703, 846.2383854530922, 853.1127627267638, 1162.6628277799439, 32015.199620009513, 43326.0, 44202.778986105026, 44242.778786106064, 44298.33552496715, 43938.7803060985, 44158.77920610392, 44303.77848110755, 44342.33486497705, 44370.33444498335, 7550.244975502461, 7660.387169026479, 7724.459287849852, 7734.613269336511, 7831.569263690495, 7653.579053152074, 7769.0677118745825, 7778.4166187535875, 7793.532388056735, 7799.298063174313, 7772.3393511551585, 7829.17793631669, 7832.530048197098, 7837.804054898645, 7842.686292548291, 7743.341815945651, 7777.805554861117, 7790.610469476532, 7813.648385822652, 7818.06183258007, 7657.310842024189, 7690.807729806799, 7736.883946740803, 7739.729109481197, 7740.26467485588, 38501.0, 38811.22377552462, 38822.41766373507, 38850.61149388498, 38897.22205555901, 3641.8725344613076, 3689.6679298863232, 3691.151035261878, 3691.372466680644, 3692.7045836333027, 32317.6768232317, 32381.35237295241, 32429.6757032429, 32439.837800810845, 32531.837340813145, 4712.835050773207, 4859.465458799529, 4893.608511319086, 4896.657233993622, 4930.408350997904, 193056.0, 194231.0, 194585.0, 195073.0, 195093.02453487783, 49281.50718492841, 49501.52492375367, 49507.50492495101, 49509.75245123752, 49595.50404495981, 51696.0, 52273.215901761505, 52822.0, 52826.471735282925, 52897.413077607736, 14163.0, 16092.436764713178, 16149.596260093356, 16322.428714994918, 16337.673246535003, 11811.291322520676, 13384.866151338361, 13668.111572747739, 13686.178829270275, 13695.178289302674, 14318.785218221736, 14326.426942922375, 14337.139771613736, 14387.856121438861, 14480.493182738554, 5738.196652468658, 5877.118432235114, 5936.673482958478, 5944.583879128506, 5962.880742385215, 1002.1932344462778, 1015.8120747661707, 1017.5217647705566, 1022.9693109206736, 1045.8744950605976, 22125.446863828212, 28491.857540712164, 29265.0, 29795.10614681563, 30195.245118871764, 1077.7305673581604, 1105.5909313554037, 1106.076426184129, 1109.589451902801, 1112.010310823368, 12154.939225303993, 16084.276207570687, 16137.67724645524, 16434.076026193983, 16534.338626455046, 238067.0, 238427.0, 240072.0, 240369.0, 240379.0, 59635.0, 59887.10169347463, 59891.0, 59970.70014649899, 60023.69988150118, 1469.7648376259747, 1512.470635277644, 1518.1574226304508, 1518.5140754958306, 1523.2079318754186, 27308.0, 27355.72644273532, 27812.721872781014, 27980.86009569939, 28010.85994570014, 52841.735791320796, 54151.0, 54278.45721542734, 54359.184612230056, 54363.18455223096, 150595.24702376418, 152411.0, 152986.0, 153650.23174884054, 154055.22972385515, 33291.334173316885, 33847.83076084604, 33937.66062339345, 36831.263374732895, 37454.250914981, 46086.078278433575, 46311.76844115893, 46465.303020455394, 46598.53401465942, 46608.30087548622, 31052.534211986385, 33100.66899330976, 33451.665483344856, 33466.330673385906, 33764.0, 31796.36407271795, 32779.508307374934, 33088.83455582707, 33514.329713406085, 33634.0, 36631.08422289464, 37503.624963750015, 37577.060573485884, 37614.811925940194, 37616.059598510255, 31689.36621267608, 32138.517922231655, 32335.353292933538, 32581.0, 32707.509387358732, 22669.88665056664, 23498.177563785186, 24984.750152498244, 25019.249422517354, 25920.22239332823], "value": 17863.439365690607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.611304313067, 581.2734082397006, 587.3979171349368, 596.561527277451, 608.677400977482, 21893.781062189373, 22133.335999920007, 23583.0, 23592.29223123305, 23636.763632363673, 25589.616155757678, 25898.48203035938, 26156.869215653896, 26192.0, 26299.3425164371, 6436.549441539082, 6604.867902641944, 6617.503687223453, 6620.470362370998, 6620.702068406933, 5983.0, 6467.644279564622, 6542.50931180161, 6548.312427195124, 6550.8689826203445, 6516.967415162918, 6517.967410162966, 6527.0, 6533.281339052701, 6548.345165483461, 6507.772227971998, 6509.446697030734, 6511.902321465182, 6523.608583485006, 6540.4440622547145, 6063.818085457443, 6069.15031895535, 6079.240094988127, 6084.756609735606, 6089.360617135226, 28066.43867122646, 29118.0, 29582.408351832844, 29610.851945740134, 29841.104766857028, 1932.5361913140885, 1960.1669290551458, 1964.803519648038, 1968.0258272155231, 1970.8226259636701, 18694.0, 19396.321128760424, 19421.4173574793, 19425.708614370797, 19438.611227775364, 2225.0654725015534, 2239.6080685879906, 2296.873671948042, 2300.344401845483, 2397.3407312988893, 123499.3825030878, 130022.0, 130116.0, 130334.3483282587, 131040.0, 13911.373988170557, 15082.622934426727, 15118.168500732565, 15123.773143402857, 15404.768928466083, 23178.072877084727, 23205.0, 23214.41963950881, 23291.650625240636, 23370.532589348117, 9898.950505247427, 10076.748081298027, 10095.0, 10102.595896164217, 10122.898771012344, 9177.587008584629, 9198.770030749285, 9301.255899528156, 9352.859707104399, 9406.95296523513, 7663.961680191564, 8966.327525435618, 9133.812604361523, 9399.201067909304, 9431.6698915539, 2640.6567146270863, 2690.125709144536, 2813.324802047494, 2817.0, 2924.2543151496234, 951.1344676344631, 971.0, 975.8487434447673, 995.4475266227313, 1009.5204777730667, 18914.148863301183, 19552.706709399372, 19632.70550941737, 19659.41021769349, 19949.401517954484, 989.8069876374182, 1042.8748550173875, 1044.9791004180026, 1059.3432072115338, 1066.4347895615335, 10500.212484063726, 10592.364458132382, 10711.517981690842, 11010.50452729613, 11145.331280123219, 476293.0, 477134.0, 493706.0, 498039.0, 502083.0, 118643.0, 120585.0, 123573.76426235623, 123747.0, 125930.37034814767, 1224.5836415618733, 1254.736505333872, 1292.6186774901428, 1293.4373547506864, 1297.474522818279, 16540.421085261958, 17450.798124881287, 17527.386541470987, 17590.94454332744, 17964.73052904181, 53576.73211633917, 53719.46280537145, 54255.0, 54593.1811022827, 55846.0, 73576.0, 74439.62780186064, 74489.62755186406, 74543.0, 74560.0, 11683.824742628698, 12321.44553495077, 13847.30763461843, 14303.570892873231, 14598.197099159648, 23103.88448057749, 23109.422264443525, 23126.768732312463, 23151.536969260185, 23190.884045579664, 17636.73544896853, 18126.72809907826, 19462.513437164183, 19792.505187370432, 19848.90075549613, 16975.490735277963, 17337.479875603247, 17530.649387011934, 18084.276628935222, 18337.266509339475, 17221.39725109615, 18868.43394698161, 18932.716009259595, 20094.0, 20141.295054673017, 14749.336279867646, 15069.773953390928, 15097.094174349575, 15099.169545675093, 15135.470258540898, 18012.0, 18122.546936326697, 18182.36361727333, 18201.362952296608, 18233.179506921955], "value": 11960.874352327786, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.559118286557, 1385.570473153322, 1420.9289535523221, 1422.082756621979, 1424.3448013913599, 13010.349482525871, 13864.168149911, 13883.028188026818, 13885.861141388583, 13925.721485570282, 14710.0, 14939.253037348144, 14976.925115374435, 15004.474843380483, 15006.174660393674, 2595.1306312385373, 2648.0202325139726, 2666.1868130220273, 2666.5733482642686, 2667.719889411613, 2571.0872640212738, 2655.5485567453484, 2701.4326991331845, 2711.4577084583066, 2712.742289482496, 2526.494701059786, 2678.9464210715773, 2706.2287248134285, 2707.3637695141624, 2707.390837061665, 2638.4459263554677, 2639.907603233887, 2647.6690413698384, 2671.2654020144423, 2676.1035053256987, 2487.3657217409445, 2539.606361014046, 2596.31197732601, 2599.0643368387364, 2601.206631977246, 14230.501932432418, 14295.28523573817, 14298.499552515612, 14304.713905721932, 14321.78517322241, 7504.249575042507, 7842.372610191171, 7856.450048496607, 7887.566183859885, 7899.881501777478, 4945.67853089548, 4997.100521906055, 5061.822836200715, 5120.820771272987, 5152.742362881879, 1887.5186827359073, 1897.2031746666296, 1901.6767149584605, 1946.240966023252, 1961.7743959444704, 23107.76892231073, 23312.650310245528, 23346.766532334797, 23442.53114937692, 23444.88277558601, 6094.786682466092, 6476.902846457307, 6523.510736694767, 6565.80302590923, 6730.899036514456, 14475.203863787592, 16023.679526409407, 16029.19854007295, 16064.518064458085, 16064.839351606568, 7296.270372962767, 7450.143233528213, 7484.176740558534, 7504.099508059068, 7582.886256706154, 6784.8303792404595, 6987.406070484066, 6990.965045174741, 7179.928200717926, 7274.781756547312, 4858.149823780825, 5042.42012168598, 5096.108181068298, 5096.413912400048, 5121.74391280442, 1446.4503488674236, 1452.1650051220379, 1456.978145327821, 1470.2942587557818, 1475.6753514226853, 812.5165526511717, 814.9266566009088, 826.8387664405383, 849.2781136034322, 880.2649787427441, 6769.613800053362, 6794.558353706993, 6901.999210114605, 6935.6878940447805, 6995.825104372431, 690.5511417578614, 710.4139085254583, 716.9677364518609, 728.8505856299446, 730.9707611695579, 3882.437046628223, 4118.382242663624, 4159.480064991876, 4180.163967206571, 4191.413202151702, 18659.626807464047, 18967.336143235196, 19381.806181938002, 19422.417327480198, 19501.0, 18295.26818927228, 19488.0, 19596.804031959782, 19632.509187270432, 19649.508762281057, 10085.193184545218, 10352.844707329396, 10375.533101010473, 10381.377117372982, 10385.948070259752, 7494.662740176815, 8274.13121622221, 8456.830863382575, 8710.21608055278, 8712.651493940171, 16301.26644301033, 16730.832691672927, 16760.832391675925, 17393.478195654152, 17605.64788704193, 17591.472255832345, 17768.28926842912, 17956.281748729903, 17960.371387001393, 17967.460976170736, 12531.624051278477, 12767.87232127704, 12815.359232038174, 12817.038722095693, 12831.871681283068, 13270.33648317561, 13596.0, 13611.31943402806, 13612.25132617676, 13624.65938351549, 10308.32995855267, 10879.673609791718, 11017.559297628006, 11143.164262680493, 11338.0, 10011.0, 10340.844887326546, 10658.62694805678, 10742.785144297226, 11060.557577697124, 9164.725058248263, 9219.723408297761, 9257.907420925705, 9263.351565390358, 9264.629414823332, 6678.465722742266, 6849.520533562602, 6916.688749006407, 7020.543664661985, 7033.788986330418, 6944.722211111701, 6946.2011868635755, 7024.26245244242, 7071.36357727807, 7195.46034047459], "value": 6281.367661014116, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.13185576593776, 497.46850347344855, 516.9948300516995, 524.984250472486, 526.5340173946057, 5952.70236488176, 6069.5144388448925, 6116.7553297868035, 6120.296165940918, 6148.63108213507, 5955.910661340084, 5967.612105213158, 6001.849953751158, 6061.696915154235, 6123.326434092246, 4887.682300650446, 4889.486603906592, 4953.777080031389, 4971.304017437562, 4979.10376132296, 4743.035602748282, 4898.387701537308, 4933.901321973558, 4959.6528243023, 4965.925511117336, 4825.252085926687, 4827.58965487934, 4838.870896805394, 4868.245421959602, 4882.340883980671, 4876.0, 4892.3639926809465, 4901.926471102936, 4903.950960490385, 4920.729359885205, 4372.693911426201, 4415.845445409427, 4428.40216570762, 4449.888752781207, 4469.150861336336, 5896.882062358772, 5953.2856057272975, 5968.552358573124, 6006.249218847644, 6012.617098067425, 5586.469285417878, 5602.887942241173, 5619.915701264485, 5620.971895140539, 5649.830505084854, 6387.668500997149, 6407.967960160216, 6439.581427207217, 6457.354264573552, 6527.640979746112, 4792.424909010906, 4805.303231031516, 4806.975965120187, 4844.636652251095, 4855.902881942377, 6576.172245934295, 6646.700898459581, 6703.966480167568, 6768.593884366954, 6808.97865320201, 4854.514548545118, 4895.408992077589, 4914.729689867092, 4920.876978075506, 4951.430585482643, 4986.002799440126, 5011.1481048221885, 5038.722870242099, 5047.924281135786, 5078.111330517218, 5527.806526771544, 5593.300837395325, 5617.9438205618235, 5629.577781666391, 5671.347795003628, 6410.455111315498, 6478.4169424752, 6491.67541622917, 6501.187351581052, 6510.470039540704, 1648.4807285704965, 1657.693326734558, 1687.05524906053, 1705.6440130096603, 1731.437282883068, 1196.1686627793774, 1207.7342984543386, 1220.951161953512, 1233.7039110613389, 1235.4502246500401, 5590.301212348457, 5621.297337832771, 5642.6864985355805, 5668.319801623831, 5723.599348045597, 6404.48764098871, 6445.742170313229, 6522.217333919865, 6563.737450502022, 6580.243272023683, 5567.387587365387, 5667.234923285386, 5678.943210567924, 5682.7442765075675, 5740.13897915316, 3486.91282717929, 3502.772319799256, 3504.123969007748, 3533.3993221152464, 3546.3793836078585, 6217.813465596039, 6274.780382686584, 6332.366763323723, 6420.390062944013, 6445.967770161119, 6665.300143484961, 6680.799576012728, 6683.732650693918, 6792.694328755218, 6797.388235058868, 6333.46165575922, 6368.235811702625, 6380.457661098859, 6407.590330127365, 6415.839604009937, 6584.637844918576, 6595.558664102231, 6596.30738772422, 6614.570052946543, 6641.933580664131, 6490.415862572391, 6495.213816200583, 6498.610083395011, 6504.089427480251, 6534.477241820738, 6282.780102696383, 6359.841003974938, 6369.45859601939, 6381.0, 6392.264889537762, 4924.8276310328965, 4933.777979990838, 4959.925601116059, 4963.478834722447, 4983.0, 6498.805035848932, 6610.10763546915, 6623.602583844985, 6665.433438157811, 6707.396334329934, 6206.348333424925, 6236.438720515175, 6292.937070629235, 6322.936770632235, 6348.4925702749715, 6131.172291740558, 6284.151639528788, 6331.398517140864, 6361.522885783492, 6367.713452894538, 6005.8349819156365, 6158.414950579688, 6267.1539342188225, 6331.746730130743, 6342.524310676626, 6384.457321127757, 6412.35876412355, 6461.838454038687, 6465.224173099258, 6481.0, 6097.420745029215, 6211.0, 6239.4696450800375, 6253.874922501615, 6291.842703932438], "value": 4958.812765206447, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.2960705453277, 911.6717981526651, 915.6245939164944, 926.7080869526096, 926.7683079230193, 18343.908280458596, 19294.903525482354, 19306.227750889982, 19319.903400483014, 19341.419757407282, 16910.408135715254, 17354.0, 18103.0, 18108.275668973227, 18116.72824907624, 1030.5877648940427, 1066.5733706517417, 1066.898644628763, 1067.1036329483234, 1067.2209287220335, 1013.513513513514, 1054.3568423261804, 1056.9471526423686, 1057.0961827637375, 1057.148995058977, 1110.1396417776248, 1125.4935279124386, 1126.8366086917392, 1127.4362818590705, 1130.146739211898, 1105.8285965675293, 1118.3234143343282, 1120.176670147441, 1120.8991190792826, 1123.5056575107008, 812.6383759227147, 813.0487329824061, 818.3902992270796, 819.6393586821779, 821.0434843407423, 18952.336668216685, 19428.320008799623, 19532.609347812962, 19640.821550707, 19643.82137071766, 20362.898185509126, 20568.588628227353, 20795.16819327225, 20897.79102208989, 20898.37304880856, 16067.116308603023, 16227.350905963747, 16347.100909449975, 16480.505584832474, 16770.496885093467, 3503.3518799022263, 3520.0, 3537.9823100884587, 3540.3627347077518, 3542.6103128655827, 117915.0, 120768.0, 122444.38777806143, 123125.0, 125716.37141814324, 16235.675286494205, 16741.07924064188, 16745.665086698198, 16749.66500670004, 16770.0, 28279.0, 29778.10665680033, 30429.239269018453, 30434.239144021132, 30509.0, 8653.307735381155, 8728.0, 8761.080086590944, 8828.8675669865, 8838.29293656506, 3995.400689896481, 4008.7394319369146, 4011.398290256485, 4024.7987600619854, 4033.515978082649, 5051.444341122474, 5096.464871188472, 5105.821296254613, 5165.302684137593, 5223.895522089537, 982.8574856645746, 1011.5397494140149, 1017.99491002546, 1023.2428003277521, 1025.0569476082023, 652.4269612328011, 668.5220067651652, 677.11298199359, 697.7976386847859, 698.1622053535777, 11592.246503977214, 11898.702532436759, 12041.33772642513, 12215.694607634703, 12422.440990155465, 665.1486097794831, 673.0543586261213, 689.6000319814495, 699.8005568412977, 700.9905735740517, 5168.328117344721, 5641.830745077655, 5665.150227465913, 5706.144078388275, 6004.819855404345, 95678.52160739152, 99469.50265248628, 99825.50087249518, 100337.49831250797, 102631.48684256531, 82851.58574207211, 87216.12783872207, 87504.56247718721, 91180.54409728042, 91231.5438422817, 74970.0, 76893.23106768973, 77676.22323776803, 77936.61031694805, 78937.81593276105, 10918.617848375268, 11018.50416731233, 11087.889121108685, 11625.360605166798, 11743.530258789895, 34453.82773086119, 36602.8169859149, 37172.0, 37175.25649487049, 38001.23997519979, 43681.34477982896, 45501.0, 46572.0, 47064.0, 48296.5170348292, 18076.819231807513, 18466.169022393755, 18522.16650250715, 18678.25286988505, 18734.812651873308, 19714.112864920826, 19910.70133948021, 19960.101795418952, 19992.400227993185, 20307.59384812266, 17233.138343083046, 18083.36708215206, 18851.528711782314, 19175.52061198481, 19185.8081419184, 18857.528561786065, 18996.905015474833, 19098.331558395388, 19625.70561441551, 19765.604687905874, 17738.5565360867, 18347.35784247545, 18530.351437699617, 18639.72040419422, 18709.25162993465, 13348.93325533366, 13752.31238438054, 13963.58109256724, 14203.715925681221, 14234.14595124296, 14500.129992200502, 14675.266236688336, 15208.935374523677, 15398.846011539741, 15622.140782257085], "value": 8959.274823708094, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 104.0, 109.0, 111.0, 111.0, 111.0, 102.0, 112.0, 115.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 121.0, 156.0, 177.0, 124.0, 156.0, 145.0, 123.0, 175.0, 121.0], "value": 145.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 164.0, 161.0, 163.0, 164.0, 163.0, 165.0, 168.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 167.0, 76.0, 74.0, 75.0, 77.0, 155.0, 76.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 130.0, 82.0, 82.0, 83.0, 136.0, 82.0, 81.0, 129.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 116.0, 115.0, 115.0, 113.0, 115.0, 115.0, 115.0, 120.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 150.0, 150.0, 151.0, 151.0, 151.0, 153.0, 151.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 95.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 55.0, 55.0, 54.0, 59.0, 54.0, 54.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 56.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 79.0, 91.0, 78.0, 78.0, 77.0, 87.0, 78.0, 78.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 141.0, 134.0, 128.0, 126.0, 136.0, 127.0, 127.0, 142.0, 161.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 179.0, 184.0, 190.0, 178.0, 176.0, 179.0, 176.0, 189.0, 178.0], "value": 181.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 77.0, 68.0, 77.0, 69.0, 68.0, 73.0, 75.0, 68.0], "value": 71.8, "unit": "score"}]}]} 05:13:24 INFO - Return code: 0 05:13:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:13:24 INFO - # TBPL SUCCESS # 05:13:24 INFO - Running post-action listener: _package_coverage_data 05:13:24 INFO - Running post-action listener: _resource_record_post_action 05:13:24 INFO - [mozharness: 2017-07-22 12:13:24.142477Z] Finished run-tests step (success) 05:13:24 INFO - Running post-run listener: _resource_record_post_run 05:13:24 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 495616; Write bytes: 450433024; Read time: 80; Write time: 370312 05:13:24 INFO - TinderboxPrint: CPU usage
13.1% 05:13:24 INFO - TinderboxPrint: I/O read bytes / time
495,616 / 80 05:13:24 INFO - TinderboxPrint: I/O write bytes / time
450,433,024 / 370,312 05:13:24 INFO - TinderboxPrint: CPU idle
8,274.8 (86.8%) 05:13:24 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 05:13:24 INFO - TinderboxPrint: Swap in / out
0 / 0 05:13:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107184128; Read time: 0; Write time: 120584 05:13:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:13:24 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 491520; Write bytes: 328531968; Read time: 60; Write time: 229380 05:13:24 INFO - Running post-run listener: _upload_blobber_files 05:13:24 INFO - Blob upload gear active. 05:13:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:13:24 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 05:13:24 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:13:24 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:13:25 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:13:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:13:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:26 INFO - (blobuploader) - INFO - Done attempting. 05:13:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:13:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:13:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:26 INFO - (blobuploader) - INFO - Done attempting. 05:13:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:13:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:13:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:27 INFO - (blobuploader) - INFO - Done attempting. 05:13:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:13:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:13:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:31 INFO - (blobuploader) - INFO - Done attempting. 05:13:31 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:31 INFO - Return code: 0 05:13:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:13:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:31 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a4b18cf34c80b80064f8fed914223d195b19e59c29269d2a46a859e39da1d4ba69f14d0e24f2e2b96abc488d309e4ce16a99c61d30d9bbb3aed44cc9925159d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ce8ea59a68134a33d4c048888b9a8aed09396dfa1f8eabbadf0789d245bfd49049e88d9dd77a70a6a8e08539a440178cb9a4fb674071bbcf4a019004effd643", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d715ab15c48eb0b8606b9aad73237e30788e5b6a5bb9c1997da07aa4774a94b3a871dd30e783f1ed6f4eb3a8d5efbdae96e85bb5003df8ff650fd0949b5fbec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abe6ecfc9de4a9db4f40e6903dd78e70a54471dfcbd1728c8b55295fa2f222394b9945b7ae73eb4a2a5bdd26faa09f121a264319410e6e8813ec39796c7b2905"} 05:13:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:13:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:13:31 INFO - Contents: 05:13:31 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a4b18cf34c80b80064f8fed914223d195b19e59c29269d2a46a859e39da1d4ba69f14d0e24f2e2b96abc488d309e4ce16a99c61d30d9bbb3aed44cc9925159d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ce8ea59a68134a33d4c048888b9a8aed09396dfa1f8eabbadf0789d245bfd49049e88d9dd77a70a6a8e08539a440178cb9a4fb674071bbcf4a019004effd643", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d715ab15c48eb0b8606b9aad73237e30788e5b6a5bb9c1997da07aa4774a94b3a871dd30e783f1ed6f4eb3a8d5efbdae96e85bb5003df8ff650fd0949b5fbec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abe6ecfc9de4a9db4f40e6903dd78e70a54471dfcbd1728c8b55295fa2f222394b9945b7ae73eb4a2a5bdd26faa09f121a264319410e6e8813ec39796c7b2905"} 05:13:31 INFO - Running post-run listener: copy_logs_to_upload_dir 05:13:31 INFO - Copying logs to upload dir... 05:13:31 INFO - mkdir: /builds/slave/test/build/upload/logs 05:13:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.410136 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-07-22 05:13:31.079758) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 05:13:31.083171) ========= 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=14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a4b18cf34c80b80064f8fed914223d195b19e59c29269d2a46a859e39da1d4ba69f14d0e24f2e2b96abc488d309e4ce16a99c61d30d9bbb3aed44cc9925159d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ce8ea59a68134a33d4c048888b9a8aed09396dfa1f8eabbadf0789d245bfd49049e88d9dd77a70a6a8e08539a440178cb9a4fb674071bbcf4a019004effd643", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d715ab15c48eb0b8606b9aad73237e30788e5b6a5bb9c1997da07aa4774a94b3a871dd30e783f1ed6f4eb3a8d5efbdae96e85bb5003df8ff650fd0949b5fbec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abe6ecfc9de4a9db4f40e6903dd78e70a54471dfcbd1728c8b55295fa2f222394b9945b7ae73eb4a2a5bdd26faa09f121a264319410e6e8813ec39796c7b2905"} build_url:https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011527 build_url: 'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a4b18cf34c80b80064f8fed914223d195b19e59c29269d2a46a859e39da1d4ba69f14d0e24f2e2b96abc488d309e4ce16a99c61d30d9bbb3aed44cc9925159d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ce8ea59a68134a33d4c048888b9a8aed09396dfa1f8eabbadf0789d245bfd49049e88d9dd77a70a6a8e08539a440178cb9a4fb674071bbcf4a019004effd643", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d715ab15c48eb0b8606b9aad73237e30788e5b6a5bb9c1997da07aa4774a94b3a871dd30e783f1ed6f4eb3a8d5efbdae96e85bb5003df8ff650fd0949b5fbec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abe6ecfc9de4a9db4f40e6903dd78e70a54471dfcbd1728c8b55295fa2f222394b9945b7ae73eb4a2a5bdd26faa09f121a264319410e6e8813ec39796c7b2905"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 05:13:31.107693) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 05:13:31.108036) ========= 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=14ef55db36f7623abb31b9cf000001d5-1500720803.209034-1995879802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 05:13:31.191787) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 05:13:31.192106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 05:13:31.192429) ========= ========= Total master_lag: 0.16 =========