builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1501062741.72 results: success (0) revision: 4f821dab4306fd0aff947ce55a1304acd7e4cf95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-26 02:52:21.725127) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-26 02:52:21.729030) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-26 02:52:21.729368) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-26 02:52:21.746602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 02:52:21.747286) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-26 02:52:23-- 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% 223M=0s 2017-07-26 02:52:24 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129390 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 02:52:21.891614) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 02:52:21.891953) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018666 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 02:52:21.941800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-26 02:52:21.942154) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4f821dab4306fd0aff947ce55a1304acd7e4cf95 --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 4f821dab4306fd0aff947ce55a1304acd7e4cf95 --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=a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-26 02:52:24,201 truncating revision to first 12 chars 2017-07-26 02:52:24,201 Setting DEBUG logging. 2017-07-26 02:52:24,201 attempt 1/10 2017-07-26 02:52:24,201 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4f821dab4306?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-26 02:52:25,697 unpacking tar archive at: mozilla-central-4f821dab4306/testing/mozharness/ program finished with exit code 0 elapsedTime=1.875211 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-26 02:52:23.830609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-26 02:52:23.831070) ========= script_repo_revision: 4f821dab4306fd0aff947ce55a1304acd7e4cf95 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-26 02:52:23.831609) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-26 02:52:23.831892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-26 02:52:23.840654) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-26 02:52:23.841122) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:52:26 INFO - MultiFileLogger online at 20170726 02:52:26 in /builds/slave/test 02:52:26 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 02:52:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:52:26 INFO - {'append_to_log': False, 02:52:26 INFO - 'base_work_dir': '/builds/slave/test', 02:52:26 INFO - 'blob_upload_branch': 'Firefox', 02:52:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:52:26 INFO - 'branch': 'Firefox', 02:52:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:52:26 INFO - 'code_coverage': False, 02:52:26 INFO - 'config_files': ('talos/linux_config.py',), 02:52:26 INFO - 'default_actions': ('clobber', 02:52:26 INFO - 'read-buildbot-config', 02:52:26 INFO - 'download-and-extract', 02:52:26 INFO - 'populate-webroot', 02:52:26 INFO - 'create-virtualenv', 02:52:26 INFO - 'install', 02:52:26 INFO - 'setup-mitmproxy', 02:52:26 INFO - 'run-tests'), 02:52:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:52:26 INFO - 'disable_ccov_upload': False, 02:52:26 INFO - 'download_minidump_stackwalk': True, 02:52:26 INFO - 'download_symbols': 'ondemand', 02:52:26 INFO - 'enable_stylo': False, 02:52:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:52:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:52:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:52:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:52:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:52:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:52:26 INFO - 'gecko_profile': False, 02:52:26 INFO - 'gecko_profile_interval': 0, 02:52:26 INFO - 'installer_path': 'installer.exe', 02:52:26 INFO - 'log_level': 'info', 02:52:26 INFO - 'log_name': 'talos', 02:52:26 INFO - 'log_to_console': True, 02:52:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:52:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:52:26 INFO - 'opt_config_files': (), 02:52:26 INFO - 'pip_index': False, 02:52:26 INFO - 'suite': 'dromaeojs-e10s', 02:52:26 INFO - 'system_bits': '32', 02:52:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:52:26 INFO - 'title': 'talos-linux64-ix-064', 02:52:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:52:26 INFO - 'use_talos_json': True, 02:52:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:52:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:52:26 INFO - 'work_dir': 'build'} 02:52:26 INFO - [mozharness: 2017-07-26 09:52:26.206600Z] Running clobber step. 02:52:26 INFO - Running pre-action listener: _resource_record_pre_action 02:52:26 INFO - Running main action method: clobber 02:52:26 INFO - rmtree: /builds/slave/test/build 02:52:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:52:27 INFO - Running post-action listener: _resource_record_post_action 02:52:27 INFO - [mozharness: 2017-07-26 09:52:27.774713Z] Finished clobber step (success) 02:52:27 INFO - [mozharness: 2017-07-26 09:52:27.774813Z] Running read-buildbot-config step. 02:52:27 INFO - Running pre-action listener: _resource_record_pre_action 02:52:27 INFO - Running main action method: read_buildbot_config 02:52:27 INFO - Using buildbot properties: 02:52:27 INFO - { 02:52:27 INFO - "project": "", 02:52:27 INFO - "product": "firefox", 02:52:27 INFO - "who": "cbook@mozilla.com", 02:52:27 INFO - "installer_path": "public/build/target.tar.bz2", 02:52:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:52:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:52:27 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:52:27 INFO - "stage_platform": "linux64-stylosequential", 02:52:27 INFO - "basedir": "/builds/slave/test", 02:52:27 INFO - "buildnumber": 150, 02:52:27 INFO - "platform": "ubuntu64_hw_styloseq", 02:52:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:52:27 INFO - "slavebuilddir": "test", 02:52:27 INFO - "taskId": "C1gCWHyeRBGZzdpC_J37qg", 02:52:27 INFO - "branch": "mozilla-central", 02:52:27 INFO - "script_repo_revision": "production", 02:52:27 INFO - "revision": "4f821dab4306fd0aff947ce55a1304acd7e4cf95", 02:52:27 INFO - "slavename": "talos-linux64-ix-064", 02:52:27 INFO - "repo_path": "mozilla-central" 02:52:27 INFO - } 02:52:27 INFO - Finding installer, test and symbols from parent task. 02:52:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C1gCWHyeRBGZzdpC_J37qg'}, attempt #1 02:52:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C1gCWHyeRBGZzdpC_J37qg'}, attempt #1 02:52:28 INFO - Task dependencies: J3w66787QiyxdpLlfODfTA 02:52:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA'}, attempt #1 02:52:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.tar.bz2 02:52:29 INFO - Set test_url: https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/test_packages.json 02:52:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.crashreporter-symbols.zip 02:52:29 INFO - Running post-action listener: _resource_record_post_action 02:52:29 INFO - [mozharness: 2017-07-26 09:52:29.092820Z] Finished read-buildbot-config step (success) 02:52:29 INFO - [mozharness: 2017-07-26 09:52:29.093131Z] Running download-and-extract step. 02:52:29 INFO - Running pre-action listener: _resource_record_pre_action 02:52:29 INFO - Running main action method: download_and_extract 02:52:29 INFO - mkdir: /builds/slave/test/build/tests 02:52:29 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')]} 02:52:29 INFO - trying https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.test_packages.json 02:52:29 INFO - Downloading https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:52:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:52:29 INFO - Downloaded 989 bytes. 02:52:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:52:29 INFO - Using the following test package requirements: 02:52:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:52:29 INFO - u'common': [u'target.common.tests.zip'], 02:52:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:52:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:52:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:52:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:52:29 INFO - u'mozbase': [u'target.common.tests.zip'], 02:52:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:52:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:52:29 INFO - u'web-platform': [u'target.common.tests.zip', 02:52:29 INFO - u'target.web-platform.tests.tar.gz'], 02:52:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:52:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:52:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.common.tests.zip 02:52:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:52:29 INFO - Fetch https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.common.tests.zip into memory 02:52:32 INFO - Content-Length response header: 72522256 02:52:32 INFO - Bytes received: 72522256 02:52:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:52:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.common.tests.zip 02:52:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:52:43 INFO - Fetch https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.common.tests.zip into memory 02:52:44 INFO - Content-Length response header: 72522256 02:52:44 INFO - Bytes received: 72522256 02:52:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.talos.tests.zip 02:52:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:52:56 INFO - Fetch https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.talos.tests.zip into memory 02:52:57 INFO - Content-Length response header: 14496448 02:52:57 INFO - Bytes received: 14496448 02:52:58 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')]} 02:52:58 INFO - trying https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.tar.bz2 02:52:58 INFO - Downloading https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:52:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:52:59 INFO - Downloaded 62161460 bytes. 02:52:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.tar.bz2 02:52:59 INFO - mkdir: /builds/slave/test/properties 02:52:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:59 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:59 INFO - Contents: 02:52:59 INFO - build_url:https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.tar.bz2 02:52:59 INFO - Running post-action listener: _resource_record_post_action 02:52:59 INFO - Running post-action listener: set_extra_try_arguments 02:52:59 INFO - [mozharness: 2017-07-26 09:52:59.550518Z] Finished download-and-extract step (success) 02:52:59 INFO - [mozharness: 2017-07-26 09:52:59.550662Z] Running populate-webroot step. 02:52:59 INFO - Running pre-action listener: _resource_record_pre_action 02:52:59 INFO - Running main action method: populate_webroot 02:52:59 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:52:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:52:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:52:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:52:59 INFO - 'tests': ['damp', 'tps']}, 02:52:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:52:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:52:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:52:59 INFO - 'other-e10s': {'tests': ['a11yr', 02:52:59 INFO - 'ts_paint', 02:52:59 INFO - 'tpaint', 02:52:59 INFO - 'sessionrestore', 02:52:59 INFO - 'sessionrestore_many_windows', 02:52:59 INFO - 'sessionrestore_no_auto_restore', 02:52:59 INFO - 'tabpaint']}, 02:52:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:52:59 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:52:59 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:59 INFO - 'talos_options': ['--mitmproxy', 02:52:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:59 INFO - '--firstNonBlankPaint'], 02:52:59 INFO - 'tests': ['quantum_pageload_google', 02:52:59 INFO - 'quantum_pageload_youtube', 02:52:59 INFO - 'quantum_pageload_amazon', 02:52:59 INFO - 'quantum_pageload_facebook']}, 02:52:59 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:59 INFO - 'talos_options': ['--stylo', 02:52:59 INFO - '--mitmproxy', 02:52:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:59 INFO - '--firstNonBlankPaint'], 02:52:59 INFO - 'tests': ['quantum_pageload_google', 02:52:59 INFO - 'quantum_pageload_youtube', 02:52:59 INFO - 'quantum_pageload_amazon', 02:52:59 INFO - 'quantum_pageload_facebook']}, 02:52:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:52:59 INFO - 'tsvgr_opacity', 02:52:59 INFO - 'tart', 02:52:59 INFO - 'tscrollx', 02:52:59 INFO - 'cart', 02:52:59 INFO - 'tsvg_static']}, 02:52:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:52:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:52:59 INFO - 'talos_options': ['--xperf_path', 02:52:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:59 INFO - 'tests': ['tp5n']}}} 02:52:59 INFO - Running post-action listener: _resource_record_post_action 02:52:59 INFO - [mozharness: 2017-07-26 09:52:59.558703Z] Finished populate-webroot step (success) 02:52:59 INFO - [mozharness: 2017-07-26 09:52:59.558793Z] Running create-virtualenv step. 02:52:59 INFO - Running pre-action listener: _resource_record_pre_action 02:52:59 INFO - Running main action method: create_virtualenv 02:52:59 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:59 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 02:52:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:52:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:52:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:59 INFO - Using real prefix '/usr' 02:52:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:53:00 INFO - Installing distribute.............................................................................................................................................................................................done. 02:53:02 INFO - Installing pip.................done. 02:53:02 INFO - Return code: 0 02:53:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:53:02 INFO - Reading from file tmpfile_stdout 02:53:02 INFO - Output received: 02:53:02 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) 02:53:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4eb0>, '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 0x2aa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6240>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', '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 02:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:53:02 INFO - Using env: {'DISPLAY': ':0', 02:53:02 INFO - 'HOME': '/home/cltbld', 02:53:02 INFO - 'LANG': 'en_US.UTF-8', 02:53:02 INFO - 'LANGUAGE': 'en_US:en', 02:53:02 INFO - 'LOGNAME': 'cltbld', 02:53:02 INFO - 'MAIL': '/var/mail/cltbld', 02:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:02 INFO - 'MOZ_NO_REMOTE': '1', 02:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:02 INFO - 'NO_EM_RESTART': '1', 02:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:02 INFO - 'PWD': '/builds/slave/test', 02:53:02 INFO - 'SHELL': '/bin/bash', 02:53:02 INFO - 'SHLVL': '1', 02:53:02 INFO - 'TERM': 'linux', 02:53:02 INFO - 'TMOUT': '86400', 02:53:02 INFO - 'USER': 'cltbld', 02:53:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', 02:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:02 INFO - '_': '/tools/buildbot/bin/python'} 02:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:02 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 02:53:02 INFO - Cleaning up... 02:53:02 INFO - Return code: 0 02:53:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4eb0>, '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 0x2aa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6240>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', '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 02:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:53:02 INFO - Using env: {'DISPLAY': ':0', 02:53:02 INFO - 'HOME': '/home/cltbld', 02:53:02 INFO - 'LANG': 'en_US.UTF-8', 02:53:02 INFO - 'LANGUAGE': 'en_US:en', 02:53:02 INFO - 'LOGNAME': 'cltbld', 02:53:02 INFO - 'MAIL': '/var/mail/cltbld', 02:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:02 INFO - 'MOZ_NO_REMOTE': '1', 02:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:02 INFO - 'NO_EM_RESTART': '1', 02:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:02 INFO - 'PWD': '/builds/slave/test', 02:53:02 INFO - 'SHELL': '/bin/bash', 02:53:02 INFO - 'SHLVL': '1', 02:53:02 INFO - 'TERM': 'linux', 02:53:02 INFO - 'TMOUT': '86400', 02:53:02 INFO - 'USER': 'cltbld', 02:53:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', 02:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:02 INFO - '_': '/tools/buildbot/bin/python'} 02:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:02 INFO - Downloading/unpacking psutil>=3.1.1 02:53:02 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 02:53:02 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 02:53:02 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 02:53:02 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 02:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:04 INFO - Installing collected packages: psutil 02:53:04 INFO - Running setup.py install for psutil 02:53:04 INFO - building 'psutil._psutil_linux' extension 02:53:04 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 02:53:04 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 02:53:04 INFO - building 'psutil._psutil_posix' extension 02:53:04 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 02:53:04 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 02:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:04 INFO - Successfully installed psutil 02:53:04 INFO - Cleaning up... 02:53:04 INFO - Return code: 0 02:53:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4eb0>, '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 0x2aa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6240>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', '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 02:53:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:53:04 INFO - Using env: {'DISPLAY': ':0', 02:53:04 INFO - 'HOME': '/home/cltbld', 02:53:04 INFO - 'LANG': 'en_US.UTF-8', 02:53:04 INFO - 'LANGUAGE': 'en_US:en', 02:53:04 INFO - 'LOGNAME': 'cltbld', 02:53:04 INFO - 'MAIL': '/var/mail/cltbld', 02:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:04 INFO - 'MOZ_NO_REMOTE': '1', 02:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:04 INFO - 'NO_EM_RESTART': '1', 02:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:04 INFO - 'PWD': '/builds/slave/test', 02:53:04 INFO - 'SHELL': '/bin/bash', 02:53:04 INFO - 'SHLVL': '1', 02:53:04 INFO - 'TERM': 'linux', 02:53:04 INFO - 'TMOUT': '86400', 02:53:04 INFO - 'USER': 'cltbld', 02:53:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', 02:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:04 INFO - '_': '/tools/buildbot/bin/python'} 02:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:53:06 INFO - Installing collected packages: mozsystemmonitor 02:53:06 INFO - Running setup.py install for mozsystemmonitor 02:53:06 INFO - Successfully installed mozsystemmonitor 02:53:06 INFO - Cleaning up... 02:53:06 INFO - Return code: 0 02:53:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4eb0>, '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 0x2aa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6240>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', '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 02:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:53:06 INFO - Using env: {'DISPLAY': ':0', 02:53:06 INFO - 'HOME': '/home/cltbld', 02:53:06 INFO - 'LANG': 'en_US.UTF-8', 02:53:06 INFO - 'LANGUAGE': 'en_US:en', 02:53:06 INFO - 'LOGNAME': 'cltbld', 02:53:06 INFO - 'MAIL': '/var/mail/cltbld', 02:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:06 INFO - 'MOZ_NO_REMOTE': '1', 02:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:06 INFO - 'NO_EM_RESTART': '1', 02:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:06 INFO - 'PWD': '/builds/slave/test', 02:53:06 INFO - 'SHELL': '/bin/bash', 02:53:06 INFO - 'SHLVL': '1', 02:53:06 INFO - 'TERM': 'linux', 02:53:06 INFO - 'TMOUT': '86400', 02:53:06 INFO - 'USER': 'cltbld', 02:53:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', 02:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:06 INFO - '_': '/tools/buildbot/bin/python'} 02:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:06 INFO - Downloading/unpacking jsonschema==2.5.1 02:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:53:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:53:07 INFO - warning: no files found matching '*.txt' 02:53:07 INFO - no previously-included directories found matching 'build' 02:53:07 INFO - no previously-included directories found matching 'dist' 02:53:07 INFO - no previously-included directories found matching '.git*' 02:53:07 INFO - Installing collected packages: jsonschema, functools32 02:53:07 INFO - Running setup.py install for functools32 02:53:07 INFO - warning: no files found matching '*.txt' 02:53:07 INFO - no previously-included directories found matching 'build' 02:53:07 INFO - no previously-included directories found matching 'dist' 02:53:07 INFO - no previously-included directories found matching '.git*' 02:53:07 INFO - Successfully installed jsonschema functools32 02:53:07 INFO - Cleaning up... 02:53:07 INFO - Return code: 0 02:53:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:53:07 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')]} 02:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:07 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')]} 02:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:07 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 0x27381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4eb0>, '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 0x2aa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6240>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', '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 02:53:07 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 02:53:07 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 02:53:07 INFO - Using env: {'DISPLAY': ':0', 02:53:07 INFO - 'HOME': '/home/cltbld', 02:53:07 INFO - 'LANG': 'en_US.UTF-8', 02:53:07 INFO - 'LANGUAGE': 'en_US:en', 02:53:07 INFO - 'LOGNAME': 'cltbld', 02:53:07 INFO - 'MAIL': '/var/mail/cltbld', 02:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:07 INFO - 'MOZ_NO_REMOTE': '1', 02:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:07 INFO - 'NO_EM_RESTART': '1', 02:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:07 INFO - 'PWD': '/builds/slave/test', 02:53:07 INFO - 'SHELL': '/bin/bash', 02:53:07 INFO - 'SHLVL': '1', 02:53:07 INFO - 'TERM': 'linux', 02:53:07 INFO - 'TMOUT': '86400', 02:53:07 INFO - 'USER': 'cltbld', 02:53:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', 02:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:07 INFO - '_': '/tools/buildbot/bin/python'} 02:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:53:08 INFO - Cleaning up... 02:53:08 INFO - Return code: 0 02:53:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4eb0>, '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 0x2aa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6240>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', '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 02:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:53:08 INFO - Using env: {'DISPLAY': ':0', 02:53:08 INFO - 'HOME': '/home/cltbld', 02:53:08 INFO - 'LANG': 'en_US.UTF-8', 02:53:08 INFO - 'LANGUAGE': 'en_US:en', 02:53:08 INFO - 'LOGNAME': 'cltbld', 02:53:08 INFO - 'MAIL': '/var/mail/cltbld', 02:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:08 INFO - 'MOZ_NO_REMOTE': '1', 02:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:08 INFO - 'NO_EM_RESTART': '1', 02:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:08 INFO - 'PWD': '/builds/slave/test', 02:53:08 INFO - 'SHELL': '/bin/bash', 02:53:08 INFO - 'SHLVL': '1', 02:53:08 INFO - 'TERM': 'linux', 02:53:08 INFO - 'TMOUT': '86400', 02:53:08 INFO - 'USER': 'cltbld', 02:53:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', 02:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:08 INFO - '_': '/tools/buildbot/bin/python'} 02:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:09 INFO - Downloading blobuploader-1.2.4.tar.gz 02:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:53:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:53:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:09 INFO - Downloading docopt-0.6.1.tar.gz 02:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:53:09 INFO - Installing collected packages: blobuploader, requests, docopt 02:53:09 INFO - Running setup.py install for blobuploader 02:53:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:53:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:53:10 INFO - Running setup.py install for requests 02:53:10 INFO - Running setup.py install for docopt 02:53:10 INFO - Successfully installed blobuploader requests docopt 02:53:10 INFO - Cleaning up... 02:53:10 INFO - Return code: 0 02:53:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:10 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')]} 02:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:10 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')]} 02:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:10 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 0x27381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4eb0>, '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 0x2aa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6240>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', '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 02:53:10 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 02:53:10 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 02:53:10 INFO - Using env: {'DISPLAY': ':0', 02:53:10 INFO - 'HOME': '/home/cltbld', 02:53:10 INFO - 'LANG': 'en_US.UTF-8', 02:53:10 INFO - 'LANGUAGE': 'en_US:en', 02:53:10 INFO - 'LOGNAME': 'cltbld', 02:53:10 INFO - 'MAIL': '/var/mail/cltbld', 02:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:10 INFO - 'MOZ_NO_REMOTE': '1', 02:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:10 INFO - 'NO_EM_RESTART': '1', 02:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:10 INFO - 'PWD': '/builds/slave/test', 02:53:10 INFO - 'SHELL': '/bin/bash', 02:53:10 INFO - 'SHLVL': '1', 02:53:10 INFO - 'TERM': 'linux', 02:53:10 INFO - 'TMOUT': '86400', 02:53:10 INFO - 'USER': 'cltbld', 02:53:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', 02:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:10 INFO - '_': '/tools/buildbot/bin/python'} 02:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:10 INFO - Running setup.py (path:/tmp/pip-nL1SeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:10 INFO - Running setup.py (path:/tmp/pip-LR7cr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:10 INFO - Running setup.py (path:/tmp/pip-XSZ6sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:11 INFO - Running setup.py (path:/tmp/pip-ScpnWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:11 INFO - Running setup.py (path:/tmp/pip-79c8hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:11 INFO - Running setup.py (path:/tmp/pip-sEupjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:11 INFO - Running setup.py (path:/tmp/pip-zzGtZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:11 INFO - Running setup.py (path:/tmp/pip-IjkYVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:11 INFO - Running setup.py (path:/tmp/pip-KHB2Av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:11 INFO - Running setup.py (path:/tmp/pip-OwgGKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:11 INFO - Running setup.py (path:/tmp/pip-3PDfYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:11 INFO - Running setup.py (path:/tmp/pip-3K9oyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:11 INFO - Running setup.py (path:/tmp/pip-3Rz3aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:11 INFO - Running setup.py (path:/tmp/pip-um0suZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:11 INFO - Running setup.py (path:/tmp/pip-bI2QeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:11 INFO - Running setup.py (path:/tmp/pip-bPX4Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:11 INFO - Running setup.py (path:/tmp/pip-UBMKpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:53:12 INFO - Running setup.py install for manifestparser 02:53:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:53:12 INFO - Running setup.py install for mozcrash 02:53:12 INFO - Running setup.py install for mozdebug 02:53:12 INFO - Running setup.py install for mozdevice 02:53:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:53:12 INFO - Running setup.py install for mozfile 02:53:12 INFO - Running setup.py install for mozhttpd 02:53:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:53:12 INFO - Running setup.py install for mozinfo 02:53:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:53:12 INFO - Running setup.py install for mozInstall 02:53:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:53:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:53:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:53:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:53:12 INFO - Running setup.py install for mozleak 02:53:12 INFO - Running setup.py install for mozlog 02:53:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:53:13 INFO - Running setup.py install for moznetwork 02:53:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:53:13 INFO - Running setup.py install for mozprocess 02:53:13 INFO - Running setup.py install for mozprofile 02:53:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:53:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:53:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:53:13 INFO - Running setup.py install for mozrunner 02:53:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:53:13 INFO - Running setup.py install for mozscreenshot 02:53:13 INFO - Running setup.py install for moztest 02:53:13 INFO - Running setup.py install for mozversion 02:53:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:53:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:53:13 INFO - Cleaning up... 02:53:13 INFO - Return code: 0 02:53:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:13 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 0x27381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4eb0>, '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 0x2aa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6240>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', '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 02:53:13 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 02:53:13 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 02:53:13 INFO - Using env: {'DISPLAY': ':0', 02:53:13 INFO - 'HOME': '/home/cltbld', 02:53:13 INFO - 'LANG': 'en_US.UTF-8', 02:53:13 INFO - 'LANGUAGE': 'en_US:en', 02:53:13 INFO - 'LOGNAME': 'cltbld', 02:53:13 INFO - 'MAIL': '/var/mail/cltbld', 02:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:13 INFO - 'MOZ_NO_REMOTE': '1', 02:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:13 INFO - 'NO_EM_RESTART': '1', 02:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:13 INFO - 'PWD': '/builds/slave/test', 02:53:13 INFO - 'SHELL': '/bin/bash', 02:53:13 INFO - 'SHLVL': '1', 02:53:13 INFO - 'TERM': 'linux', 02:53:13 INFO - 'TMOUT': '86400', 02:53:13 INFO - 'USER': 'cltbld', 02:53:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', 02:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:13 INFO - '_': '/tools/buildbot/bin/python'} 02:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:14 INFO - Running setup.py (path:/tmp/pip-Q9l7Ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:14 INFO - Running setup.py (path:/tmp/pip-OPjMdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:14 INFO - Running setup.py (path:/tmp/pip-0L5Fkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:14 INFO - Running setup.py (path:/tmp/pip-1GjDOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:14 INFO - Running setup.py (path:/tmp/pip-Cp30Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:14 INFO - Running setup.py (path:/tmp/pip-VxusgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:14 INFO - Running setup.py (path:/tmp/pip-utm9IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:14 INFO - Running setup.py (path:/tmp/pip-7TtZJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:14 INFO - Running setup.py (path:/tmp/pip-Vx7xw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:14 INFO - Running setup.py (path:/tmp/pip-dEOuEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:14 INFO - Running setup.py (path:/tmp/pip-4yl_hI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:14 INFO - Running setup.py (path:/tmp/pip-RuECQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:14 INFO - Running setup.py (path:/tmp/pip-h5_PPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:14 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)) 02:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:14 INFO - Running setup.py (path:/tmp/pip-XFzxcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:15 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)) 02:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:15 INFO - Running setup.py (path:/tmp/pip-WTOKUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:15 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)) 02:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:15 INFO - Running setup.py (path:/tmp/pip-_KzFzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:15 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)) 02:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:15 INFO - Running setup.py (path:/tmp/pip-y6HZXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:15 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)) 02:53:15 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)) 02:53:15 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)) 02:53:15 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)) 02:53:15 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)) 02:53:15 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)) 02:53:15 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)) 02:53:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:16 INFO - Downloading blessings-1.6.tar.gz 02:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:53:16 INFO - Installing collected packages: blessings 02:53:16 INFO - Running setup.py install for blessings 02:53:16 INFO - Successfully installed blessings 02:53:16 INFO - Cleaning up... 02:53:16 INFO - Return code: 0 02:53:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:53:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:16 INFO - Reading from file tmpfile_stdout 02:53:16 INFO - Current package versions: 02:53:16 INFO - argparse == 1.2.1 02:53:16 INFO - blessings == 1.6 02:53:16 INFO - blobuploader == 1.2.4 02:53:16 INFO - docopt == 0.6.1 02:53:16 INFO - functools32 == 3.2.3-2 02:53:16 INFO - jsonschema == 2.5.1 02:53:16 INFO - manifestparser == 1.1 02:53:16 INFO - mozInstall == 1.13 02:53:16 INFO - mozcrash == 1.0 02:53:16 INFO - mozdebug == 0.1 02:53:16 INFO - mozdevice == 0.51 02:53:16 INFO - mozfile == 1.2 02:53:16 INFO - mozhttpd == 0.7 02:53:16 INFO - mozinfo == 0.10 02:53:16 INFO - mozleak == 0.1 02:53:16 INFO - mozlog == 3.5 02:53:16 INFO - moznetwork == 0.27 02:53:16 INFO - mozprocess == 0.25 02:53:16 INFO - mozprofile == 0.28 02:53:16 INFO - mozrunner == 6.13 02:53:16 INFO - mozscreenshot == 0.1 02:53:16 INFO - mozsystemmonitor == 0.3 02:53:16 INFO - moztest == 0.8 02:53:16 INFO - mozversion == 1.4 02:53:16 INFO - psutil == 3.1.1 02:53:16 INFO - requests == 1.2.3 02:53:16 INFO - wsgiref == 0.1.2 02:53:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:16 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 0x27381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4eb0>, '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 0x2aa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6240>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', '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 02:53:16 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 02:53:16 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 02:53:16 INFO - Using env: {'DISPLAY': ':0', 02:53:16 INFO - 'HOME': '/home/cltbld', 02:53:16 INFO - 'LANG': 'en_US.UTF-8', 02:53:16 INFO - 'LANGUAGE': 'en_US:en', 02:53:16 INFO - 'LOGNAME': 'cltbld', 02:53:16 INFO - 'MAIL': '/var/mail/cltbld', 02:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:16 INFO - 'MOZ_NO_REMOTE': '1', 02:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:16 INFO - 'NO_EM_RESTART': '1', 02:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:16 INFO - 'PWD': '/builds/slave/test', 02:53:16 INFO - 'SHELL': '/bin/bash', 02:53:16 INFO - 'SHLVL': '1', 02:53:16 INFO - 'TERM': 'linux', 02:53:16 INFO - 'TMOUT': '86400', 02:53:16 INFO - 'USER': 'cltbld', 02:53:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', 02:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:16 INFO - '_': '/tools/buildbot/bin/python'} 02:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:17 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)) 02:53:17 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)) 02:53:17 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)) 02:53:17 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)) 02:53:17 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)) 02:53:17 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)) 02:53:17 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)) 02:53:17 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)) 02:53:17 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)) 02:53:17 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:18 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:53:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 02:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:53:18 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)) 02:53:18 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)) 02:53:18 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)) 02:53:18 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)) 02:53:18 INFO - Installing collected packages: marionette-driver, simplejson 02:53:18 INFO - Running setup.py install for marionette-driver 02:53:18 INFO - Running setup.py install for simplejson 02:53:18 INFO - building 'simplejson._speedups' extension 02:53:18 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 02:53:19 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 02:53:19 INFO - Successfully installed marionette-driver simplejson 02:53:19 INFO - Cleaning up... 02:53:19 INFO - Return code: 0 02:53:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:19 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 0x27381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2904a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa4eb0>, '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 0x2aa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6240>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', '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 02:53:19 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 02:53:19 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 02:53:19 INFO - Using env: {'DISPLAY': ':0', 02:53:19 INFO - 'HOME': '/home/cltbld', 02:53:19 INFO - 'LANG': 'en_US.UTF-8', 02:53:19 INFO - 'LANGUAGE': 'en_US:en', 02:53:19 INFO - 'LOGNAME': 'cltbld', 02:53:19 INFO - 'MAIL': '/var/mail/cltbld', 02:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:19 INFO - 'MOZ_NO_REMOTE': '1', 02:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:19 INFO - 'NO_EM_RESTART': '1', 02:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:19 INFO - 'PWD': '/builds/slave/test', 02:53:19 INFO - 'SHELL': '/bin/bash', 02:53:19 INFO - 'SHLVL': '1', 02:53:19 INFO - 'TERM': 'linux', 02:53:19 INFO - 'TMOUT': '86400', 02:53:19 INFO - 'USER': 'cltbld', 02:53:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', 02:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:19 INFO - '_': '/tools/buildbot/bin/python'} 02:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:53:19 INFO - Cleaning up... 02:53:19 INFO - Return code: 0 02:53:19 INFO - Running post-action listener: _resource_record_post_action 02:53:19 INFO - Running post-action listener: _start_resource_monitoring 02:53:19 INFO - Starting resource monitoring. 02:53:19 INFO - [mozharness: 2017-07-26 09:53:19.858097Z] Finished create-virtualenv step (success) 02:53:19 INFO - [mozharness: 2017-07-26 09:53:19.858619Z] Running install step. 02:53:19 INFO - Running pre-action listener: _resource_record_pre_action 02:53:19 INFO - Running main action method: install 02:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:20 INFO - Reading from file tmpfile_stdout 02:53:20 INFO - Detecting whether we're running mozinstall >=1.0... 02:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:53:20 INFO - Reading from file tmpfile_stdout 02:53:20 INFO - Output received: 02:53:20 INFO - Usage: mozinstall [options] installer 02:53:20 INFO - Options: 02:53:20 INFO - -h, --help show this help message and exit 02:53:20 INFO - -d DEST, --destination=DEST 02:53:20 INFO - Directory to install application into. [default: 02:53:20 INFO - "/builds/slave/test"] 02:53:20 INFO - --app=APP Application being installed. [default: firefox] 02:53:20 INFO - mkdir: /builds/slave/test/build/application 02:53:20 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'] 02:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:53:38 INFO - Reading from file tmpfile_stdout 02:53:38 INFO - Output received: 02:53:38 INFO - /builds/slave/test/build/application/firefox/firefox 02:53:38 INFO - Running post-action listener: _resource_record_post_action 02:53:38 INFO - [mozharness: 2017-07-26 09:53:38.205815Z] Finished install step (success) 02:53:38 INFO - [mozharness: 2017-07-26 09:53:38.206043Z] Running setup-mitmproxy step. 02:53:38 INFO - Running pre-action listener: _resource_record_pre_action 02:53:38 INFO - Running main action method: setup_mitmproxy 02:53:38 INFO - Skipping: mitmproxy is not required 02:53:38 INFO - Running post-action listener: _resource_record_post_action 02:53:38 INFO - [mozharness: 2017-07-26 09:53:38.206590Z] Finished setup-mitmproxy step (success) 02:53:38 INFO - [mozharness: 2017-07-26 09:53:38.206694Z] Running run-tests step. 02:53:38 INFO - Running pre-action listener: _resource_record_pre_action 02:53:38 INFO - Running pre-action listener: _set_gcov_prefix 02:53:38 INFO - Running main action method: run_tests 02:53:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:53:38 INFO - Python 2.7.3 02:53:38 INFO - Return code: 0 02:53:38 INFO - grabbing minidump binary from tooltool 02:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:38 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 0x2aa4eb0>, '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 0x2aa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa6240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:53:38 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 02:53:38 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 02:53:38 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 02:53:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:53:38 INFO - Return code: 0 02:53:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:53:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:53:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:53:38 INFO - ENV: RUST_BACKTRACE is now 1 02:53:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:53:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:53:38 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/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 02:53:38 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/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 02:53:38 INFO - Using env: {'DISPLAY': ':0', 02:53:38 INFO - 'HOME': '/home/cltbld', 02:53:38 INFO - 'LANG': 'en_US.UTF-8', 02:53:38 INFO - 'LANGUAGE': 'en_US:en', 02:53:38 INFO - 'LOGNAME': 'cltbld', 02:53:38 INFO - 'MAIL': '/var/mail/cltbld', 02:53:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:53:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:38 INFO - 'MOZ_NO_REMOTE': '1', 02:53:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:38 INFO - 'NO_EM_RESTART': '1', 02:53:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:38 INFO - 'PWD': '/builds/slave/test', 02:53:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:53:38 INFO - 'RUST_BACKTRACE': '1', 02:53:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:53:38 INFO - 'SHELL': '/bin/bash', 02:53:38 INFO - 'SHLVL': '1', 02:53:38 INFO - 'STYLO_FORCE_ENABLED': '1', 02:53:38 INFO - 'TERM': 'linux', 02:53:38 INFO - 'TMOUT': '86400', 02:53:38 INFO - 'USER': 'cltbld', 02:53:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078', 02:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:38 INFO - '_': '/tools/buildbot/bin/python'} 02:53:38 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/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 02:53:38 INFO - mozversion application_buildid: 20170726090220 02:53:38 INFO - mozversion application_changeset: 4f821dab4306fd0aff947ce55a1304acd7e4cf95 02:53:38 INFO - mozversion application_display_name: Nightly 02:53:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:53:38 INFO - mozversion application_name: Firefox 02:53:38 INFO - mozversion application_remotingname: firefox 02:53:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:53:38 INFO - mozversion application_vendor: Mozilla 02:53:38 INFO - mozversion application_version: 56.0a1 02:53:38 INFO - mozversion platform_buildid: 20170726090220 02:53:38 INFO - mozversion platform_changeset: 4f821dab4306fd0aff947ce55a1304acd7e4cf95 02:53:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:53:38 INFO - mozversion platform_version: 56.0a1 02:53:38 INFO - using testdate: 1501062818 02:53:38 INFO - actual date: 1501062818 02:53:38 INFO - starting webserver on 'localhost:51009' 02:53:38 INFO - SUITE-START | Running 2 tests 02:53:38 INFO - TEST-START | dromaeo_css 02:53:38 INFO - Initialising browser for dromaeo_css test... 02:53:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51009/getInfo.html -profile /tmp/tmpBqNPnk/profile 02:53:38 INFO - TEST-INFO | started process 12377 (/builds/slave/test/build/application/firefox/firefox http://localhost:51009/getInfo.html) 02:53:45 INFO - TEST-INFO | 12377: exit 0 02:53:45 INFO - Browser initialized. 02:53:45 INFO - Running cycle 1/1 for dromaeo_css test... 02:53:45 INFO - TEST-INFO | started process 12605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBqNPnk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:46 INFO - PID 12605 | 02:53:46 INFO - PID 12605 | (/builds/slave/test/build/application/firefox/firefox:12659): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:53:46 INFO - PID 12605 | 02:53:56 INFO - PID 12605 | RSS: Main: 171421696 02:53:56 INFO - PID 12605 | 02:56:55 INFO - PID 12605 | Cycle 1(1): loaded http://localhost:51009/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51009/tests/dromaeo/cssquery-ext.html) 02:56:57 INFO - PID 12605 | RSS: Main: 174972928 02:56:57 INFO - PID 12605 | 02:59:58 INFO - PID 12605 | Cycle 1(1): loaded http://localhost:51009/tests/dromaeo/cssquery-ext.html (next: http://localhost:51009/tests/dromaeo/cssquery-jquery.html) 02:59:59 INFO - PID 12605 | RSS: Main: 173154304 02:59:59 INFO - PID 12605 | 03:03:01 INFO - PID 12605 | Cycle 1(1): loaded http://localhost:51009/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51009/tests/dromaeo/cssquery-mootools.html) 03:03:01 INFO - PID 12605 | RSS: Main: 175992832 03:03:01 INFO - PID 12605 | 03:06:03 INFO - PID 12605 | Cycle 1(1): loaded http://localhost:51009/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51009/tests/dromaeo/cssquery-prototype.html) 03:06:04 INFO - PID 12605 | RSS: Main: 173969408 03:06:04 INFO - PID 12605 | 03:09:08 INFO - PID 12605 | Cycle 1(1): loaded http://localhost:51009/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51009/tests/dromaeo/cssquery-yui.html) 03:09:09 INFO - PID 12605 | RSS: Main: 174841856 03:09:09 INFO - PID 12605 | 03:12:11 INFO - PID 12605 | Cycle 1(1): loaded http://localhost:51009/tests/dromaeo/cssquery-yui.html (next: http://localhost:51009/tests/dromaeo/cssquery-dojo.html) 03:12:11 INFO - PID 12605 | RSS: Main: 178036736 03:12:11 INFO - PID 12605 | 03:12:11 INFO - PID 12605 | __start_tp_report 03:12:11 INFO - PID 12605 | _x_x_mozilla_page_load 03:12:11 INFO - PID 12605 | _x_x_mozilla_page_load_details 03:12:11 INFO - PID 12605 | |i|pagename|runs| 03:12:11 INFO - PID 12605 | |0;dojo.html;3049.161480592838;3083.691630836915;3091.2271932016993;3110.828904410258;3126.5779119818817;5975.774966131943;6089.695515224232;6126.693665316728;6171.197744293241;6174.0430233313855;5905.85235369116;6093.299270583884;6107.236595425572;6135.693215339237;6141.969290153543;5623.4938855503;5629.662220266777;5639.492445679888;5647.322321321447;5667.348254950672;5641.887162256752;5688.687122208277;5693.174489698991;5701.002324593201;5717.628354156987;5630.211770352154;5676.347220069703;5721.799737009205;5729.226554415163;5732.914006289909;5444.074507333763;5547.140193270049;5554.1391084381985;5601.327840659106;5645.689487078209;5578.191162281487;5596.776128954837;5654.123610840285;5671.6880571568545;5678.37537870838;5945.940540594582;6016.42843929826;6101.450869421773;6123.8162855114415;6152.200213972155;6359.300476947578;6430.3891130342545;6488.643124628144;6507.837304067389;6566.441852442548;6650.068990341356;6661.600303981777;6690.0968369270495;6692.665366731692;6702.597844129368;6123.846903827395;6142.539309551801;6205.968970155165;6232.283287421914;6233;6751.054852320679;6793.898091528631;6833.487488438387;6843.213030501556;6863.38229559342;6318.052292156121;6394.776182833579;6401.07184458251;6401.9039714404325;6411.647359395185;6500.967495162494;6559.47524198063;6570.408663220333;6572.047053177263;6582.670866456754;6523.24982627004;6566.67166641666;6567.310432404624;6569.211694596679;6569.868602628017;6561.376669216417;6567.44176744982;6572.4084832365315;6574.868502629921;6578.3092775258865;5250.0549901018185;5263.078961181778;5267.71027593486;5278.947210527922;5284.180951952453;4291.871243862689;4556.521565235669;4564.338170965191;4573.5426457354;4581.335706322565;5660.660360378308;5698.202251684767;5735.082386818172;5736.569757268222;5740.167675687002;6480.4815614750705;6539.47684185264;6564.540482166202;6604.471642268607;6654.933450665529;5666.490015898589;5738.770449181986;5740.770369185186;5740.856478587985;5751.338596061507;5758.165066065397;5806.767729290866;5824.475797178189;5843.649381037151;5863.442972917566;6301.558890877686;6375.2987171411105;6396.392342727433;6413.615183089029;6428.357164283628;6500.934990650033;6564.573302735307;6592.736290548516;6599.8020059398295;6631.568948018364;6373.840653983502;6400.359964003563;6414.166158399378;6418.646974416265;6492.675366231764;6474.0612611172055;6482.189726284215;6491.318411566717;6550.967245163743;6559.147310849559;6564.606123632598;6623.337666233531;6655.500837437115;6668.233153187251;6686.565373250918;6172.907406388818;6283.120363149254;6284.937150628435;6303.716332764945;6327.145835312174;6386.840328991627;6404.359564043559;6422.807315780534;6429.51778616615;6482.448991835747;6285.214348206474;6345.428911397997;6409.8718025640155;6427.389398007182;6431.5819471734185;6401.231852177769;6455.419012288917;6464.41820236181;6513.446357059703;6524.412802847766;6178.073289006685;6211.192544969306;6240.375962403723;6280.0893870389455;6361.522885783677 03:12:11 INFO - PID 12605 | |1;ext.html;804.9959750201248;840.730966090851;866.4627930682975;869.5695630662823;1140.5893878203851;31925.52111718323;32603.67396326039;42232.366514502304;42361.57638423615;42444.99999999996;42554;42866.57133428665;42905.57094429055;42989.140217195716;43072;7655.770326890174;7710.653020614058;7903.920960790405;7904.762857114296;7912.050553933536;7707.152213256537;7826.843463130734;7829.569373684445;7836.960815195945;7838.137804841463;7799.805004874866;7852.921470785276;7862.921370786305;7877.606119694021;7887.171846956073;7787.143414224431;7834.412419068536;7844.803879902991;7871.370290376756;7872.29149376556;7707.614619269014;7760.223977602251;7772.922270777333;7796.298333150044;7802.765917022499;39673.80163099195;39873.80063099695;39997.60002399968;40101.19797604061;40102.39846402306;3562.2341196642587;3566.1797786508987;3575.535180426528;3589.5513060867393;3600.963990360089;31919.202019949687;31965.360692786246;32193;32201.51697724536;32382.352352953043;4817.181079216542;4943.876403089952;4952.133376659106;4952.579030782388;4988.476209997971;183578;184338;184370;185044;185552;49727;49781.50218497769;49904.251436228486;50083.74958125186;50363.24455133176;50945;51156.23265651018;51239.487605123475;51260.487395126314;51371;14085.507007254697;14432.567022989328;16576.83423165753;16999.49001529956;17011.659766804594;13779.517716879862;14006;14062.929685351712;14101.224432656303;14101.224432656303;14528.491502797351;14532;14546.345414456375;14672.633184170481;14676.412943482355;5815.389384114692;5915.40845915405;5963.701814909237;6003.099535069775;6040.486558642477;966.6080843585215;987.3582171588525;1010.8837483689323;1028.2596530498029;1032.8450732390052;22178.556428871656;22580.66129008066;22624.208152714906;23054.887590175113;23107.768922310897;1100.2408338246585;1101.2071308657753;1120.467777805536;1124.7356871135278;1128.6275529075385;11739.88260117405;11949.283043017273;12017.819732704016;12114.878851211375;12170.634880953585;224767;225127;225624;225804;225915;52381.476185238425;52551.47448525542;52963.73518132385;53123;53167.20249196265;1469.1111877314286;1473.5947614406125;1504.74419348711;1514.4775052606833;1515.8711509521593;21920.01359938775;22290;22686.43283917849;22744.431389215402;23290.65064024007;38299.425508616834;38656.42015369715;38744.80627596957;38778.4183237246;38833.223335533694;188402;189609;190597;190820;191217;34423.655763442046;34847.47728784019;37158.07104822401;37293.254134916606;37353.252934941695;46586.53413465822;46615.06769864652;46783.76608116938;47384.28923566218;47428.7628561855;33333;33453.498197527544;33967.15082122868;34217.315653687285;34578;32236.677633223368;33416.33167336591;34234.31531369408;34416.82791586026;34514.30971380508;38073.80963095167;38191.42712859365;38331.808340958116;38350;38404.42393364158;31901.36197276088;32252;33482.162945926546;34238.48642270318;34491.65508344985;24112;24130.276091717278;24340.547936996434;24467.510649787262;24624.384390389667 03:12:11 INFO - PID 12605 | |2;jquery.html;571.8827640333732;574.5087949802919;577.5466258986696;594.2838879150622;595.9761609535619;22327.441813954658;23097.076116955344;23240.535189296203;23241.302760917177;23294.534109317825;19251.326203582877;19615.31346402876;20005.799942000576;24361.756382436215;25057;6383.744650213997;6397.584157029778;6450.838729031765;6478.611283323015;6500.837479063014;6375.203099612549;6453;6481.384268494486;6485.189351331083;6485.416312531871;5906.37983011784;6489.643069631168;6496.090547323379;6500.154979852612;6507.186601674791;6363.109164716943;6409.166808314889;6414.8717025659225;6418.871622567546;6426.967865160667;5961.046232602806;5964.224650795369;5973.581849270553;5991.820245392645;5992.101184822268;27479.313017174532;27532.311692207655;27968.300792480146;28563.714362856314;28634.14097577076;1858.5911099558075;1894.232835701543;1896.706010568364;1902.4673091534391;1903.1055403960117;18269.45191644253;18912.71630925537;18972.14625341849;18994.430167095008;19032.238710451566;2257.582347265761;2280.395695140789;2308.5729140109133;2311.4914718761847;2380.33350661815;129413;132258.33870830585;132586.337068315;134996;135790;14111.2944352784;14399.280035998368;14692.926535367254;14840.851591484163;14909.179995100156;23305.41736456568;23330.65004024941;23370.013548848197;23384.18155364588;23488.765112349;10476.63331783384;10569.63006294776;10587.311824731369;10624.150067994542;10667.786644267226;9826.606935722633;9848.655297064568;9996.200303975664;10029.79940401188;10114.595416183418;8501.234888860032;9003.234725048444;9111.851803731004;9307.906920930704;9443.622255109718;2759.572266298727;2761.6271803306295;2761.9309517262227;2778.8471634059915;2841.7300356466103;943.1228957069991;958.1185309515263;962.5331714118647;987.8221920054459;995.9900400996042;18801.341953031577;19387.51531211731;19575.706364404545;19669.40991770249;19870.205191792455;978.6232300564334;1000.8548760429696;1021.5913634546092;1032.2722480651123;1033.4574348467115;10824.567017319376;10850.403227822388;10905.945470272598;10983.371688440098;11195.944020280009;456705;467522;472345;484543;490423;108264.4586777061;110914.44542777234;111224;111858.44070779593;112306.43846780877;1164.2490593567102;1187.1749134351542;1210.6186551236333;1215.2890559023072;1216.92698438094;16483.505494835175;19950.20199192016;20274.89862550678;21044.47388815292;21232.36302910915;56922.43077569171;57245.71377143254;58255.41744582669;58431.70784146222;58479.70760146172;67411;67529.32470675427;68000.6599966997;68038.65980670066;68059.65970170118;12335.876641233473;14512.564623061326;14830.110193388431;14848.7772683412;14871;21202;23221.187258445872;23380.298591042298;23502.529949401258;23711.103111751363;18252;18325;18454.63090738151;18607.627847443247;18669.43991680252;16646.750298745286;16752.41366552165;17250.137493125545;17330.220140093475;17480.21339039721;17519;17768.378106766202;18005.459836204936;18794.6241075175;18797.34209302668;14354.569362919128;14392.856071439151;14456.494022709154;14490.710185796013;14542.4910128145;18282.268709251483;18309.17608707638;18338.63322733511;18387.356442524448;18426.07869606541 03:12:11 INFO - PID 12605 | |3;mootools.html;1312.829332186816;1356.3828458051587;1358.2393859438719;1367.5145323410188;1384.4111511473545;13585.320733963299;13622.727545449085;14160.362783674733;14201.289935503222;14210.644733881658;14090;14310.499132530364;14342.282885855717;14349.784753228683;14385.928070359634;2625.7242989486067;2700.054980756729;2708.2823051891264;2708.79684023699;2716.212298433452;2575.7939364850768;2647.099986004758;2685.717999610042;2721.6597925259343;2746.533089374811;2653.548896687568;2725.427660191362;2726.4001919577663;2727.6498133423984;2728.877200525981;2643.5505963985975;2679.732026797324;2690.582959641249;2691.973080269192;2693.7979651526116;2660.600909863517;2666.3600735823456;2672.078133044097;2680.0485827531143;2680.718524554913;13550.186988780704;13750.724985500334;13770.93114534431;13840.238786866717;13850.09974351664;7299.160596531414;7490.063742032246;7496.6251687415415;7548.735794247175;7597.506162099446;4951.727654978975;5044.419891712463;5157.896842063138;5167.121589329823;5186.611004174702;1798.8291112344307;1841.2174825699024;1871.5130523767807;1875.1374367790831;1880.3042874136656;21953.560928781495;22093.33719988403;22194;22273.888630556907;22291.888540557193;6459.61242325462;6464.159659244362;6501.252355979028;6662.83342916431;6675;15603.843961560466;15623.375064997274;15623.843761562239;15640.139792311305;15651;7620.847583048308;7932.325752311118;7933.127355990837;7935.880961785462;7950.4832185907735;7053.89419158713;7138.857222855514;7168.319009694071;7205.92794072063;7219.8556028880175;4845.224764037807;4935.087008903364;5020.096382651085;5043.87390315245;5044.873878153076;1345.4080204709896;1349.44672684199;1426.5363756779088;1435.6195608163846;1459.0734883348937;863.2791618998082;892.3931726426092;913.6984795017628;930.042056681619;944.9574769135405;8017.919820801717;8126.634301456449;8169.101398846122;8191;8264.545450000187;683.2518392360357;683.7880257120308;720.1753991679498;733.8789099798473;808.4664121679663;4618.630509559227;4979.053979743837;5074.162763144113;5103.923441148386;5203.7918483261;18524.351647692267;19182.040897955045;19304.32434864773;19316.613667726568;19321.323753668556;18487.722684159748;18714.1578628962;18724.531886702942;18741.531461713566;18743.34398296053;9728.929817720045;10647.414392208348;10720.624778132727;10739.301945373682;10743.677689669323;7472.476926615085;7789.8831517528415;7946.086200087064;8020.639071241691;8133.308668762985;15977.360905564112;16106.919465402598;16309;16901.239444225284;17007;15466.690666186838;16405.343786248417;16632;16927.15364231759;17019.744703829205;11113.277636953571;11199.496022678835;11316.26444281119;11328.03711684516;11684.415779211175;12884.613461596167;12980.610581682564;12998.935005324913;13002.544910928073;13030.609081727564;9072.95463522678;9506.524673766422;10409.1672666185;10610.204234682584;10871.402072886067;9189.264858811146;9700.417974921527;9721.4653194075;9983.900160998297;10647.733806654896;9133.725988220363;9320.067993200626;9387.530623468663;9400.153986141007;9417.199538039069;6771.255161932282;6864.725410983505;7216.134063912364;7346.449016323904;7478.102627684712;6499.2200935887995;6811.455083593201;6976.302369762983;6993.580385176906;7015.579065256101 03:12:11 INFO - PID 12605 | |4;prototype.html;500.3895247797686;500.52700198312584;527.2276115490805;535.1972041937095;537.8305833662396;5969.313528944162;6077.9999999999945;6142.201513803205;6229.162397092857;6254.186955695759;5834.533237341013;5885.49973252273;6006.249218847644;6024.487918526919;6064.181335519704;5005.774740136684;5023.120953833083;5060.951239008797;5069.290299358075;5094.388673359202;4742.407199100113;5115.872103197413;5116.334876466054;5119.7696103675235;5151.587872970172;4836.322914791932;4888.584470320027;4888.926666100011;4914.926276105862;4928.225838698066;4861.295112208728;4895.192293271606;4943.431505376856;4948.356713627241;4961.776720047606;4439.089986552749;4457.818678050319;4461.754603496806;4462.576055274743;4507.594316511497;5845.707714614252;6022.819315420545;6047.425494578008;6048.848778780522;6076.635401875901;5483.698396588186;5547.972260138674;5604.600388694855;5648.181013753024;5687.118496633028;6357.17356743625;6360.363963603602;6384.201974753156;6401.615903045786;6409.743610255584;4753.809847606091;4824;4826.251930950708;4833.564979151858;4886.900447399342;6714.261431242559;6725.899111513282;6750.662466876636;6770.255271920085;6847.007183958348;4977.253411988231;5012.774425150877;5012.874678133003;5017.21544542775;5034.144195486776;5081.8729531762;5085.542301192836;5086.041873878584;5089.3638295213095;5100.413452452941;5611.8877622448135;5640.5487560995025;5675.716214189274;5683.602147849693;5705.686187259741;6318.810435686937;6375.776847810304;6428.532170141707;6430.903536446957;6526.738930442729;1672.3895778040928;1697.125980120239;1717.519094653474;1722.3110755697821;1724.8102708702033;1206.342543313896;1221.1024896700917;1221.6823625857342;1225;1237.6410840856051;5653.265075540154;5660.877171060853;5678.3186017678145;5682.982541197898;5692.8861422771315;6503.642299673564;6654.234763002317;6661.566998145105;6671.63306018164;6696.296888826603;5678.346990096192;5719.28508936383;5735.4551317624755;5746.4253574643035;5773.797917072966;3481.711766646357;3505.7738336156212;3511.648835116519;3522.9295414091575;3580.445031020144;6341.8097457076365;6407.743690252338;6412.134361861089;6491.96247489839;6506.869862602722;6665.566738162004;6674.499412544079;6715;6736.966315168393;6776.220734615582;6411.2306523216575;6495.317991610813;6511.837204069841;6521.934780652133;6538.901916471256;6649.700763465752;6678.23200331968;6703.899441508283;6729.293424190585;6733.696983635846;6308.463780578702;6437.420632143129;6528.445082168069;6555.147830781968;6646.169228846395;6342.8919829282395;6358.268799088164;6386.808395747949;6398.168238129014;6403.679816009274;4903.141950158637;4954;4983.127952608352;4985;4991.176455884738;6343.841403964938;6431.549791514549;6540.215174179129;6556.9837874578225;6685.933140668531;6027.558838670346;6287.119803227461;6329.145565348619;6349.428551430394;6382.170317858649;6353.36466353361;6371.55399122057;6393.6163830170335;6397.936020639734;6438.356164383712;6291.874162516632;6316.873662526816;6361.377848648565;6368.42684158428;6394.186557914502;6403.583767055313;6441;6465.321141280097;6495.895697731492;6504.707288171949;6182.485291103529;6230.314665386713;6241.157443745036;6261.186045814015;6273.71768270438 03:12:11 INFO - PID 12605 | |5;yui.html;885.282920834124;903.661127077346;915.4644532948225;924.8242833861566;925.6297481007596;16215.675686486278;16280.75578866318;16450.50648480546;18110;18951.715724264148;19610.313639022635;19785.901070494627;19819.50451238716;19848.603027939433;19895.900520497376;1014.2950649298722;1041.6822869024945;1044.394251334228;1044.7231483656838;1047.0367262118868;945.0927109974433;1044.1803184500168;1046.7330830638177;1047.1622701838498;1047.3611097230682;1086.8804431512526;1094.63876920616;1098.3739268616891;1100.367288808934;1101.0365929811414;1077.8437126616675;1079.185215162555;1082.65355086372;1084.6529110684585;1087.8041952448557;793.1909452358562;796.7609717084852;798.3732769775698;803.7910143362709;804.4770898915693;18098.728519072225;18140.45578632643;18160.455186344432;18161.45515634533;19924.60150796976;19913.203471861107;20050.398488045237;20311.695324570144;20366.796332036785;20380.796192038037;15213.847861521464;15468.071915684983;15701.764473532907;15719.37122515098;15737.527874163794;3527.8236088195486;3540.9114772130647;3546.929061418783;3557.875474358411;3559.501669766235;127332;129175;130441;132736.99999999904;134926.3253683735;15586.922065389826;16076.43732469358;16079;16169.272382742805;16204.270807813677;29068;30212.69787302143;30232.395352092833;30313.545296820565;30410;8499.660013599387;8653.69712060075;8663.91336086631;8682.52246126469;8705.998810136789;4015;4046.3323551614244;4124.278251306009;4138.048248902709;4188.057687020396;5084.49155084496;5185.948140518622;5186.092433824066;5200.6879587224885;5203.531682148625;973.8636590877283;993.4337427666305;1012.8885822559513;1013.8175128476945;1015.7257540464182;643.2634633344794;670.3464122480542;685.3044160177424;687.845234822171;700.8738427083174;10634.41510716918;12761.68095797594;12835.807462888064;13050.608481745563;13235.07354485196;676.7755492635349;692.0760784352844;707.2997732245041;711.1182134153715;717.1465955512923;4703.6942598730975;4877.463479017305;5010.949890501049;5012.67417617861;5149.098907691214;97467.61395737209;99113.50443247882;100136;101467;101526;80631.59684201541;89659;89717.55141224252;89751;90249.09750902538;75241.66167365732;78171;79474.60262698765;80754.59622701966;83086.75369869456;11515.712107197387;11616.30302181838;11768.646940591796;11918;11938.582149625068;32306.515402268513;33336.16659583433;34358.82820585881;37476.62523374731;37495.2500949974;62923.6853815728;65194.67402662956;66607.33392666011;66969.66515167394;67762;17507.82492175113;17555.912220438815;17756.46730598084;17851.642967140844;18533.351332703292;19720;20304;20330.288439904532;20331.288404905757;20519.38441846747;17497.82502175013;17641.558961025563;17979.910100449415;18322.358717444826;18455.446336609923;18200.271989120287;18434.72347914809;18475.722864157317;18739.812601873808;18791;16923.323067077177;17296.740548892027;17407.738883917005;17830.732539011668;18576.535586610444;12029.518819247482;12371.75256494883;12647.430865610886;12715.237085774883;13038;12596.370181491073;12741.93629031886;12774.297413642338;12959.481620735065;13084.495283042572 03:12:11 INFO - PID 12605 | __end_tp_report 03:12:11 INFO - PID 12605 | __start_cc_report 03:12:11 INFO - PID 12605 | _x_x_mozilla_cycle_collect,369 03:12:11 INFO - PID 12605 | __end_cc_report 03:12:11 INFO - PID 12605 | __startTimestamp1501063931326__endTimestamp 03:12:11 INFO - PID 12605 | 03:12:11 INFO - PID 12605 | ------- Summary: start ------- 03:12:11 INFO - PID 12605 | Number of tests: 6 03:12:11 INFO - PID 12605 | 03:12:11 INFO - PID 12605 | [#0] dojo.html Cycles:165 Average:6052.84 Median:6285.21 stddev:717.05 (11.4%) stddev-sans-first:679.43 03:12:11 INFO - PID 12605 | Values: 3049.2 3083.7 3091.2 3110.8 3126.6 5975.8 6089.7 6126.7 6171.2 6174.0 5905.9 6093.3 6107.2 6135.7 6142.0 5623.5 5629.7 5639.5 5647.3 5667.3 5641.9 5688.7 5693.2 5701.0 5717.6 5630.2 5676.3 5721.8 5729.2 5732.9 5444.1 5547.1 5554.1 5601.3 5645.7 5578.2 5596.8 5654.1 5671.7 5678.4 5945.9 6016.4 6101.5 6123.8 6152.2 6359.3 6430.4 6488.6 6507.8 6566.4 6650.1 6661.6 6690.1 6692.7 6702.6 6123.8 6142.5 6206.0 6232.3 6233.0 6751.1 6793.9 6833.5 6843.2 6863.4 6318.1 6394.8 6401.1 6401.9 6411.6 6501.0 6559.5 6570.4 6572.0 6582.7 6523.2 6566.7 6567.3 6569.2 6569.9 6561.4 6567.4 6572.4 6574.9 6578.3 5250.1 5263.1 5267.7 5278.9 5284.2 4291.9 4556.5 4564.3 4573.5 4581.3 5660.7 5698.2 5735.1 5736.6 5740.2 6480.5 6539.5 6564.5 6604.5 6654.9 5666.5 5738.8 5740.8 5740.9 5751.3 5758.2 5806.8 5824.5 5843.6 5863.4 6301.6 6375.3 6396.4 6413.6 6428.4 6500.9 6564.6 6592.7 6599.8 6631.6 6373.8 6400.4 6414.2 6418.6 6492.7 6474.1 6482.2 6491.3 6551.0 6559.1 6564.6 6623.3 6655.5 6668.2 6686.6 6172.9 6283.1 6284.9 6303.7 6327.1 6386.8 6404.4 6422.8 6429.5 6482.4 6285.2 6345.4 6409.9 6427.4 6431.6 6401.2 6455.4 6464.4 6513.4 6524.4 6178.1 6211.2 6240.4 6280.1 6361.5 03:12:11 INFO - PID 12605 | 03:12:11 INFO - PID 12605 | [#1] ext.html Cycles:180 Average:37572.34 Median:3582.54 stddev:51993.41 (1451.3%) stddev-sans-first:52065.97 03:12:11 INFO - PID 12605 | Values: 805.0 840.7 866.5 869.6 1140.6 31925.5 32603.7 42232.4 42361.6 42445.0 42554.0 42866.6 42905.6 42989.1 43072.0 7655.8 7710.7 7903.9 7904.8 7912.1 7707.2 7826.8 7829.6 7837.0 7838.1 7799.8 7852.9 7862.9 7877.6 7887.2 7787.1 7834.4 7844.8 7871.4 7872.3 7707.6 7760.2 7772.9 7796.3 7802.8 39673.8 39873.8 39997.6 40101.2 40102.4 3562.2 3566.2 3575.5 3589.6 3601.0 31919.2 31965.4 32193.0 32201.5 32382.4 4817.2 4943.9 4952.1 4952.6 4988.5 183578.0 184338.0 184370.0 185044.0 185552.0 49727.0 49781.5 49904.3 50083.7 50363.2 50945.0 51156.2 51239.5 51260.5 51371.0 14085.5 14432.6 16576.8 16999.5 17011.7 13779.5 14006.0 14062.9 14101.2 14101.2 14528.5 14532.0 14546.3 14672.6 14676.4 5815.4 5915.4 5963.7 6003.1 6040.5 966.6 987.4 1010.9 1028.3 1032.8 22178.6 22580.7 22624.2 23054.9 23107.8 1100.2 1101.2 1120.5 1124.7 1128.6 11739.9 11949.3 12017.8 12114.9 12170.6 224767.0 225127.0 225624.0 225804.0 225915.0 52381.5 52551.5 52963.7 53123.0 53167.2 1469.1 1473.6 1504.7 1514.5 1515.9 21920.0 22290.0 22686.4 22744.4 23290.7 38299.4 38656.4 38744.8 38778.4 38833.2 188402.0 189609.0 190597.0 190820.0 191217.0 34423.7 34847.5 37158.1 37293.3 37353.3 46586.5 46615.1 46783.8 47384.3 47428.8 33333.0 33453.5 33967.2 34217.3 34578.0 32236.7 33416.3 34234.3 34416.8 34514.3 38073.8 38191.4 38331.8 38350.0 38404.4 31901.4 32252.0 33482.2 34238.5 34491.7 24112.0 24130.3 24340.5 24467.5 24624.4 03:12:11 INFO - PID 12605 | 03:12:11 INFO - PID 12605 | [#2] jquery.html Cycles:180 Average:33874.68 Median:12292.51 stddev:79858.37 (649.7%) stddev-sans-first:80043.25 03:12:11 INFO - PID 12605 | Values: 571.9 574.5 577.5 594.3 596.0 22327.4 23097.1 23240.5 23241.3 23294.5 19251.3 19615.3 20005.8 24361.8 25057.0 6383.7 6397.6 6450.8 6478.6 6500.8 6375.2 6453.0 6481.4 6485.2 6485.4 5906.4 6489.6 6496.1 6500.2 6507.2 6363.1 6409.2 6414.9 6418.9 6427.0 5961.0 5964.2 5973.6 5991.8 5992.1 27479.3 27532.3 27968.3 28563.7 28634.1 1858.6 1894.2 1896.7 1902.5 1903.1 18269.5 18912.7 18972.1 18994.4 19032.2 2257.6 2280.4 2308.6 2311.5 2380.3 129413.0 132258.3 132586.3 134996.0 135790.0 14111.3 14399.3 14692.9 14840.9 14909.2 23305.4 23330.7 23370.0 23384.2 23488.8 10476.6 10569.6 10587.3 10624.2 10667.8 9826.6 9848.7 9996.2 10029.8 10114.6 8501.2 9003.2 9111.9 9307.9 9443.6 2759.6 2761.6 2761.9 2778.8 2841.7 943.1 958.1 962.5 987.8 996.0 18801.3 19387.5 19575.7 19669.4 19870.2 978.6 1000.9 1021.6 1032.3 1033.5 10824.6 10850.4 10905.9 10983.4 11195.9 456705.0 467522.0 472345.0 484543.0 490423.0 108264.5 110914.4 111224.0 111858.4 112306.4 1164.2 1187.2 1210.6 1215.3 1216.9 16483.5 19950.2 20274.9 21044.5 21232.4 56922.4 57245.7 58255.4 58431.7 58479.7 67411.0 67529.3 68000.7 68038.7 68059.7 12335.9 14512.6 14830.1 14848.8 14871.0 21202.0 23221.2 23380.3 23502.5 23711.1 18252.0 18325.0 18454.6 18607.6 18669.4 16646.8 16752.4 17250.1 17330.2 17480.2 17519.0 17768.4 18005.5 18794.6 18797.3 14354.6 14392.9 14456.5 14490.7 14542.5 18282.3 18309.2 18338.6 18387.4 18426.1 03:12:11 INFO - PID 12605 | 03:12:11 INFO - PID 12605 | [#3] mootools.html Cycles:180 Average:8569.45 Median:2691.28 stddev:5770.58 (214.4%) stddev-sans-first:5761.01 03:12:11 INFO - PID 12605 | Values: 1312.8 1356.4 1358.2 1367.5 1384.4 13585.3 13622.7 14160.4 14201.3 14210.6 14090.0 14310.5 14342.3 14349.8 14385.9 2625.7 2700.1 2708.3 2708.8 2716.2 2575.8 2647.1 2685.7 2721.7 2746.5 2653.5 2725.4 2726.4 2727.6 2728.9 2643.6 2679.7 2690.6 2692.0 2693.8 2660.6 2666.4 2672.1 2680.0 2680.7 13550.2 13750.7 13770.9 13840.2 13850.1 7299.2 7490.1 7496.6 7548.7 7597.5 4951.7 5044.4 5157.9 5167.1 5186.6 1798.8 1841.2 1871.5 1875.1 1880.3 21953.6 22093.3 22194.0 22273.9 22291.9 6459.6 6464.2 6501.3 6662.8 6675.0 15603.8 15623.4 15623.8 15640.1 15651.0 7620.8 7932.3 7933.1 7935.9 7950.5 7053.9 7138.9 7168.3 7205.9 7219.9 4845.2 4935.1 5020.1 5043.9 5044.9 1345.4 1349.4 1426.5 1435.6 1459.1 863.3 892.4 913.7 930.0 945.0 8017.9 8126.6 8169.1 8191.0 8264.5 683.3 683.8 720.2 733.9 808.5 4618.6 4979.1 5074.2 5103.9 5203.8 18524.4 19182.0 19304.3 19316.6 19321.3 18487.7 18714.2 18724.5 18741.5 18743.3 9728.9 10647.4 10720.6 10739.3 10743.7 7472.5 7789.9 7946.1 8020.6 8133.3 15977.4 16106.9 16309.0 16901.2 17007.0 15466.7 16405.3 16632.0 16927.2 17019.7 11113.3 11199.5 11316.3 11328.0 11684.4 12884.6 12980.6 12998.9 13002.5 13030.6 9073.0 9506.5 10409.2 10610.2 10871.4 9189.3 9700.4 9721.5 9983.9 10647.7 9133.7 9320.1 9387.5 9400.2 9417.2 6771.3 6864.7 7216.1 7346.4 7478.1 6499.2 6811.5 6976.3 6993.6 7015.6 03:12:11 INFO - PID 12605 | 03:12:11 INFO - PID 12605 | [#4] prototype.html Cycles:180 Average:5434.45 Median:6023.65 stddev:1507.42 (25.0%) stddev-sans-first:1465.45 03:12:11 INFO - PID 12605 | Values: 500.4 500.5 527.2 535.2 537.8 5969.3 6078.0 6142.2 6229.2 6254.2 5834.5 5885.5 6006.2 6024.5 6064.2 5005.8 5023.1 5061.0 5069.3 5094.4 4742.4 5115.9 5116.3 5119.8 5151.6 4836.3 4888.6 4888.9 4914.9 4928.2 4861.3 4895.2 4943.4 4948.4 4961.8 4439.1 4457.8 4461.8 4462.6 4507.6 5845.7 6022.8 6047.4 6048.8 6076.6 5483.7 5548.0 5604.6 5648.2 5687.1 6357.2 6360.4 6384.2 6401.6 6409.7 4753.8 4824.0 4826.3 4833.6 4886.9 6714.3 6725.9 6750.7 6770.3 6847.0 4977.3 5012.8 5012.9 5017.2 5034.1 5081.9 5085.5 5086.0 5089.4 5100.4 5611.9 5640.5 5675.7 5683.6 5705.7 6318.8 6375.8 6428.5 6430.9 6526.7 1672.4 1697.1 1717.5 1722.3 1724.8 1206.3 1221.1 1221.7 1225.0 1237.6 5653.3 5660.9 5678.3 5683.0 5692.9 6503.6 6654.2 6661.6 6671.6 6696.3 5678.3 5719.3 5735.5 5746.4 5773.8 3481.7 3505.8 3511.6 3522.9 3580.4 6341.8 6407.7 6412.1 6492.0 6506.9 6665.6 6674.5 6715.0 6737.0 6776.2 6411.2 6495.3 6511.8 6521.9 6538.9 6649.7 6678.2 6703.9 6729.3 6733.7 6308.5 6437.4 6528.4 6555.1 6646.2 6342.9 6358.3 6386.8 6398.2 6403.7 4903.1 4954.0 4983.1 4985.0 4991.2 6343.8 6431.5 6540.2 6557.0 6685.9 6027.6 6287.1 6329.1 6349.4 6382.2 6353.4 6371.6 6393.6 6397.9 6438.4 6291.9 6316.9 6361.4 6368.4 6394.2 6403.6 6441.0 6465.3 6495.9 6504.7 6182.5 6230.3 6241.2 6261.2 6273.7 03:12:11 INFO - PID 12605 | 03:12:11 INFO - PID 12605 | [#5] yui.html Cycles:180 Average:22583.95 Median:19752.95 stddev:30699.52 (155.4%) stddev-sans-first:30742.40 03:12:11 INFO - PID 12605 | Values: 885.3 903.7 915.5 924.8 925.6 16215.7 16280.8 16450.5 18110.0 18951.7 19610.3 19785.9 19819.5 19848.6 19895.9 1014.3 1041.7 1044.4 1044.7 1047.0 945.1 1044.2 1046.7 1047.2 1047.4 1086.9 1094.6 1098.4 1100.4 1101.0 1077.8 1079.2 1082.7 1084.7 1087.8 793.2 796.8 798.4 803.8 804.5 18098.7 18140.5 18160.5 18161.5 19924.6 19913.2 20050.4 20311.7 20366.8 20380.8 15213.8 15468.1 15701.8 15719.4 15737.5 3527.8 3540.9 3546.9 3557.9 3559.5 127332.0 129175.0 130441.0 132737.0 134926.3 15586.9 16076.4 16079.0 16169.3 16204.3 29068.0 30212.7 30232.4 30313.5 30410.0 8499.7 8653.7 8663.9 8682.5 8706.0 4015.0 4046.3 4124.3 4138.0 4188.1 5084.5 5185.9 5186.1 5200.7 5203.5 973.9 993.4 1012.9 1013.8 1015.7 643.3 670.3 685.3 687.8 700.9 10634.4 12761.7 12835.8 13050.6 13235.1 676.8 692.1 707.3 711.1 717.1 4703.7 4877.5 5010.9 5012.7 5149.1 97467.6 99113.5 100136.0 101467.0 101526.0 80631.6 89659.0 89717.6 89751.0 90249.1 75241.7 78171.0 79474.6 80754.6 83086.8 11515.7 11616.3 11768.6 11918.0 11938.6 32306.5 33336.2 34358.8 37476.6 37495.3 62923.7 65194.7 66607.3 66969.7 67762.0 17507.8 17555.9 17756.5 17851.6 18533.4 19720.0 20304.0 20330.3 20331.3 20519.4 17497.8 17641.6 17979.9 18322.4 18455.4 18200.3 18434.7 18475.7 18739.8 18791.0 16923.3 17296.7 17407.7 17830.7 18576.5 12029.5 12371.8 12647.4 12715.2 13038.0 12596.4 12741.9 12774.3 12959.5 13084.5 03:12:11 INFO - PID 12605 | -------- Summary: end -------- 03:12:11 INFO - PID 12605 | 03:12:12 INFO - TEST-INFO | 12605: exit 0 03:12:12 INFO - TEST-OK | dromaeo_css | took 1113559ms 03:12:12 INFO - TEST-START | kraken 03:12:12 INFO - Initialising browser for kraken test... 03:12:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51009/getInfo.html -profile /tmp/tmpTA5U6J/profile 03:12:12 INFO - TEST-INFO | started process 12992 (/builds/slave/test/build/application/firefox/firefox http://localhost:51009/getInfo.html) 03:12:18 INFO - TEST-INFO | 12992: exit 0 03:12:18 INFO - Browser initialized. 03:12:18 INFO - Running cycle 1/1 for kraken test... 03:12:18 INFO - TEST-INFO | started process 13219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTA5U6J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:19 INFO - PID 13219 | 03:12:19 INFO - PID 13219 | (/builds/slave/test/build/application/firefox/firefox:13273): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:12:19 INFO - PID 13219 | 03:12:30 INFO - PID 13219 | RSS: Main: 174170112 03:12:30 INFO - PID 13219 | 03:12:32 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51009/tests/kraken/driver.html?testName=audio-beat-detection) 03:12:33 INFO - PID 13219 | RSS: Main: 178704384 03:12:33 INFO - PID 13219 | 03:12:36 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51009/tests/kraken/driver.html?testName=audio-dft) 03:12:36 INFO - PID 13219 | RSS: Main: 179552256 03:12:36 INFO - PID 13219 | 03:12:39 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51009/tests/kraken/driver.html?testName=audio-fft) 03:12:40 INFO - PID 13219 | RSS: Main: 174628864 03:12:40 INFO - PID 13219 | 03:12:42 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51009/tests/kraken/driver.html?testName=audio-oscillator) 03:12:43 INFO - PID 13219 | RSS: Main: 174850048 03:12:43 INFO - PID 13219 | 03:12:45 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51009/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:12:46 INFO - PID 13219 | RSS: Main: 175013888 03:12:46 INFO - PID 13219 | 03:12:49 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51009/tests/kraken/driver.html?testName=imaging-darkroom) 03:12:49 INFO - PID 13219 | RSS: Main: 178745344 03:12:49 INFO - PID 13219 | 03:12:53 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51009/tests/kraken/driver.html?testName=imaging-desaturate) 03:12:53 INFO - PID 13219 | RSS: Main: 177586176 03:12:53 INFO - PID 13219 | 03:12:56 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51009/tests/kraken/driver.html?testName=json-parse-financial) 03:12:57 INFO - PID 13219 | RSS: Main: 178352128 03:12:57 INFO - PID 13219 | 03:12:59 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51009/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:12:59 INFO - PID 13219 | RSS: Main: 178237440 03:12:59 INFO - PID 13219 | 03:13:01 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51009/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:13:02 INFO - PID 13219 | RSS: Main: 175476736 03:13:02 INFO - PID 13219 | 03:13:04 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51009/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:13:05 INFO - PID 13219 | RSS: Main: 175128576 03:13:05 INFO - PID 13219 | 03:13:07 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:13:08 INFO - PID 13219 | RSS: Main: 175738880 03:13:08 INFO - PID 13219 | 03:13:11 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:13:12 INFO - PID 13219 | RSS: Main: 175644672 03:13:12 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | Cycle 1(1): loaded http://localhost:51009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51009/tests/kraken/driver.html?testName=ai-astar) 03:13:14 INFO - PID 13219 | RSS: Main: 177299456 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | __start_tp_report 03:13:14 INFO - PID 13219 | _x_x_mozilla_page_load 03:13:14 INFO - PID 13219 | _x_x_mozilla_page_load_details 03:13:14 INFO - PID 13219 | |i|pagename|runs| 03:13:14 INFO - PID 13219 | |0;ai-astar;98;109;103;109;107;108;110;102;110;113 03:13:14 INFO - PID 13219 | |1;audio-beat-detection;143;117;140;179;122;144;149;118;174;119 03:13:14 INFO - PID 13219 | |2;audio-dft;163;162;164;164;175;164;168;172;166;164 03:13:14 INFO - PID 13219 | |3;audio-fft;77;75;76;178;76;74;76;87;96;75 03:13:14 INFO - PID 13219 | |4;audio-oscillator;79;79;132;79;80;80;131;80;79;123 03:13:14 INFO - PID 13219 | |5;imaging-gaussian-blur;114;114;125;114;113;114;113;114;114;120 03:13:14 INFO - PID 13219 | |6;imaging-darkroom;150;151;152;151;149;151;151;150;153;151 03:13:14 INFO - PID 13219 | |7;imaging-desaturate;95;94;95;94;95;101;94;93;94;94 03:13:14 INFO - PID 13219 | |8;json-parse-financial;53;54;54;54;53;54;58;54;54;55 03:13:14 INFO - PID 13219 | |9;json-stringify-tinderbox;55;55;54;55;54;55;55;55;59;59 03:13:14 INFO - PID 13219 | |10;stanford-crypto-aes;79;77;80;78;79;94;89;87;78;77 03:13:14 INFO - PID 13219 | |11;stanford-crypto-ccm;126;134;126;133;129;124;129;124;125;180 03:13:14 INFO - PID 13219 | |12;stanford-crypto-pbkdf2;195;189;175;179;181;182;188;176;176;181 03:13:14 INFO - PID 13219 | |13;stanford-crypto-sha256-iterative;72;71;70;69;68;67;69;69;70;68 03:13:14 INFO - PID 13219 | __end_tp_report 03:13:14 INFO - PID 13219 | __start_cc_report 03:13:14 INFO - PID 13219 | _x_x_mozilla_cycle_collect,975 03:13:14 INFO - PID 13219 | __end_cc_report 03:13:14 INFO - PID 13219 | __startTimestamp1501063994263__endTimestamp 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | ------- Summary: start ------- 03:13:14 INFO - PID 13219 | Number of tests: 14 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#0] ai-astar Cycles:10 Average:106.90 Median:109.50 stddev:4.53 (4.1%) stddev-sans-first:3.48 03:13:14 INFO - PID 13219 | Values: 98.0 109.0 103.0 109.0 107.0 108.0 110.0 102.0 110.0 113.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:143.50 stddev:22.51 (15.7%) stddev-sans-first:23.85 03:13:14 INFO - PID 13219 | Values: 143.0 117.0 140.0 179.0 122.0 144.0 149.0 118.0 174.0 119.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#2] audio-dft Cycles:10 Average:166.20 Median:165.00 stddev:4.24 (2.6%) stddev-sans-first:4.33 03:13:14 INFO - PID 13219 | Values: 163.0 162.0 164.0 164.0 175.0 164.0 168.0 172.0 166.0 164.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#3] audio-fft Cycles:10 Average:89.00 Median:76.00 stddev:32.05 (42.2%) stddev-sans-first:33.69 03:13:14 INFO - PID 13219 | Values: 77.0 75.0 76.0 178.0 76.0 74.0 76.0 87.0 96.0 75.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:79.00 stddev:23.90 (30.3%) stddev-sans-first:24.71 03:13:14 INFO - PID 13219 | Values: 79.0 79.0 132.0 79.0 80.0 80.0 131.0 80.0 79.0 123.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:114.00 stddev:3.89 (3.4%) stddev-sans-first:4.09 03:13:14 INFO - PID 13219 | Values: 114.0 114.0 125.0 114.0 113.0 114.0 113.0 114.0 114.0 120.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 03:13:14 INFO - PID 13219 | Values: 150.0 151.0 152.0 151.0 149.0 151.0 151.0 150.0 153.0 151.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:2.23 (2.4%) stddev-sans-first:2.37 03:13:14 INFO - PID 13219 | Values: 95.0 94.0 95.0 94.0 95.0 101.0 94.0 93.0 94.0 94.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:1.42 (2.6%) stddev-sans-first:1.42 03:13:14 INFO - PID 13219 | Values: 53.0 54.0 54.0 54.0 53.0 54.0 58.0 54.0 54.0 55.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:55.00 stddev:1.84 (3.3%) stddev-sans-first:1.94 03:13:14 INFO - PID 13219 | Values: 55.0 55.0 54.0 55.0 54.0 55.0 55.0 55.0 59.0 59.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:79.50 stddev:5.98 (7.5%) stddev-sans-first:6.25 03:13:14 INFO - PID 13219 | Values: 79.0 77.0 80.0 78.0 79.0 94.0 89.0 87.0 78.0 77.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:129.00 stddev:16.89 (13.1%) stddev-sans-first:17.72 03:13:14 INFO - PID 13219 | Values: 126.0 134.0 126.0 133.0 129.0 124.0 129.0 124.0 125.0 180.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:181.50 stddev:6.55 (3.6%) stddev-sans-first:5.04 03:13:14 INFO - PID 13219 | Values: 195.0 189.0 175.0 179.0 181.0 182.0 188.0 176.0 176.0 181.0 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.49 (2.2%) stddev-sans-first:1.22 03:13:14 INFO - PID 13219 | Values: 72.0 71.0 70.0 69.0 68.0 67.0 69.0 69.0 70.0 68.0 03:13:14 INFO - PID 13219 | -------- Summary: end -------- 03:13:14 INFO - PID 13219 | 03:13:14 INFO - PID 13219 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:13:14 INFO - TEST-INFO | 13219: exit 0 03:13:15 INFO - TEST-OK | kraken | took 62877ms 03:13:15 INFO - SUITE-END | took 1176s 03:13:15 INFO - Completed test suite (00:19:36) 03:13:15 INFO - javascript benchmark 03:13:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8369.389436920475, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.161480592838, 3083.691630836915, 3091.2271932016993, 3110.828904410258, 3126.5779119818817, 5975.774966131943, 6089.695515224232, 6126.693665316728, 6171.197744293241, 6174.0430233313855, 5905.85235369116, 6093.299270583884, 6107.236595425572, 6135.693215339237, 6141.969290153543, 5623.4938855503, 5629.662220266777, 5639.492445679888, 5647.322321321447, 5667.348254950672, 5641.887162256752, 5688.687122208277, 5693.174489698991, 5701.002324593201, 5717.628354156987, 5630.211770352154, 5676.347220069703, 5721.799737009205, 5729.226554415163, 5732.914006289909, 5444.074507333763, 5547.140193270049, 5554.1391084381985, 5601.327840659106, 5645.689487078209, 5578.191162281487, 5596.776128954837, 5654.123610840285, 5671.6880571568545, 5678.37537870838, 5945.940540594582, 6016.42843929826, 6101.450869421773, 6123.8162855114415, 6152.200213972155, 6359.300476947578, 6430.3891130342545, 6488.643124628144, 6507.837304067389, 6566.441852442548, 6650.068990341356, 6661.600303981777, 6690.0968369270495, 6692.665366731692, 6702.597844129368, 6123.846903827395, 6142.539309551801, 6205.968970155165, 6232.283287421914, 6233.0, 6751.054852320679, 6793.898091528631, 6833.487488438387, 6843.213030501556, 6863.38229559342, 6318.052292156121, 6394.776182833579, 6401.07184458251, 6401.9039714404325, 6411.647359395185, 6500.967495162494, 6559.47524198063, 6570.408663220333, 6572.047053177263, 6582.670866456754, 6523.24982627004, 6566.67166641666, 6567.310432404624, 6569.211694596679, 6569.868602628017, 6561.376669216417, 6567.44176744982, 6572.4084832365315, 6574.868502629921, 6578.3092775258865, 5250.0549901018185, 5263.078961181778, 5267.71027593486, 5278.947210527922, 5284.180951952453, 4291.871243862689, 4556.521565235669, 4564.338170965191, 4573.5426457354, 4581.335706322565, 5660.660360378308, 5698.202251684767, 5735.082386818172, 5736.569757268222, 5740.167675687002, 6480.4815614750705, 6539.47684185264, 6564.540482166202, 6604.471642268607, 6654.933450665529, 5666.490015898589, 5738.770449181986, 5740.770369185186, 5740.856478587985, 5751.338596061507, 5758.165066065397, 5806.767729290866, 5824.475797178189, 5843.649381037151, 5863.442972917566, 6301.558890877686, 6375.2987171411105, 6396.392342727433, 6413.615183089029, 6428.357164283628, 6500.934990650033, 6564.573302735307, 6592.736290548516, 6599.8020059398295, 6631.568948018364, 6373.840653983502, 6400.359964003563, 6414.166158399378, 6418.646974416265, 6492.675366231764, 6474.0612611172055, 6482.189726284215, 6491.318411566717, 6550.967245163743, 6559.147310849559, 6564.606123632598, 6623.337666233531, 6655.500837437115, 6668.233153187251, 6686.565373250918, 6172.907406388818, 6283.120363149254, 6284.937150628435, 6303.716332764945, 6327.145835312174, 6386.840328991627, 6404.359564043559, 6422.807315780534, 6429.51778616615, 6482.448991835747, 6285.214348206474, 6345.428911397997, 6409.8718025640155, 6427.389398007182, 6431.5819471734185, 6401.231852177769, 6455.419012288917, 6464.41820236181, 6513.446357059703, 6524.412802847766, 6178.073289006685, 6211.192544969306, 6240.375962403723, 6280.0893870389455, 6361.522885783677], "value": 5998.559816282821, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.9959750201248, 840.730966090851, 866.4627930682975, 869.5695630662823, 1140.5893878203851, 31925.52111718323, 32603.67396326039, 42232.366514502304, 42361.57638423615, 42444.99999999996, 42554.0, 42866.57133428665, 42905.57094429055, 42989.140217195716, 43072.0, 7655.770326890174, 7710.653020614058, 7903.920960790405, 7904.762857114296, 7912.050553933536, 7707.152213256537, 7826.843463130734, 7829.569373684445, 7836.960815195945, 7838.137804841463, 7799.805004874866, 7852.921470785276, 7862.921370786305, 7877.606119694021, 7887.171846956073, 7787.143414224431, 7834.412419068536, 7844.803879902991, 7871.370290376756, 7872.29149376556, 7707.614619269014, 7760.223977602251, 7772.922270777333, 7796.298333150044, 7802.765917022499, 39673.80163099195, 39873.80063099695, 39997.60002399968, 40101.19797604061, 40102.39846402306, 3562.2341196642587, 3566.1797786508987, 3575.535180426528, 3589.5513060867393, 3600.963990360089, 31919.202019949687, 31965.360692786246, 32193.0, 32201.51697724536, 32382.352352953043, 4817.181079216542, 4943.876403089952, 4952.133376659106, 4952.579030782388, 4988.476209997971, 183578.0, 184338.0, 184370.0, 185044.0, 185552.0, 49727.0, 49781.50218497769, 49904.251436228486, 50083.74958125186, 50363.24455133176, 50945.0, 51156.23265651018, 51239.487605123475, 51260.487395126314, 51371.0, 14085.507007254697, 14432.567022989328, 16576.83423165753, 16999.49001529956, 17011.659766804594, 13779.517716879862, 14006.0, 14062.929685351712, 14101.224432656303, 14101.224432656303, 14528.491502797351, 14532.0, 14546.345414456375, 14672.633184170481, 14676.412943482355, 5815.389384114692, 5915.40845915405, 5963.701814909237, 6003.099535069775, 6040.486558642477, 966.6080843585215, 987.3582171588525, 1010.8837483689323, 1028.2596530498029, 1032.8450732390052, 22178.556428871656, 22580.66129008066, 22624.208152714906, 23054.887590175113, 23107.768922310897, 1100.2408338246585, 1101.2071308657753, 1120.467777805536, 1124.7356871135278, 1128.6275529075385, 11739.88260117405, 11949.283043017273, 12017.819732704016, 12114.878851211375, 12170.634880953585, 224767.0, 225127.0, 225624.0, 225804.0, 225915.0, 52381.476185238425, 52551.47448525542, 52963.73518132385, 53123.0, 53167.20249196265, 1469.1111877314286, 1473.5947614406125, 1504.74419348711, 1514.4775052606833, 1515.8711509521593, 21920.01359938775, 22290.0, 22686.43283917849, 22744.431389215402, 23290.65064024007, 38299.425508616834, 38656.42015369715, 38744.80627596957, 38778.4183237246, 38833.223335533694, 188402.0, 189609.0, 190597.0, 190820.0, 191217.0, 34423.655763442046, 34847.47728784019, 37158.07104822401, 37293.254134916606, 37353.252934941695, 46586.53413465822, 46615.06769864652, 46783.76608116938, 47384.28923566218, 47428.7628561855, 33333.0, 33453.498197527544, 33967.15082122868, 34217.315653687285, 34578.0, 32236.677633223368, 33416.33167336591, 34234.31531369408, 34416.82791586026, 34514.30971380508, 38073.80963095167, 38191.42712859365, 38331.808340958116, 38350.0, 38404.42393364158, 31901.36197276088, 32252.0, 33482.162945926546, 34238.48642270318, 34491.65508344985, 24112.0, 24130.276091717278, 24340.547936996434, 24467.510649787262, 24624.384390389667], "value": 17432.43900374883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.8827640333732, 574.5087949802919, 577.5466258986696, 594.2838879150622, 595.9761609535619, 22327.441813954658, 23097.076116955344, 23240.535189296203, 23241.302760917177, 23294.534109317825, 19251.326203582877, 19615.31346402876, 20005.799942000576, 24361.756382436215, 25057.0, 6383.744650213997, 6397.584157029778, 6450.838729031765, 6478.611283323015, 6500.837479063014, 6375.203099612549, 6453.0, 6481.384268494486, 6485.189351331083, 6485.416312531871, 5906.37983011784, 6489.643069631168, 6496.090547323379, 6500.154979852612, 6507.186601674791, 6363.109164716943, 6409.166808314889, 6414.8717025659225, 6418.871622567546, 6426.967865160667, 5961.046232602806, 5964.224650795369, 5973.581849270553, 5991.820245392645, 5992.101184822268, 27479.313017174532, 27532.311692207655, 27968.300792480146, 28563.714362856314, 28634.14097577076, 1858.5911099558075, 1894.232835701543, 1896.706010568364, 1902.4673091534391, 1903.1055403960117, 18269.45191644253, 18912.71630925537, 18972.14625341849, 18994.430167095008, 19032.238710451566, 2257.582347265761, 2280.395695140789, 2308.5729140109133, 2311.4914718761847, 2380.33350661815, 129413.0, 132258.33870830585, 132586.337068315, 134996.0, 135790.0, 14111.2944352784, 14399.280035998368, 14692.926535367254, 14840.851591484163, 14909.179995100156, 23305.41736456568, 23330.65004024941, 23370.013548848197, 23384.18155364588, 23488.765112349, 10476.63331783384, 10569.63006294776, 10587.311824731369, 10624.150067994542, 10667.786644267226, 9826.606935722633, 9848.655297064568, 9996.200303975664, 10029.79940401188, 10114.595416183418, 8501.234888860032, 9003.234725048444, 9111.851803731004, 9307.906920930704, 9443.622255109718, 2759.572266298727, 2761.6271803306295, 2761.9309517262227, 2778.8471634059915, 2841.7300356466103, 943.1228957069991, 958.1185309515263, 962.5331714118647, 987.8221920054459, 995.9900400996042, 18801.341953031577, 19387.51531211731, 19575.706364404545, 19669.40991770249, 19870.205191792455, 978.6232300564334, 1000.8548760429696, 1021.5913634546092, 1032.2722480651123, 1033.4574348467115, 10824.567017319376, 10850.403227822388, 10905.945470272598, 10983.371688440098, 11195.944020280009, 456705.0, 467522.0, 472345.0, 484543.0, 490423.0, 108264.4586777061, 110914.44542777234, 111224.0, 111858.44070779593, 112306.43846780877, 1164.2490593567102, 1187.1749134351542, 1210.6186551236333, 1215.2890559023072, 1216.92698438094, 16483.505494835175, 19950.20199192016, 20274.89862550678, 21044.47388815292, 21232.36302910915, 56922.43077569171, 57245.71377143254, 58255.41744582669, 58431.70784146222, 58479.70760146172, 67411.0, 67529.32470675427, 68000.6599966997, 68038.65980670066, 68059.65970170118, 12335.876641233473, 14512.564623061326, 14830.110193388431, 14848.7772683412, 14871.0, 21202.0, 23221.187258445872, 23380.298591042298, 23502.529949401258, 23711.103111751363, 18252.0, 18325.0, 18454.63090738151, 18607.627847443247, 18669.43991680252, 16646.750298745286, 16752.41366552165, 17250.137493125545, 17330.220140093475, 17480.21339039721, 17519.0, 17768.378106766202, 18005.459836204936, 18794.6241075175, 18797.34209302668, 14354.569362919128, 14392.856071439151, 14456.494022709154, 14490.710185796013, 14542.4910128145, 18282.268709251483, 18309.17608707638, 18338.63322733511, 18387.356442524448, 18426.07869606541], "value": 11829.35217806102, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.829332186816, 1356.3828458051587, 1358.2393859438719, 1367.5145323410188, 1384.4111511473545, 13585.320733963299, 13622.727545449085, 14160.362783674733, 14201.289935503222, 14210.644733881658, 14090.0, 14310.499132530364, 14342.282885855717, 14349.784753228683, 14385.928070359634, 2625.7242989486067, 2700.054980756729, 2708.2823051891264, 2708.79684023699, 2716.212298433452, 2575.7939364850768, 2647.099986004758, 2685.717999610042, 2721.6597925259343, 2746.533089374811, 2653.548896687568, 2725.427660191362, 2726.4001919577663, 2727.6498133423984, 2728.877200525981, 2643.5505963985975, 2679.732026797324, 2690.582959641249, 2691.973080269192, 2693.7979651526116, 2660.600909863517, 2666.3600735823456, 2672.078133044097, 2680.0485827531143, 2680.718524554913, 13550.186988780704, 13750.724985500334, 13770.93114534431, 13840.238786866717, 13850.09974351664, 7299.160596531414, 7490.063742032246, 7496.6251687415415, 7548.735794247175, 7597.506162099446, 4951.727654978975, 5044.419891712463, 5157.896842063138, 5167.121589329823, 5186.611004174702, 1798.8291112344307, 1841.2174825699024, 1871.5130523767807, 1875.1374367790831, 1880.3042874136656, 21953.560928781495, 22093.33719988403, 22194.0, 22273.888630556907, 22291.888540557193, 6459.61242325462, 6464.159659244362, 6501.252355979028, 6662.83342916431, 6675.0, 15603.843961560466, 15623.375064997274, 15623.843761562239, 15640.139792311305, 15651.0, 7620.847583048308, 7932.325752311118, 7933.127355990837, 7935.880961785462, 7950.4832185907735, 7053.89419158713, 7138.857222855514, 7168.319009694071, 7205.92794072063, 7219.8556028880175, 4845.224764037807, 4935.087008903364, 5020.096382651085, 5043.87390315245, 5044.873878153076, 1345.4080204709896, 1349.44672684199, 1426.5363756779088, 1435.6195608163846, 1459.0734883348937, 863.2791618998082, 892.3931726426092, 913.6984795017628, 930.042056681619, 944.9574769135405, 8017.919820801717, 8126.634301456449, 8169.101398846122, 8191.0, 8264.545450000187, 683.2518392360357, 683.7880257120308, 720.1753991679498, 733.8789099798473, 808.4664121679663, 4618.630509559227, 4979.053979743837, 5074.162763144113, 5103.923441148386, 5203.7918483261, 18524.351647692267, 19182.040897955045, 19304.32434864773, 19316.613667726568, 19321.323753668556, 18487.722684159748, 18714.1578628962, 18724.531886702942, 18741.531461713566, 18743.34398296053, 9728.929817720045, 10647.414392208348, 10720.624778132727, 10739.301945373682, 10743.677689669323, 7472.476926615085, 7789.8831517528415, 7946.086200087064, 8020.639071241691, 8133.308668762985, 15977.360905564112, 16106.919465402598, 16309.0, 16901.239444225284, 17007.0, 15466.690666186838, 16405.343786248417, 16632.0, 16927.15364231759, 17019.744703829205, 11113.277636953571, 11199.496022678835, 11316.26444281119, 11328.03711684516, 11684.415779211175, 12884.613461596167, 12980.610581682564, 12998.935005324913, 13002.544910928073, 13030.609081727564, 9072.95463522678, 9506.524673766422, 10409.1672666185, 10610.204234682584, 10871.402072886067, 9189.264858811146, 9700.417974921527, 9721.4653194075, 9983.900160998297, 10647.733806654896, 9133.725988220363, 9320.067993200626, 9387.530623468663, 9400.153986141007, 9417.199538039069, 6771.255161932282, 6864.725410983505, 7216.134063912364, 7346.449016323904, 7478.102627684712, 6499.2200935887995, 6811.455083593201, 6976.302369762983, 6993.580385176906, 7015.579065256101], "value": 6260.297613524284, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.3895247797686, 500.52700198312584, 527.2276115490805, 535.1972041937095, 537.8305833662396, 5969.313528944162, 6077.9999999999945, 6142.201513803205, 6229.162397092857, 6254.186955695759, 5834.533237341013, 5885.49973252273, 6006.249218847644, 6024.487918526919, 6064.181335519704, 5005.774740136684, 5023.120953833083, 5060.951239008797, 5069.290299358075, 5094.388673359202, 4742.407199100113, 5115.872103197413, 5116.334876466054, 5119.7696103675235, 5151.587872970172, 4836.322914791932, 4888.584470320027, 4888.926666100011, 4914.926276105862, 4928.225838698066, 4861.295112208728, 4895.192293271606, 4943.431505376856, 4948.356713627241, 4961.776720047606, 4439.089986552749, 4457.818678050319, 4461.754603496806, 4462.576055274743, 4507.594316511497, 5845.707714614252, 6022.819315420545, 6047.425494578008, 6048.848778780522, 6076.635401875901, 5483.698396588186, 5547.972260138674, 5604.600388694855, 5648.181013753024, 5687.118496633028, 6357.17356743625, 6360.363963603602, 6384.201974753156, 6401.615903045786, 6409.743610255584, 4753.809847606091, 4824.0, 4826.251930950708, 4833.564979151858, 4886.900447399342, 6714.261431242559, 6725.899111513282, 6750.662466876636, 6770.255271920085, 6847.007183958348, 4977.253411988231, 5012.774425150877, 5012.874678133003, 5017.21544542775, 5034.144195486776, 5081.8729531762, 5085.542301192836, 5086.041873878584, 5089.3638295213095, 5100.413452452941, 5611.8877622448135, 5640.5487560995025, 5675.716214189274, 5683.602147849693, 5705.686187259741, 6318.810435686937, 6375.776847810304, 6428.532170141707, 6430.903536446957, 6526.738930442729, 1672.3895778040928, 1697.125980120239, 1717.519094653474, 1722.3110755697821, 1724.8102708702033, 1206.342543313896, 1221.1024896700917, 1221.6823625857342, 1225.0, 1237.6410840856051, 5653.265075540154, 5660.877171060853, 5678.3186017678145, 5682.982541197898, 5692.8861422771315, 6503.642299673564, 6654.234763002317, 6661.566998145105, 6671.63306018164, 6696.296888826603, 5678.346990096192, 5719.28508936383, 5735.4551317624755, 5746.4253574643035, 5773.797917072966, 3481.711766646357, 3505.7738336156212, 3511.648835116519, 3522.9295414091575, 3580.445031020144, 6341.8097457076365, 6407.743690252338, 6412.134361861089, 6491.96247489839, 6506.869862602722, 6665.566738162004, 6674.499412544079, 6715.0, 6736.966315168393, 6776.220734615582, 6411.2306523216575, 6495.317991610813, 6511.837204069841, 6521.934780652133, 6538.901916471256, 6649.700763465752, 6678.23200331968, 6703.899441508283, 6729.293424190585, 6733.696983635846, 6308.463780578702, 6437.420632143129, 6528.445082168069, 6555.147830781968, 6646.169228846395, 6342.8919829282395, 6358.268799088164, 6386.808395747949, 6398.168238129014, 6403.679816009274, 4903.141950158637, 4954.0, 4983.127952608352, 4985.0, 4991.176455884738, 6343.841403964938, 6431.549791514549, 6540.215174179129, 6556.9837874578225, 6685.933140668531, 6027.558838670346, 6287.119803227461, 6329.145565348619, 6349.428551430394, 6382.170317858649, 6353.36466353361, 6371.55399122057, 6393.6163830170335, 6397.936020639734, 6438.356164383712, 6291.874162516632, 6316.873662526816, 6361.377848648565, 6368.42684158428, 6394.186557914502, 6403.583767055313, 6441.0, 6465.321141280097, 6495.895697731492, 6504.707288171949, 6182.485291103529, 6230.314665386713, 6241.157443745036, 6261.186045814015, 6273.71768270438], "value": 4993.348876946508, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.282920834124, 903.661127077346, 915.4644532948225, 924.8242833861566, 925.6297481007596, 16215.675686486278, 16280.75578866318, 16450.50648480546, 18110.0, 18951.715724264148, 19610.313639022635, 19785.901070494627, 19819.50451238716, 19848.603027939433, 19895.900520497376, 1014.2950649298722, 1041.6822869024945, 1044.394251334228, 1044.7231483656838, 1047.0367262118868, 945.0927109974433, 1044.1803184500168, 1046.7330830638177, 1047.1622701838498, 1047.3611097230682, 1086.8804431512526, 1094.63876920616, 1098.3739268616891, 1100.367288808934, 1101.0365929811414, 1077.8437126616675, 1079.185215162555, 1082.65355086372, 1084.6529110684585, 1087.8041952448557, 793.1909452358562, 796.7609717084852, 798.3732769775698, 803.7910143362709, 804.4770898915693, 18098.728519072225, 18140.45578632643, 18160.455186344432, 18161.45515634533, 19924.60150796976, 19913.203471861107, 20050.398488045237, 20311.695324570144, 20366.796332036785, 20380.796192038037, 15213.847861521464, 15468.071915684983, 15701.764473532907, 15719.37122515098, 15737.527874163794, 3527.8236088195486, 3540.9114772130647, 3546.929061418783, 3557.875474358411, 3559.501669766235, 127332.0, 129175.0, 130441.0, 132736.99999999904, 134926.3253683735, 15586.922065389826, 16076.43732469358, 16079.0, 16169.272382742805, 16204.270807813677, 29068.0, 30212.69787302143, 30232.395352092833, 30313.545296820565, 30410.0, 8499.660013599387, 8653.69712060075, 8663.91336086631, 8682.52246126469, 8705.998810136789, 4015.0, 4046.3323551614244, 4124.278251306009, 4138.048248902709, 4188.057687020396, 5084.49155084496, 5185.948140518622, 5186.092433824066, 5200.6879587224885, 5203.531682148625, 973.8636590877283, 993.4337427666305, 1012.8885822559513, 1013.8175128476945, 1015.7257540464182, 643.2634633344794, 670.3464122480542, 685.3044160177424, 687.845234822171, 700.8738427083174, 10634.41510716918, 12761.68095797594, 12835.807462888064, 13050.608481745563, 13235.07354485196, 676.7755492635349, 692.0760784352844, 707.2997732245041, 711.1182134153715, 717.1465955512923, 4703.6942598730975, 4877.463479017305, 5010.949890501049, 5012.67417617861, 5149.098907691214, 97467.61395737209, 99113.50443247882, 100136.0, 101467.0, 101526.0, 80631.59684201541, 89659.0, 89717.55141224252, 89751.0, 90249.09750902538, 75241.66167365732, 78171.0, 79474.60262698765, 80754.59622701966, 83086.75369869456, 11515.712107197387, 11616.30302181838, 11768.646940591796, 11918.0, 11938.582149625068, 32306.515402268513, 33336.16659583433, 34358.82820585881, 37476.62523374731, 37495.2500949974, 62923.6853815728, 65194.67402662956, 66607.33392666011, 66969.66515167394, 67762.0, 17507.82492175113, 17555.912220438815, 17756.46730598084, 17851.642967140844, 18533.351332703292, 19720.0, 20304.0, 20330.288439904532, 20331.288404905757, 20519.38441846747, 17497.82502175013, 17641.558961025563, 17979.910100449415, 18322.358717444826, 18455.446336609923, 18200.271989120287, 18434.72347914809, 18475.722864157317, 18739.812601873808, 18791.0, 16923.323067077177, 17296.740548892027, 17407.738883917005, 17830.732539011668, 18576.535586610444, 12029.518819247482, 12371.75256494883, 12647.430865610886, 12715.237085774883, 13038.0, 12596.370181491073, 12741.93629031886, 12774.297413642338, 12959.481620735065, 13084.495283042572], "value": 8887.544156239725, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 109.0, 103.0, 109.0, 107.0, 108.0, 110.0, 102.0, 110.0, 113.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 140.0, 179.0, 122.0, 144.0, 149.0, 118.0, 174.0, 119.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 164.0, 175.0, 164.0, 168.0, 172.0, 166.0, 164.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 178.0, 76.0, 74.0, 76.0, 87.0, 96.0, 75.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 132.0, 79.0, 80.0, 80.0, 131.0, 80.0, 79.0, 123.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 125.0, 114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 120.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 152.0, 151.0, 149.0, 151.0, 151.0, 150.0, 153.0, 151.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 101.0, 94.0, 93.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 53.0, 54.0, 58.0, 54.0, 54.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 54.0, 55.0, 55.0, 55.0, 59.0, 59.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 80.0, 78.0, 79.0, 94.0, 89.0, 87.0, 78.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 134.0, 126.0, 133.0, 129.0, 124.0, 129.0, 124.0, 125.0, 180.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 189.0, 175.0, 179.0, 181.0, 182.0, 188.0, 176.0, 176.0, 181.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 70.0, 69.0, 68.0, 67.0, 69.0, 69.0, 70.0, 68.0], "value": 69.3, "unit": "score"}]}]} 03:13:15 INFO - Return code: 0 03:13:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:13:15 INFO - # TBPL SUCCESS # 03:13:15 INFO - Running post-action listener: _package_coverage_data 03:13:15 INFO - Running post-action listener: _resource_record_post_action 03:13:15 INFO - [mozharness: 2017-07-26 10:13:15.541693Z] Finished run-tests step (success) 03:13:15 INFO - Running post-run listener: _resource_record_post_run 03:13:15 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433782784; Read time: 12; Write time: 495096 03:13:15 INFO - TinderboxPrint: CPU usage
13.2% 03:13:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:13:15 INFO - TinderboxPrint: I/O write bytes / time
433,782,784 / 495,096 03:13:15 INFO - TinderboxPrint: CPU idle
8,270.9 (86.8%) 03:13:15 INFO - TinderboxPrint: CPU user
1,203.4 (12.6%) 03:13:15 INFO - TinderboxPrint: Swap in / out
0 / 0 03:13:15 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106733568; Read time: 0; Write time: 97604 03:13:15 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:13:15 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 327049216; Read time: 0; Write time: 397492 03:13:16 INFO - Running post-run listener: _upload_blobber_files 03:13:16 INFO - Blob upload gear active. 03:13:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:13:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:13:16 INFO - (blobuploader) - INFO - Open directory for files ... 03:13:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:13:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:13:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:17 INFO - (blobuploader) - INFO - Done attempting. 03:13:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:13:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:13:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:18 INFO - (blobuploader) - INFO - Done attempting. 03:13:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:13:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:13:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:21 INFO - (blobuploader) - INFO - Done attempting. 03:13:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:13:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:13:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:22 INFO - (blobuploader) - INFO - Done attempting. 03:13:22 INFO - (blobuploader) - INFO - Iteration through files over. 03:13:22 INFO - Return code: 0 03:13:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:13:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:13:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cee0b4208e109b372eb85c375fec1b104c504ce99b8aaf979637d2b19b387f2d3d57346c6f6df9efbbd0ea6095aee89bcfc242b78a2031276c05f9ae3f32c33", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a10c8043ae7e94b22aaeea31ae5d426fdd41ef79c9506cc8ff99b0f152c338c16d1cff64166332434bbfb280e2be737ea1f664abc45af957d51692eb2b4a8e74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4d15ffe785acea869b3cdbf7d11f21d3d2d98d00d22c181ed1e0553134c2edcb17b4a87543d3a47f4708d82576f2de6767fd4f3324d0b0e153b398d9558c15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e4716fa1ebdf24912ad2c707aad1b8cc902c3611b9eea7ada715783476b8c67256fb9a4f619445f3075f3beb3416de0067fc3bc81426e37217ab0abb13d967a"} 03:13:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:13:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:13:22 INFO - Contents: 03:13:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cee0b4208e109b372eb85c375fec1b104c504ce99b8aaf979637d2b19b387f2d3d57346c6f6df9efbbd0ea6095aee89bcfc242b78a2031276c05f9ae3f32c33", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a10c8043ae7e94b22aaeea31ae5d426fdd41ef79c9506cc8ff99b0f152c338c16d1cff64166332434bbfb280e2be737ea1f664abc45af957d51692eb2b4a8e74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4d15ffe785acea869b3cdbf7d11f21d3d2d98d00d22c181ed1e0553134c2edcb17b4a87543d3a47f4708d82576f2de6767fd4f3324d0b0e153b398d9558c15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e4716fa1ebdf24912ad2c707aad1b8cc902c3611b9eea7ada715783476b8c67256fb9a4f619445f3075f3beb3416de0067fc3bc81426e37217ab0abb13d967a"} 03:13:22 INFO - Running post-run listener: copy_logs_to_upload_dir 03:13:22 INFO - Copying logs to upload dir... 03:13:22 INFO - mkdir: /builds/slave/test/build/upload/logs 03:13:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.827832 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-26 03:13:20.662557) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-26 03:13:20.665692) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cee0b4208e109b372eb85c375fec1b104c504ce99b8aaf979637d2b19b387f2d3d57346c6f6df9efbbd0ea6095aee89bcfc242b78a2031276c05f9ae3f32c33", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a10c8043ae7e94b22aaeea31ae5d426fdd41ef79c9506cc8ff99b0f152c338c16d1cff64166332434bbfb280e2be737ea1f664abc45af957d51692eb2b4a8e74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4d15ffe785acea869b3cdbf7d11f21d3d2d98d00d22c181ed1e0553134c2edcb17b4a87543d3a47f4708d82576f2de6767fd4f3324d0b0e153b398d9558c15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e4716fa1ebdf24912ad2c707aad1b8cc902c3611b9eea7ada715783476b8c67256fb9a4f619445f3075f3beb3416de0067fc3bc81426e37217ab0abb13d967a"} build_url:https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/J3w66787QiyxdpLlfODfTA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cee0b4208e109b372eb85c375fec1b104c504ce99b8aaf979637d2b19b387f2d3d57346c6f6df9efbbd0ea6095aee89bcfc242b78a2031276c05f9ae3f32c33", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a10c8043ae7e94b22aaeea31ae5d426fdd41ef79c9506cc8ff99b0f152c338c16d1cff64166332434bbfb280e2be737ea1f664abc45af957d51692eb2b4a8e74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4d15ffe785acea869b3cdbf7d11f21d3d2d98d00d22c181ed1e0553134c2edcb17b4a87543d3a47f4708d82576f2de6767fd4f3324d0b0e153b398d9558c15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e4716fa1ebdf24912ad2c707aad1b8cc902c3611b9eea7ada715783476b8c67256fb9a4f619445f3075f3beb3416de0067fc3bc81426e37217ab0abb13d967a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-26 03:13:20.690326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 03:13:20.690643) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1501045353.105033-1939032078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 03:13:20.773992) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-26 03:13:20.774310) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-26 03:13:20.774567) ========= ========= Total master_lag: 0.15 =========