builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1501207376.7 results: success (0) revision: 556f19ef392ac2d9aac579864e2179d6c1d464e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:56.697194) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:56.697715) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:56.698064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:56.751855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:56.752683) ========= 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=3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-27 19:02:56-- 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% 42.9M=0s 2017-07-27 19:02:56 (42.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.158717 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:56.967350) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:56.967719) ========= 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=3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018324 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:57.018539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:57.018969) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 556f19ef392ac2d9aac579864e2179d6c1d464e8 --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 556f19ef392ac2d9aac579864e2179d6c1d464e8 --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=3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-27 19:02:57,010 truncating revision to first 12 chars 2017-07-27 19:02:57,010 Setting DEBUG logging. 2017-07-27 19:02:57,010 attempt 1/10 2017-07-27 19:02:57,010 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/556f19ef392a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-27 19:02:57,322 unpacking tar archive at: mozilla-central-556f19ef392a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617911 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:57.653918) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:57.654640) ========= script_repo_revision: 556f19ef392ac2d9aac579864e2179d6c1d464e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:57.655521) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:57.656210) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 19:02:57.666542) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-07-27 19:02:57.667121) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:02:57 INFO - MultiFileLogger online at 20170727 19:02:57 in /builds/slave/test 19:02:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:02:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:02:57 INFO - {'append_to_log': False, 19:02:57 INFO - 'base_work_dir': '/builds/slave/test', 19:02:57 INFO - 'blob_upload_branch': 'Firefox', 19:02:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:02:57 INFO - 'branch': 'Firefox', 19:02:57 INFO - 'buildbot_json_path': 'buildprops.json', 19:02:57 INFO - 'code_coverage': False, 19:02:57 INFO - 'config_files': ('talos/linux_config.py',), 19:02:57 INFO - 'default_actions': ('clobber', 19:02:57 INFO - 'read-buildbot-config', 19:02:57 INFO - 'download-and-extract', 19:02:57 INFO - 'populate-webroot', 19:02:57 INFO - 'create-virtualenv', 19:02:57 INFO - 'install', 19:02:57 INFO - 'setup-mitmproxy', 19:02:57 INFO - 'run-tests'), 19:02:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:02:57 INFO - 'disable_ccov_upload': False, 19:02:57 INFO - 'download_minidump_stackwalk': True, 19:02:57 INFO - 'download_symbols': 'ondemand', 19:02:57 INFO - 'enable_stylo': False, 19:02:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:02:57 INFO - 'tooltool.py': '/tools/tooltool.py', 19:02:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:02:57 INFO - '/tools/misc-python/virtualenv.py')}, 19:02:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:02:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:02:57 INFO - 'gecko_profile': False, 19:02:57 INFO - 'gecko_profile_interval': 0, 19:02:57 INFO - 'installer_path': 'installer.exe', 19:02:57 INFO - 'log_level': 'info', 19:02:57 INFO - 'log_name': 'talos', 19:02:57 INFO - 'log_to_console': True, 19:02:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:02:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:02:57 INFO - 'opt_config_files': (), 19:02:57 INFO - 'pip_index': False, 19:02:57 INFO - 'suite': 'dromaeojs-e10s', 19:02:57 INFO - 'system_bits': '32', 19:02:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:02:57 INFO - 'title': 'talos-linux64-ix-030', 19:02:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:02:57 INFO - 'use_talos_json': True, 19:02:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:02:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:02:57 INFO - 'work_dir': 'build'} 19:02:57 INFO - [mozharness: 2017-07-28 02:02:57.862345Z] Running clobber step. 19:02:57 INFO - Running pre-action listener: _resource_record_pre_action 19:02:57 INFO - Running main action method: clobber 19:02:57 INFO - rmtree: /builds/slave/test/build 19:02:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:02:58 INFO - Running post-action listener: _resource_record_post_action 19:02:58 INFO - [mozharness: 2017-07-28 02:02:58.845441Z] Finished clobber step (success) 19:02:58 INFO - [mozharness: 2017-07-28 02:02:58.845562Z] Running read-buildbot-config step. 19:02:58 INFO - Running pre-action listener: _resource_record_pre_action 19:02:58 INFO - Running main action method: read_buildbot_config 19:02:58 INFO - Using buildbot properties: 19:02:58 INFO - { 19:02:58 INFO - "project": "", 19:02:58 INFO - "product": "firefox", 19:02:58 INFO - "who": "Callek@gmail.com", 19:02:58 INFO - "installer_path": "public/build/target.tar.bz2", 19:02:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 19:02:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:02:58 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 19:02:58 INFO - "stage_platform": "linux64-stylo", 19:02:58 INFO - "basedir": "/builds/slave/test", 19:02:58 INFO - "buildnumber": 242, 19:02:58 INFO - "platform": "ubuntu64_hw_stylo", 19:02:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:02:58 INFO - "slavebuilddir": "test", 19:02:58 INFO - "taskId": "WmkZjjHeSIuYyq2qC48vFg", 19:02:58 INFO - "branch": "mozilla-central", 19:02:58 INFO - "script_repo_revision": "production", 19:02:58 INFO - "revision": "556f19ef392ac2d9aac579864e2179d6c1d464e8", 19:02:58 INFO - "slavename": "talos-linux64-ix-030", 19:02:58 INFO - "repo_path": "mozilla-central" 19:02:58 INFO - } 19:02:58 INFO - Finding installer, test and symbols from parent task. 19:02:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WmkZjjHeSIuYyq2qC48vFg'}, attempt #1 19:02:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WmkZjjHeSIuYyq2qC48vFg'}, attempt #1 19:02:59 INFO - Task dependencies: clJckGzdS1qkQbdfhk8DRA 19:02:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA'}, attempt #1 19:03:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.tar.bz2 19:03:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/test_packages.json 19:03:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.crashreporter-symbols.zip 19:03:00 INFO - Running post-action listener: _resource_record_post_action 19:03:00 INFO - [mozharness: 2017-07-28 02:03:00.200231Z] Finished read-buildbot-config step (success) 19:03:00 INFO - [mozharness: 2017-07-28 02:03:00.200454Z] Running download-and-extract step. 19:03:00 INFO - Running pre-action listener: _resource_record_pre_action 19:03:00 INFO - Running main action method: download_and_extract 19:03:00 INFO - mkdir: /builds/slave/test/build/tests 19:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:00 INFO - trying https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.test_packages.json 19:03:00 INFO - Downloading https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:03:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:03:00 INFO - Downloaded 989 bytes. 19:03:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:03:00 INFO - Using the following test package requirements: 19:03:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:03:00 INFO - u'common': [u'target.common.tests.zip'], 19:03:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:03:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:03:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:03:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:03:00 INFO - u'mozbase': [u'target.common.tests.zip'], 19:03:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:03:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:03:00 INFO - u'web-platform': [u'target.common.tests.zip', 19:03:00 INFO - u'target.web-platform.tests.tar.gz'], 19:03:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:03:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:03:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.common.tests.zip 19:03:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:03:00 INFO - Fetch https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.common.tests.zip into memory 19:03:02 INFO - Content-Length response header: 72561232 19:03:02 INFO - Bytes received: 72561232 19:03:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:03:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.common.tests.zip 19:03:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:03:13 INFO - Fetch https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.common.tests.zip into memory 19:03:14 INFO - Content-Length response header: 72561232 19:03:14 INFO - Bytes received: 72561232 19:03:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.talos.tests.zip 19:03:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:03:27 INFO - Fetch https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.talos.tests.zip into memory 19:03:28 INFO - Content-Length response header: 14496465 19:03:28 INFO - Bytes received: 14496465 19:03: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')]} 19:03:28 INFO - trying https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.tar.bz2 19:03:28 INFO - Downloading https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:03:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:03:29 INFO - Downloaded 62038064 bytes. 19:03:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.tar.bz2 19:03:29 INFO - mkdir: /builds/slave/test/properties 19:03:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:03:29 INFO - Writing to file /builds/slave/test/properties/build_url 19:03:29 INFO - Contents: 19:03:29 INFO - build_url:https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.tar.bz2 19:03:29 INFO - Running post-action listener: _resource_record_post_action 19:03:29 INFO - Running post-action listener: set_extra_try_arguments 19:03:29 INFO - [mozharness: 2017-07-28 02:03:29.900417Z] Finished download-and-extract step (success) 19:03:29 INFO - [mozharness: 2017-07-28 02:03:29.900561Z] Running populate-webroot step. 19:03:29 INFO - Running pre-action listener: _resource_record_pre_action 19:03:29 INFO - Running main action method: populate_webroot 19:03:29 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:03:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:03:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:03:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:03:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:03:29 INFO - 'tests': ['damp', 'tps']}, 19:03:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:03:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:03:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:03:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:03:29 INFO - 'other-e10s': {'tests': ['a11yr', 19:03:29 INFO - 'ts_paint', 19:03:29 INFO - 'tpaint', 19:03:29 INFO - 'sessionrestore', 19:03:29 INFO - 'sessionrestore_many_windows', 19:03:29 INFO - 'sessionrestore_no_auto_restore', 19:03:29 INFO - 'tabpaint']}, 19:03:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:03:29 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:03:29 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:03:29 INFO - 'talos_options': ['--mitmproxy', 19:03:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:03:29 INFO - '--firstNonBlankPaint'], 19:03:29 INFO - 'tests': ['quantum_pageload_google', 19:03:29 INFO - 'quantum_pageload_youtube', 19:03:29 INFO - 'quantum_pageload_amazon', 19:03:29 INFO - 'quantum_pageload_facebook']}, 19:03:29 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:03:29 INFO - 'talos_options': ['--stylo', 19:03:29 INFO - '--mitmproxy', 19:03:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:03:29 INFO - '--firstNonBlankPaint'], 19:03:29 INFO - 'tests': ['quantum_pageload_google', 19:03:29 INFO - 'quantum_pageload_youtube', 19:03:29 INFO - 'quantum_pageload_amazon', 19:03:29 INFO - 'quantum_pageload_facebook']}, 19:03:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:03:29 INFO - 'tsvgr_opacity', 19:03:29 INFO - 'tart', 19:03:29 INFO - 'tscrollx', 19:03:29 INFO - 'cart', 19:03:29 INFO - 'tsvg_static']}, 19:03:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:03:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:03:29 INFO - 'talos_options': ['--xperf_path', 19:03:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:03:29 INFO - 'tests': ['tp5n']}}} 19:03:29 INFO - Running post-action listener: _resource_record_post_action 19:03:29 INFO - [mozharness: 2017-07-28 02:03:29.911928Z] Finished populate-webroot step (success) 19:03:29 INFO - [mozharness: 2017-07-28 02:03:29.912062Z] Running create-virtualenv step. 19:03:29 INFO - Running pre-action listener: _resource_record_pre_action 19:03:29 INFO - Running main action method: create_virtualenv 19:03:29 INFO - Creating virtualenv /builds/slave/test/build/venv 19:03:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:03:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:03:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:03:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:03:30 INFO - Using real prefix '/usr' 19:03:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:03:30 INFO - Installing distribute.............................................................................................................................................................................................done. 19:03:32 INFO - Installing pip.................done. 19:03:32 INFO - Return code: 0 19:03:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:03:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:03:33 INFO - Reading from file tmpfile_stdout 19:03:33 INFO - Output received: 19:03:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:03:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:33 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 0x28841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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 0x2bf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf2240>, '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': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:03:33 INFO - Using env: {'DISPLAY': ':0', 19:03:33 INFO - 'HOME': '/home/cltbld', 19:03:33 INFO - 'LANG': 'en_US.UTF-8', 19:03:33 INFO - 'LANGUAGE': 'en_US:en', 19:03:33 INFO - 'LOGNAME': 'cltbld', 19:03:33 INFO - 'MAIL': '/var/mail/cltbld', 19:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:33 INFO - 'MOZ_NO_REMOTE': '1', 19:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:33 INFO - 'NO_EM_RESTART': '1', 19:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:33 INFO - 'PWD': '/builds/slave/test', 19:03:33 INFO - 'SHELL': '/bin/bash', 19:03:33 INFO - 'SHLVL': '1', 19:03:33 INFO - 'TERM': 'linux', 19:03:33 INFO - 'TMOUT': '86400', 19:03:33 INFO - 'USER': 'cltbld', 19:03:33 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 19:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:33 INFO - '_': '/tools/buildbot/bin/python'} 19:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:03:33 INFO - Cleaning up... 19:03:33 INFO - Return code: 0 19:03:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:33 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 0x28841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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 0x2bf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf2240>, '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': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:03:33 INFO - Using env: {'DISPLAY': ':0', 19:03:33 INFO - 'HOME': '/home/cltbld', 19:03:33 INFO - 'LANG': 'en_US.UTF-8', 19:03:33 INFO - 'LANGUAGE': 'en_US:en', 19:03:33 INFO - 'LOGNAME': 'cltbld', 19:03:33 INFO - 'MAIL': '/var/mail/cltbld', 19:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:33 INFO - 'MOZ_NO_REMOTE': '1', 19:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:33 INFO - 'NO_EM_RESTART': '1', 19:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:33 INFO - 'PWD': '/builds/slave/test', 19:03:33 INFO - 'SHELL': '/bin/bash', 19:03:33 INFO - 'SHLVL': '1', 19:03:33 INFO - 'TERM': 'linux', 19:03:33 INFO - 'TMOUT': '86400', 19:03:33 INFO - 'USER': 'cltbld', 19:03:33 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 19:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:33 INFO - '_': '/tools/buildbot/bin/python'} 19:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:33 INFO - Downloading/unpacking psutil>=3.1.1 19:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:03:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:03:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:03:34 INFO - Installing collected packages: psutil 19:03:34 INFO - Running setup.py install for psutil 19:03:34 INFO - building 'psutil._psutil_linux' extension 19:03:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:03:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:03:35 INFO - building 'psutil._psutil_posix' extension 19:03:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:03:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:03:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:03:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:03:36 INFO - Successfully installed psutil 19:03:36 INFO - Cleaning up... 19:03:36 INFO - Return code: 0 19:03:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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 0x2bf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf2240>, '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': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:03:36 INFO - Using env: {'DISPLAY': ':0', 19:03:36 INFO - 'HOME': '/home/cltbld', 19:03:36 INFO - 'LANG': 'en_US.UTF-8', 19:03:36 INFO - 'LANGUAGE': 'en_US:en', 19:03:36 INFO - 'LOGNAME': 'cltbld', 19:03:36 INFO - 'MAIL': '/var/mail/cltbld', 19:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:36 INFO - 'MOZ_NO_REMOTE': '1', 19:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:36 INFO - 'NO_EM_RESTART': '1', 19:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:36 INFO - 'PWD': '/builds/slave/test', 19:03:36 INFO - 'SHELL': '/bin/bash', 19:03:36 INFO - 'SHLVL': '1', 19:03:36 INFO - 'TERM': 'linux', 19:03:36 INFO - 'TMOUT': '86400', 19:03:36 INFO - 'USER': 'cltbld', 19:03:36 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 19:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:36 INFO - '_': '/tools/buildbot/bin/python'} 19:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:03:37 INFO - Installing collected packages: mozsystemmonitor 19:03:37 INFO - Running setup.py install for mozsystemmonitor 19:03:37 INFO - Successfully installed mozsystemmonitor 19:03:37 INFO - Cleaning up... 19:03:37 INFO - Return code: 0 19:03:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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 0x2bf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf2240>, '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': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:03:37 INFO - Using env: {'DISPLAY': ':0', 19:03:37 INFO - 'HOME': '/home/cltbld', 19:03:37 INFO - 'LANG': 'en_US.UTF-8', 19:03:37 INFO - 'LANGUAGE': 'en_US:en', 19:03:37 INFO - 'LOGNAME': 'cltbld', 19:03:37 INFO - 'MAIL': '/var/mail/cltbld', 19:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:37 INFO - 'MOZ_NO_REMOTE': '1', 19:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:37 INFO - 'NO_EM_RESTART': '1', 19:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:37 INFO - 'PWD': '/builds/slave/test', 19:03:37 INFO - 'SHELL': '/bin/bash', 19:03:37 INFO - 'SHLVL': '1', 19:03:37 INFO - 'TERM': 'linux', 19:03:37 INFO - 'TMOUT': '86400', 19:03:37 INFO - 'USER': 'cltbld', 19:03:37 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 19:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:37 INFO - '_': '/tools/buildbot/bin/python'} 19:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:37 INFO - Downloading/unpacking jsonschema==2.5.1 19:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:03:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:39 INFO - Downloading functools32-3.2.3-2.tar.gz 19:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:03:39 INFO - warning: no files found matching '*.txt' 19:03:39 INFO - no previously-included directories found matching 'build' 19:03:39 INFO - no previously-included directories found matching 'dist' 19:03:39 INFO - no previously-included directories found matching '.git*' 19:03:39 INFO - Installing collected packages: jsonschema, functools32 19:03:39 INFO - Running setup.py install for functools32 19:03:39 INFO - warning: no files found matching '*.txt' 19:03:39 INFO - no previously-included directories found matching 'build' 19:03:39 INFO - no previously-included directories found matching 'dist' 19:03:39 INFO - no previously-included directories found matching '.git*' 19:03:39 INFO - Successfully installed jsonschema functools32 19:03:39 INFO - Cleaning up... 19:03:39 INFO - Return code: 0 19:03:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:39 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 0x28841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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 0x2bf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf2240>, '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': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:03:39 INFO - Using env: {'DISPLAY': ':0', 19:03:39 INFO - 'HOME': '/home/cltbld', 19:03:39 INFO - 'LANG': 'en_US.UTF-8', 19:03:39 INFO - 'LANGUAGE': 'en_US:en', 19:03:39 INFO - 'LOGNAME': 'cltbld', 19:03:39 INFO - 'MAIL': '/var/mail/cltbld', 19:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:39 INFO - 'MOZ_NO_REMOTE': '1', 19:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:39 INFO - 'NO_EM_RESTART': '1', 19:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:39 INFO - 'PWD': '/builds/slave/test', 19:03:39 INFO - 'SHELL': '/bin/bash', 19:03:39 INFO - 'SHLVL': '1', 19:03:39 INFO - 'TERM': 'linux', 19:03:39 INFO - 'TMOUT': '86400', 19:03:39 INFO - 'USER': 'cltbld', 19:03:39 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 19:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:39 INFO - '_': '/tools/buildbot/bin/python'} 19:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:03:39 INFO - Cleaning up... 19:03:39 INFO - Return code: 0 19:03:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:39 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 0x28841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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 0x2bf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf2240>, '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': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:03:39 INFO - Using env: {'DISPLAY': ':0', 19:03:39 INFO - 'HOME': '/home/cltbld', 19:03:39 INFO - 'LANG': 'en_US.UTF-8', 19:03:39 INFO - 'LANGUAGE': 'en_US:en', 19:03:39 INFO - 'LOGNAME': 'cltbld', 19:03:39 INFO - 'MAIL': '/var/mail/cltbld', 19:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:39 INFO - 'MOZ_NO_REMOTE': '1', 19:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:39 INFO - 'NO_EM_RESTART': '1', 19:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:39 INFO - 'PWD': '/builds/slave/test', 19:03:39 INFO - 'SHELL': '/bin/bash', 19:03:39 INFO - 'SHLVL': '1', 19:03:39 INFO - 'TERM': 'linux', 19:03:39 INFO - 'TMOUT': '86400', 19:03:39 INFO - 'USER': 'cltbld', 19:03:39 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 19:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:39 INFO - '_': '/tools/buildbot/bin/python'} 19:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:39 INFO - Downloading/unpacking blobuploader==1.2.4 19:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:40 INFO - Downloading blobuploader-1.2.4.tar.gz 19:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:03:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:03:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:41 INFO - Downloading docopt-0.6.1.tar.gz 19:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:03:41 INFO - Installing collected packages: blobuploader, requests, docopt 19:03:41 INFO - Running setup.py install for blobuploader 19:03:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:03:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:03:41 INFO - Running setup.py install for requests 19:03:41 INFO - Running setup.py install for docopt 19:03:41 INFO - Successfully installed blobuploader requests docopt 19:03:41 INFO - Cleaning up... 19:03:41 INFO - Return code: 0 19:03:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:41 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 0x28841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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 0x2bf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf2240>, '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': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:03:41 INFO - Using env: {'DISPLAY': ':0', 19:03:41 INFO - 'HOME': '/home/cltbld', 19:03:41 INFO - 'LANG': 'en_US.UTF-8', 19:03:42 INFO - 'LANGUAGE': 'en_US:en', 19:03:42 INFO - 'LOGNAME': 'cltbld', 19:03:42 INFO - 'MAIL': '/var/mail/cltbld', 19:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:42 INFO - 'MOZ_NO_REMOTE': '1', 19:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:42 INFO - 'NO_EM_RESTART': '1', 19:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:42 INFO - 'PWD': '/builds/slave/test', 19:03:42 INFO - 'SHELL': '/bin/bash', 19:03:42 INFO - 'SHLVL': '1', 19:03:42 INFO - 'TERM': 'linux', 19:03:42 INFO - 'TMOUT': '86400', 19:03:42 INFO - 'USER': 'cltbld', 19:03:42 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 19:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:42 INFO - '_': '/tools/buildbot/bin/python'} 19:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:03:42 INFO - Running setup.py (path:/tmp/pip-Eqeqc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:03:42 INFO - Running setup.py (path:/tmp/pip-ty7Nns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:03:42 INFO - Running setup.py (path:/tmp/pip-iHEKi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:03:42 INFO - Running setup.py (path:/tmp/pip-o74NXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:03:42 INFO - Running setup.py (path:/tmp/pip-rm5k1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:03:42 INFO - Running setup.py (path:/tmp/pip-_lL447-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:03:42 INFO - Running setup.py (path:/tmp/pip-ECObuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:03:42 INFO - Running setup.py (path:/tmp/pip-cuoRwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:03:42 INFO - Running setup.py (path:/tmp/pip-DdcAo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:03:42 INFO - Running setup.py (path:/tmp/pip-94LJag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:03:42 INFO - Running setup.py (path:/tmp/pip-eTzZ7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:03:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:03:42 INFO - Running setup.py (path:/tmp/pip-_Lvorz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:03:43 INFO - Running setup.py (path:/tmp/pip-oafE05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:03:43 INFO - Running setup.py (path:/tmp/pip-PMOEJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:43 INFO - Running setup.py (path:/tmp/pip-trBMas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:03:43 INFO - Running setup.py (path:/tmp/pip-DXBiBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:03:43 INFO - Running setup.py (path:/tmp/pip-x0QTKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:03:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:03:43 INFO - Running setup.py install for manifestparser 19:03:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:03:43 INFO - Running setup.py install for mozcrash 19:03:43 INFO - Running setup.py install for mozdebug 19:03:43 INFO - Running setup.py install for mozdevice 19:03:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:03:43 INFO - Running setup.py install for mozfile 19:03:43 INFO - Running setup.py install for mozhttpd 19:03:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:03:44 INFO - Running setup.py install for mozinfo 19:03:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:03:44 INFO - Running setup.py install for mozInstall 19:03:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:03:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:03:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:03:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:03:44 INFO - Running setup.py install for mozleak 19:03:44 INFO - Running setup.py install for mozlog 19:03:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:03:44 INFO - Running setup.py install for moznetwork 19:03:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:03:44 INFO - Running setup.py install for mozprocess 19:03:44 INFO - Running setup.py install for mozprofile 19:03:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:03:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:03:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:03:44 INFO - Running setup.py install for mozrunner 19:03:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:03:44 INFO - Running setup.py install for mozscreenshot 19:03:44 INFO - Running setup.py install for moztest 19:03:45 INFO - Running setup.py install for mozversion 19:03:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:03:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:03:45 INFO - Cleaning up... 19:03:45 INFO - Return code: 0 19:03:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:45 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 0x28841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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 0x2bf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf2240>, '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': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:03:45 INFO - Using env: {'DISPLAY': ':0', 19:03:45 INFO - 'HOME': '/home/cltbld', 19:03:45 INFO - 'LANG': 'en_US.UTF-8', 19:03:45 INFO - 'LANGUAGE': 'en_US:en', 19:03:45 INFO - 'LOGNAME': 'cltbld', 19:03:45 INFO - 'MAIL': '/var/mail/cltbld', 19:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:45 INFO - 'MOZ_NO_REMOTE': '1', 19:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:45 INFO - 'NO_EM_RESTART': '1', 19:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:45 INFO - 'PWD': '/builds/slave/test', 19:03:45 INFO - 'SHELL': '/bin/bash', 19:03:45 INFO - 'SHLVL': '1', 19:03:45 INFO - 'TERM': 'linux', 19:03:45 INFO - 'TMOUT': '86400', 19:03:45 INFO - 'USER': 'cltbld', 19:03:45 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 19:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:45 INFO - '_': '/tools/buildbot/bin/python'} 19:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:03:45 INFO - Running setup.py (path:/tmp/pip-tvxuL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:03:45 INFO - Running setup.py (path:/tmp/pip-kmWJMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:03:45 INFO - Running setup.py (path:/tmp/pip-ODrP3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:03:45 INFO - Running setup.py (path:/tmp/pip-iUvNT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:03:45 INFO - Running setup.py (path:/tmp/pip-qOBkh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:03:45 INFO - Running setup.py (path:/tmp/pip-f908A2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:03:45 INFO - Running setup.py (path:/tmp/pip-YhJMyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:03:45 INFO - Running setup.py (path:/tmp/pip-3Y3JMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:03:45 INFO - Running setup.py (path:/tmp/pip-_XYD0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:03:46 INFO - Running setup.py (path:/tmp/pip-wWZQ7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:03:46 INFO - Running setup.py (path:/tmp/pip-6BuepV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:03:46 INFO - Running setup.py (path:/tmp/pip-v6HCzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:03:46 INFO - Running setup.py (path:/tmp/pip-kUlBtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:03:46 INFO - Running setup.py (path:/tmp/pip-11OyHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:46 INFO - Running setup.py (path:/tmp/pip-k59dZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:03:46 INFO - Running setup.py (path:/tmp/pip-0AWSWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:03:46 INFO - Running setup.py (path:/tmp/pip-QIf789-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:03:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:47 INFO - Downloading blessings-1.6.tar.gz 19:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:03:47 INFO - Installing collected packages: blessings 19:03:47 INFO - Running setup.py install for blessings 19:03:47 INFO - Successfully installed blessings 19:03:47 INFO - Cleaning up... 19:03:47 INFO - Return code: 0 19:03:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:03:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:03:48 INFO - Reading from file tmpfile_stdout 19:03:48 INFO - Current package versions: 19:03:48 INFO - argparse == 1.2.1 19:03:48 INFO - blessings == 1.6 19:03:48 INFO - blobuploader == 1.2.4 19:03:48 INFO - docopt == 0.6.1 19:03:48 INFO - functools32 == 3.2.3-2 19:03:48 INFO - jsonschema == 2.5.1 19:03:48 INFO - manifestparser == 1.1 19:03:48 INFO - mozInstall == 1.13 19:03:48 INFO - mozcrash == 1.0 19:03:48 INFO - mozdebug == 0.1 19:03:48 INFO - mozdevice == 0.51 19:03:48 INFO - mozfile == 1.2 19:03:48 INFO - mozhttpd == 0.7 19:03:48 INFO - mozinfo == 0.10 19:03:48 INFO - mozleak == 0.1 19:03:48 INFO - mozlog == 3.5 19:03:48 INFO - moznetwork == 0.27 19:03:48 INFO - mozprocess == 0.25 19:03:48 INFO - mozprofile == 0.28 19:03:48 INFO - mozrunner == 6.13 19:03:48 INFO - mozscreenshot == 0.1 19:03:48 INFO - mozsystemmonitor == 0.3 19:03:48 INFO - moztest == 0.8 19:03:48 INFO - mozversion == 1.4 19:03:48 INFO - psutil == 3.1.1 19:03:48 INFO - requests == 1.2.3 19:03:48 INFO - wsgiref == 0.1.2 19:03:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:48 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 0x28841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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 0x2bf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf2240>, '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': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:03:48 INFO - Using env: {'DISPLAY': ':0', 19:03:48 INFO - 'HOME': '/home/cltbld', 19:03:48 INFO - 'LANG': 'en_US.UTF-8', 19:03:48 INFO - 'LANGUAGE': 'en_US:en', 19:03:48 INFO - 'LOGNAME': 'cltbld', 19:03:48 INFO - 'MAIL': '/var/mail/cltbld', 19:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:48 INFO - 'MOZ_NO_REMOTE': '1', 19:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:48 INFO - 'NO_EM_RESTART': '1', 19:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:48 INFO - 'PWD': '/builds/slave/test', 19:03:48 INFO - 'SHELL': '/bin/bash', 19:03:48 INFO - 'SHLVL': '1', 19:03:48 INFO - 'TERM': 'linux', 19:03:48 INFO - 'TMOUT': '86400', 19:03:48 INFO - 'USER': 'cltbld', 19:03:48 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 19:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:48 INFO - '_': '/tools/buildbot/bin/python'} 19:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:03:48 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:49 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:03:49 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 19:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:03:49 INFO - Installing collected packages: marionette-driver, simplejson 19:03:49 INFO - Running setup.py install for marionette-driver 19:03:49 INFO - Running setup.py install for simplejson 19:03:49 INFO - building 'simplejson._speedups' extension 19:03:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 19:03:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 19:03:50 INFO - Successfully installed marionette-driver simplejson 19:03:50 INFO - Cleaning up... 19:03:50 INFO - Return code: 0 19:03:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:50 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 0x28841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a50a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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 0x2bf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf2240>, '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': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:03:50 INFO - Using env: {'DISPLAY': ':0', 19:03:50 INFO - 'HOME': '/home/cltbld', 19:03:50 INFO - 'LANG': 'en_US.UTF-8', 19:03:50 INFO - 'LANGUAGE': 'en_US:en', 19:03:50 INFO - 'LOGNAME': 'cltbld', 19:03:50 INFO - 'MAIL': '/var/mail/cltbld', 19:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:50 INFO - 'MOZ_NO_REMOTE': '1', 19:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:50 INFO - 'NO_EM_RESTART': '1', 19:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:50 INFO - 'PWD': '/builds/slave/test', 19:03:50 INFO - 'SHELL': '/bin/bash', 19:03:50 INFO - 'SHLVL': '1', 19:03:50 INFO - 'TERM': 'linux', 19:03:50 INFO - 'TMOUT': '86400', 19:03:50 INFO - 'USER': 'cltbld', 19:03:50 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 19:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:50 INFO - '_': '/tools/buildbot/bin/python'} 19:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:03:51 INFO - Cleaning up... 19:03:51 INFO - Return code: 0 19:03:51 INFO - Running post-action listener: _resource_record_post_action 19:03:51 INFO - Running post-action listener: _start_resource_monitoring 19:03:51 INFO - Starting resource monitoring. 19:03:51 INFO - [mozharness: 2017-07-28 02:03:51.265726Z] Finished create-virtualenv step (success) 19:03:51 INFO - [mozharness: 2017-07-28 02:03:51.266681Z] Running install step. 19:03:51 INFO - Running pre-action listener: _resource_record_pre_action 19:03:51 INFO - Running main action method: install 19:03:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:03:51 INFO - Reading from file tmpfile_stdout 19:03:51 INFO - Detecting whether we're running mozinstall >=1.0... 19:03:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:03:51 INFO - Reading from file tmpfile_stdout 19:03:51 INFO - Output received: 19:03:51 INFO - Usage: mozinstall [options] installer 19:03:51 INFO - Options: 19:03:51 INFO - -h, --help show this help message and exit 19:03:51 INFO - -d DEST, --destination=DEST 19:03:51 INFO - Directory to install application into. [default: 19:03:51 INFO - "/builds/slave/test"] 19:03:51 INFO - --app=APP Application being installed. [default: firefox] 19:03:51 INFO - mkdir: /builds/slave/test/build/application 19:03:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:04:09 INFO - Reading from file tmpfile_stdout 19:04:09 INFO - Output received: 19:04:09 INFO - /builds/slave/test/build/application/firefox/firefox 19:04:09 INFO - Running post-action listener: _resource_record_post_action 19:04:09 INFO - [mozharness: 2017-07-28 02:04:09.601885Z] Finished install step (success) 19:04:09 INFO - [mozharness: 2017-07-28 02:04:09.601996Z] Running setup-mitmproxy step. 19:04:09 INFO - Running pre-action listener: _resource_record_pre_action 19:04:09 INFO - Running main action method: setup_mitmproxy 19:04:09 INFO - Skipping: mitmproxy is not required 19:04:09 INFO - Running post-action listener: _resource_record_post_action 19:04:09 INFO - [mozharness: 2017-07-28 02:04:09.602481Z] Finished setup-mitmproxy step (success) 19:04:09 INFO - [mozharness: 2017-07-28 02:04:09.602575Z] Running run-tests step. 19:04:09 INFO - Running pre-action listener: _resource_record_pre_action 19:04:09 INFO - Running pre-action listener: _set_gcov_prefix 19:04:09 INFO - Running main action method: run_tests 19:04:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:04:09 INFO - Python 2.7.3 19:04:09 INFO - Return code: 0 19:04:09 INFO - grabbing minidump binary from tooltool 19:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:04:09 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 0x2bf0eb0>, '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 0x2bf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf2240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:04:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:04:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:04:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:04:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:04:09 INFO - Return code: 0 19:04:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:04:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:04:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:04:09 INFO - ENV: RUST_BACKTRACE is now 1 19:04:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:04:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:04:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:04:09 INFO - Using env: {'DISPLAY': ':0', 19:04:09 INFO - 'HOME': '/home/cltbld', 19:04:09 INFO - 'LANG': 'en_US.UTF-8', 19:04:09 INFO - 'LANGUAGE': 'en_US:en', 19:04:09 INFO - 'LOGNAME': 'cltbld', 19:04:09 INFO - 'MAIL': '/var/mail/cltbld', 19:04:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:04:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:09 INFO - 'MOZ_NO_REMOTE': '1', 19:04:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:09 INFO - 'NO_EM_RESTART': '1', 19:04:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:09 INFO - 'PWD': '/builds/slave/test', 19:04:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:04:09 INFO - 'RUST_BACKTRACE': '1', 19:04:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:04:09 INFO - 'SHELL': '/bin/bash', 19:04:09 INFO - 'SHLVL': '1', 19:04:09 INFO - 'STYLO_FORCE_ENABLED': '1', 19:04:09 INFO - 'TERM': 'linux', 19:04:09 INFO - 'TMOUT': '86400', 19:04:09 INFO - 'USER': 'cltbld', 19:04:09 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402', 19:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:09 INFO - '_': '/tools/buildbot/bin/python'} 19:04:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:04:10 INFO - mozversion application_buildid: 20170728011528 19:04:10 INFO - mozversion application_changeset: 556f19ef392ac2d9aac579864e2179d6c1d464e8 19:04:10 INFO - mozversion application_display_name: Nightly 19:04:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:04:10 INFO - mozversion application_name: Firefox 19:04:10 INFO - mozversion application_remotingname: firefox 19:04:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:04:10 INFO - mozversion application_vendor: Mozilla 19:04:10 INFO - mozversion application_version: 56.0a1 19:04:10 INFO - mozversion platform_buildid: 20170728011528 19:04:10 INFO - mozversion platform_changeset: 556f19ef392ac2d9aac579864e2179d6c1d464e8 19:04:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:04:10 INFO - mozversion platform_version: 56.0a1 19:04:10 INFO - using testdate: 1501207450 19:04:10 INFO - actual date: 1501207450 19:04:10 INFO - starting webserver on 'localhost:51390' 19:04:10 INFO - SUITE-START | Running 2 tests 19:04:10 INFO - TEST-START | dromaeo_css 19:04:10 INFO - Initialising browser for dromaeo_css test... 19:04:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51390/getInfo.html -profile /tmp/tmp4Bokjw/profile 19:04:10 INFO - TEST-INFO | started process 3321 (/builds/slave/test/build/application/firefox/firefox http://localhost:51390/getInfo.html) 19:04:18 INFO - TEST-INFO | 3321: exit 0 19:04:18 INFO - Browser initialized. 19:04:18 INFO - Running cycle 1/1 for dromaeo_css test... 19:04:18 INFO - TEST-INFO | started process 3549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Bokjw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:19 INFO - PID 3549 | 19:04:19 INFO - PID 3549 | (/builds/slave/test/build/application/firefox/firefox:3603): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:04:19 INFO - PID 3549 | 19:04:29 INFO - PID 3549 | RSS: Main: 173395968 19:04:29 INFO - PID 3549 | 19:07:29 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:51390/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51390/tests/dromaeo/cssquery-ext.html) 19:07:31 INFO - PID 3549 | RSS: Main: 175185920 19:07:31 INFO - PID 3549 | 19:10:33 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:51390/tests/dromaeo/cssquery-ext.html (next: http://localhost:51390/tests/dromaeo/cssquery-jquery.html) 19:10:33 INFO - PID 3549 | RSS: Main: 172224512 19:10:33 INFO - PID 3549 | 19:13:35 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:51390/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51390/tests/dromaeo/cssquery-mootools.html) 19:13:36 INFO - PID 3549 | RSS: Main: 174858240 19:13:36 INFO - PID 3549 | 19:16:38 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:51390/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51390/tests/dromaeo/cssquery-prototype.html) 19:16:39 INFO - PID 3549 | RSS: Main: 173031424 19:16:39 INFO - PID 3549 | 19:19:42 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:51390/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51390/tests/dromaeo/cssquery-yui.html) 19:19:43 INFO - PID 3549 | RSS: Main: 174522368 19:19:43 INFO - PID 3549 | 19:22:45 INFO - PID 3549 | Cycle 1(1): loaded http://localhost:51390/tests/dromaeo/cssquery-yui.html (next: http://localhost:51390/tests/dromaeo/cssquery-dojo.html) 19:22:45 INFO - PID 3549 | RSS: Main: 175341568 19:22:45 INFO - PID 3549 | 19:22:45 INFO - PID 3549 | __start_tp_report 19:22:45 INFO - PID 3549 | _x_x_mozilla_page_load 19:22:45 INFO - PID 3549 | _x_x_mozilla_page_load_details 19:22:45 INFO - PID 3549 | |i|pagename|runs| 19:22:45 INFO - PID 3549 | |0;dojo.html;3171.666974967627;3186.426443240216;3188.1392024153474;3197.0568682238736;3238.7732858699887;6151.169592105064;6166.414190651881;6214.1300217969465;6220.657863817488;6222.12890195373;6181.845453863644;6213.161223234862;6226.719797609107;6272.278687950887;6316.27362853272;5676.432356764311;5714.685692286933;5749.367569567345;5785.421457854223;5830.32951210612;5560.888782224353;5681.602287839853;5773;5776.075827867542;5848.970755146218;5587.469190426923;5639.774409023634;5652.660840349592;5680.659160450366;5681;5735.11105778605;5748.2527271454865;5755.510781583571;5797.217375654317;5802.912956305659;5570.526505247059;5708.914366284509;5732.140178973145;5740.827775166752;5757.539396848242;6126.540509461808;6134.325224225332;6135.2024236849375;6210.844728881769;6221.751129954796;6601.768938087192;6697.22981857083;6700.530962832604;6702.530822842355;6764.323567643246;6717.294684058153;6731.899021514681;6736.360045795642;6738.35985581369;6753.257141714407;6138.47822935051;6196.2874269459135;6200.751969921198;6202.782902598477;6344.714487848058;6960.338767817049;6968.198657154391;6979.616121113388;6985.79042628722;6988.755393561302;6516.57642253252;6634.800955971328;6639.933600664028;6674.5327827052615;6676.298988606223;6660.067590537328;6660.56706314088;6663.533552651268;6664.133662623828;6664.466842652673;6605.86788264232;6613.801585952429;6635.9336406636285;6680.198376194888;6712.328767123347;6470.5147113965695;6670.4997125215805;6680.6993685283305;6708.798736037927;6782.457403407716;5432.2123292123215;5498.862528436821;5508.228847961289;5511.917321240185;5519.69641669704;4633.513481084505;4685.367475390847;4698.3187437821325;4700.059988002413;4724.4094488188975;5818.7672493100645;5822.563307751935;5883.794067207713;5905.498032667186;5915.142304365843;6695.933040669628;6711.664416779142;6715.328467153343;6779.322067793181;6832.145981752281;5752.223449834302;5832.270966129234;5834.066549352168;5836.066229403275;5840.415958404125;5881.617694849821;5890.322612899486;5914.142449344821;5918.2898052234;5925.318588362394;6387.169667943138;6467;6484.578502397329;6487.870242595121;6504.5446818723185;6730.4952128589575;6731.932680673326;6736.292689267556;6737.191537015589;6743.8988415172835;6483.610983341015;6507.349265073455;6511.3163117871945;6519.7392104315295;6524.67376631176;5754.395788442321;6562.639054852029;6629.5359324846795;6650.168728908887;6658.866822663423;6468.579542329733;6660.800175994728;6662.333766623299;6751.966240168964;6760.661966901537;6447.6131432114225;6448.25845027809;6448.387403196689;6454.806355809145;6463.612183269019;6369.554131210956;6414.10202571631;6420.550561460653;6450.612963222034;6454.064160696579;6390.584612000205;6404.615723056631;6434.227892652912;6485.0596663484475;6517.315681853337;6387.8722425550295;6515.218173819172;6595.637239951849;6612.404883560503;6616.66916654175;6240.968795155995;6290.811275661737;6305.653189074645;6334.398232167937;6417.8716425672155 19:22:45 INFO - PID 3549 | |1;ext.html;778.7585848387;858.8969323681157;880.7313769300365;884.7390019944116;1177.16421340848;30287.09138725839;30737.07788766335;40722.99999999996;41296.58703412965;41479;41447.79276103623;41828.58171418285;41829.58170418302;41908.58091419085;41931;5899.085641725539;6038.215032045828;7633.770986870402;7684.577348245858;7840.13758486566;7660.961695191516;7733.110692270377;7747.147813740512;7756.263155000266;7758.262965018314;7693.884591731128;7731.304182623563;7759.146493885668;7775.961120194391;7778.4166187535875;7623.275788800055;7680.462367634268;7709.845803083963;7774.144844067148;7781.26078022587;7662.923370766277;7686.654100565488;7694.461387702863;7696.461247712662;7719.575423351714;37399.25201495982;37510.81244593787;37556.24887502235;37749.62250377489;37885.052873678105;3498.5801703795705;3541.13242255649;3546.2552863898613;3546.7517273790845;3554.289142171576;30213.395732085235;30348.54477182844;30405.391892162253;30516.694833051606;30577.847110764305;4692.178868697998;4763.118823017753;4802.567768900781;4808.735519546423;4846.830360937385;181118;183000;183145;183488.99999999866;183810;47691.90002649886;47695.523044769805;47737.04525909462;47842;47922;49756.253656195186;49843.25235121476;49866.750666247164;49935.50064499381;49990.25014624783;16273.10497922602;16291.348346066025;16334.673306533803;16476.0938148403;16536.503904882873;12258.325792081343;12479.5008199671;13478.056536042383;13547;13757.037007409586;13617.727645447036;13653.795193072112;13667.043306968615;13733.45066197341;13846.65383365424;5307.177387504943;5336.733163341895;5378.892422151535;5384.488473595002;5501.982133305351;959.6305422412421;967.1585720423136;988.7033889833021;1000.614763316114;1006.2955930848435;21634.675479867816;28098.71901281002;28973.56539651907;29467.263318416783;30038.399232015236;1056.630179437191;1076.3757020927842;1096.2107282756403;1106.8948449897407;1106.9446527673583;11782.234154780082;11790.23363481371;11851.644450666494;11881.524739010343;12021.33882636446;225898;227123;227430;228290;228713;51578.48421515737;51967;52183.217251741255;52220;52389.214161787604;1514.6364872430538;1521.5739592914001;1540.6687562174186;1543.1898253417046;1547.6208328959476;21716.782832171477;21747.347579572637;21950.231741888958;22183.556328873656;22248.332550023526;37430.251394972496;37715.43426848654;37731;37764.24471510499;37821.62178378181;196467;197544;197646;198010;198696;34532.48201277033;35702.642973569935;37344.253114938096;37409.625903741704;37589;44512.77743611391;45917.54082459133;46062.539374607164;46200.30699539442;46359.3046104302;29999.700003000562;31611;32184;32431;32464.35071298608;30380.392392151593;30698;31841.840790795897;32266.83866580652;32722.672773272916;33628.32743345168;33666;33667.83166084154;33669.49495757517;37402.43896341503;31410;31414.371712565164;33782.49326260157;33802.3239535203;34283.828580856934;24292.878535607208;24568.877155614107;24589.016439342227;24599;24727.25818225456 19:22:45 INFO - PID 3549 | |2;jquery.html;562.2157090858253;563.3465180390748;567.9695090053061;574.5633318677803;581.4331027248433;21881.562368752617;22449.102035918564;22583.774162258393;22597.322080337573;22736.43158921028;25893.741062589368;27946.161615151526;27974.580381294247;28004.159875203724;28173;6803.693833777492;6968.407685346751;6968.651567421634;6972.163340399159;6975.337342952437;6386.680665966706;6706.899396509032;6727.798166055026;6863.794086177398;6954.16550013999;6636.336366363374;6672.432843208333;6681.465482761368;6683.799486015428;6690.330966903295;6602.306757790435;6634.469242460592;6661.467082633402;6663.100481435041;6688.464922806188;6507.154069970921;6562.901556476609;6574.145361103074;6584.5061620378665;6585.637789921552;29890.10329690113;31582;31792;32080.679193208;32154.678453215638;1892.4511891551572;1962.4603234110734;1964.5285131568464;1964.567795085079;1965.3514340267677;19233.51916202106;19593.80406195934;19611.80388196114;19787;19800.108995095256;2340.9180678676335;2351.6472529120597;2398.5322862041735;2405.1581946318825;2409.8554086754675;122668;126475.36762316129;126908.36545817304;127343.36328318392;127551.36224318911;20422.97885105739;21145.577088458143;22130.11893989029;22335.888320558293;22384;43982.340264896055;43999;44148.55851441444;44176.558234417884;44284.55715442869;12009;12029;12067.758644827054;12186.939065304794;12226.877731222752;9136.406133601295;9541.093596108358;10346.844797328045;10347.172226221885;10379.740506487247;9989.650362237287;11309.547618095185;11369.943150284362;11631.65105046833;11859;4534.410526631516;4588.609968152745;4703.929441058387;4727.810887564459;4747.454042785055;954.2795189631784;966.3332300712486;973.7516933182135;974.9220062394992;987.7530617345664;19130.71303930442;19447.027648617513;19530;19723.605527889362;20599;1009.8131845608586;1011.2819897872446;1030.4332617060586;1044.9268551201344;1050.8423736439595;10743.194260430499;10876.728081798019;10882.564697412174;11182.337600286728;11300.265482743594;463694;480459;481645;486182;491338;116834;120647;121093;121559.39220303841;124989;1246.9750604987848;1252.092233130991;1305.745379650959;1306.8235788168665;1307.0981023094034;19353.225870965005;20594.485137871674;20697.27559535469;20836.791632083485;21199.15203391847;54560.72719636376;55006.72496637491;56628;57142;57441.85116297734;69968.65015674889;70101.29898700948;70174.64912675404;70627;72606.63696681483;12121.69695757613;14582.19797911125;14899.925500372428;14957.326920288831;15014.174220417983;20142.798572014093;20326.695099573815;20910;23413.06347746071;23589.646155308026;17674.116294184983;17889.642207156045;17890.463286101436;17894.28422863123;17952.640947181244;15285.235738213267;15996.883911268196;16141.354345826036;16519;16958.06730629827;17873.463796086136;18251.45245642633;18348.633027339645;19637.509062272988;19655.606887861875;14779.187144707144;14807.259637018322;14816.851831481546;14818.481353152589;14866.628334291729;18002.729959050364;18880.867147971167;19149.329773457863;19223.61552768909;19391.4182574523 19:22:45 INFO - PID 3549 | |3;mootools.html;1333.859944705806;1375.8968077394193;1398.8810951069158;1404.9157050576966;1408.9154650720957;13614.795778063324;13948.511802086903;14010.159390436582;14125.576232713021;14190.858091419082;14365.78451323231;14627.634309142277;14643.19462429566;14650.34073466694;14681.77977330341;2701.5002224588466;2755.7244275572384;2757.5174344489733;2758.3242105684035;2761.226856480179;2654.21700598323;2729.8089133760645;2751.312171957011;2755.0219672016447;2758.655168103987;2496.400863792686;2705.7970652201166;2754.132448278786;2755.4626847764694;2760.1029665358838;2620.096066856941;2621.6591843060373;2627.106783693544;2648.708642049373;2653.4162484253434;2597.285746419731;2627.5795872660283;2640.023191419168;2652.336915771057;2665.4802313548867;13640.65898352549;13865.584032479042;13884.791728124086;13912.304384780822;13914.652133696738;7301.2333704961275;7471.402287816962;7486.700531978714;7512.211217822105;7522.623868806538;4683.180443422388;4771.498992605796;4852.078105160008;4927.384076990376;4931;1790.579213884736;1824.1608859924452;1830.514913547911;1865.1047497201419;1875.6811342071744;22087.66868496974;22243.332700019026;22254.221102261505;22269.777302227096;22398.216062437736;6532.869342613216;6545.181852268466;6708.295628958889;6739.056532085512;6779.661016949133;15608.063516188839;15660.608484787743;15663.530094097196;15669.764953525706;15672.843271567366;7585.279398457138;7749.883751743729;7759.57322347265;7759.7672069838;7778.533288002624;6238.844028899314;6262.436380725757;6317.1156038154695;6444.613323200623;7019.5086343956455;5053.469385714447;5176.094183517869;5252.422233554306;5272.288241087481;5272.288241087481;1458.8117823265102;1527.1447989126125;1532.4866169833008;1533.7162624914426;1536.402141772544;815.2173913043545;822.8765685147276;833.9749807505784;850.953197574127;871.2811930157645;6590.275069742324;6860.245373008965;6890.517663763589;6910.930890691129;6963.61700106499;670.8658268346351;685.0854109763521;697.7278861244118;699.923008469068;700.8738427083072;3924.0582260257333;4579.6414846354155;4886.291487734258;4969.130402179677;5079.314292570456;16787.580310492336;17401.738973915402;17675;17684.557886052695;17740.822591774177;17129.22918468672;17388.739168912478;17816.198271077832;17863.46409607714;17918.10409479521;10286.485675716185;10331.690049298382;10368.118709909591;10491.580336786596;10519.421431821323;6857;7745.148033716399;7951.32413744815;8138.511689298661;8157.8368432632205;15851.682966340839;16196.757048644044;16680.332786688396;17172.484825455256;17389.217485212943;16816.990980541206;16930.66138677195;17118.229679664197;17155.399561015303;17311.740323895403;10812.891871081189;10988.725281868017;11256.099512038854;11261.380624065756;11303.095752339957;12708.87291127077;12772.872271277169;12774.68063298425;12789.488420463078;12839.679008024874;10053.246006549683;10246.846297305696;10454.63408780689;10559.947200264256;10570.2600817942;9880.160186384237;9934.900650993397;10025.649102281384;10122.79754404893;10196.235282354002;8632.266257368194;8730.56347182651;8811.427257228259;8828.51443170606;8834.116588341114;6185.2886918003205;6393.680315984089;6522.869542609026;6560.507961902781;6639.2364878037715;6327.4305312520255;6507.316731743099;6623.900641490478;6824.93175068243;6830.453563714792 19:22:45 INFO - PID 3549 | |4;prototype.html;488.30904270457324;494.8342305327715;513.7200225876896;520.6173462505059;527.1723394270996;6102.359252278514;6152.784652537162;6271.404216599416;6288.465480434169;6328.392816094828;5993.880122397561;6085.695715214232;6122.9387706122925;6174.567780255384;6190.226221722285;4986.925196122061;4995.475475075101;5009.6242781791325;5032.220005899082;5034.82378116766;4960.826371077013;5002.549770520653;5002.849914502571;5006.774695138709;5048.343715317003;4822.132016237076;4946.826861059863;4963.677360971544;4975.975120124394;4977.511244377811;4979.958217130977;4986.2769898364895;5014.949850501484;5016.698998060092;5030.094582975063;4411.470623525165;4451.888702782424;4455.554444555519;4487.461504619434;4506.211413002711;5856.1508581255475;5895.55334536167;6064.63612183266;6069.877072741557;6096.573239873211;5743;5754.539636829086;5762.510186634141;5775.220345253379;5776.162456443834;6545.803625891231;6620.6358650274215;6652.600843949379;6653.201615806086;6661.700223489906;4833.468318484964;4915.238138088566;4917.631177661689;4927.334809800667;4929.630277729185;6917.342852429011;6997;7024.473164512682;7053.259407762213;7061.47038972074;5011.649184557046;5030.949690503121;5086.287919691246;5088.465711100355;5105;4981.975090124526;5010.749462526859;5034.874128146753;5103.489651034867;5118.129917913963;5706.201131841545;5716.799912003143;5752.252207213036;5769.365369809318;5786.913196302059;6543.607383557001;6734.552071304693;6745.325467453215;6753.696083676246;6773.254941956381;1752.6582316448425;1775.2366482412428;1778.7193220880945;1779.1549014218142;1786.1426515272742;1149.3448734221581;1192.4812706472712;1194.6177223288637;1215.9878401216051;1234.0066246671336;5726.938302211201;5759.164921086419;5767.85580360486;5776.42235776419;5797.333306669702;6540.444062254666;6633.635150066792;6670.733170673216;6672.599644021374;6762.830929226809;5608.579356548275;5762.423757624288;5781.335146458127;5801.317617890849;5814.825555233349;3569.303985722759;3591.94612080819;3617.656322649344;3632.6912212462234;3662.926741465209;6537.673116344164;6605.966970165118;6607.735690572419;6613.900791488131;6614.206295244601;6963.6866341014775;6967.895481567781;6985.26654701249;6992.755253566203;7059.89410158848;6404.455621272151;6564.934350656527;6571.84992626298;6584.341565843473;6635.4359879410795;6669.933300667125;6762.526623136333;6785.728570857111;6793.320667933167;6803.523753337219;6635.933640663725;6643.867122657616;6692.498062645223;6697.464202863856;6757.3242675734;6436.388543088399;6455.419012288917;6500.707468164039;6536.346365363425;6538.934610653832;4942.654014219114;4983.202687569971;5019.146745053276;5043.2435134730085;5058.064258112261;6693.163354580677;6694.4644428444635;6750.831229219112;6769.89845152333;6861.313868613299;6476.676166191766;6519.674016299071;6567.146270984741;6586.703598338182;6588.868222635425;6417.518686098468;6482.351764823668;6510.153680021567;6517.73929042833;6534.542582019213;6047.667378294236;6342.429181373698;6355.904661430175;6420.133282007057;6467.708953097216;6372.362763723776;6373.012183111625;6428.582142160744;6434.49054868611;6503.512236582181;6261.937380626136;6336.176297081534;6363.677257800777;6392.552521323462;6419.935800642121 19:22:45 INFO - PID 3549 | |5;yui.html;885.6147575804522;907.990920090799;916.0701887584099;920.4109370003199;922.9815403691927;15784.368625254976;16191.83808161918;16228;16270.430534931294;16293.348266069373;15416.537503874873;18611.627767444676;19515.12181951812;21487.355379338645;21642.35072947814;984.247051005981;996.9152622027136;1002.1481740520572;1004.0010189861099;1008.2287050406445;1011.1556850030233;1060.0406631998055;1077.6336045744445;1077.7144056824948;1081.6809041332826;1045.592219034577;1110.189561620018;1118.3569447567681;1118.3792994887833;1119.6361182615642;1097.3580455433541;1105.4528008635777;1108.41808050774;1109.4230999880058;1109.983350249747;812.2080971053235;818.7461886815106;820.8932838730987;821.4003777242647;822.013583699557;17523.474295771146;17550.297988080463;19346;19460.80539194604;19464.610707785905;20460.590788184152;20625;20675.483112922146;21132.471688207763;21141.471463213387;15179.924100379538;15369;15607.921960390238;15616.609584760472;15618.609534761608;3471.0628130404903;3475.791452512857;3498.5626796650417;3511.719062474996;3512.877049303262;113577.86422135755;114060.42969785181;114651;119116.40441797735;121016.39491802573;15917.442889498812;16268.430604928772;16308.75536866948;16314.102724350038;16334.101624410772;28076.71923280782;29671.406571868443;29683.703162968526;29700.40599188004;29720.55419168714;8503.957480212559;8511.616977236039;8538.743837684879;8610.44032137909;8635.740927772176;3819.6753275971296;4030.91938161241;4048.332025215865;4053.858114965962;4083.4283200351974;4589.829593453648;4773.570378665867;4775.140474714584;4778.402699662543;4805.495422980537;929.716436486878;953.1707414549386;971.6696323250129;975.190591808797;979.2117345536911;629.2763322179438;640.4684112186874;653.7450394346209;681.8670359279992;682.8702546516146;10785.78428431427;12861.678458038625;13455.125416847874;13461.259630720404;13677.726445471233;631.425402883374;664.2593508238376;674.2280089297726;688.1638808847274;695.523566357047;4984.950150498448;5067.442581316052;5172.767225474862;5185.766640501187;5244.6328756987405;98990.51514227293;102036.48981755043;102227.48886255521;103871.4806425963;105000.47499762605;85136.14863851406;87336.56331718301;87679.56160219158;88597.11402886017;90758.54620726855;73467.63266183635;77264.61367693238;77371;79173.20826791774;80387;10477.214208934209;10766.407847568145;11011.944940275567;11090.390028548507;11352.489137988645;29942.401151977276;31440.685593143775;32069.518957215194;36687.08282292964;36794.448083278236;60542;60747;64983;65352.67323663351;68864.65567672129;18527.53681157982;18942.905285473484;19003.809961900202;19018.23927042958;19142.23431062742;20227.59544809125;20695.58608827845;21236.150553977666;21585.352439426842;22018;17514.38699645506;17902.641947160722;18340.908295458437;18649.720254195927;18720.625587487903;16839.073850938315;16873.409430669868;17008.744868827223;17066;18627.72058419152;17419.912900435418;17548.59611231073;17660.470185894443;18097.909510452362;18548.350807721665;12187.51249949992;13743.381547830571;14069.296535173406;14230.501932432315;14499.92750036243;13851.376688049264;14701.41194352214;15185.772213416587;15268.770968435705;15354.30905609228 19:22:45 INFO - PID 3549 | __end_tp_report 19:22:45 INFO - PID 3549 | __start_cc_report 19:22:45 INFO - PID 3549 | _x_x_mozilla_cycle_collect,374 19:22:45 INFO - PID 3549 | __end_cc_report 19:22:45 INFO - PID 3549 | __startTimestamp1501208565598__endTimestamp 19:22:45 INFO - PID 3549 | 19:22:45 INFO - PID 3549 | ------- Summary: start ------- 19:22:45 INFO - PID 3549 | Number of tests: 6 19:22:45 INFO - PID 3549 | 19:22:45 INFO - PID 3549 | [#0] dojo.html Cycles:165 Average:6156.15 Median:6387.87 stddev:714.32 (11.2%) stddev-sans-first:677.06 19:22:45 INFO - PID 3549 | Values: 3171.7 3186.4 3188.1 3197.1 3238.8 6151.2 6166.4 6214.1 6220.7 6222.1 6181.8 6213.2 6226.7 6272.3 6316.3 5676.4 5714.7 5749.4 5785.4 5830.3 5560.9 5681.6 5773.0 5776.1 5849.0 5587.5 5639.8 5652.7 5680.7 5681.0 5735.1 5748.3 5755.5 5797.2 5802.9 5570.5 5708.9 5732.1 5740.8 5757.5 6126.5 6134.3 6135.2 6210.8 6221.8 6601.8 6697.2 6700.5 6702.5 6764.3 6717.3 6731.9 6736.4 6738.4 6753.3 6138.5 6196.3 6200.8 6202.8 6344.7 6960.3 6968.2 6979.6 6985.8 6988.8 6516.6 6634.8 6639.9 6674.5 6676.3 6660.1 6660.6 6663.5 6664.1 6664.5 6605.9 6613.8 6635.9 6680.2 6712.3 6470.5 6670.5 6680.7 6708.8 6782.5 5432.2 5498.9 5508.2 5511.9 5519.7 4633.5 4685.4 4698.3 4700.1 4724.4 5818.8 5822.6 5883.8 5905.5 5915.1 6695.9 6711.7 6715.3 6779.3 6832.1 5752.2 5832.3 5834.1 5836.1 5840.4 5881.6 5890.3 5914.1 5918.3 5925.3 6387.2 6467.0 6484.6 6487.9 6504.5 6730.5 6731.9 6736.3 6737.2 6743.9 6483.6 6507.3 6511.3 6519.7 6524.7 5754.4 6562.6 6629.5 6650.2 6658.9 6468.6 6660.8 6662.3 6752.0 6760.7 6447.6 6448.3 6448.4 6454.8 6463.6 6369.6 6414.1 6420.6 6450.6 6454.1 6390.6 6404.6 6434.2 6485.1 6517.3 6387.9 6515.2 6595.6 6612.4 6616.7 6241.0 6290.8 6305.7 6334.4 6417.9 19:22:45 INFO - PID 3549 | 19:22:45 INFO - PID 3549 | [#1] ext.html Cycles:180 Average:37237.80 Median:3519.86 stddev:52704.50 (1497.3%) stddev-sans-first:52781.25 19:22:45 INFO - PID 3549 | Values: 778.8 858.9 880.7 884.7 1177.2 30287.1 30737.1 40723.0 41296.6 41479.0 41447.8 41828.6 41829.6 41908.6 41931.0 5899.1 6038.2 7633.8 7684.6 7840.1 7661.0 7733.1 7747.1 7756.3 7758.3 7693.9 7731.3 7759.1 7776.0 7778.4 7623.3 7680.5 7709.8 7774.1 7781.3 7662.9 7686.7 7694.5 7696.5 7719.6 37399.3 37510.8 37556.2 37749.6 37885.1 3498.6 3541.1 3546.3 3546.8 3554.3 30213.4 30348.5 30405.4 30516.7 30577.8 4692.2 4763.1 4802.6 4808.7 4846.8 181118.0 183000.0 183145.0 183489.0 183810.0 47691.9 47695.5 47737.0 47842.0 47922.0 49756.3 49843.3 49866.8 49935.5 49990.3 16273.1 16291.3 16334.7 16476.1 16536.5 12258.3 12479.5 13478.1 13547.0 13757.0 13617.7 13653.8 13667.0 13733.5 13846.7 5307.2 5336.7 5378.9 5384.5 5502.0 959.6 967.2 988.7 1000.6 1006.3 21634.7 28098.7 28973.6 29467.3 30038.4 1056.6 1076.4 1096.2 1106.9 1106.9 11782.2 11790.2 11851.6 11881.5 12021.3 225898.0 227123.0 227430.0 228290.0 228713.0 51578.5 51967.0 52183.2 52220.0 52389.2 1514.6 1521.6 1540.7 1543.2 1547.6 21716.8 21747.3 21950.2 22183.6 22248.3 37430.3 37715.4 37731.0 37764.2 37821.6 196467.0 197544.0 197646.0 198010.0 198696.0 34532.5 35702.6 37344.3 37409.6 37589.0 44512.8 45917.5 46062.5 46200.3 46359.3 29999.7 31611.0 32184.0 32431.0 32464.4 30380.4 30698.0 31841.8 32266.8 32722.7 33628.3 33666.0 33667.8 33669.5 37402.4 31410.0 31414.4 33782.5 33802.3 34283.8 24292.9 24568.9 24589.0 24599.0 24727.3 19:22:45 INFO - PID 3549 | 19:22:45 INFO - PID 3549 | [#2] jquery.html Cycles:180 Average:35419.97 Median:21172.36 stddev:80762.48 (381.5%) stddev-sans-first:80946.63 19:22:45 INFO - PID 3549 | Values: 562.2 563.3 568.0 574.6 581.4 21881.6 22449.1 22583.8 22597.3 22736.4 25893.7 27946.2 27974.6 28004.2 28173.0 6803.7 6968.4 6968.7 6972.2 6975.3 6386.7 6706.9 6727.8 6863.8 6954.2 6636.3 6672.4 6681.5 6683.8 6690.3 6602.3 6634.5 6661.5 6663.1 6688.5 6507.2 6562.9 6574.1 6584.5 6585.6 29890.1 31582.0 31792.0 32080.7 32154.7 1892.5 1962.5 1964.5 1964.6 1965.4 19233.5 19593.8 19611.8 19787.0 19800.1 2340.9 2351.6 2398.5 2405.2 2409.9 122668.0 126475.4 126908.4 127343.4 127551.4 20423.0 21145.6 22130.1 22335.9 22384.0 43982.3 43999.0 44148.6 44176.6 44284.6 12009.0 12029.0 12067.8 12186.9 12226.9 9136.4 9541.1 10346.8 10347.2 10379.7 9989.7 11309.5 11369.9 11631.7 11859.0 4534.4 4588.6 4703.9 4727.8 4747.5 954.3 966.3 973.8 974.9 987.8 19130.7 19447.0 19530.0 19723.6 20599.0 1009.8 1011.3 1030.4 1044.9 1050.8 10743.2 10876.7 10882.6 11182.3 11300.3 463694.0 480459.0 481645.0 486182.0 491338.0 116834.0 120647.0 121093.0 121559.4 124989.0 1247.0 1252.1 1305.7 1306.8 1307.1 19353.2 20594.5 20697.3 20836.8 21199.2 54560.7 55006.7 56628.0 57142.0 57441.9 69968.7 70101.3 70174.6 70627.0 72606.6 12121.7 14582.2 14899.9 14957.3 15014.2 20142.8 20326.7 20910.0 23413.1 23589.6 17674.1 17889.6 17890.5 17894.3 17952.6 15285.2 15996.9 16141.4 16519.0 16958.1 17873.5 18251.5 18348.6 19637.5 19655.6 14779.2 14807.3 14816.9 14818.5 14866.6 18002.7 18880.9 19149.3 19223.6 19391.4 19:22:45 INFO - PID 3549 | 19:22:45 INFO - PID 3549 | [#3] mootools.html Cycles:180 Average:8417.78 Median:2650.52 stddev:5708.56 (215.4%) stddev-sans-first:5699.76 19:22:45 INFO - PID 3549 | Values: 1333.9 1375.9 1398.9 1404.9 1408.9 13614.8 13948.5 14010.2 14125.6 14190.9 14365.8 14627.6 14643.2 14650.3 14681.8 2701.5 2755.7 2757.5 2758.3 2761.2 2654.2 2729.8 2751.3 2755.0 2758.7 2496.4 2705.8 2754.1 2755.5 2760.1 2620.1 2621.7 2627.1 2648.7 2653.4 2597.3 2627.6 2640.0 2652.3 2665.5 13640.7 13865.6 13884.8 13912.3 13914.7 7301.2 7471.4 7486.7 7512.2 7522.6 4683.2 4771.5 4852.1 4927.4 4931.0 1790.6 1824.2 1830.5 1865.1 1875.7 22087.7 22243.3 22254.2 22269.8 22398.2 6532.9 6545.2 6708.3 6739.1 6779.7 15608.1 15660.6 15663.5 15669.8 15672.8 7585.3 7749.9 7759.6 7759.8 7778.5 6238.8 6262.4 6317.1 6444.6 7019.5 5053.5 5176.1 5252.4 5272.3 5272.3 1458.8 1527.1 1532.5 1533.7 1536.4 815.2 822.9 834.0 851.0 871.3 6590.3 6860.2 6890.5 6910.9 6963.6 670.9 685.1 697.7 699.9 700.9 3924.1 4579.6 4886.3 4969.1 5079.3 16787.6 17401.7 17675.0 17684.6 17740.8 17129.2 17388.7 17816.2 17863.5 17918.1 10286.5 10331.7 10368.1 10491.6 10519.4 6857.0 7745.1 7951.3 8138.5 8157.8 15851.7 16196.8 16680.3 17172.5 17389.2 16817.0 16930.7 17118.2 17155.4 17311.7 10812.9 10988.7 11256.1 11261.4 11303.1 12708.9 12772.9 12774.7 12789.5 12839.7 10053.2 10246.8 10454.6 10559.9 10570.3 9880.2 9934.9 10025.6 10122.8 10196.2 8632.3 8730.6 8811.4 8828.5 8834.1 6185.3 6393.7 6522.9 6560.5 6639.2 6327.4 6507.3 6623.9 6824.9 6830.5 19:22:45 INFO - PID 3549 | 19:22:45 INFO - PID 3549 | [#4] prototype.html Cycles:180 Average:5524.93 Median:6077.79 stddev:1552.38 (25.5%) stddev-sans-first:1510.00 19:22:45 INFO - PID 3549 | Values: 488.3 494.8 513.7 520.6 527.2 6102.4 6152.8 6271.4 6288.5 6328.4 5993.9 6085.7 6122.9 6174.6 6190.2 4986.9 4995.5 5009.6 5032.2 5034.8 4960.8 5002.5 5002.8 5006.8 5048.3 4822.1 4946.8 4963.7 4976.0 4977.5 4980.0 4986.3 5014.9 5016.7 5030.1 4411.5 4451.9 4455.6 4487.5 4506.2 5856.2 5895.6 6064.6 6069.9 6096.6 5743.0 5754.5 5762.5 5775.2 5776.2 6545.8 6620.6 6652.6 6653.2 6661.7 4833.5 4915.2 4917.6 4927.3 4929.6 6917.3 6997.0 7024.5 7053.3 7061.5 5011.6 5030.9 5086.3 5088.5 5105.0 4982.0 5010.7 5034.9 5103.5 5118.1 5706.2 5716.8 5752.3 5769.4 5786.9 6543.6 6734.6 6745.3 6753.7 6773.3 1752.7 1775.2 1778.7 1779.2 1786.1 1149.3 1192.5 1194.6 1216.0 1234.0 5726.9 5759.2 5767.9 5776.4 5797.3 6540.4 6633.6 6670.7 6672.6 6762.8 5608.6 5762.4 5781.3 5801.3 5814.8 3569.3 3591.9 3617.7 3632.7 3662.9 6537.7 6606.0 6607.7 6613.9 6614.2 6963.7 6967.9 6985.3 6992.8 7059.9 6404.5 6564.9 6571.8 6584.3 6635.4 6669.9 6762.5 6785.7 6793.3 6803.5 6635.9 6643.9 6692.5 6697.5 6757.3 6436.4 6455.4 6500.7 6536.3 6538.9 4942.7 4983.2 5019.1 5043.2 5058.1 6693.2 6694.5 6750.8 6769.9 6861.3 6476.7 6519.7 6567.1 6586.7 6588.9 6417.5 6482.4 6510.2 6517.7 6534.5 6047.7 6342.4 6355.9 6420.1 6467.7 6372.4 6373.0 6428.6 6434.5 6503.5 6261.9 6336.2 6363.7 6392.6 6419.9 19:22:45 INFO - PID 3549 | 19:22:45 INFO - PID 3549 | [#5] yui.html Cycles:180 Average:22165.17 Median:20344.09 stddev:29319.26 (144.1%) stddev-sans-first:29357.97 19:22:45 INFO - PID 3549 | Values: 885.6 908.0 916.1 920.4 923.0 15784.4 16191.8 16228.0 16270.4 16293.3 15416.5 18611.6 19515.1 21487.4 21642.4 984.2 996.9 1002.1 1004.0 1008.2 1011.2 1060.0 1077.6 1077.7 1081.7 1045.6 1110.2 1118.4 1118.4 1119.6 1097.4 1105.5 1108.4 1109.4 1110.0 812.2 818.7 820.9 821.4 822.0 17523.5 17550.3 19346.0 19460.8 19464.6 20460.6 20625.0 20675.5 21132.5 21141.5 15179.9 15369.0 15607.9 15616.6 15618.6 3471.1 3475.8 3498.6 3511.7 3512.9 113577.9 114060.4 114651.0 119116.4 121016.4 15917.4 16268.4 16308.8 16314.1 16334.1 28076.7 29671.4 29683.7 29700.4 29720.6 8504.0 8511.6 8538.7 8610.4 8635.7 3819.7 4030.9 4048.3 4053.9 4083.4 4589.8 4773.6 4775.1 4778.4 4805.5 929.7 953.2 971.7 975.2 979.2 629.3 640.5 653.7 681.9 682.9 10785.8 12861.7 13455.1 13461.3 13677.7 631.4 664.3 674.2 688.2 695.5 4985.0 5067.4 5172.8 5185.8 5244.6 98990.5 102036.5 102227.5 103871.5 105000.5 85136.1 87336.6 87679.6 88597.1 90758.5 73467.6 77264.6 77371.0 79173.2 80387.0 10477.2 10766.4 11011.9 11090.4 11352.5 29942.4 31440.7 32069.5 36687.1 36794.4 60542.0 60747.0 64983.0 65352.7 68864.7 18527.5 18942.9 19003.8 19018.2 19142.2 20227.6 20695.6 21236.2 21585.4 22018.0 17514.4 17902.6 18340.9 18649.7 18720.6 16839.1 16873.4 17008.7 17066.0 18627.7 17419.9 17548.6 17660.5 18097.9 18548.4 12187.5 13743.4 14069.3 14230.5 14499.9 13851.4 14701.4 15185.8 15268.8 15354.3 19:22:45 INFO - PID 3549 | -------- Summary: end -------- 19:22:45 INFO - PID 3549 | 19:22:46 INFO - TEST-INFO | 3549: exit 0 19:22:46 INFO - TEST-OK | dromaeo_css | took 1116012ms 19:22:46 INFO - TEST-START | kraken 19:22:46 INFO - Initialising browser for kraken test... 19:22:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51390/getInfo.html -profile /tmp/tmpUoo_Mz/profile 19:22:46 INFO - TEST-INFO | started process 3921 (/builds/slave/test/build/application/firefox/firefox http://localhost:51390/getInfo.html) 19:22:52 INFO - TEST-INFO | 3921: exit 0 19:22:52 INFO - Browser initialized. 19:22:52 INFO - Running cycle 1/1 for kraken test... 19:22:52 INFO - TEST-INFO | started process 4146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUoo_Mz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:22:53 INFO - PID 4146 | 19:22:53 INFO - PID 4146 | (/builds/slave/test/build/application/firefox/firefox:4200): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:22:53 INFO - PID 4146 | 19:23:03 INFO - PID 4146 | RSS: Main: 173027328 19:23:03 INFO - PID 4146 | 19:23:06 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51390/tests/kraken/driver.html?testName=audio-beat-detection) 19:23:07 INFO - PID 4146 | RSS: Main: 177905664 19:23:07 INFO - PID 4146 | 19:23:09 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51390/tests/kraken/driver.html?testName=audio-dft) 19:23:10 INFO - PID 4146 | RSS: Main: 178270208 19:23:10 INFO - PID 4146 | 19:23:13 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51390/tests/kraken/driver.html?testName=audio-fft) 19:23:14 INFO - PID 4146 | RSS: Main: 173318144 19:23:14 INFO - PID 4146 | 19:23:16 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51390/tests/kraken/driver.html?testName=audio-oscillator) 19:23:17 INFO - PID 4146 | RSS: Main: 173838336 19:23:17 INFO - PID 4146 | 19:23:19 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51390/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:23:20 INFO - PID 4146 | RSS: Main: 174145536 19:23:20 INFO - PID 4146 | 19:23:23 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51390/tests/kraken/driver.html?testName=imaging-darkroom) 19:23:23 INFO - PID 4146 | RSS: Main: 176635904 19:23:23 INFO - PID 4146 | 19:23:27 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51390/tests/kraken/driver.html?testName=imaging-desaturate) 19:23:27 INFO - PID 4146 | RSS: Main: 176939008 19:23:27 INFO - PID 4146 | 19:23:30 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51390/tests/kraken/driver.html?testName=json-parse-financial) 19:23:31 INFO - PID 4146 | RSS: Main: 177283072 19:23:31 INFO - PID 4146 | 19:23:33 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51390/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:23:33 INFO - PID 4146 | RSS: Main: 177418240 19:23:33 INFO - PID 4146 | 19:23:35 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51390/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:23:36 INFO - PID 4146 | RSS: Main: 174522368 19:23:36 INFO - PID 4146 | 19:23:38 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51390/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:23:39 INFO - PID 4146 | RSS: Main: 174219264 19:23:39 INFO - PID 4146 | 19:23:41 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:23:42 INFO - PID 4146 | RSS: Main: 174895104 19:23:42 INFO - PID 4146 | 19:23:45 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:23:46 INFO - PID 4146 | RSS: Main: 174972928 19:23:46 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | Cycle 1(1): loaded http://localhost:51390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51390/tests/kraken/driver.html?testName=ai-astar) 19:23:48 INFO - PID 4146 | RSS: Main: 176738304 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | __start_tp_report 19:23:48 INFO - PID 4146 | _x_x_mozilla_page_load 19:23:48 INFO - PID 4146 | _x_x_mozilla_page_load_details 19:23:48 INFO - PID 4146 | |i|pagename|runs| 19:23:48 INFO - PID 4146 | |0;ai-astar;99;108;105;112;111;112;109;101;110;108 19:23:48 INFO - PID 4146 | |1;audio-beat-detection;144;121;146;174;118;144;158;118;168;117 19:23:48 INFO - PID 4146 | |2;audio-dft;170;166;164;170;169;181;165;165;165;164 19:23:48 INFO - PID 4146 | |3;audio-fft;77;75;77;188;75;85;76;85;104;76 19:23:48 INFO - PID 4146 | |4;audio-oscillator;79;79;124;83;79;78;129;79;78;138 19:23:48 INFO - PID 4146 | |5;imaging-gaussian-blur;113;115;115;116;114;114;114;114;113;119 19:23:48 INFO - PID 4146 | |6;imaging-darkroom;149;149;151;150;155;150;150;151;152;152 19:23:48 INFO - PID 4146 | |7;imaging-desaturate;94;94;94;98;98;100;95;95;94;94 19:23:48 INFO - PID 4146 | |8;json-parse-financial;56;57;55;55;55;59;55;55;54;55 19:23:48 INFO - PID 4146 | |9;json-stringify-tinderbox;54;54;55;61;65;54;55;54;56;60 19:23:48 INFO - PID 4146 | |10;stanford-crypto-aes;79;80;81;81;79;79;80;80;82;87 19:23:48 INFO - PID 4146 | |11;stanford-crypto-ccm;127;132;124;136;126;130;129;139;120;162 19:23:48 INFO - PID 4146 | |12;stanford-crypto-pbkdf2;176;185;173;176;170;180;169;174;184;170 19:23:48 INFO - PID 4146 | |13;stanford-crypto-sha256-iterative;68;71;71;68;75;70;68;84;69;67 19:23:48 INFO - PID 4146 | __end_tp_report 19:23:48 INFO - PID 4146 | __start_cc_report 19:23:48 INFO - PID 4146 | _x_x_mozilla_cycle_collect,949 19:23:48 INFO - PID 4146 | __end_cc_report 19:23:48 INFO - PID 4146 | __startTimestamp1501208628469__endTimestamp 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | ------- Summary: start ------- 19:23:48 INFO - PID 4146 | Number of tests: 14 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#0] ai-astar Cycles:10 Average:107.50 Median:110.50 stddev:4.50 (4.1%) stddev-sans-first:3.57 19:23:48 INFO - PID 4146 | Values: 99.0 108.0 105.0 112.0 111.0 112.0 109.0 101.0 110.0 108.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:145.00 stddev:21.56 (14.9%) stddev-sans-first:22.84 19:23:48 INFO - PID 4146 | Values: 144.0 121.0 146.0 174.0 118.0 144.0 158.0 118.0 168.0 117.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#2] audio-dft Cycles:10 Average:167.90 Median:167.50 stddev:5.17 (3.1%) stddev-sans-first:5.43 19:23:48 INFO - PID 4146 | Values: 170.0 166.0 164.0 170.0 169.0 181.0 165.0 165.0 165.0 164.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#3] audio-fft Cycles:10 Average:91.80 Median:76.50 stddev:34.96 (45.7%) stddev-sans-first:36.66 19:23:48 INFO - PID 4146 | Values: 77.0 75.0 77.0 188.0 75.0 85.0 76.0 85.0 104.0 76.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.00 stddev:24.92 (31.5%) stddev-sans-first:25.79 19:23:48 INFO - PID 4146 | Values: 79.0 79.0 124.0 83.0 79.0 78.0 129.0 79.0 78.0 138.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.77 (1.5%) stddev-sans-first:1.76 19:23:48 INFO - PID 4146 | Values: 113.0 115.0 115.0 116.0 114.0 114.0 114.0 114.0 113.0 119.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:1.79 (1.2%) stddev-sans-first:1.76 19:23:48 INFO - PID 4146 | Values: 149.0 149.0 151.0 150.0 155.0 150.0 150.0 151.0 152.0 152.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:94.50 stddev:2.22 (2.4%) stddev-sans-first:2.28 19:23:48 INFO - PID 4146 | Values: 94.0 94.0 94.0 98.0 98.0 100.0 95.0 95.0 94.0 94.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:1.43 (2.6%) stddev-sans-first:1.51 19:23:48 INFO - PID 4146 | Values: 56.0 57.0 55.0 55.0 55.0 59.0 55.0 55.0 54.0 55.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:55.50 stddev:3.85 (6.9%) stddev-sans-first:3.95 19:23:48 INFO - PID 4146 | Values: 54.0 54.0 55.0 61.0 65.0 54.0 55.0 54.0 56.0 60.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:2.39 (3.0%) stddev-sans-first:2.45 19:23:48 INFO - PID 4146 | Values: 79.0 80.0 81.0 81.0 79.0 79.0 80.0 80.0 82.0 87.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:131.00 stddev:11.76 (9.0%) stddev-sans-first:12.30 19:23:48 INFO - PID 4146 | Values: 127.0 132.0 124.0 136.0 126.0 130.0 129.0 139.0 120.0 162.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:176.00 stddev:5.72 (3.2%) stddev-sans-first:6.06 19:23:48 INFO - PID 4146 | Values: 176.0 185.0 173.0 176.0 170.0 180.0 169.0 174.0 184.0 170.0 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:70.50 stddev:5.09 (7.2%) stddev-sans-first:5.27 19:23:48 INFO - PID 4146 | Values: 68.0 71.0 71.0 68.0 75.0 70.0 68.0 84.0 69.0 67.0 19:23:48 INFO - PID 4146 | -------- Summary: end -------- 19:23:48 INFO - PID 4146 | 19:23:48 INFO - PID 4146 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:23:49 INFO - TEST-INFO | 4146: exit 0 19:23:49 INFO - TEST-OK | kraken | took 62807ms 19:23:49 INFO - SUITE-END | took 1178s 19:23:49 INFO - Completed test suite (00:19:39) 19:23:49 INFO - javascript benchmark 19:23:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8458.796956954513, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3171.666974967627, 3186.426443240216, 3188.1392024153474, 3197.0568682238736, 3238.7732858699887, 6151.169592105064, 6166.414190651881, 6214.1300217969465, 6220.657863817488, 6222.12890195373, 6181.845453863644, 6213.161223234862, 6226.719797609107, 6272.278687950887, 6316.27362853272, 5676.432356764311, 5714.685692286933, 5749.367569567345, 5785.421457854223, 5830.32951210612, 5560.888782224353, 5681.602287839853, 5773.0, 5776.075827867542, 5848.970755146218, 5587.469190426923, 5639.774409023634, 5652.660840349592, 5680.659160450366, 5681.0, 5735.11105778605, 5748.2527271454865, 5755.510781583571, 5797.217375654317, 5802.912956305659, 5570.526505247059, 5708.914366284509, 5732.140178973145, 5740.827775166752, 5757.539396848242, 6126.540509461808, 6134.325224225332, 6135.2024236849375, 6210.844728881769, 6221.751129954796, 6601.768938087192, 6697.22981857083, 6700.530962832604, 6702.530822842355, 6764.323567643246, 6717.294684058153, 6731.899021514681, 6736.360045795642, 6738.35985581369, 6753.257141714407, 6138.47822935051, 6196.2874269459135, 6200.751969921198, 6202.782902598477, 6344.714487848058, 6960.338767817049, 6968.198657154391, 6979.616121113388, 6985.79042628722, 6988.755393561302, 6516.57642253252, 6634.800955971328, 6639.933600664028, 6674.5327827052615, 6676.298988606223, 6660.067590537328, 6660.56706314088, 6663.533552651268, 6664.133662623828, 6664.466842652673, 6605.86788264232, 6613.801585952429, 6635.9336406636285, 6680.198376194888, 6712.328767123347, 6470.5147113965695, 6670.4997125215805, 6680.6993685283305, 6708.798736037927, 6782.457403407716, 5432.2123292123215, 5498.862528436821, 5508.228847961289, 5511.917321240185, 5519.69641669704, 4633.513481084505, 4685.367475390847, 4698.3187437821325, 4700.059988002413, 4724.4094488188975, 5818.7672493100645, 5822.563307751935, 5883.794067207713, 5905.498032667186, 5915.142304365843, 6695.933040669628, 6711.664416779142, 6715.328467153343, 6779.322067793181, 6832.145981752281, 5752.223449834302, 5832.270966129234, 5834.066549352168, 5836.066229403275, 5840.415958404125, 5881.617694849821, 5890.322612899486, 5914.142449344821, 5918.2898052234, 5925.318588362394, 6387.169667943138, 6467.0, 6484.578502397329, 6487.870242595121, 6504.5446818723185, 6730.4952128589575, 6731.932680673326, 6736.292689267556, 6737.191537015589, 6743.8988415172835, 6483.610983341015, 6507.349265073455, 6511.3163117871945, 6519.7392104315295, 6524.67376631176, 5754.395788442321, 6562.639054852029, 6629.5359324846795, 6650.168728908887, 6658.866822663423, 6468.579542329733, 6660.800175994728, 6662.333766623299, 6751.966240168964, 6760.661966901537, 6447.6131432114225, 6448.25845027809, 6448.387403196689, 6454.806355809145, 6463.612183269019, 6369.554131210956, 6414.10202571631, 6420.550561460653, 6450.612963222034, 6454.064160696579, 6390.584612000205, 6404.615723056631, 6434.227892652912, 6485.0596663484475, 6517.315681853337, 6387.8722425550295, 6515.218173819172, 6595.637239951849, 6612.404883560503, 6616.66916654175, 6240.968795155995, 6290.811275661737, 6305.653189074645, 6334.398232167937, 6417.8716425672155], "value": 6103.952930709273, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.7585848387, 858.8969323681157, 880.7313769300365, 884.7390019944116, 1177.16421340848, 30287.09138725839, 30737.07788766335, 40722.99999999996, 41296.58703412965, 41479.0, 41447.79276103623, 41828.58171418285, 41829.58170418302, 41908.58091419085, 41931.0, 5899.085641725539, 6038.215032045828, 7633.770986870402, 7684.577348245858, 7840.13758486566, 7660.961695191516, 7733.110692270377, 7747.147813740512, 7756.263155000266, 7758.262965018314, 7693.884591731128, 7731.304182623563, 7759.146493885668, 7775.961120194391, 7778.4166187535875, 7623.275788800055, 7680.462367634268, 7709.845803083963, 7774.144844067148, 7781.26078022587, 7662.923370766277, 7686.654100565488, 7694.461387702863, 7696.461247712662, 7719.575423351714, 37399.25201495982, 37510.81244593787, 37556.24887502235, 37749.62250377489, 37885.052873678105, 3498.5801703795705, 3541.13242255649, 3546.2552863898613, 3546.7517273790845, 3554.289142171576, 30213.395732085235, 30348.54477182844, 30405.391892162253, 30516.694833051606, 30577.847110764305, 4692.178868697998, 4763.118823017753, 4802.567768900781, 4808.735519546423, 4846.830360937385, 181118.0, 183000.0, 183145.0, 183488.99999999866, 183810.0, 47691.90002649886, 47695.523044769805, 47737.04525909462, 47842.0, 47922.0, 49756.253656195186, 49843.25235121476, 49866.750666247164, 49935.50064499381, 49990.25014624783, 16273.10497922602, 16291.348346066025, 16334.673306533803, 16476.0938148403, 16536.503904882873, 12258.325792081343, 12479.5008199671, 13478.056536042383, 13547.0, 13757.037007409586, 13617.727645447036, 13653.795193072112, 13667.043306968615, 13733.45066197341, 13846.65383365424, 5307.177387504943, 5336.733163341895, 5378.892422151535, 5384.488473595002, 5501.982133305351, 959.6305422412421, 967.1585720423136, 988.7033889833021, 1000.614763316114, 1006.2955930848435, 21634.675479867816, 28098.71901281002, 28973.56539651907, 29467.263318416783, 30038.399232015236, 1056.630179437191, 1076.3757020927842, 1096.2107282756403, 1106.8948449897407, 1106.9446527673583, 11782.234154780082, 11790.23363481371, 11851.644450666494, 11881.524739010343, 12021.33882636446, 225898.0, 227123.0, 227430.0, 228290.0, 228713.0, 51578.48421515737, 51967.0, 52183.217251741255, 52220.0, 52389.214161787604, 1514.6364872430538, 1521.5739592914001, 1540.6687562174186, 1543.1898253417046, 1547.6208328959476, 21716.782832171477, 21747.347579572637, 21950.231741888958, 22183.556328873656, 22248.332550023526, 37430.251394972496, 37715.43426848654, 37731.0, 37764.24471510499, 37821.62178378181, 196467.0, 197544.0, 197646.0, 198010.0, 198696.0, 34532.48201277033, 35702.642973569935, 37344.253114938096, 37409.625903741704, 37589.0, 44512.77743611391, 45917.54082459133, 46062.539374607164, 46200.30699539442, 46359.3046104302, 29999.700003000562, 31611.0, 32184.0, 32431.0, 32464.35071298608, 30380.392392151593, 30698.0, 31841.840790795897, 32266.83866580652, 32722.672773272916, 33628.32743345168, 33666.0, 33667.83166084154, 33669.49495757517, 37402.43896341503, 31410.0, 31414.371712565164, 33782.49326260157, 33802.3239535203, 34283.828580856934, 24292.878535607208, 24568.877155614107, 24589.016439342227, 24599.0, 24727.25818225456], "value": 17072.382266267326, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.2157090858253, 563.3465180390748, 567.9695090053061, 574.5633318677803, 581.4331027248433, 21881.562368752617, 22449.102035918564, 22583.774162258393, 22597.322080337573, 22736.43158921028, 25893.741062589368, 27946.161615151526, 27974.580381294247, 28004.159875203724, 28173.0, 6803.693833777492, 6968.407685346751, 6968.651567421634, 6972.163340399159, 6975.337342952437, 6386.680665966706, 6706.899396509032, 6727.798166055026, 6863.794086177398, 6954.16550013999, 6636.336366363374, 6672.432843208333, 6681.465482761368, 6683.799486015428, 6690.330966903295, 6602.306757790435, 6634.469242460592, 6661.467082633402, 6663.100481435041, 6688.464922806188, 6507.154069970921, 6562.901556476609, 6574.145361103074, 6584.5061620378665, 6585.637789921552, 29890.10329690113, 31582.0, 31792.0, 32080.679193208, 32154.678453215638, 1892.4511891551572, 1962.4603234110734, 1964.5285131568464, 1964.567795085079, 1965.3514340267677, 19233.51916202106, 19593.80406195934, 19611.80388196114, 19787.0, 19800.108995095256, 2340.9180678676335, 2351.6472529120597, 2398.5322862041735, 2405.1581946318825, 2409.8554086754675, 122668.0, 126475.36762316129, 126908.36545817304, 127343.36328318392, 127551.36224318911, 20422.97885105739, 21145.577088458143, 22130.11893989029, 22335.888320558293, 22384.0, 43982.340264896055, 43999.0, 44148.55851441444, 44176.558234417884, 44284.55715442869, 12009.0, 12029.0, 12067.758644827054, 12186.939065304794, 12226.877731222752, 9136.406133601295, 9541.093596108358, 10346.844797328045, 10347.172226221885, 10379.740506487247, 9989.650362237287, 11309.547618095185, 11369.943150284362, 11631.65105046833, 11859.0, 4534.410526631516, 4588.609968152745, 4703.929441058387, 4727.810887564459, 4747.454042785055, 954.2795189631784, 966.3332300712486, 973.7516933182135, 974.9220062394992, 987.7530617345664, 19130.71303930442, 19447.027648617513, 19530.0, 19723.605527889362, 20599.0, 1009.8131845608586, 1011.2819897872446, 1030.4332617060586, 1044.9268551201344, 1050.8423736439595, 10743.194260430499, 10876.728081798019, 10882.564697412174, 11182.337600286728, 11300.265482743594, 463694.0, 480459.0, 481645.0, 486182.0, 491338.0, 116834.0, 120647.0, 121093.0, 121559.39220303841, 124989.0, 1246.9750604987848, 1252.092233130991, 1305.745379650959, 1306.8235788168665, 1307.0981023094034, 19353.225870965005, 20594.485137871674, 20697.27559535469, 20836.791632083485, 21199.15203391847, 54560.72719636376, 55006.72496637491, 56628.0, 57142.0, 57441.85116297734, 69968.65015674889, 70101.29898700948, 70174.64912675404, 70627.0, 72606.63696681483, 12121.69695757613, 14582.19797911125, 14899.925500372428, 14957.326920288831, 15014.174220417983, 20142.798572014093, 20326.695099573815, 20910.0, 23413.06347746071, 23589.646155308026, 17674.116294184983, 17889.642207156045, 17890.463286101436, 17894.28422863123, 17952.640947181244, 15285.235738213267, 15996.883911268196, 16141.354345826036, 16519.0, 16958.06730629827, 17873.463796086136, 18251.45245642633, 18348.633027339645, 19637.509062272988, 19655.606887861875, 14779.187144707144, 14807.259637018322, 14816.851831481546, 14818.481353152589, 14866.628334291729, 18002.729959050364, 18880.867147971167, 19149.329773457863, 19223.61552768909, 19391.4182574523], "value": 12764.205426001074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.859944705806, 1375.8968077394193, 1398.8810951069158, 1404.9157050576966, 1408.9154650720957, 13614.795778063324, 13948.511802086903, 14010.159390436582, 14125.576232713021, 14190.858091419082, 14365.78451323231, 14627.634309142277, 14643.19462429566, 14650.34073466694, 14681.77977330341, 2701.5002224588466, 2755.7244275572384, 2757.5174344489733, 2758.3242105684035, 2761.226856480179, 2654.21700598323, 2729.8089133760645, 2751.312171957011, 2755.0219672016447, 2758.655168103987, 2496.400863792686, 2705.7970652201166, 2754.132448278786, 2755.4626847764694, 2760.1029665358838, 2620.096066856941, 2621.6591843060373, 2627.106783693544, 2648.708642049373, 2653.4162484253434, 2597.285746419731, 2627.5795872660283, 2640.023191419168, 2652.336915771057, 2665.4802313548867, 13640.65898352549, 13865.584032479042, 13884.791728124086, 13912.304384780822, 13914.652133696738, 7301.2333704961275, 7471.402287816962, 7486.700531978714, 7512.211217822105, 7522.623868806538, 4683.180443422388, 4771.498992605796, 4852.078105160008, 4927.384076990376, 4931.0, 1790.579213884736, 1824.1608859924452, 1830.514913547911, 1865.1047497201419, 1875.6811342071744, 22087.66868496974, 22243.332700019026, 22254.221102261505, 22269.777302227096, 22398.216062437736, 6532.869342613216, 6545.181852268466, 6708.295628958889, 6739.056532085512, 6779.661016949133, 15608.063516188839, 15660.608484787743, 15663.530094097196, 15669.764953525706, 15672.843271567366, 7585.279398457138, 7749.883751743729, 7759.57322347265, 7759.7672069838, 7778.533288002624, 6238.844028899314, 6262.436380725757, 6317.1156038154695, 6444.613323200623, 7019.5086343956455, 5053.469385714447, 5176.094183517869, 5252.422233554306, 5272.288241087481, 5272.288241087481, 1458.8117823265102, 1527.1447989126125, 1532.4866169833008, 1533.7162624914426, 1536.402141772544, 815.2173913043545, 822.8765685147276, 833.9749807505784, 850.953197574127, 871.2811930157645, 6590.275069742324, 6860.245373008965, 6890.517663763589, 6910.930890691129, 6963.61700106499, 670.8658268346351, 685.0854109763521, 697.7278861244118, 699.923008469068, 700.8738427083072, 3924.0582260257333, 4579.6414846354155, 4886.291487734258, 4969.130402179677, 5079.314292570456, 16787.580310492336, 17401.738973915402, 17675.0, 17684.557886052695, 17740.822591774177, 17129.22918468672, 17388.739168912478, 17816.198271077832, 17863.46409607714, 17918.10409479521, 10286.485675716185, 10331.690049298382, 10368.118709909591, 10491.580336786596, 10519.421431821323, 6857.0, 7745.148033716399, 7951.32413744815, 8138.511689298661, 8157.8368432632205, 15851.682966340839, 16196.757048644044, 16680.332786688396, 17172.484825455256, 17389.217485212943, 16816.990980541206, 16930.66138677195, 17118.229679664197, 17155.399561015303, 17311.740323895403, 10812.891871081189, 10988.725281868017, 11256.099512038854, 11261.380624065756, 11303.095752339957, 12708.87291127077, 12772.872271277169, 12774.68063298425, 12789.488420463078, 12839.679008024874, 10053.246006549683, 10246.846297305696, 10454.63408780689, 10559.947200264256, 10570.2600817942, 9880.160186384237, 9934.900650993397, 10025.649102281384, 10122.79754404893, 10196.235282354002, 8632.266257368194, 8730.56347182651, 8811.427257228259, 8828.51443170606, 8834.116588341114, 6185.2886918003205, 6393.680315984089, 6522.869542609026, 6560.507961902781, 6639.2364878037715, 6327.4305312520255, 6507.316731743099, 6623.900641490478, 6824.93175068243, 6830.453563714792], "value": 6144.648237378906, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.30904270457324, 494.8342305327715, 513.7200225876896, 520.6173462505059, 527.1723394270996, 6102.359252278514, 6152.784652537162, 6271.404216599416, 6288.465480434169, 6328.392816094828, 5993.880122397561, 6085.695715214232, 6122.9387706122925, 6174.567780255384, 6190.226221722285, 4986.925196122061, 4995.475475075101, 5009.6242781791325, 5032.220005899082, 5034.82378116766, 4960.826371077013, 5002.549770520653, 5002.849914502571, 5006.774695138709, 5048.343715317003, 4822.132016237076, 4946.826861059863, 4963.677360971544, 4975.975120124394, 4977.511244377811, 4979.958217130977, 4986.2769898364895, 5014.949850501484, 5016.698998060092, 5030.094582975063, 4411.470623525165, 4451.888702782424, 4455.554444555519, 4487.461504619434, 4506.211413002711, 5856.1508581255475, 5895.55334536167, 6064.63612183266, 6069.877072741557, 6096.573239873211, 5743.0, 5754.539636829086, 5762.510186634141, 5775.220345253379, 5776.162456443834, 6545.803625891231, 6620.6358650274215, 6652.600843949379, 6653.201615806086, 6661.700223489906, 4833.468318484964, 4915.238138088566, 4917.631177661689, 4927.334809800667, 4929.630277729185, 6917.342852429011, 6997.0, 7024.473164512682, 7053.259407762213, 7061.47038972074, 5011.649184557046, 5030.949690503121, 5086.287919691246, 5088.465711100355, 5105.0, 4981.975090124526, 5010.749462526859, 5034.874128146753, 5103.489651034867, 5118.129917913963, 5706.201131841545, 5716.799912003143, 5752.252207213036, 5769.365369809318, 5786.913196302059, 6543.607383557001, 6734.552071304693, 6745.325467453215, 6753.696083676246, 6773.254941956381, 1752.6582316448425, 1775.2366482412428, 1778.7193220880945, 1779.1549014218142, 1786.1426515272742, 1149.3448734221581, 1192.4812706472712, 1194.6177223288637, 1215.9878401216051, 1234.0066246671336, 5726.938302211201, 5759.164921086419, 5767.85580360486, 5776.42235776419, 5797.333306669702, 6540.444062254666, 6633.635150066792, 6670.733170673216, 6672.599644021374, 6762.830929226809, 5608.579356548275, 5762.423757624288, 5781.335146458127, 5801.317617890849, 5814.825555233349, 3569.303985722759, 3591.94612080819, 3617.656322649344, 3632.6912212462234, 3662.926741465209, 6537.673116344164, 6605.966970165118, 6607.735690572419, 6613.900791488131, 6614.206295244601, 6963.6866341014775, 6967.895481567781, 6985.26654701249, 6992.755253566203, 7059.89410158848, 6404.455621272151, 6564.934350656527, 6571.84992626298, 6584.341565843473, 6635.4359879410795, 6669.933300667125, 6762.526623136333, 6785.728570857111, 6793.320667933167, 6803.523753337219, 6635.933640663725, 6643.867122657616, 6692.498062645223, 6697.464202863856, 6757.3242675734, 6436.388543088399, 6455.419012288917, 6500.707468164039, 6536.346365363425, 6538.934610653832, 4942.654014219114, 4983.202687569971, 5019.146745053276, 5043.2435134730085, 5058.064258112261, 6693.163354580677, 6694.4644428444635, 6750.831229219112, 6769.89845152333, 6861.313868613299, 6476.676166191766, 6519.674016299071, 6567.146270984741, 6586.703598338182, 6588.868222635425, 6417.518686098468, 6482.351764823668, 6510.153680021567, 6517.73929042833, 6534.542582019213, 6047.667378294236, 6342.429181373698, 6355.904661430175, 6420.133282007057, 6467.708953097216, 6372.362763723776, 6373.012183111625, 6428.582142160744, 6434.49054868611, 6503.512236582181, 6261.937380626136, 6336.176297081534, 6363.677257800777, 6392.552521323462, 6419.935800642121], "value": 5065.837623155061, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.6147575804522, 907.990920090799, 916.0701887584099, 920.4109370003199, 922.9815403691927, 15784.368625254976, 16191.83808161918, 16228.0, 16270.430534931294, 16293.348266069373, 15416.537503874873, 18611.627767444676, 19515.12181951812, 21487.355379338645, 21642.35072947814, 984.247051005981, 996.9152622027136, 1002.1481740520572, 1004.0010189861099, 1008.2287050406445, 1011.1556850030233, 1060.0406631998055, 1077.6336045744445, 1077.7144056824948, 1081.6809041332826, 1045.592219034577, 1110.189561620018, 1118.3569447567681, 1118.3792994887833, 1119.6361182615642, 1097.3580455433541, 1105.4528008635777, 1108.41808050774, 1109.4230999880058, 1109.983350249747, 812.2080971053235, 818.7461886815106, 820.8932838730987, 821.4003777242647, 822.013583699557, 17523.474295771146, 17550.297988080463, 19346.0, 19460.80539194604, 19464.610707785905, 20460.590788184152, 20625.0, 20675.483112922146, 21132.471688207763, 21141.471463213387, 15179.924100379538, 15369.0, 15607.921960390238, 15616.609584760472, 15618.609534761608, 3471.0628130404903, 3475.791452512857, 3498.5626796650417, 3511.719062474996, 3512.877049303262, 113577.86422135755, 114060.42969785181, 114651.0, 119116.40441797735, 121016.39491802573, 15917.442889498812, 16268.430604928772, 16308.75536866948, 16314.102724350038, 16334.101624410772, 28076.71923280782, 29671.406571868443, 29683.703162968526, 29700.40599188004, 29720.55419168714, 8503.957480212559, 8511.616977236039, 8538.743837684879, 8610.44032137909, 8635.740927772176, 3819.6753275971296, 4030.91938161241, 4048.332025215865, 4053.858114965962, 4083.4283200351974, 4589.829593453648, 4773.570378665867, 4775.140474714584, 4778.402699662543, 4805.495422980537, 929.716436486878, 953.1707414549386, 971.6696323250129, 975.190591808797, 979.2117345536911, 629.2763322179438, 640.4684112186874, 653.7450394346209, 681.8670359279992, 682.8702546516146, 10785.78428431427, 12861.678458038625, 13455.125416847874, 13461.259630720404, 13677.726445471233, 631.425402883374, 664.2593508238376, 674.2280089297726, 688.1638808847274, 695.523566357047, 4984.950150498448, 5067.442581316052, 5172.767225474862, 5185.766640501187, 5244.6328756987405, 98990.51514227293, 102036.48981755043, 102227.48886255521, 103871.4806425963, 105000.47499762605, 85136.14863851406, 87336.56331718301, 87679.56160219158, 88597.11402886017, 90758.54620726855, 73467.63266183635, 77264.61367693238, 77371.0, 79173.20826791774, 80387.0, 10477.214208934209, 10766.407847568145, 11011.944940275567, 11090.390028548507, 11352.489137988645, 29942.401151977276, 31440.685593143775, 32069.518957215194, 36687.08282292964, 36794.448083278236, 60542.0, 60747.0, 64983.0, 65352.67323663351, 68864.65567672129, 18527.53681157982, 18942.905285473484, 19003.809961900202, 19018.23927042958, 19142.23431062742, 20227.59544809125, 20695.58608827845, 21236.150553977666, 21585.352439426842, 22018.0, 17514.38699645506, 17902.641947160722, 18340.908295458437, 18649.720254195927, 18720.625587487903, 16839.073850938315, 16873.409430669868, 17008.744868827223, 17066.0, 18627.72058419152, 17419.912900435418, 17548.59611231073, 17660.470185894443, 18097.909510452362, 18548.350807721665, 12187.51249949992, 13743.381547830571, 14069.296535173406, 14230.501932432315, 14499.92750036243, 13851.376688049264, 14701.41194352214, 15185.772213416587, 15268.770968435705, 15354.30905609228], "value": 8846.5955330975, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 105.0, 112.0, 111.0, 112.0, 109.0, 101.0, 110.0, 108.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 121.0, 146.0, 174.0, 118.0, 144.0, 158.0, 118.0, 168.0, 117.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 164.0, 170.0, 169.0, 181.0, 165.0, 165.0, 165.0, 164.0], "value": 167.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 188.0, 75.0, 85.0, 76.0, 85.0, 104.0, 76.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 124.0, 83.0, 79.0, 78.0, 129.0, 79.0, 78.0, 138.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 116.0, 114.0, 114.0, 114.0, 114.0, 113.0, 119.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 151.0, 150.0, 155.0, 150.0, 150.0, 151.0, 152.0, 152.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 98.0, 98.0, 100.0, 95.0, 95.0, 94.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 55.0, 55.0, 59.0, 55.0, 55.0, 54.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 61.0, 65.0, 54.0, 55.0, 54.0, 56.0, 60.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 81.0, 81.0, 79.0, 79.0, 80.0, 80.0, 82.0, 87.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 132.0, 124.0, 136.0, 126.0, 130.0, 129.0, 139.0, 120.0, 162.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 185.0, 173.0, 176.0, 170.0, 180.0, 169.0, 174.0, 184.0, 170.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 71.0, 68.0, 75.0, 70.0, 68.0, 84.0, 69.0, 67.0], "value": 71.1, "unit": "score"}]}]} 19:23:49 INFO - Return code: 0 19:23:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:23:49 INFO - # TBPL SUCCESS # 19:23:49 INFO - Running post-action listener: _package_coverage_data 19:23:49 INFO - Running post-action listener: _resource_record_post_action 19:23:49 INFO - [mozharness: 2017-07-28 02:23:49.778057Z] Finished run-tests step (success) 19:23:49 INFO - Running post-run listener: _resource_record_post_run 19:23:49 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8462336; Write bytes: 438734848; Read time: 3952; Write time: 455888 19:23:49 INFO - TinderboxPrint: CPU usage
13.2% 19:23:49 INFO - TinderboxPrint: I/O read bytes / time
8,462,336 / 3,952 19:23:49 INFO - TinderboxPrint: I/O write bytes / time
438,734,848 / 455,888 19:23:49 INFO - TinderboxPrint: CPU idle
8,292.4 (86.8%) 19:23:49 INFO - TinderboxPrint: CPU user
1,203.5 (12.6%) 19:23:49 INFO - TinderboxPrint: Swap in / out
0 / 0 19:23:49 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 210661376; Read time: 0; Write time: 214844 19:23:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:23:49 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 6332416; Write bytes: 161062912; Read time: 3568; Write time: 123832 19:23:50 INFO - Running post-run listener: _upload_blobber_files 19:23:50 INFO - Blob upload gear active. 19:23:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:23:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:23:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:23:50 INFO - (blobuploader) - INFO - Open directory for files ... 19:23:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:23:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:23:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:54 INFO - (blobuploader) - INFO - Done attempting. 19:23:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:23:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:23:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:55 INFO - (blobuploader) - INFO - Done attempting. 19:23:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:23:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:23:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:56 INFO - (blobuploader) - INFO - Done attempting. 19:23:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:23:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:23:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:57 INFO - (blobuploader) - INFO - Done attempting. 19:23:57 INFO - (blobuploader) - INFO - Iteration through files over. 19:23:57 INFO - Return code: 0 19:23:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:23:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:23:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/815d2ea085ed44a4b4f3ec94431c95894c812165ac4d542dff1ac40a73917a6f74d0f4cf05d40c5a109fd811089360a1314d483ee3273fe84675cb18db3d6307", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eeab10542f1704b781d7401de8e734f2f121829e43c418c73287b722177f6158feccb0ab8ddca39914bcd11ea4c9cb0932484baac2440bd00c4099976414cb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47d6c5d0d1786b4dd26f76ca7d4b16b5cc6c29c968bdf1798b1a43d5d18e327b2280ddc266366e46bf9a8f0d5912381cd574ee058552c7b67bd51a735662924e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deadf0d689025a71260c2bd274200c4a239680196ef70103c47f757b99919796fb1676d5b49ecfdd6b624e9bb3ed6af51fafaf7a3e4ad4b622bca45a77b7c9bb"} 19:23:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:23:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:23:57 INFO - Contents: 19:23:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/815d2ea085ed44a4b4f3ec94431c95894c812165ac4d542dff1ac40a73917a6f74d0f4cf05d40c5a109fd811089360a1314d483ee3273fe84675cb18db3d6307", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eeab10542f1704b781d7401de8e734f2f121829e43c418c73287b722177f6158feccb0ab8ddca39914bcd11ea4c9cb0932484baac2440bd00c4099976414cb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47d6c5d0d1786b4dd26f76ca7d4b16b5cc6c29c968bdf1798b1a43d5d18e327b2280ddc266366e46bf9a8f0d5912381cd574ee058552c7b67bd51a735662924e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deadf0d689025a71260c2bd274200c4a239680196ef70103c47f757b99919796fb1676d5b49ecfdd6b624e9bb3ed6af51fafaf7a3e4ad4b622bca45a77b7c9bb"} 19:23:57 INFO - Running post-run listener: copy_logs_to_upload_dir 19:23:57 INFO - Copying logs to upload dir... 19:23:57 INFO - mkdir: /builds/slave/test/build/upload/logs 19:23:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.480544 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-07-27 19:23:57.182370) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 19:23:57.189356) ========= 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=3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/815d2ea085ed44a4b4f3ec94431c95894c812165ac4d542dff1ac40a73917a6f74d0f4cf05d40c5a109fd811089360a1314d483ee3273fe84675cb18db3d6307", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eeab10542f1704b781d7401de8e734f2f121829e43c418c73287b722177f6158feccb0ab8ddca39914bcd11ea4c9cb0932484baac2440bd00c4099976414cb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47d6c5d0d1786b4dd26f76ca7d4b16b5cc6c29c968bdf1798b1a43d5d18e327b2280ddc266366e46bf9a8f0d5912381cd574ee058552c7b67bd51a735662924e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deadf0d689025a71260c2bd274200c4a239680196ef70103c47f757b99919796fb1676d5b49ecfdd6b624e9bb3ed6af51fafaf7a3e4ad4b622bca45a77b7c9bb"} build_url:https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/clJckGzdS1qkQbdfhk8DRA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/815d2ea085ed44a4b4f3ec94431c95894c812165ac4d542dff1ac40a73917a6f74d0f4cf05d40c5a109fd811089360a1314d483ee3273fe84675cb18db3d6307", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eeab10542f1704b781d7401de8e734f2f121829e43c418c73287b722177f6158feccb0ab8ddca39914bcd11ea4c9cb0932484baac2440bd00c4099976414cb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47d6c5d0d1786b4dd26f76ca7d4b16b5cc6c29c968bdf1798b1a43d5d18e327b2280ddc266366e46bf9a8f0d5912381cd574ee058552c7b67bd51a735662924e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deadf0d689025a71260c2bd274200c4a239680196ef70103c47f757b99919796fb1676d5b49ecfdd6b624e9bb3ed6af51fafaf7a3e4ad4b622bca45a77b7c9bb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 19:23:57.213328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 19:23:57.213642) ========= 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=3836458cccd887f2d2de3cf1000001de-1501206459.689075-1840368402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 19:23:57.298676) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 19:23:57.299033) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 19:23:57.299326) ========= ========= Total master_lag: 0.23 =========