builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1501039178.08 results: success (0) revision: 9eddb0a92820c6445f9d1e680e4c239e888e93f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:38.079615) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:38.080194) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:38.080468) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:38.094279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:38.094589) ========= 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=c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-25 20:19:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2017-07-25 20:19:38 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:38.236214) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:38.236522) ========= 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=c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016329 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:38.289922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:38.290254) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9eddb0a92820c6445f9d1e680e4c239e888e93f0 --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 9eddb0a92820c6445f9d1e680e4c239e888e93f0 --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=c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-25 20:19:38,565 truncating revision to first 12 chars 2017-07-25 20:19:38,565 Setting DEBUG logging. 2017-07-25 20:19:38,565 attempt 1/10 2017-07-25 20:19:38,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9eddb0a92820?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-25 20:19:39,033 unpacking tar archive at: mozilla-central-9eddb0a92820/testing/mozharness/ program finished with exit code 0 elapsedTime=0.828832 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:39.136443) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:39.136777) ========= script_repo_revision: 9eddb0a92820c6445f9d1e680e4c239e888e93f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:39.137140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:39.137402) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 20:19:39.150158) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-07-25 20:19:39.150460) ========= /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=c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:19:39 INFO - MultiFileLogger online at 20170725 20:19:39 in /builds/slave/test 20:19:39 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 20:19:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:19:39 INFO - {'append_to_log': False, 20:19:39 INFO - 'base_work_dir': '/builds/slave/test', 20:19:39 INFO - 'blob_upload_branch': 'Firefox', 20:19:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:19:39 INFO - 'branch': 'Firefox', 20:19:39 INFO - 'buildbot_json_path': 'buildprops.json', 20:19:39 INFO - 'code_coverage': False, 20:19:39 INFO - 'config_files': ('talos/linux_config.py',), 20:19:39 INFO - 'default_actions': ('clobber', 20:19:39 INFO - 'read-buildbot-config', 20:19:39 INFO - 'download-and-extract', 20:19:39 INFO - 'populate-webroot', 20:19:39 INFO - 'create-virtualenv', 20:19:39 INFO - 'install', 20:19:39 INFO - 'setup-mitmproxy', 20:19:39 INFO - 'run-tests'), 20:19:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:19:39 INFO - 'disable_ccov_upload': False, 20:19:39 INFO - 'download_minidump_stackwalk': True, 20:19:39 INFO - 'download_symbols': 'ondemand', 20:19:39 INFO - 'enable_stylo': False, 20:19:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:19:39 INFO - 'tooltool.py': '/tools/tooltool.py', 20:19:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:19:39 INFO - '/tools/misc-python/virtualenv.py')}, 20:19:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:19:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:19:39 INFO - 'gecko_profile': False, 20:19:39 INFO - 'gecko_profile_interval': 0, 20:19:39 INFO - 'installer_path': 'installer.exe', 20:19:39 INFO - 'log_level': 'info', 20:19:39 INFO - 'log_name': 'talos', 20:19:39 INFO - 'log_to_console': True, 20:19:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:19:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:19:39 INFO - 'opt_config_files': (), 20:19:39 INFO - 'pip_index': False, 20:19:39 INFO - 'suite': 'dromaeojs-e10s', 20:19:39 INFO - 'system_bits': '32', 20:19:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:19:39 INFO - 'title': 'talos-linux64-ix-004', 20:19:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:19:39 INFO - 'use_talos_json': True, 20:19:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:19:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:19:39 INFO - 'work_dir': 'build'} 20:19:39 INFO - [mozharness: 2017-07-26 03:19:39.530486Z] Running clobber step. 20:19:39 INFO - Running pre-action listener: _resource_record_pre_action 20:19:39 INFO - Running main action method: clobber 20:19:39 INFO - rmtree: /builds/slave/test/build 20:19:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:19:41 INFO - Running post-action listener: _resource_record_post_action 20:19:41 INFO - [mozharness: 2017-07-26 03:19:41.103097Z] Finished clobber step (success) 20:19:41 INFO - [mozharness: 2017-07-26 03:19:41.103200Z] Running read-buildbot-config step. 20:19:41 INFO - Running pre-action listener: _resource_record_pre_action 20:19:41 INFO - Running main action method: read_buildbot_config 20:19:41 INFO - Using buildbot properties: 20:19:41 INFO - { 20:19:41 INFO - "project": "", 20:19:41 INFO - "product": "firefox", 20:19:41 INFO - "who": "kwierso@gmail.com", 20:19:41 INFO - "installer_path": "public/build/target.tar.bz2", 20:19:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 20:19:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:19:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 20:19:41 INFO - "stage_platform": "linux64-pgo", 20:19:41 INFO - "basedir": "/builds/slave/test", 20:19:41 INFO - "buildnumber": 87, 20:19:41 INFO - "platform": "ubuntu64_hw", 20:19:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:19:41 INFO - "slavebuilddir": "test", 20:19:41 INFO - "taskId": "K5egc252TmuPPYAaQAnofw", 20:19:41 INFO - "branch": "mozilla-central", 20:19:41 INFO - "script_repo_revision": "production", 20:19:41 INFO - "revision": "9eddb0a92820c6445f9d1e680e4c239e888e93f0", 20:19:41 INFO - "slavename": "talos-linux64-ix-004", 20:19:41 INFO - "repo_path": "mozilla-central" 20:19:41 INFO - } 20:19:41 INFO - Finding installer, test and symbols from parent task. 20:19:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K5egc252TmuPPYAaQAnofw'}, attempt #1 20:19:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K5egc252TmuPPYAaQAnofw'}, attempt #1 20:19:42 INFO - Task dependencies: DMqhmBp3Qdy3GrLt7kLPxA 20:19:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA'}, attempt #1 20:19:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.tar.bz2 20:19:42 INFO - Set test_url: https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/test_packages.json 20:19:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.crashreporter-symbols.zip 20:19:42 INFO - Running post-action listener: _resource_record_post_action 20:19:42 INFO - [mozharness: 2017-07-26 03:19:42.574102Z] Finished read-buildbot-config step (success) 20:19:42 INFO - [mozharness: 2017-07-26 03:19:42.574326Z] Running download-and-extract step. 20:19:42 INFO - Running pre-action listener: _resource_record_pre_action 20:19:42 INFO - Running main action method: download_and_extract 20:19:42 INFO - mkdir: /builds/slave/test/build/tests 20:19:42 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')]} 20:19:42 INFO - trying https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.test_packages.json 20:19:42 INFO - Downloading https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:19:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:19:43 INFO - Downloaded 989 bytes. 20:19:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:19:43 INFO - Using the following test package requirements: 20:19:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:19:43 INFO - u'common': [u'target.common.tests.zip'], 20:19:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:19:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:19:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:19:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:19:43 INFO - u'mozbase': [u'target.common.tests.zip'], 20:19:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:19:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:19:43 INFO - u'web-platform': [u'target.common.tests.zip', 20:19:43 INFO - u'target.web-platform.tests.tar.gz'], 20:19:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:19:43 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:19:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.common.tests.zip 20:19:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:19:43 INFO - Fetch https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.common.tests.zip into memory 20:19:44 INFO - Content-Length response header: 73375357 20:19:44 INFO - Bytes received: 73375357 20:19:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:19:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.common.tests.zip 20:19:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:19:55 INFO - Fetch https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.common.tests.zip into memory 20:19:57 INFO - Content-Length response header: 73375357 20:19:57 INFO - Bytes received: 73375357 20:20:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.talos.tests.zip 20:20:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:20:09 INFO - Fetch https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.talos.tests.zip into memory 20:20:09 INFO - Content-Length response header: 14498866 20:20:09 INFO - Bytes received: 14498866 20:20: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')]} 20:20:10 INFO - trying https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.tar.bz2 20:20:10 INFO - Downloading https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:20:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:20:11 INFO - Downloaded 62976911 bytes. 20:20:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.tar.bz2 20:20:11 INFO - mkdir: /builds/slave/test/properties 20:20:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:20:11 INFO - Writing to file /builds/slave/test/properties/build_url 20:20:11 INFO - Contents: 20:20:11 INFO - build_url:https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.tar.bz2 20:20:11 INFO - Running post-action listener: _resource_record_post_action 20:20:11 INFO - Running post-action listener: set_extra_try_arguments 20:20:11 INFO - [mozharness: 2017-07-26 03:20:11.437213Z] Finished download-and-extract step (success) 20:20:11 INFO - [mozharness: 2017-07-26 03:20:11.437311Z] Running populate-webroot step. 20:20:11 INFO - Running pre-action listener: _resource_record_pre_action 20:20:11 INFO - Running main action method: populate_webroot 20:20:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:20:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:20:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:20:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:20:11 INFO - 'tests': ['damp', 'tps']}, 20:20:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:20:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:20:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:20:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:20:11 INFO - 'other-e10s': {'tests': ['a11yr', 20:20:11 INFO - 'ts_paint', 20:20:11 INFO - 'tpaint', 20:20:11 INFO - 'sessionrestore', 20:20:11 INFO - 'sessionrestore_many_windows', 20:20:11 INFO - 'sessionrestore_no_auto_restore', 20:20:11 INFO - 'tabpaint']}, 20:20:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 20:20:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 20:20:11 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:20:11 INFO - 'talos_options': ['--mitmproxy', 20:20:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:20:11 INFO - '--firstNonBlankPaint'], 20:20:11 INFO - 'tests': ['quantum_pageload_google', 20:20:11 INFO - 'quantum_pageload_youtube', 20:20:11 INFO - 'quantum_pageload_amazon', 20:20:11 INFO - 'quantum_pageload_facebook']}, 20:20:11 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:20:11 INFO - 'talos_options': ['--stylo', 20:20:11 INFO - '--mitmproxy', 20:20:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:20:11 INFO - '--firstNonBlankPaint'], 20:20:11 INFO - 'tests': ['quantum_pageload_google', 20:20:11 INFO - 'quantum_pageload_youtube', 20:20:11 INFO - 'quantum_pageload_amazon', 20:20:11 INFO - 'quantum_pageload_facebook']}, 20:20:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:20:11 INFO - 'tsvgr_opacity', 20:20:11 INFO - 'tart', 20:20:11 INFO - 'tscrollx', 20:20:11 INFO - 'cart', 20:20:11 INFO - 'tsvg_static']}, 20:20:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:20:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:20:11 INFO - 'talos_options': ['--xperf_path', 20:20:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:11 INFO - 'tests': ['tp5n']}}} 20:20:11 INFO - Running post-action listener: _resource_record_post_action 20:20:11 INFO - [mozharness: 2017-07-26 03:20:11.444638Z] Finished populate-webroot step (success) 20:20:11 INFO - [mozharness: 2017-07-26 03:20:11.444730Z] Running create-virtualenv step. 20:20:11 INFO - Running pre-action listener: _resource_record_pre_action 20:20:11 INFO - Running main action method: create_virtualenv 20:20:11 INFO - Creating virtualenv /builds/slave/test/build/venv 20:20:11 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 20:20:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:20:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:20:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:20:11 INFO - Using real prefix '/usr' 20:20:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:20:12 INFO - Installing distribute.............................................................................................................................................................................................done. 20:20:14 INFO - Installing pip.................done. 20:20:14 INFO - Return code: 0 20:20:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:20:14 INFO - Reading from file tmpfile_stdout 20:20:14 INFO - Output received: 20:20:14 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) 20:20:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e59eb0>, '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 0x1e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b240>, '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': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', '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 20:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:20:14 INFO - Using env: {'DISPLAY': ':0', 20:20:14 INFO - 'HOME': '/home/cltbld', 20:20:14 INFO - 'LANG': 'en_US.UTF-8', 20:20:14 INFO - 'LANGUAGE': 'en_US:en', 20:20:14 INFO - 'LOGNAME': 'cltbld', 20:20:14 INFO - 'MAIL': '/var/mail/cltbld', 20:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:14 INFO - 'MOZ_NO_REMOTE': '1', 20:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:14 INFO - 'NO_EM_RESTART': '1', 20:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:14 INFO - 'PWD': '/builds/slave/test', 20:20:14 INFO - 'SHELL': '/bin/bash', 20:20:14 INFO - 'SHLVL': '1', 20:20:14 INFO - 'TERM': 'linux', 20:20:14 INFO - 'TMOUT': '86400', 20:20:14 INFO - 'USER': 'cltbld', 20:20:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', 20:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:14 INFO - '_': '/tools/buildbot/bin/python'} 20:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:14 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 20:20:14 INFO - Cleaning up... 20:20:14 INFO - Return code: 0 20:20:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1aed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e59eb0>, '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 0x1e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b240>, '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': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', '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 20:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:20:14 INFO - Using env: {'DISPLAY': ':0', 20:20:14 INFO - 'HOME': '/home/cltbld', 20:20:14 INFO - 'LANG': 'en_US.UTF-8', 20:20:14 INFO - 'LANGUAGE': 'en_US:en', 20:20:14 INFO - 'LOGNAME': 'cltbld', 20:20:14 INFO - 'MAIL': '/var/mail/cltbld', 20:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:14 INFO - 'MOZ_NO_REMOTE': '1', 20:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:14 INFO - 'NO_EM_RESTART': '1', 20:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:14 INFO - 'PWD': '/builds/slave/test', 20:20:14 INFO - 'SHELL': '/bin/bash', 20:20:14 INFO - 'SHLVL': '1', 20:20:14 INFO - 'TERM': 'linux', 20:20:14 INFO - 'TMOUT': '86400', 20:20:14 INFO - 'USER': 'cltbld', 20:20:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', 20:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:14 INFO - '_': '/tools/buildbot/bin/python'} 20:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:14 INFO - Downloading/unpacking psutil>=3.1.1 20:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:20:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:15 INFO - Installing collected packages: psutil 20:20:15 INFO - Running setup.py install for psutil 20:20:15 INFO - building 'psutil._psutil_linux' extension 20:20:15 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 20:20:16 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 20:20:16 INFO - building 'psutil._psutil_posix' extension 20:20:16 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 20:20:16 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 20:20:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:16 INFO - Successfully installed psutil 20:20:16 INFO - Cleaning up... 20:20:16 INFO - Return code: 0 20:20:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20: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')]} 20:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e59eb0>, '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 0x1e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b240>, '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': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', '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 20:20:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:20:16 INFO - Using env: {'DISPLAY': ':0', 20:20:16 INFO - 'HOME': '/home/cltbld', 20:20:16 INFO - 'LANG': 'en_US.UTF-8', 20:20:16 INFO - 'LANGUAGE': 'en_US:en', 20:20:16 INFO - 'LOGNAME': 'cltbld', 20:20:16 INFO - 'MAIL': '/var/mail/cltbld', 20:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:16 INFO - 'MOZ_NO_REMOTE': '1', 20:20:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:16 INFO - 'NO_EM_RESTART': '1', 20:20:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:16 INFO - 'PWD': '/builds/slave/test', 20:20:16 INFO - 'SHELL': '/bin/bash', 20:20:16 INFO - 'SHLVL': '1', 20:20:16 INFO - 'TERM': 'linux', 20:20:16 INFO - 'TMOUT': '86400', 20:20:16 INFO - 'USER': 'cltbld', 20:20:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', 20:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:16 INFO - '_': '/tools/buildbot/bin/python'} 20:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:20:17 INFO - Installing collected packages: mozsystemmonitor 20:20:17 INFO - Running setup.py install for mozsystemmonitor 20:20:17 INFO - Successfully installed mozsystemmonitor 20:20:17 INFO - Cleaning up... 20:20:17 INFO - Return code: 0 20:20:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e59eb0>, '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 0x1e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b240>, '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': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', '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 20:20:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:20:17 INFO - Using env: {'DISPLAY': ':0', 20:20:17 INFO - 'HOME': '/home/cltbld', 20:20:17 INFO - 'LANG': 'en_US.UTF-8', 20:20:17 INFO - 'LANGUAGE': 'en_US:en', 20:20:17 INFO - 'LOGNAME': 'cltbld', 20:20:17 INFO - 'MAIL': '/var/mail/cltbld', 20:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:17 INFO - 'MOZ_NO_REMOTE': '1', 20:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:17 INFO - 'NO_EM_RESTART': '1', 20:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:17 INFO - 'PWD': '/builds/slave/test', 20:20:17 INFO - 'SHELL': '/bin/bash', 20:20:17 INFO - 'SHLVL': '1', 20:20:17 INFO - 'TERM': 'linux', 20:20:17 INFO - 'TMOUT': '86400', 20:20:17 INFO - 'USER': 'cltbld', 20:20:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', 20:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:17 INFO - '_': '/tools/buildbot/bin/python'} 20:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:18 INFO - Downloading/unpacking jsonschema==2.5.1 20:20: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 20:20: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 20:20: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 20:20: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 20:20:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:20:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:20:19 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 20:20:19 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 20:20:19 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 20:20:19 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 20:20:19 INFO - Downloading functools32-3.2.3-2.tar.gz 20:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:20:19 INFO - warning: no files found matching '*.txt' 20:20:19 INFO - no previously-included directories found matching 'build' 20:20:19 INFO - no previously-included directories found matching 'dist' 20:20:19 INFO - no previously-included directories found matching '.git*' 20:20:19 INFO - Installing collected packages: jsonschema, functools32 20:20:19 INFO - Running setup.py install for functools32 20:20:19 INFO - warning: no files found matching '*.txt' 20:20:19 INFO - no previously-included directories found matching 'build' 20:20:19 INFO - no previously-included directories found matching 'dist' 20:20:19 INFO - no previously-included directories found matching '.git*' 20:20:19 INFO - Successfully installed jsonschema functools32 20:20:19 INFO - Cleaning up... 20:20:19 INFO - Return code: 0 20:20:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20: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')]} 20:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20: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', '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 0x1aed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e59eb0>, '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 0x1e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b240>, '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': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', '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 20:20: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:20: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 functools32==3.2.3-2 20:20:19 INFO - Using env: {'DISPLAY': ':0', 20:20:19 INFO - 'HOME': '/home/cltbld', 20:20:19 INFO - 'LANG': 'en_US.UTF-8', 20:20:19 INFO - 'LANGUAGE': 'en_US:en', 20:20:19 INFO - 'LOGNAME': 'cltbld', 20:20:19 INFO - 'MAIL': '/var/mail/cltbld', 20:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:19 INFO - 'MOZ_NO_REMOTE': '1', 20:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:19 INFO - 'NO_EM_RESTART': '1', 20:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:19 INFO - 'PWD': '/builds/slave/test', 20:20:19 INFO - 'SHELL': '/bin/bash', 20:20:19 INFO - 'SHLVL': '1', 20:20:19 INFO - 'TERM': 'linux', 20:20:19 INFO - 'TMOUT': '86400', 20:20:19 INFO - 'USER': 'cltbld', 20:20:19 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', 20:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:19 INFO - '_': '/tools/buildbot/bin/python'} 20:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:20:19 INFO - Cleaning up... 20:20:19 INFO - Return code: 0 20:20:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20: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')]} 20:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20: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', '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 0x1aed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e59eb0>, '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 0x1e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b240>, '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': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', '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 20:20: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:20: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 blobuploader==1.2.4 20:20:19 INFO - Using env: {'DISPLAY': ':0', 20:20:19 INFO - 'HOME': '/home/cltbld', 20:20:19 INFO - 'LANG': 'en_US.UTF-8', 20:20:19 INFO - 'LANGUAGE': 'en_US:en', 20:20:19 INFO - 'LOGNAME': 'cltbld', 20:20:19 INFO - 'MAIL': '/var/mail/cltbld', 20:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:19 INFO - 'MOZ_NO_REMOTE': '1', 20:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:19 INFO - 'NO_EM_RESTART': '1', 20:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:19 INFO - 'PWD': '/builds/slave/test', 20:20:19 INFO - 'SHELL': '/bin/bash', 20:20:19 INFO - 'SHLVL': '1', 20:20:19 INFO - 'TERM': 'linux', 20:20:19 INFO - 'TMOUT': '86400', 20:20:19 INFO - 'USER': 'cltbld', 20:20:19 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', 20:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:19 INFO - '_': '/tools/buildbot/bin/python'} 20:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:20 INFO - Downloading/unpacking blobuploader==1.2.4 20:20:20 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 20:20:20 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 20:20:20 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 20:20:20 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 20:20:21 INFO - Downloading blobuploader-1.2.4.tar.gz 20:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:20:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:20:21 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 20:20:21 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 20:20:21 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 20:20:21 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 20:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:20:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:20:21 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 20:20:21 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 20:20:21 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 20:20:21 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 20:20:21 INFO - Downloading docopt-0.6.1.tar.gz 20:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:20:21 INFO - Installing collected packages: blobuploader, requests, docopt 20:20:21 INFO - Running setup.py install for blobuploader 20:20:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:20:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:20:21 INFO - Running setup.py install for requests 20:20:22 INFO - Running setup.py install for docopt 20:20:22 INFO - Successfully installed blobuploader requests docopt 20:20:22 INFO - Cleaning up... 20:20:22 INFO - Return code: 0 20:20:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:22 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 0x1aed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e59eb0>, '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 0x1e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b240>, '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': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', '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 20:20:22 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 20:20:22 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 20:20:22 INFO - Using env: {'DISPLAY': ':0', 20:20:22 INFO - 'HOME': '/home/cltbld', 20:20:22 INFO - 'LANG': 'en_US.UTF-8', 20:20:22 INFO - 'LANGUAGE': 'en_US:en', 20:20:22 INFO - 'LOGNAME': 'cltbld', 20:20:22 INFO - 'MAIL': '/var/mail/cltbld', 20:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:22 INFO - 'MOZ_NO_REMOTE': '1', 20:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:22 INFO - 'NO_EM_RESTART': '1', 20:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:22 INFO - 'PWD': '/builds/slave/test', 20:20:22 INFO - 'SHELL': '/bin/bash', 20:20:22 INFO - 'SHLVL': '1', 20:20:22 INFO - 'TERM': 'linux', 20:20:22 INFO - 'TMOUT': '86400', 20:20:22 INFO - 'USER': 'cltbld', 20:20:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', 20:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:22 INFO - '_': '/tools/buildbot/bin/python'} 20:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:22 INFO - Running setup.py (path:/tmp/pip-RnI3Ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:22 INFO - Running setup.py (path:/tmp/pip-6l38sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:22 INFO - Running setup.py (path:/tmp/pip-REBT7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:22 INFO - Running setup.py (path:/tmp/pip-a6bSQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:22 INFO - Running setup.py (path:/tmp/pip-TLqMt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:22 INFO - Running setup.py (path:/tmp/pip-UotxpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:22 INFO - Running setup.py (path:/tmp/pip-QIJdhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:23 INFO - Running setup.py (path:/tmp/pip-XqQl5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:23 INFO - Running setup.py (path:/tmp/pip-uuzZqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:23 INFO - Running setup.py (path:/tmp/pip-EuNeoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:23 INFO - Running setup.py (path:/tmp/pip-qzXfZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:23 INFO - Running setup.py (path:/tmp/pip-MRiAIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:23 INFO - Running setup.py (path:/tmp/pip-zhujuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:23 INFO - Running setup.py (path:/tmp/pip-FVQRtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:23 INFO - Running setup.py (path:/tmp/pip-8pTxJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:23 INFO - Running setup.py (path:/tmp/pip-hLpvAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:23 INFO - Running setup.py (path:/tmp/pip-jC_EwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:20:23 INFO - Running setup.py install for manifestparser 20:20:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:20:23 INFO - Running setup.py install for mozcrash 20:20:23 INFO - Running setup.py install for mozdebug 20:20:24 INFO - Running setup.py install for mozdevice 20:20:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for mozfile 20:20:24 INFO - Running setup.py install for mozhttpd 20:20:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for mozinfo 20:20:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for mozInstall 20:20:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for mozleak 20:20:24 INFO - Running setup.py install for mozlog 20:20:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for moznetwork 20:20:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for mozprocess 20:20:25 INFO - Running setup.py install for mozprofile 20:20:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Running setup.py install for mozrunner 20:20:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Running setup.py install for mozscreenshot 20:20:25 INFO - Running setup.py install for moztest 20:20:25 INFO - Running setup.py install for mozversion 20:20:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:20:25 INFO - Cleaning up... 20:20:25 INFO - Return code: 0 20:20:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:25 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 0x1aed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e59eb0>, '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 0x1e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b240>, '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': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', '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 20:20:25 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 20:20:25 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 20:20:25 INFO - Using env: {'DISPLAY': ':0', 20:20:25 INFO - 'HOME': '/home/cltbld', 20:20:25 INFO - 'LANG': 'en_US.UTF-8', 20:20:25 INFO - 'LANGUAGE': 'en_US:en', 20:20:25 INFO - 'LOGNAME': 'cltbld', 20:20:25 INFO - 'MAIL': '/var/mail/cltbld', 20:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:25 INFO - 'MOZ_NO_REMOTE': '1', 20:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:25 INFO - 'NO_EM_RESTART': '1', 20:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:25 INFO - 'PWD': '/builds/slave/test', 20:20:25 INFO - 'SHELL': '/bin/bash', 20:20:25 INFO - 'SHLVL': '1', 20:20:25 INFO - 'TERM': 'linux', 20:20:25 INFO - 'TMOUT': '86400', 20:20:25 INFO - 'USER': 'cltbld', 20:20:25 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', 20:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:25 INFO - '_': '/tools/buildbot/bin/python'} 20:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:25 INFO - Running setup.py (path:/tmp/pip-bLBcL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:25 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)) 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:25 INFO - Running setup.py (path:/tmp/pip-5HktXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:25 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)) 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:25 INFO - Running setup.py (path:/tmp/pip-onT1QJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:26 INFO - Running setup.py (path:/tmp/pip-iAWejy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:26 INFO - Running setup.py (path:/tmp/pip-eu0dsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:26 INFO - Running setup.py (path:/tmp/pip-d86RzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:26 INFO - Running setup.py (path:/tmp/pip-qjsgpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:26 INFO - Running setup.py (path:/tmp/pip-HLxkVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:26 INFO - Running setup.py (path:/tmp/pip-lm0zeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:26 INFO - Running setup.py (path:/tmp/pip-ryFHVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:26 INFO - Running setup.py (path:/tmp/pip-0gPNMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:26 INFO - Running setup.py (path:/tmp/pip-hx9__t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:26 INFO - Running setup.py (path:/tmp/pip-dntenj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:26 INFO - Running setup.py (path:/tmp/pip-q7H1zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:26 INFO - Running setup.py (path:/tmp/pip-T6XKWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:26 INFO - Running setup.py (path:/tmp/pip-7Fr54T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:26 INFO - Running setup.py (path:/tmp/pip-KcJrxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:27 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)) 20:20:27 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)) 20:20:27 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)) 20:20:27 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)) 20:20:27 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)) 20:20:27 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)) 20:20:27 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)) 20:20:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:20:27 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 20:20:27 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 20:20:27 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 20:20:27 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 20:20:28 INFO - Downloading blessings-1.6.tar.gz 20:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:20:28 INFO - Installing collected packages: blessings 20:20:28 INFO - Running setup.py install for blessings 20:20:28 INFO - Successfully installed blessings 20:20:28 INFO - Cleaning up... 20:20:28 INFO - Return code: 0 20:20:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:20:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:20:28 INFO - Reading from file tmpfile_stdout 20:20:28 INFO - Current package versions: 20:20:28 INFO - argparse == 1.2.1 20:20:28 INFO - blessings == 1.6 20:20:28 INFO - blobuploader == 1.2.4 20:20:28 INFO - docopt == 0.6.1 20:20:28 INFO - functools32 == 3.2.3-2 20:20:28 INFO - jsonschema == 2.5.1 20:20:28 INFO - manifestparser == 1.1 20:20:28 INFO - mozInstall == 1.13 20:20:28 INFO - mozcrash == 1.0 20:20:28 INFO - mozdebug == 0.1 20:20:28 INFO - mozdevice == 0.51 20:20:28 INFO - mozfile == 1.2 20:20:28 INFO - mozhttpd == 0.7 20:20:28 INFO - mozinfo == 0.10 20:20:28 INFO - mozleak == 0.1 20:20:28 INFO - mozlog == 3.5 20:20:28 INFO - moznetwork == 0.27 20:20:28 INFO - mozprocess == 0.25 20:20:28 INFO - mozprofile == 0.28 20:20:28 INFO - mozrunner == 6.13 20:20:28 INFO - mozscreenshot == 0.1 20:20:28 INFO - mozsystemmonitor == 0.3 20:20:28 INFO - moztest == 0.8 20:20:28 INFO - mozversion == 1.4 20:20:28 INFO - psutil == 3.1.1 20:20:28 INFO - requests == 1.2.3 20:20:28 INFO - wsgiref == 0.1.2 20:20:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:28 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 0x1aed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e59eb0>, '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 0x1e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b240>, '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': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', '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 20:20:28 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 20:20:28 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 20:20:28 INFO - Using env: {'DISPLAY': ':0', 20:20:28 INFO - 'HOME': '/home/cltbld', 20:20:28 INFO - 'LANG': 'en_US.UTF-8', 20:20:28 INFO - 'LANGUAGE': 'en_US:en', 20:20:28 INFO - 'LOGNAME': 'cltbld', 20:20:28 INFO - 'MAIL': '/var/mail/cltbld', 20:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:28 INFO - 'MOZ_NO_REMOTE': '1', 20:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:28 INFO - 'NO_EM_RESTART': '1', 20:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:28 INFO - 'PWD': '/builds/slave/test', 20:20:28 INFO - 'SHELL': '/bin/bash', 20:20:28 INFO - 'SHLVL': '1', 20:20:28 INFO - 'TERM': 'linux', 20:20:28 INFO - 'TMOUT': '86400', 20:20:28 INFO - 'USER': 'cltbld', 20:20:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', 20:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:28 INFO - '_': '/tools/buildbot/bin/python'} 20:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:28 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)) 20:20:28 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)) 20:20:28 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)) 20:20:28 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)) 20:20:28 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)) 20:20:28 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)) 20:20:28 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)) 20:20:28 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)) 20:20:28 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)) 20:20:28 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:20:28 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 20:20:28 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 20:20:28 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 20:20:28 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 20:20:29 INFO - Downloading marionette_driver-1.4.0.tar.gz 20:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 20:20:29 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 20:20:29 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 20:20:29 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 20:20:29 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 20:20:29 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 20:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20:20:30 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)) 20:20:30 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)) 20:20:30 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)) 20:20:30 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)) 20:20:30 INFO - Installing collected packages: marionette-driver, simplejson 20:20:30 INFO - Running setup.py install for marionette-driver 20:20:30 INFO - Running setup.py install for simplejson 20:20:30 INFO - building 'simplejson._speedups' extension 20:20:30 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 20:20:31 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 20:20:31 INFO - Successfully installed marionette-driver simplejson 20:20:31 INFO - Cleaning up... 20:20:31 INFO - Return code: 0 20:20:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:20:31 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')]} 20:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:31 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')]} 20:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:31 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 0x1aed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e59eb0>, '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 0x1e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b240>, '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': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', '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 20:20:31 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 20:20:31 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 20:20:31 INFO - Using env: {'DISPLAY': ':0', 20:20:31 INFO - 'HOME': '/home/cltbld', 20:20:31 INFO - 'LANG': 'en_US.UTF-8', 20:20:31 INFO - 'LANGUAGE': 'en_US:en', 20:20:31 INFO - 'LOGNAME': 'cltbld', 20:20:31 INFO - 'MAIL': '/var/mail/cltbld', 20:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:31 INFO - 'MOZ_NO_REMOTE': '1', 20:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:31 INFO - 'NO_EM_RESTART': '1', 20:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:31 INFO - 'PWD': '/builds/slave/test', 20:20:31 INFO - 'SHELL': '/bin/bash', 20:20:31 INFO - 'SHLVL': '1', 20:20:31 INFO - 'TERM': 'linux', 20:20:31 INFO - 'TMOUT': '86400', 20:20:31 INFO - 'USER': 'cltbld', 20:20:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', 20:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:31 INFO - '_': '/tools/buildbot/bin/python'} 20:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:20:31 INFO - Cleaning up... 20:20:31 INFO - Return code: 0 20:20:31 INFO - Running post-action listener: _resource_record_post_action 20:20:31 INFO - Running post-action listener: _start_resource_monitoring 20:20:31 INFO - Starting resource monitoring. 20:20:31 INFO - [mozharness: 2017-07-26 03:20:31.574563Z] Finished create-virtualenv step (success) 20:20:31 INFO - [mozharness: 2017-07-26 03:20:31.575156Z] Running install step. 20:20:31 INFO - Running pre-action listener: _resource_record_pre_action 20:20:31 INFO - Running main action method: install 20:20:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:20:31 INFO - Reading from file tmpfile_stdout 20:20:31 INFO - Detecting whether we're running mozinstall >=1.0... 20:20:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:20:31 INFO - Reading from file tmpfile_stdout 20:20:31 INFO - Output received: 20:20:31 INFO - Usage: mozinstall [options] installer 20:20:31 INFO - Options: 20:20:31 INFO - -h, --help show this help message and exit 20:20:31 INFO - -d DEST, --destination=DEST 20:20:31 INFO - Directory to install application into. [default: 20:20:31 INFO - "/builds/slave/test"] 20:20:31 INFO - --app=APP Application being installed. [default: firefox] 20:20:31 INFO - mkdir: /builds/slave/test/build/application 20:20:31 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'] 20:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:20:49 INFO - Reading from file tmpfile_stdout 20:20:49 INFO - Output received: 20:20:49 INFO - /builds/slave/test/build/application/firefox/firefox 20:20:49 INFO - Running post-action listener: _resource_record_post_action 20:20:49 INFO - [mozharness: 2017-07-26 03:20:49.736759Z] Finished install step (success) 20:20:49 INFO - [mozharness: 2017-07-26 03:20:49.737017Z] Running setup-mitmproxy step. 20:20:49 INFO - Running pre-action listener: _resource_record_pre_action 20:20:49 INFO - Running main action method: setup_mitmproxy 20:20:49 INFO - Skipping: mitmproxy is not required 20:20:49 INFO - Running post-action listener: _resource_record_post_action 20:20:49 INFO - [mozharness: 2017-07-26 03:20:49.738168Z] Finished setup-mitmproxy step (success) 20:20:49 INFO - [mozharness: 2017-07-26 03:20:49.738395Z] Running run-tests step. 20:20:49 INFO - Running pre-action listener: _resource_record_pre_action 20:20:49 INFO - Running pre-action listener: _set_gcov_prefix 20:20:49 INFO - Running main action method: run_tests 20:20:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:20:49 INFO - Python 2.7.3 20:20:49 INFO - Return code: 0 20:20:49 INFO - grabbing minidump binary from tooltool 20:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:49 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 0x1e59eb0>, '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 0x1e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5b240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:20:49 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 20:20:49 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 20:20:49 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 20:20:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:20:49 INFO - Return code: 0 20:20:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:20:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:20:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:20:49 INFO - ENV: RUST_BACKTRACE is now 1 20:20:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:20:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:20:49 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/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 20:20:49 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/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 20:20:49 INFO - Using env: {'DISPLAY': ':0', 20:20:49 INFO - 'HOME': '/home/cltbld', 20:20:49 INFO - 'LANG': 'en_US.UTF-8', 20:20:49 INFO - 'LANGUAGE': 'en_US:en', 20:20:49 INFO - 'LOGNAME': 'cltbld', 20:20:49 INFO - 'MAIL': '/var/mail/cltbld', 20:20:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:20:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:49 INFO - 'MOZ_NO_REMOTE': '1', 20:20:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:49 INFO - 'NO_EM_RESTART': '1', 20:20:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:49 INFO - 'PWD': '/builds/slave/test', 20:20:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:20:49 INFO - 'RUST_BACKTRACE': '1', 20:20:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:20:49 INFO - 'SHELL': '/bin/bash', 20:20:49 INFO - 'SHLVL': '1', 20:20:49 INFO - 'TERM': 'linux', 20:20:49 INFO - 'TMOUT': '86400', 20:20:49 INFO - 'USER': 'cltbld', 20:20:49 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605', 20:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:49 INFO - '_': '/tools/buildbot/bin/python'} 20:20:49 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/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 20:20:50 INFO - mozversion application_buildid: 20170726020448 20:20:50 INFO - mozversion application_changeset: 9eddb0a92820c6445f9d1e680e4c239e888e93f0 20:20:50 INFO - mozversion application_display_name: Nightly 20:20:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:20:50 INFO - mozversion application_name: Firefox 20:20:50 INFO - mozversion application_remotingname: firefox 20:20:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:20:50 INFO - mozversion application_vendor: Mozilla 20:20:50 INFO - mozversion application_version: 56.0a1 20:20:50 INFO - mozversion platform_buildid: 20170726020448 20:20:50 INFO - mozversion platform_changeset: 9eddb0a92820c6445f9d1e680e4c239e888e93f0 20:20:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:20:50 INFO - mozversion platform_version: 56.0a1 20:20:50 INFO - using testdate: 1501039250 20:20:50 INFO - actual date: 1501039250 20:20:50 INFO - starting webserver on 'localhost:33572' 20:20:50 INFO - SUITE-START | Running 2 tests 20:20:50 INFO - TEST-START | dromaeo_css 20:20:50 INFO - Initialising browser for dromaeo_css test... 20:20:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33572/getInfo.html -profile /tmp/tmpjqiYzy/profile 20:20:50 INFO - TEST-INFO | started process 18442 (/builds/slave/test/build/application/firefox/firefox http://localhost:33572/getInfo.html) 20:20:56 INFO - TEST-INFO | 18442: exit 0 20:20:56 INFO - Browser initialized. 20:20:56 INFO - Running cycle 1/1 for dromaeo_css test... 20:20:56 INFO - TEST-INFO | started process 18651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjqiYzy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:57 INFO - PID 18651 | 20:20:57 INFO - PID 18651 | (/builds/slave/test/build/application/firefox/firefox:18699): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:20:57 INFO - PID 18651 | 20:21:07 INFO - PID 18651 | RSS: Main: 162508800 20:21:07 INFO - PID 18651 | 20:24:06 INFO - PID 18651 | Cycle 1(1): loaded http://localhost:33572/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33572/tests/dromaeo/cssquery-ext.html) 20:24:07 INFO - PID 18651 | RSS: Main: 163913728 20:24:07 INFO - PID 18651 | 20:27:08 INFO - PID 18651 | Cycle 1(1): loaded http://localhost:33572/tests/dromaeo/cssquery-ext.html (next: http://localhost:33572/tests/dromaeo/cssquery-jquery.html) 20:27:09 INFO - PID 18651 | RSS: Main: 164044800 20:27:09 INFO - PID 18651 | 20:30:11 INFO - PID 18651 | Cycle 1(1): loaded http://localhost:33572/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33572/tests/dromaeo/cssquery-mootools.html) 20:30:11 INFO - PID 18651 | RSS: Main: 165834752 20:30:11 INFO - PID 18651 | 20:33:13 INFO - PID 18651 | Cycle 1(1): loaded http://localhost:33572/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33572/tests/dromaeo/cssquery-prototype.html) 20:33:14 INFO - PID 18651 | RSS: Main: 165179392 20:33:14 INFO - PID 18651 | 20:36:17 INFO - PID 18651 | Cycle 1(1): loaded http://localhost:33572/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33572/tests/dromaeo/cssquery-yui.html) 20:36:18 INFO - PID 18651 | RSS: Main: 166273024 20:36:18 INFO - PID 18651 | 20:39:19 INFO - PID 18651 | Cycle 1(1): loaded http://localhost:33572/tests/dromaeo/cssquery-yui.html (next: http://localhost:33572/tests/dromaeo/cssquery-dojo.html) 20:39:19 INFO - PID 18651 | RSS: Main: 169205760 20:39:19 INFO - PID 18651 | 20:39:19 INFO - PID 18651 | __start_tp_report 20:39:19 INFO - PID 18651 | _x_x_mozilla_page_load 20:39:19 INFO - PID 18651 | _x_x_mozilla_page_load_details 20:39:19 INFO - PID 18651 | |i|pagename|runs| 20:39:19 INFO - PID 18651 | |0;dojo.html;3303.025607445805;3358.7648864579483;3361.512580675802;3365.781224220424;3380.8309584520775;6059.878802423949;6112.113743507189;6143.109249158875;6159.476444502217;6172.259328880529;6068.817935461932;6121.908171377433;6140.1096840958035;6152.415520525543;6154.538409619286;5363.865903352408;5417.295751552293;5445.646033007862;5466.371367292772;5504.862378440531;5268.4994925482015;5349.037173308803;5410.2966614340085;5414.675119492843;5418.187271909225;5338.519533242007;5357.544608708265;5399.1631297148615;5432.945670543283;5435.619506634557;5367.677939323653;5396.973015134939;5451.236826844245;5454.181872719124;5454.59090568205;5277.656952298088;5358.383785864637;5368.30212072432;5371.274877891474;5388.595855310868;6024.759009639609;6089.056196289582;6102.603330783485;6113.969430152865;6122;6457.935420645827;6584.078229047937;6613.272540020642;6666.699998500079;6718.328167183291;6703.899441508382;6720.227173875018;6771.762988295386;6773.593584384953;6782.898256526156;6203.596766210182;6239.937600624026;6255.12428260044;6286.87426251477;6308.053791931247;6650.467962562983;6769.526133170631;6774.796756097325;6824.7952561423235;6871.690773915186;6541;6577.309382514863;6610.603363798091;6622.9006564901565;6628.966855165693;6664.400203981665;6677.732890684319;6741.157355330583;6749.93250067493;6766.849635561966;6415;6516.0877477153235;6545.509086818508;6622.63575503352;6688.799336019927;6478.481721462272;6610.107635469246;6619.404253617101;6625.271220165778;6644;4803.18345881201;4812.35033270511;4854.053459575349;4893.388326459192;4907.582855457326;4302.483701955723;4332.566743325642;4354.629856462173;4365.825366985285;4380.759058251827;6209.19280493542;6356.904646430307;6376.649284289409;6441.710123044474;6448.129502517194;6596.208454985336;6626.900596491057;6629.569078009914;6636.070950066995;6639.86720265592;6359.682015899279;6411.743530258831;6428.967855160788;6431.710573024225;6432.807015789534;5480.369757477862;5499.841131146264;5561.721913904288;5566.721663916788;5568.192612071227;6889.069975553336;6977.6511174441075;6990.440764738809;7039.084918960502;7121.572705637678;6559.6064236145985;6663.733450662113;6680.766173183915;6715.4291885190305;6719.193696756225;6940.514164008673;7025.6487175639995;7083.7520686775715;7094.219635839951;7094.326039026284;6480.6435646038035;6506.41442270198;6549.0176473529355;6549.148610680581;6596.373344532261;6614.603123812587;6723.7646682365885;6734.3939045484185;6736.124303840469;6766.120404347404;6484.059811327425;6552.737890484327;6555.737770489127;6559.212894452697;6565.737370505126;6471.191101112361;6489.3510648934725;6508.674566271573;6567.770128045687;6573.901391479228;6363.6818159090935;6445.871082578416;6452.451541619015;6523.706433210612;6527.249366322933;6520.869582608416;6546.607203567611;6569.178852643419;6592.736290548324;6629.403353697998;6269.62382257066;6339;6427.260865000585;6434.388733070351;6443.96778016107 20:39:19 INFO - PID 18651 | |1;ext.html;902.2181192145514;913.7436025464986;914.7758799094221;941.8775559177305;952.7475219066953;42702.572974270246;43052;43212.3518147228;43266.783666081705;43306.35040474396;40526.39210411846;40781.796091019576;40794.59205407945;40796.38805417914;40812;6859.314068593126;6935.618540980244;6939.340762627542;6953.513254072217;6974.616396098212;6749.662516874137;6801.115854938876;6808.863822723567;6815.284395138513;6827.965860170692;6790.287019862917;6800.489963252751;6803.047573339736;6804.455643548505;6808.21705503866;7211.567305961633;7331.266873312679;7389.556626602421;7421.332080112816;7441.59071251081;7454.515456495311;7486.85026299471;7552.131504876955;7554.508956917783;7555.2067032961295;39016.414753778714;39115.804420978;39175.8041209795;39749.60250397488;40667.389989150186;3444.896653100411;3503.929921401583;3509.8069606171653;3514.209302906851;3520.612732599412;32474;32531.67468325334;32730;32845;32848.34303313944;5108.4125325587665;5118.897622047538;5132.101882170605;5135.35808023997;5197.376314842243;210009;243136;247497;247705.52294477005;248970.75514622492;52400.475995240326;52437.213441798405;52548.21177682338;52711.20933186005;52770.20844687333;58032;58750.70624646935;58915.705421473474;59115.40884591185;59136.70431647814;16644.417445389354;16747.995120292577;16769.413070542472;16777;16803.075830829177;13543.98420118495;13548.796768048487;13555.254461004739;13558.593242202749;13560.59318220455;15624.687506249811;15660.295286712126;15722.213889305718;15724.29240684172;15755.291011904492;6223;6265.342139075423;6339.7003614258965;6416;6466.224053113657;1097.846301517788;1099.8130317845985;1103.100972707241;1109.7835921995134;1110.228391268077;23763.881180593988;24306.635400469007;24488.877555612107;24559;24577.262682119566;1192.0820967854704;1196.8683444821063;1206.818977153434;1215.2829830400105;1231.0213380362634;12548.18436801605;13077.149985250928;13109.60671179866;13156.539521116714;13206.933965330112;271679;272815;273126;273809;274496;55290.72354638201;55966;56129.71935140298;57556.42443575511;61926.380736192965;1509.0794615284667;1563.273078018704;1563.5700182449916;1568.2864296744954;1571.2143928035982;29217.269568260963;29272.853635731684;29424.558631620115;29616.555751664175;30318.393632127674;54935;55158.172627411426;55376.44623553713;55558.16662750143;55611;232118;233276;234443;234836;235320;36002.45996310005;37181.25637487289;37208;37747.43378849374;37786;45132.77433612811;46666;46740.53259467498;46960.76519617517;47239.52760472351;31359.372812543166;32311.51532726964;34014.65985340115;34058.489122662686;34231.486527702604;32514.187145321557;33460.49809252814;33690.663093368756;33709.49435758417;33945.151371215914;38263.42604860874;38732.80633596814;38875.416868746426;39028;39077.8046109779;30844.537331940486;32329.191770205933;32673.509897351083;32798.836005819816;32991.340173195924;24848.751512485367;25271.747282527675;25889;26365.34086647849;26758.464830702887 20:39:19 INFO - PID 18651 | |2;jquery.html;580.5906835680845;591.2904514582502;598.3507893935079;600.9789657361994;612.9540284478664;17891.463256102306;23255.069797208114;23940;24078.398040048985;24096.75903240967;19704;25253.494930101388;26169;26300.86849565754;26303.34241643955;6081.452669259766;6290.748370065192;6298.685065746694;6334.588251763644;6337.778177763779;4206.326987681971;4406;5778.855528611776;6044.697765111749;6123.846903827418;6024.1566180734735;6027.789027384042;6028.668423236721;6035.336113027585;6037.7584896604085;6006;6014.8797024059495;6025.8192254232445;6030.185924900148;6040.667763273018;5590.972045139789;5596.944030559683;5597.692126933017;5600.52395546379;5601.60788744788;28131.437371252665;29381.11856644304;29518;30074.54888176679;30100.69899301001;2192.8793916334594;2224.354937068248;2231.6987206727044;2238.653008783625;2240.1263507232193;17289.30842766288;18292.908535457238;18298.45104646863;19121;19498.512537186543;2427.1626288930293;2443.621238708003;2478.4547399572066;2482.2056941778637;2490;143396;144268;146009.26995365063;146921.26539367234;147439.26280368638;14660.193689347188;15142.697146057017;15182.544523664308;15329.9233503834;15396.923015385075;23674.7632523676;23716.881415593158;23748.525029499313;23751.40621484442;23814.880925595608;9884.30809843304;9903.554340054714;9935;9952.402855828674;9999.500024998866;8899.510526921082;8951.41815781972;9000.594973226089;9075.81848363029;9082.137196966278;8297.792555186168;9796.559154838049;9949.701508954742;10009.899901001043;10057.949710251401;2765.5989881467076;2791.1486996466274;2792.5811128330506;2836.319283371976;2952.276692210422;1037.0873631204493;1040.2094408249784;1042.7288904884786;1043.3009883378154;1057.002265717794;20687.482812929495;21302.573948521254;21474.355769326947;23944.521109578058;25547.489050219265;1113.8273567597034;1114.3759494683004;1134.0684331004281;1137.147139645266;1139.7948369293606;11131.944340278247;11848.763024739457;11915.940420298017;11936.820947685792;12075.57735479254;510977;514594;514747;523325;524962;131483.34258328646;143794;145129.27435362968;145600;145767;1305.8498272698762;1318.8525982395377;1350.527315439608;1366.8701473360213;1384.4946594492937;21122.894385527972;21797.365197609925;21915.452113697283;22116.778832211472;22232.666510002688;63663.363366365746;64636.67681661562;65313.34686653263;65432;66416;74453.627731861;77089.2291077082;77698;78511.60744196242;78846;12966.35168241603;13369.465221391036;14688.485902993343;15081.849181508045;15483.5354939352;23512.764872351057;23665.881670591538;23738.848701781655;23850.52298954046;24102;18388.356407525673;19553.60892782165;19882;19955.800441995394;20005.199792008156;16701.415450459175;17489.212985415434;18087.728684070014;18345.81654183441;18644.161012754186;20531.28140515075;20880.895595521924;20996.370108896757;21091.578168436852;21133.837638930007;14195.858041419453;14358.928205358907;14403.78394324107;14408.85591144075;14621.561353159423;20081.39755807328;20151.59696806085;20329.79670203279;20341.186352545734;20347 20:39:19 INFO - PID 18651 | |3;mootools.html;1438.1586771738534;1478.3716920308866;1486.0934829753855;1488.1963739580626;1490.0835985868687;15183.544493665195;15799;15803.288852001659;15810.209489525536;16041.117738524377;16033.438829640965;16325.673486530262;16327.102009389479;16357.672846543062;16364;2636.617690434881;2692.5826496893014;2697;2697.8920843166347;2699.527582673034;2444.8899799508977;2484.354067942339;2491.9658341788136;2493.227099599121;2501.537215615108;2599.7660210581043;2612.4905643399543;2626.4747050589863;2626.921192364232;2627.159309021114;2521.7856482199127;2528.3931856354525;2539.1874600127967;2551.5407226699185;2555.310066282112;2458.545169143696;2489.8879550420274;2501.0871032073346;2501.46218563008;2504.2362079565723;14998.47505337308;15312.540623781304;15408;15425.228738563026;15440.227988600638;7994.600269986536;8264.504129752175;8270.421070525066;8313.584320783997;8313.792155196168;4823.252395878644;5057.645964782467;5165.793368265265;5168.379794424655;5297;1863.2360732099773;1863.9720404193947;1865.7481240032557;1897.9620407591772;1908.6659834529041;26597.335066623295;26764.73235267642;26875.731242687518;26898.462030759274;26908.46183076347;6591.538592298493;6779.389854913082;6862.348076932683;6893.896591551131;7151.964240178766;18131.456056318333;18201;18228.908855455637;18236.45290641283;18257.81742182588;7868.331191848642;8030.317423018992;8077.474964127313;8091.231333023354;8091.676332946734;6266.905996410058;7420.814479638052;7555.962220188864;7567.01628788254;7584.582847943306;5248.212768084742;5353.411124776271;5389.245505629215;5528.75120619573;5625.324961004706;1548.535439368185;1562.1408225475943;1563.077784107382;1570.9921450392903;1571.3321838218712;973.6981535723949;985.8176237396104;994.5922171909482;998.4159266828841;1005.2510879394897;8054.718084867119;8153.959230203811;8163.79590510242;8353.248207661218;8462.87305690415;709.7373971630426;718.9712411503481;734.9412047036225;736.988945165823;755.3353049316567;4986.950130498649;5110.565601923804;5329.973350133225;5821.301443826683;5892.705364731746;20544.691829622567;20951.266705665228;20956.266530671353;21081.15675372968;21616.973623692695;20259.696104558443;20515.487112822;20699.06854191565;20708.275210367865;20719.171233150806;11436.485358158903;11741.119416043832;11839.940800296115;11966.282023078644;11971.940140299417;8500.659973600987;9330.720078397659;9351.859722104038;9575.808483830424;9596.088371604686;18567.652486160507;19054.7141792876;19080.427587172406;19282.517937051125;19386.127624257224;19605;19623.31318403849;19858.90070549638;19934.60130797347;20026.499337516678;11351.772964540829;12423.130380873614;12863.22820630765;13348.666283342605;13384.531541396005;14655.340509677304;14705.705885882437;14718.411263549766;14734.705305894036;14773.113613183243;11013.394263315275;11545.191836571359;11635.709107272385;11712.121590880548;11832.70418239551;11621.88378116208;11702.765944680888;11757.235779674294;11768.70578235551;12025.158238923192;9965.302428829913;10316.329438586768;10571;10587.788244235226;10594.788104238027;7718.53688778675;7720.6139693014;7897.368210543258;8030.919690803017;8055.677772889253;7668.6165691716305;7671.53970761756;7890.408219383455;8018.238267364591;8064.838703225785 20:39:19 INFO - PID 18651 | |4;prototype.html;479.4438451396381;498.88721265440853;509.94900509948997;514.5831876180295;514.7400562715831;6042.82164977829;6123.1733715948385;6149.262088549369;6167.537434692394;6244.188255526787;5999.310079340877;6068.33248342682;6088.66512341821;6091.573589848713;6141.263048434194;4804.183288840905;4815.686980346284;4862.489438608939;4864.14877396456;4864.708117512961;4566.771661416932;4679.8362057328;4726.645501587377;4774;4781.187198176319;4610.147122782296;4656.906861862761;4662.790174442158;4670.229412146991;4695.60087392572;4612.331211974279;4643.396358473411;4672.299155126724;4686.414198225222;4690.57784799368;4125.257453658341;4148.842601847053;4173.10278290166;4176.728512646699;4204;5847.210626565445;5867.090600956859;5896.292444906596;5917.171595976567;5941.762329506814;5583.637063590853;5638.238837756891;5645.717714114277;5657.434256574351;5682.6306290091425;6522.184726909137;6524.184476940382;6528.910748560463;6529.836754081139;6546.3961329474105;4771.689840160413;4787.449443314029;4808.326834243208;4811.422629284473;4825.504093730955;6568.343165683394;6654.467642588581;6733.629650369227;6751.156105486814;6768.255491895888;4863.270509423614;4868.391451068616;4870.561649451566;4875.098106850244;4877.414710234794;4929;4931.432885218174;4950.851474455772;4958.8760280993265;4971.950280497221;5511.118221084607;5540.418256083134;5579.218909352694;5582.692951887604;5594.692291923983;6425.710843011982;6465.450436712932;6500.739970401131;6519.934800652028;6530.183727034121;1727.7062899307148;1731.3593970231095;1737.4613869700433;1738.8956662600285;1758.454878987518;1108.706192858893;1161.175565348612;1178.911581631381;1180.6576092933126;1184.6090790039266;6186.566940314225;6187.907181392283;6198.535109866778;6207.844803879939;6230.813075607739;6527;6580.341965803382;6641.734330626818;6650.96909978954;6653.367930046637;6150.907736383958;6204.286507051656;6216.937830621636;6232.532560058014;6265.4361107500545;3472.5485686860548;3500.984714432837;3516.6834984851484;3533.4876442915634;3533.6289689582222;6917.654117294115;6966.721331146698;6990.300969902969;6991.335823096798;7012.088428504364;6753.189617245962;6807.625580593016;6822.317768223138;6822.454203663695;6871.5189936703955;6845.075914751545;6905.896411553931;6959.930400696029;6973.58158510491;6980.371766541036;6454.67726613658;6484.438646734608;6564.4748420127235;6642.734290628321;6653.367930046637;6443.710033048618;6496.935030649633;6520.9347906520325;6555.4100130986535;6577.2570268879745;6971.44228461732;6975.686094125878;6979.464517806075;6997.510174287954;7019.227884932756;4507.703036835036;4981.900361992813;4982.302477653059;4986.15235409974;4999.200127979506;6464.935350646433;6490.188726409199;6651.567648102858;6665.166854143232;6692.899606505809;6370.872582548416;6454.41910228063;6462.321456247027;6479.902801457888;6499.3175716549085;6381.904271435839;6401.743930242738;6418.229812422539;6427.807165785034;6470.094186813944;6324.557280990287;6334.334894835976;6417.197850268716;6430.3891130342545;6488;6444.677766111582;6464.4828413725845;6472.870542589216;6476.514261430506;6533.346665333429;6286.717097730704;6326.912119000811;6327.778527751507;6349.856820873697;6353.428191462791 20:39:19 INFO - PID 18651 | |5;yui.html;939.6573131363298;939.7650587353162;952.1573407534335;972.572068289952;984.1978787288359;17996.820031799678;18928.242870285172;18944.24223031077;18955.905220473913;18958.620827583458;21128.049237784297;21642.458938526506;21658.566828663417;21848.12607495698;21939.890300548515;1046.4715318764033;1051.2220956492179;1057.6245432871335;1059.9258051936367;1060.241927022179;1018.684207895551;1086.1799341497158;1086.9565217391296;1114.4873358255172;1118.8265818798059;1165.9300441973467;1167.112994124463;1167.2587906679234;1167.597178973257;1167.6380322100176;1151.0446329546498;1153.9192256542046;1156.9884301156965;1161.3554477265116;1162.8546431696038;851.535912927456;851.5954921412341;851.7955690634266;852.4714676900361;852.7015544559416;19974.60050798976;19982.80017199824;20047.298344557872;20189.697154542693;20408.89795551013;21031.05360258792;21117.894410528002;21322.53711201083;21518.569628607496;21596.56806863854;15943.760843587355;16215;16221.837781622151;16349.754753678704;16388.75416868748;3618.5657721073376;3647.2705458908326;3647.6352364763575;3649.051246675857;3650.9634903651154;130909.34545327308;134201;135167.32416337953;138045;138056.30971845178;16473.258703358377;17015.829841701423;17183.914080429517;17337.393191238247;17558.20988055515;31296.687033129834;31856.362872742415;32087.197820054684;32221.51667724986;32349.191270218435;8797.252233560219;9013.098690130935;9029.097090290918;9064.184223419923;9083.772905677411;4217;4296.7851607420125;4297.076128632359;4300.376445415397;4309.332053531708;5301.761420736076;5506.174073888948;5518.310211223597;6290.433860952537;6599.703013364314;1177.4289469607234;1177.4289469607234;1198.406788639629;1202.1825158891863;1206.7284860906225;697.616311028932;741.8775901976113;746.0301607909696;750.1785544828405;751.0574229342141;12035.638930832089;14570;14812.777808332883;14886.404543818126;15021.549353519413;669.6283562622693;673.6126727131821;685.0785693242581;692.6121372031679;700.2927043685914;5689.203511508392;5877.941220587825;5954.166416701665;6258.43674069336;6263.843403914939;115525.4223728876;118009;119884;122515;122701.38649306876;105520;107810;108949.45525272323;110796;113185.43407282911;92501.53749231211;94338;98618.50690746501;100402.99597004082;101167;12300.815487767512;12548.121631485708;12675.30285834288;13053.477860885458;13297.933510332387;46155.07689846117;46994.76502617465;48033;48892.511074890215;49169.26246106383;59674.403255966885;60017.39982600118;60680.69659651673;60828.39171608404;63068;19368.4189474316;19592.51018724486;19779;19784.30754923571;20540.17839286412;20491.79508204899;20825.583488330452;20826.895865520575;20890.164393424093;21247.468813279793;21201.363959081253;21338.35984920455;21481.355559333246;21519.354419367442;21526;17918.283268669627;17950.730739038663;18345.54136146607;18417.98701071454;18628.06859657039;18148.909255453636;18442.631147377244;18452.26190952347;20428.489287767923;20762.961851907043;11652.242604230698;13145.868541314465;13277.867221327662;13310.068295219242;13849.515266965607;14710.19093949843;14951.626209344853;15071.020383675026;15203.619909502351;15310.157941313335 20:39:19 INFO - PID 18651 | __end_tp_report 20:39:19 INFO - PID 18651 | __start_cc_report 20:39:19 INFO - PID 18651 | _x_x_mozilla_cycle_collect,314 20:39:19 INFO - PID 18651 | __end_cc_report 20:39:19 INFO - PID 18651 | __startTimestamp1501040359943__endTimestamp 20:39:19 INFO - PID 18651 | 20:39:19 INFO - PID 18651 | ------- Summary: start ------- 20:39:19 INFO - PID 18651 | Number of tests: 6 20:39:19 INFO - PID 18651 | 20:39:19 INFO - PID 18651 | [#0] dojo.html Cycles:165 Average:6125.56 Median:6448.13 stddev:802.86 (12.5%) stddev-sans-first:774.19 20:39:19 INFO - PID 18651 | Values: 3303.0 3358.8 3361.5 3365.8 3380.8 6059.9 6112.1 6143.1 6159.5 6172.3 6068.8 6121.9 6140.1 6152.4 6154.5 5363.9 5417.3 5445.6 5466.4 5504.9 5268.5 5349.0 5410.3 5414.7 5418.2 5338.5 5357.5 5399.2 5432.9 5435.6 5367.7 5397.0 5451.2 5454.2 5454.6 5277.7 5358.4 5368.3 5371.3 5388.6 6024.8 6089.1 6102.6 6114.0 6122.0 6457.9 6584.1 6613.3 6666.7 6718.3 6703.9 6720.2 6771.8 6773.6 6782.9 6203.6 6239.9 6255.1 6286.9 6308.1 6650.5 6769.5 6774.8 6824.8 6871.7 6541.0 6577.3 6610.6 6622.9 6629.0 6664.4 6677.7 6741.2 6749.9 6766.8 6415.0 6516.1 6545.5 6622.6 6688.8 6478.5 6610.1 6619.4 6625.3 6644.0 4803.2 4812.4 4854.1 4893.4 4907.6 4302.5 4332.6 4354.6 4365.8 4380.8 6209.2 6356.9 6376.6 6441.7 6448.1 6596.2 6626.9 6629.6 6636.1 6639.9 6359.7 6411.7 6429.0 6431.7 6432.8 5480.4 5499.8 5561.7 5566.7 5568.2 6889.1 6977.7 6990.4 7039.1 7121.6 6559.6 6663.7 6680.8 6715.4 6719.2 6940.5 7025.6 7083.8 7094.2 7094.3 6480.6 6506.4 6549.0 6549.1 6596.4 6614.6 6723.8 6734.4 6736.1 6766.1 6484.1 6552.7 6555.7 6559.2 6565.7 6471.2 6489.4 6508.7 6567.8 6573.9 6363.7 6445.9 6452.5 6523.7 6527.2 6520.9 6546.6 6569.2 6592.7 6629.4 6269.6 6339.0 6427.3 6434.4 6444.0 20:39:19 INFO - PID 18651 | 20:39:19 INFO - PID 18651 | [#1] ext.html Cycles:180 Average:42840.25 Median:36591.86 stddev:65006.73 (177.7%) stddev-sans-first:65112.82 20:39:19 INFO - PID 18651 | Values: 902.2 913.7 914.8 941.9 952.7 42702.6 43052.0 43212.4 43266.8 43306.4 40526.4 40781.8 40794.6 40796.4 40812.0 6859.3 6935.6 6939.3 6953.5 6974.6 6749.7 6801.1 6808.9 6815.3 6828.0 6790.3 6800.5 6803.0 6804.5 6808.2 7211.6 7331.3 7389.6 7421.3 7441.6 7454.5 7486.9 7552.1 7554.5 7555.2 39016.4 39115.8 39175.8 39749.6 40667.4 3444.9 3503.9 3509.8 3514.2 3520.6 32474.0 32531.7 32730.0 32845.0 32848.3 5108.4 5118.9 5132.1 5135.4 5197.4 210009.0 243136.0 247497.0 247705.5 248970.8 52400.5 52437.2 52548.2 52711.2 52770.2 58032.0 58750.7 58915.7 59115.4 59136.7 16644.4 16748.0 16769.4 16777.0 16803.1 13544.0 13548.8 13555.3 13558.6 13560.6 15624.7 15660.3 15722.2 15724.3 15755.3 6223.0 6265.3 6339.7 6416.0 6466.2 1097.8 1099.8 1103.1 1109.8 1110.2 23763.9 24306.6 24488.9 24559.0 24577.3 1192.1 1196.9 1206.8 1215.3 1231.0 12548.2 13077.1 13109.6 13156.5 13206.9 271679.0 272815.0 273126.0 273809.0 274496.0 55290.7 55966.0 56129.7 57556.4 61926.4 1509.1 1563.3 1563.6 1568.3 1571.2 29217.3 29272.9 29424.6 29616.6 30318.4 54935.0 55158.2 55376.4 55558.2 55611.0 232118.0 233276.0 234443.0 234836.0 235320.0 36002.5 37181.3 37208.0 37747.4 37786.0 45132.8 46666.0 46740.5 46960.8 47239.5 31359.4 32311.5 34014.7 34058.5 34231.5 32514.2 33460.5 33690.7 33709.5 33945.2 38263.4 38732.8 38875.4 39028.0 39077.8 30844.5 32329.2 32673.5 32798.8 32991.3 24848.8 25271.7 25889.0 26365.3 26758.5 20:39:19 INFO - PID 18651 | 20:39:19 INFO - PID 18651 | [#2] jquery.html Cycles:180 Average:37195.24 Median:23695.82 stddev:88001.42 (371.4%) stddev-sans-first:88205.35 20:39:19 INFO - PID 18651 | Values: 580.6 591.3 598.4 601.0 613.0 17891.5 23255.1 23940.0 24078.4 24096.8 19704.0 25253.5 26169.0 26300.9 26303.3 6081.5 6290.7 6298.7 6334.6 6337.8 4206.3 4406.0 5778.9 6044.7 6123.8 6024.2 6027.8 6028.7 6035.3 6037.8 6006.0 6014.9 6025.8 6030.2 6040.7 5591.0 5596.9 5597.7 5600.5 5601.6 28131.4 29381.1 29518.0 30074.5 30100.7 2192.9 2224.4 2231.7 2238.7 2240.1 17289.3 18292.9 18298.5 19121.0 19498.5 2427.2 2443.6 2478.5 2482.2 2490.0 143396.0 144268.0 146009.3 146921.3 147439.3 14660.2 15142.7 15182.5 15329.9 15396.9 23674.8 23716.9 23748.5 23751.4 23814.9 9884.3 9903.6 9935.0 9952.4 9999.5 8899.5 8951.4 9000.6 9075.8 9082.1 8297.8 9796.6 9949.7 10009.9 10057.9 2765.6 2791.1 2792.6 2836.3 2952.3 1037.1 1040.2 1042.7 1043.3 1057.0 20687.5 21302.6 21474.4 23944.5 25547.5 1113.8 1114.4 1134.1 1137.1 1139.8 11131.9 11848.8 11915.9 11936.8 12075.6 510977.0 514594.0 514747.0 523325.0 524962.0 131483.3 143794.0 145129.3 145600.0 145767.0 1305.8 1318.9 1350.5 1366.9 1384.5 21122.9 21797.4 21915.5 22116.8 22232.7 63663.4 64636.7 65313.3 65432.0 66416.0 74453.6 77089.2 77698.0 78511.6 78846.0 12966.4 13369.5 14688.5 15081.8 15483.5 23512.8 23665.9 23738.8 23850.5 24102.0 18388.4 19553.6 19882.0 19955.8 20005.2 16701.4 17489.2 18087.7 18345.8 18644.2 20531.3 20880.9 20996.4 21091.6 21133.8 14195.9 14358.9 14403.8 14408.9 14621.6 20081.4 20151.6 20329.8 20341.2 20347.0 20:39:19 INFO - PID 18651 | 20:39:19 INFO - PID 18651 | [#3] mootools.html Cycles:180 Average:9578.50 Median:2497.16 stddev:6794.31 (272.1%) stddev-sans-first:6785.84 20:39:19 INFO - PID 18651 | Values: 1438.2 1478.4 1486.1 1488.2 1490.1 15183.5 15799.0 15803.3 15810.2 16041.1 16033.4 16325.7 16327.1 16357.7 16364.0 2636.6 2692.6 2697.0 2697.9 2699.5 2444.9 2484.4 2492.0 2493.2 2501.5 2599.8 2612.5 2626.5 2626.9 2627.2 2521.8 2528.4 2539.2 2551.5 2555.3 2458.5 2489.9 2501.1 2501.5 2504.2 14998.5 15312.5 15408.0 15425.2 15440.2 7994.6 8264.5 8270.4 8313.6 8313.8 4823.3 5057.6 5165.8 5168.4 5297.0 1863.2 1864.0 1865.7 1898.0 1908.7 26597.3 26764.7 26875.7 26898.5 26908.5 6591.5 6779.4 6862.3 6893.9 7152.0 18131.5 18201.0 18228.9 18236.5 18257.8 7868.3 8030.3 8077.5 8091.2 8091.7 6266.9 7420.8 7556.0 7567.0 7584.6 5248.2 5353.4 5389.2 5528.8 5625.3 1548.5 1562.1 1563.1 1571.0 1571.3 973.7 985.8 994.6 998.4 1005.3 8054.7 8154.0 8163.8 8353.2 8462.9 709.7 719.0 734.9 737.0 755.3 4987.0 5110.6 5330.0 5821.3 5892.7 20544.7 20951.3 20956.3 21081.2 21617.0 20259.7 20515.5 20699.1 20708.3 20719.2 11436.5 11741.1 11839.9 11966.3 11971.9 8500.7 9330.7 9351.9 9575.8 9596.1 18567.7 19054.7 19080.4 19282.5 19386.1 19605.0 19623.3 19858.9 19934.6 20026.5 11351.8 12423.1 12863.2 13348.7 13384.5 14655.3 14705.7 14718.4 14734.7 14773.1 11013.4 11545.2 11635.7 11712.1 11832.7 11621.9 11702.8 11757.2 11768.7 12025.2 9965.3 10316.3 10571.0 10587.8 10594.8 7718.5 7720.6 7897.4 8030.9 8055.7 7668.6 7671.5 7890.4 8018.2 8064.8 20:39:19 INFO - PID 18651 | 20:39:19 INFO - PID 18651 | [#4] prototype.html Cycles:180 Average:5471.86 Median:6187.24 stddev:1586.76 (25.6%) stddev-sans-first:1546.33 20:39:19 INFO - PID 18651 | Values: 479.4 498.9 509.9 514.6 514.7 6042.8 6123.2 6149.3 6167.5 6244.2 5999.3 6068.3 6088.7 6091.6 6141.3 4804.2 4815.7 4862.5 4864.1 4864.7 4566.8 4679.8 4726.6 4774.0 4781.2 4610.1 4656.9 4662.8 4670.2 4695.6 4612.3 4643.4 4672.3 4686.4 4690.6 4125.3 4148.8 4173.1 4176.7 4204.0 5847.2 5867.1 5896.3 5917.2 5941.8 5583.6 5638.2 5645.7 5657.4 5682.6 6522.2 6524.2 6528.9 6529.8 6546.4 4771.7 4787.4 4808.3 4811.4 4825.5 6568.3 6654.5 6733.6 6751.2 6768.3 4863.3 4868.4 4870.6 4875.1 4877.4 4929.0 4931.4 4950.9 4958.9 4972.0 5511.1 5540.4 5579.2 5582.7 5594.7 6425.7 6465.5 6500.7 6519.9 6530.2 1727.7 1731.4 1737.5 1738.9 1758.5 1108.7 1161.2 1178.9 1180.7 1184.6 6186.6 6187.9 6198.5 6207.8 6230.8 6527.0 6580.3 6641.7 6651.0 6653.4 6150.9 6204.3 6216.9 6232.5 6265.4 3472.5 3501.0 3516.7 3533.5 3533.6 6917.7 6966.7 6990.3 6991.3 7012.1 6753.2 6807.6 6822.3 6822.5 6871.5 6845.1 6905.9 6959.9 6973.6 6980.4 6454.7 6484.4 6564.5 6642.7 6653.4 6443.7 6496.9 6520.9 6555.4 6577.3 6971.4 6975.7 6979.5 6997.5 7019.2 4507.7 4981.9 4982.3 4986.2 4999.2 6464.9 6490.2 6651.6 6665.2 6692.9 6370.9 6454.4 6462.3 6479.9 6499.3 6381.9 6401.7 6418.2 6427.8 6470.1 6324.6 6334.3 6417.2 6430.4 6488.0 6444.7 6464.5 6472.9 6476.5 6533.3 6286.7 6326.9 6327.8 6349.9 6353.4 20:39:19 INFO - PID 18651 | 20:39:19 INFO - PID 18651 | [#5] yui.html Cycles:180 Average:25274.56 Median:20015.05 stddev:34776.23 (173.8%) stddev-sans-first:34825.78 20:39:19 INFO - PID 18651 | Values: 939.7 939.8 952.2 972.6 984.2 17996.8 18928.2 18944.2 18955.9 18958.6 21128.0 21642.5 21658.6 21848.1 21939.9 1046.5 1051.2 1057.6 1059.9 1060.2 1018.7 1086.2 1087.0 1114.5 1118.8 1165.9 1167.1 1167.3 1167.6 1167.6 1151.0 1153.9 1157.0 1161.4 1162.9 851.5 851.6 851.8 852.5 852.7 19974.6 19982.8 20047.3 20189.7 20408.9 21031.1 21117.9 21322.5 21518.6 21596.6 15943.8 16215.0 16221.8 16349.8 16388.8 3618.6 3647.3 3647.6 3649.1 3651.0 130909.3 134201.0 135167.3 138045.0 138056.3 16473.3 17015.8 17183.9 17337.4 17558.2 31296.7 31856.4 32087.2 32221.5 32349.2 8797.3 9013.1 9029.1 9064.2 9083.8 4217.0 4296.8 4297.1 4300.4 4309.3 5301.8 5506.2 5518.3 6290.4 6599.7 1177.4 1177.4 1198.4 1202.2 1206.7 697.6 741.9 746.0 750.2 751.1 12035.6 14570.0 14812.8 14886.4 15021.5 669.6 673.6 685.1 692.6 700.3 5689.2 5877.9 5954.2 6258.4 6263.8 115525.4 118009.0 119884.0 122515.0 122701.4 105520.0 107810.0 108949.5 110796.0 113185.4 92501.5 94338.0 98618.5 100403.0 101167.0 12300.8 12548.1 12675.3 13053.5 13297.9 46155.1 46994.8 48033.0 48892.5 49169.3 59674.4 60017.4 60680.7 60828.4 63068.0 19368.4 19592.5 19779.0 19784.3 20540.2 20491.8 20825.6 20826.9 20890.2 21247.5 21201.4 21338.4 21481.4 21519.4 21526.0 17918.3 17950.7 18345.5 18418.0 18628.1 18148.9 18442.6 18452.3 20428.5 20763.0 11652.2 13145.9 13277.9 13310.1 13849.5 14710.2 14951.6 15071.0 15203.6 15310.2 20:39:19 INFO - PID 18651 | -------- Summary: end -------- 20:39:19 INFO - PID 18651 | 20:39:20 INFO - TEST-INFO | 18651: exit 0 20:39:20 INFO - TEST-OK | dromaeo_css | took 1110502ms 20:39:20 INFO - TEST-START | kraken 20:39:20 INFO - Initialising browser for kraken test... 20:39:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33572/getInfo.html -profile /tmp/tmpdeDqcF/profile 20:39:20 INFO - TEST-INFO | started process 19016 (/builds/slave/test/build/application/firefox/firefox http://localhost:33572/getInfo.html) 20:39:26 INFO - TEST-INFO | 19016: exit 0 20:39:26 INFO - Browser initialized. 20:39:26 INFO - Running cycle 1/1 for kraken test... 20:39:26 INFO - TEST-INFO | started process 19229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdeDqcF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:39:27 INFO - PID 19229 | 20:39:27 INFO - PID 19229 | (/builds/slave/test/build/application/firefox/firefox:19281): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:39:27 INFO - PID 19229 | 20:39:37 INFO - PID 19229 | RSS: Main: 164614144 20:39:37 INFO - PID 19229 | 20:39:39 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33572/tests/kraken/driver.html?testName=audio-beat-detection) 20:39:40 INFO - PID 19229 | RSS: Main: 169467904 20:39:40 INFO - PID 19229 | 20:39:43 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33572/tests/kraken/driver.html?testName=audio-dft) 20:39:43 INFO - PID 19229 | RSS: Main: 169959424 20:39:43 INFO - PID 19229 | 20:39:46 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33572/tests/kraken/driver.html?testName=audio-fft) 20:39:47 INFO - PID 19229 | RSS: Main: 164388864 20:39:47 INFO - PID 19229 | 20:39:49 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33572/tests/kraken/driver.html?testName=audio-oscillator) 20:39:50 INFO - PID 19229 | RSS: Main: 165617664 20:39:50 INFO - PID 19229 | 20:39:52 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33572/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:39:52 INFO - PID 19229 | RSS: Main: 165711872 20:39:52 INFO - PID 19229 | 20:39:56 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33572/tests/kraken/driver.html?testName=imaging-darkroom) 20:39:56 INFO - PID 19229 | RSS: Main: 168615936 20:39:56 INFO - PID 19229 | 20:40:00 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33572/tests/kraken/driver.html?testName=imaging-desaturate) 20:40:00 INFO - PID 19229 | RSS: Main: 169865216 20:40:00 INFO - PID 19229 | 20:40:03 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33572/tests/kraken/driver.html?testName=json-parse-financial) 20:40:04 INFO - PID 19229 | RSS: Main: 169414656 20:40:04 INFO - PID 19229 | 20:40:05 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33572/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:40:06 INFO - PID 19229 | RSS: Main: 169795584 20:40:06 INFO - PID 19229 | 20:40:08 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33572/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:40:08 INFO - PID 19229 | RSS: Main: 169283584 20:40:08 INFO - PID 19229 | 20:40:10 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33572/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:40:11 INFO - PID 19229 | RSS: Main: 166342656 20:40:11 INFO - PID 19229 | 20:40:13 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:40:14 INFO - PID 19229 | RSS: Main: 166273024 20:40:14 INFO - PID 19229 | 20:40:17 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:40:18 INFO - PID 19229 | RSS: Main: 166735872 20:40:18 INFO - PID 19229 | 20:40:19 INFO - PID 19229 | Cycle 1(1): loaded http://localhost:33572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33572/tests/kraken/driver.html?testName=ai-astar) 20:40:20 INFO - PID 19229 | RSS: Main: 168382464 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | __start_tp_report 20:40:20 INFO - PID 19229 | _x_x_mozilla_page_load 20:40:20 INFO - PID 19229 | _x_x_mozilla_page_load_details 20:40:20 INFO - PID 19229 | |i|pagename|runs| 20:40:20 INFO - PID 19229 | |0;ai-astar;101;106;95;106;107;107;107;110;107;108 20:40:20 INFO - PID 19229 | |1;audio-beat-detection;148;112;135;173;119;143;140;124;173;121 20:40:20 INFO - PID 19229 | |2;audio-dft;162;163;164;163;167;162;163;162;173;165 20:40:20 INFO - PID 19229 | |3;audio-fft;74;79;75;178;78;76;74;89;95;75 20:40:20 INFO - PID 19229 | |4;audio-oscillator;78;78;122;79;78;79;123;78;77;135 20:40:20 INFO - PID 19229 | |5;imaging-gaussian-blur;114;114;114;114;113;118;114;115;116;114 20:40:20 INFO - PID 19229 | |6;imaging-darkroom;148;149;148;149;148;148;148;150;150;148 20:40:20 INFO - PID 19229 | |7;imaging-desaturate;94;94;94;95;94;95;94;94;95;94 20:40:20 INFO - PID 19229 | |8;json-parse-financial;50;49;48;48;47;47;52;48;50;48 20:40:20 INFO - PID 19229 | |9;json-stringify-tinderbox;54;54;54;54;55;55;56;56;54;54 20:40:20 INFO - PID 19229 | |10;stanford-crypto-aes;74;75;75;74;75;75;74;75;82;73 20:40:20 INFO - PID 19229 | |11;stanford-crypto-ccm;139;130;122;115;127;119;120;120;122;156 20:40:20 INFO - PID 19229 | |12;stanford-crypto-pbkdf2;172;163;174;163;173;164;168;170;167;160 20:40:20 INFO - PID 19229 | |13;stanford-crypto-sha256-iterative;62;62;60;62;61;61;60;62;61;71 20:40:20 INFO - PID 19229 | __end_tp_report 20:40:20 INFO - PID 19229 | __start_cc_report 20:40:20 INFO - PID 19229 | _x_x_mozilla_cycle_collect,828 20:40:20 INFO - PID 19229 | __end_cc_report 20:40:20 INFO - PID 19229 | __startTimestamp1501040420029__endTimestamp 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | ------- Summary: start ------- 20:40:20 INFO - PID 19229 | Number of tests: 14 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#0] ai-astar Cycles:10 Average:105.40 Median:107.00 stddev:4.30 (4.0%) stddev-sans-first:4.26 20:40:20 INFO - PID 19229 | Values: 101.0 106.0 95.0 106.0 107.0 107.0 107.0 110.0 107.0 108.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:141.50 stddev:21.35 (15.1%) stddev-sans-first:22.39 20:40:20 INFO - PID 19229 | Values: 148.0 112.0 135.0 173.0 119.0 143.0 140.0 124.0 173.0 121.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:3.41 (2.1%) stddev-sans-first:3.50 20:40:20 INFO - PID 19229 | Values: 162.0 163.0 164.0 163.0 167.0 162.0 163.0 162.0 173.0 165.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#3] audio-fft Cycles:10 Average:89.30 Median:77.00 stddev:31.95 (41.5%) stddev-sans-first:33.41 20:40:20 INFO - PID 19229 | Values: 74.0 79.0 75.0 178.0 78.0 76.0 74.0 89.0 95.0 75.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:78.00 stddev:23.69 (30.4%) stddev-sans-first:24.53 20:40:20 INFO - PID 19229 | Values: 78.0 78.0 122.0 79.0 78.0 79.0 123.0 78.0 77.0 135.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:1.50 20:40:20 INFO - PID 19229 | Values: 114.0 114.0 114.0 114.0 113.0 118.0 114.0 115.0 116.0 114.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 20:40:20 INFO - PID 19229 | Values: 148.0 149.0 148.0 149.0 148.0 148.0 148.0 150.0 150.0 148.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:40:20 INFO - PID 19229 | Values: 94.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#8] json-parse-financial Cycles:10 Average:48.70 Median:48.50 stddev:1.57 (3.2%) stddev-sans-first:1.59 20:40:20 INFO - PID 19229 | Values: 50.0 49.0 48.0 48.0 47.0 47.0 52.0 48.0 50.0 48.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:54.50 stddev:0.84 (1.5%) stddev-sans-first:0.87 20:40:20 INFO - PID 19229 | Values: 54.0 54.0 54.0 54.0 55.0 55.0 56.0 56.0 54.0 54.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:2.49 (3.3%) stddev-sans-first:2.60 20:40:20 INFO - PID 19229 | Values: 74.0 75.0 75.0 74.0 75.0 75.0 74.0 75.0 82.0 73.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:124.50 stddev:12.25 (9.8%) stddev-sans-first:12.20 20:40:20 INFO - PID 19229 | Values: 139.0 130.0 122.0 115.0 127.0 119.0 120.0 120.0 122.0 156.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:169.00 stddev:4.81 (2.8%) stddev-sans-first:4.81 20:40:20 INFO - PID 19229 | Values: 172.0 163.0 174.0 163.0 173.0 164.0 168.0 170.0 167.0 160.0 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:3.19 (5.1%) stddev-sans-first:3.38 20:40:20 INFO - PID 19229 | Values: 62.0 62.0 60.0 62.0 61.0 61.0 60.0 62.0 61.0 71.0 20:40:20 INFO - PID 19229 | -------- Summary: end -------- 20:40:20 INFO - PID 19229 | 20:40:20 INFO - PID 19229 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:40:20 INFO - TEST-INFO | 19229: exit 0 20:40:20 INFO - TEST-OK | kraken | took 60016ms 20:40:20 INFO - SUITE-END | took 1170s 20:40:20 INFO - Completed test suite (00:19:30) 20:40:20 INFO - javascript benchmark 20:40:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8755.428054915043, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3303.025607445805, 3358.7648864579483, 3361.512580675802, 3365.781224220424, 3380.8309584520775, 6059.878802423949, 6112.113743507189, 6143.109249158875, 6159.476444502217, 6172.259328880529, 6068.817935461932, 6121.908171377433, 6140.1096840958035, 6152.415520525543, 6154.538409619286, 5363.865903352408, 5417.295751552293, 5445.646033007862, 5466.371367292772, 5504.862378440531, 5268.4994925482015, 5349.037173308803, 5410.2966614340085, 5414.675119492843, 5418.187271909225, 5338.519533242007, 5357.544608708265, 5399.1631297148615, 5432.945670543283, 5435.619506634557, 5367.677939323653, 5396.973015134939, 5451.236826844245, 5454.181872719124, 5454.59090568205, 5277.656952298088, 5358.383785864637, 5368.30212072432, 5371.274877891474, 5388.595855310868, 6024.759009639609, 6089.056196289582, 6102.603330783485, 6113.969430152865, 6122.0, 6457.935420645827, 6584.078229047937, 6613.272540020642, 6666.699998500079, 6718.328167183291, 6703.899441508382, 6720.227173875018, 6771.762988295386, 6773.593584384953, 6782.898256526156, 6203.596766210182, 6239.937600624026, 6255.12428260044, 6286.87426251477, 6308.053791931247, 6650.467962562983, 6769.526133170631, 6774.796756097325, 6824.7952561423235, 6871.690773915186, 6541.0, 6577.309382514863, 6610.603363798091, 6622.9006564901565, 6628.966855165693, 6664.400203981665, 6677.732890684319, 6741.157355330583, 6749.93250067493, 6766.849635561966, 6415.0, 6516.0877477153235, 6545.509086818508, 6622.63575503352, 6688.799336019927, 6478.481721462272, 6610.107635469246, 6619.404253617101, 6625.271220165778, 6644.0, 4803.18345881201, 4812.35033270511, 4854.053459575349, 4893.388326459192, 4907.582855457326, 4302.483701955723, 4332.566743325642, 4354.629856462173, 4365.825366985285, 4380.759058251827, 6209.19280493542, 6356.904646430307, 6376.649284289409, 6441.710123044474, 6448.129502517194, 6596.208454985336, 6626.900596491057, 6629.569078009914, 6636.070950066995, 6639.86720265592, 6359.682015899279, 6411.743530258831, 6428.967855160788, 6431.710573024225, 6432.807015789534, 5480.369757477862, 5499.841131146264, 5561.721913904288, 5566.721663916788, 5568.192612071227, 6889.069975553336, 6977.6511174441075, 6990.440764738809, 7039.084918960502, 7121.572705637678, 6559.6064236145985, 6663.733450662113, 6680.766173183915, 6715.4291885190305, 6719.193696756225, 6940.514164008673, 7025.6487175639995, 7083.7520686775715, 7094.219635839951, 7094.326039026284, 6480.6435646038035, 6506.41442270198, 6549.0176473529355, 6549.148610680581, 6596.373344532261, 6614.603123812587, 6723.7646682365885, 6734.3939045484185, 6736.124303840469, 6766.120404347404, 6484.059811327425, 6552.737890484327, 6555.737770489127, 6559.212894452697, 6565.737370505126, 6471.191101112361, 6489.3510648934725, 6508.674566271573, 6567.770128045687, 6573.901391479228, 6363.6818159090935, 6445.871082578416, 6452.451541619015, 6523.706433210612, 6527.249366322933, 6520.869582608416, 6546.607203567611, 6569.178852643419, 6592.736290548324, 6629.403353697998, 6269.62382257066, 6339.0, 6427.260865000585, 6434.388733070351, 6443.96778016107], "value": 6062.627751728389, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [902.2181192145514, 913.7436025464986, 914.7758799094221, 941.8775559177305, 952.7475219066953, 42702.572974270246, 43052.0, 43212.3518147228, 43266.783666081705, 43306.35040474396, 40526.39210411846, 40781.796091019576, 40794.59205407945, 40796.38805417914, 40812.0, 6859.314068593126, 6935.618540980244, 6939.340762627542, 6953.513254072217, 6974.616396098212, 6749.662516874137, 6801.115854938876, 6808.863822723567, 6815.284395138513, 6827.965860170692, 6790.287019862917, 6800.489963252751, 6803.047573339736, 6804.455643548505, 6808.21705503866, 7211.567305961633, 7331.266873312679, 7389.556626602421, 7421.332080112816, 7441.59071251081, 7454.515456495311, 7486.85026299471, 7552.131504876955, 7554.508956917783, 7555.2067032961295, 39016.414753778714, 39115.804420978, 39175.8041209795, 39749.60250397488, 40667.389989150186, 3444.896653100411, 3503.929921401583, 3509.8069606171653, 3514.209302906851, 3520.612732599412, 32474.0, 32531.67468325334, 32730.0, 32845.0, 32848.34303313944, 5108.4125325587665, 5118.897622047538, 5132.101882170605, 5135.35808023997, 5197.376314842243, 210009.0, 243136.0, 247497.0, 247705.52294477005, 248970.75514622492, 52400.475995240326, 52437.213441798405, 52548.21177682338, 52711.20933186005, 52770.20844687333, 58032.0, 58750.70624646935, 58915.705421473474, 59115.40884591185, 59136.70431647814, 16644.417445389354, 16747.995120292577, 16769.413070542472, 16777.0, 16803.075830829177, 13543.98420118495, 13548.796768048487, 13555.254461004739, 13558.593242202749, 13560.59318220455, 15624.687506249811, 15660.295286712126, 15722.213889305718, 15724.29240684172, 15755.291011904492, 6223.0, 6265.342139075423, 6339.7003614258965, 6416.0, 6466.224053113657, 1097.846301517788, 1099.8130317845985, 1103.100972707241, 1109.7835921995134, 1110.228391268077, 23763.881180593988, 24306.635400469007, 24488.877555612107, 24559.0, 24577.262682119566, 1192.0820967854704, 1196.8683444821063, 1206.818977153434, 1215.2829830400105, 1231.0213380362634, 12548.18436801605, 13077.149985250928, 13109.60671179866, 13156.539521116714, 13206.933965330112, 271679.0, 272815.0, 273126.0, 273809.0, 274496.0, 55290.72354638201, 55966.0, 56129.71935140298, 57556.42443575511, 61926.380736192965, 1509.0794615284667, 1563.273078018704, 1563.5700182449916, 1568.2864296744954, 1571.2143928035982, 29217.269568260963, 29272.853635731684, 29424.558631620115, 29616.555751664175, 30318.393632127674, 54935.0, 55158.172627411426, 55376.44623553713, 55558.16662750143, 55611.0, 232118.0, 233276.0, 234443.0, 234836.0, 235320.0, 36002.45996310005, 37181.25637487289, 37208.0, 37747.43378849374, 37786.0, 45132.77433612811, 46666.0, 46740.53259467498, 46960.76519617517, 47239.52760472351, 31359.372812543166, 32311.51532726964, 34014.65985340115, 34058.489122662686, 34231.486527702604, 32514.187145321557, 33460.49809252814, 33690.663093368756, 33709.49435758417, 33945.151371215914, 38263.42604860874, 38732.80633596814, 38875.416868746426, 39028.0, 39077.8046109779, 30844.537331940486, 32329.191770205933, 32673.509897351083, 32798.836005819816, 32991.340173195924, 24848.751512485367, 25271.747282527675, 25889.0, 26365.34086647849, 26758.464830702887], "value": 18292.03717288476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.5906835680845, 591.2904514582502, 598.3507893935079, 600.9789657361994, 612.9540284478664, 17891.463256102306, 23255.069797208114, 23940.0, 24078.398040048985, 24096.75903240967, 19704.0, 25253.494930101388, 26169.0, 26300.86849565754, 26303.34241643955, 6081.452669259766, 6290.748370065192, 6298.685065746694, 6334.588251763644, 6337.778177763779, 4206.326987681971, 4406.0, 5778.855528611776, 6044.697765111749, 6123.846903827418, 6024.1566180734735, 6027.789027384042, 6028.668423236721, 6035.336113027585, 6037.7584896604085, 6006.0, 6014.8797024059495, 6025.8192254232445, 6030.185924900148, 6040.667763273018, 5590.972045139789, 5596.944030559683, 5597.692126933017, 5600.52395546379, 5601.60788744788, 28131.437371252665, 29381.11856644304, 29518.0, 30074.54888176679, 30100.69899301001, 2192.8793916334594, 2224.354937068248, 2231.6987206727044, 2238.653008783625, 2240.1263507232193, 17289.30842766288, 18292.908535457238, 18298.45104646863, 19121.0, 19498.512537186543, 2427.1626288930293, 2443.621238708003, 2478.4547399572066, 2482.2056941778637, 2490.0, 143396.0, 144268.0, 146009.26995365063, 146921.26539367234, 147439.26280368638, 14660.193689347188, 15142.697146057017, 15182.544523664308, 15329.9233503834, 15396.923015385075, 23674.7632523676, 23716.881415593158, 23748.525029499313, 23751.40621484442, 23814.880925595608, 9884.30809843304, 9903.554340054714, 9935.0, 9952.402855828674, 9999.500024998866, 8899.510526921082, 8951.41815781972, 9000.594973226089, 9075.81848363029, 9082.137196966278, 8297.792555186168, 9796.559154838049, 9949.701508954742, 10009.899901001043, 10057.949710251401, 2765.5989881467076, 2791.1486996466274, 2792.5811128330506, 2836.319283371976, 2952.276692210422, 1037.0873631204493, 1040.2094408249784, 1042.7288904884786, 1043.3009883378154, 1057.002265717794, 20687.482812929495, 21302.573948521254, 21474.355769326947, 23944.521109578058, 25547.489050219265, 1113.8273567597034, 1114.3759494683004, 1134.0684331004281, 1137.147139645266, 1139.7948369293606, 11131.944340278247, 11848.763024739457, 11915.940420298017, 11936.820947685792, 12075.57735479254, 510977.0, 514594.0, 514747.0, 523325.0, 524962.0, 131483.34258328646, 143794.0, 145129.27435362968, 145600.0, 145767.0, 1305.8498272698762, 1318.8525982395377, 1350.527315439608, 1366.8701473360213, 1384.4946594492937, 21122.894385527972, 21797.365197609925, 21915.452113697283, 22116.778832211472, 22232.666510002688, 63663.363366365746, 64636.67681661562, 65313.34686653263, 65432.0, 66416.0, 74453.627731861, 77089.2291077082, 77698.0, 78511.60744196242, 78846.0, 12966.35168241603, 13369.465221391036, 14688.485902993343, 15081.849181508045, 15483.5354939352, 23512.764872351057, 23665.881670591538, 23738.848701781655, 23850.52298954046, 24102.0, 18388.356407525673, 19553.60892782165, 19882.0, 19955.800441995394, 20005.199792008156, 16701.415450459175, 17489.212985415434, 18087.728684070014, 18345.81654183441, 18644.161012754186, 20531.28140515075, 20880.895595521924, 20996.370108896757, 21091.578168436852, 21133.837638930007, 14195.858041419453, 14358.928205358907, 14403.78394324107, 14408.85591144075, 14621.561353159423, 20081.39755807328, 20151.59696806085, 20329.79670203279, 20341.186352545734, 20347.0], "value": 12374.769571119428, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.1586771738534, 1478.3716920308866, 1486.0934829753855, 1488.1963739580626, 1490.0835985868687, 15183.544493665195, 15799.0, 15803.288852001659, 15810.209489525536, 16041.117738524377, 16033.438829640965, 16325.673486530262, 16327.102009389479, 16357.672846543062, 16364.0, 2636.617690434881, 2692.5826496893014, 2697.0, 2697.8920843166347, 2699.527582673034, 2444.8899799508977, 2484.354067942339, 2491.9658341788136, 2493.227099599121, 2501.537215615108, 2599.7660210581043, 2612.4905643399543, 2626.4747050589863, 2626.921192364232, 2627.159309021114, 2521.7856482199127, 2528.3931856354525, 2539.1874600127967, 2551.5407226699185, 2555.310066282112, 2458.545169143696, 2489.8879550420274, 2501.0871032073346, 2501.46218563008, 2504.2362079565723, 14998.47505337308, 15312.540623781304, 15408.0, 15425.228738563026, 15440.227988600638, 7994.600269986536, 8264.504129752175, 8270.421070525066, 8313.584320783997, 8313.792155196168, 4823.252395878644, 5057.645964782467, 5165.793368265265, 5168.379794424655, 5297.0, 1863.2360732099773, 1863.9720404193947, 1865.7481240032557, 1897.9620407591772, 1908.6659834529041, 26597.335066623295, 26764.73235267642, 26875.731242687518, 26898.462030759274, 26908.46183076347, 6591.538592298493, 6779.389854913082, 6862.348076932683, 6893.896591551131, 7151.964240178766, 18131.456056318333, 18201.0, 18228.908855455637, 18236.45290641283, 18257.81742182588, 7868.331191848642, 8030.317423018992, 8077.474964127313, 8091.231333023354, 8091.676332946734, 6266.905996410058, 7420.814479638052, 7555.962220188864, 7567.01628788254, 7584.582847943306, 5248.212768084742, 5353.411124776271, 5389.245505629215, 5528.75120619573, 5625.324961004706, 1548.535439368185, 1562.1408225475943, 1563.077784107382, 1570.9921450392903, 1571.3321838218712, 973.6981535723949, 985.8176237396104, 994.5922171909482, 998.4159266828841, 1005.2510879394897, 8054.718084867119, 8153.959230203811, 8163.79590510242, 8353.248207661218, 8462.87305690415, 709.7373971630426, 718.9712411503481, 734.9412047036225, 736.988945165823, 755.3353049316567, 4986.950130498649, 5110.565601923804, 5329.973350133225, 5821.301443826683, 5892.705364731746, 20544.691829622567, 20951.266705665228, 20956.266530671353, 21081.15675372968, 21616.973623692695, 20259.696104558443, 20515.487112822, 20699.06854191565, 20708.275210367865, 20719.171233150806, 11436.485358158903, 11741.119416043832, 11839.940800296115, 11966.282023078644, 11971.940140299417, 8500.659973600987, 9330.720078397659, 9351.859722104038, 9575.808483830424, 9596.088371604686, 18567.652486160507, 19054.7141792876, 19080.427587172406, 19282.517937051125, 19386.127624257224, 19605.0, 19623.31318403849, 19858.90070549638, 19934.60130797347, 20026.499337516678, 11351.772964540829, 12423.130380873614, 12863.22820630765, 13348.666283342605, 13384.531541396005, 14655.340509677304, 14705.705885882437, 14718.411263549766, 14734.705305894036, 14773.113613183243, 11013.394263315275, 11545.191836571359, 11635.709107272385, 11712.121590880548, 11832.70418239551, 11621.88378116208, 11702.765944680888, 11757.235779674294, 11768.70578235551, 12025.158238923192, 9965.302428829913, 10316.329438586768, 10571.0, 10587.788244235226, 10594.788104238027, 7718.53688778675, 7720.6139693014, 7897.368210543258, 8030.919690803017, 8055.677772889253, 7668.6165691716305, 7671.53970761756, 7890.408219383455, 8018.238267364591, 8064.838703225785], "value": 6770.316882074109, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.4438451396381, 498.88721265440853, 509.94900509948997, 514.5831876180295, 514.7400562715831, 6042.82164977829, 6123.1733715948385, 6149.262088549369, 6167.537434692394, 6244.188255526787, 5999.310079340877, 6068.33248342682, 6088.66512341821, 6091.573589848713, 6141.263048434194, 4804.183288840905, 4815.686980346284, 4862.489438608939, 4864.14877396456, 4864.708117512961, 4566.771661416932, 4679.8362057328, 4726.645501587377, 4774.0, 4781.187198176319, 4610.147122782296, 4656.906861862761, 4662.790174442158, 4670.229412146991, 4695.60087392572, 4612.331211974279, 4643.396358473411, 4672.299155126724, 4686.414198225222, 4690.57784799368, 4125.257453658341, 4148.842601847053, 4173.10278290166, 4176.728512646699, 4204.0, 5847.210626565445, 5867.090600956859, 5896.292444906596, 5917.171595976567, 5941.762329506814, 5583.637063590853, 5638.238837756891, 5645.717714114277, 5657.434256574351, 5682.6306290091425, 6522.184726909137, 6524.184476940382, 6528.910748560463, 6529.836754081139, 6546.3961329474105, 4771.689840160413, 4787.449443314029, 4808.326834243208, 4811.422629284473, 4825.504093730955, 6568.343165683394, 6654.467642588581, 6733.629650369227, 6751.156105486814, 6768.255491895888, 4863.270509423614, 4868.391451068616, 4870.561649451566, 4875.098106850244, 4877.414710234794, 4929.0, 4931.432885218174, 4950.851474455772, 4958.8760280993265, 4971.950280497221, 5511.118221084607, 5540.418256083134, 5579.218909352694, 5582.692951887604, 5594.692291923983, 6425.710843011982, 6465.450436712932, 6500.739970401131, 6519.934800652028, 6530.183727034121, 1727.7062899307148, 1731.3593970231095, 1737.4613869700433, 1738.8956662600285, 1758.454878987518, 1108.706192858893, 1161.175565348612, 1178.911581631381, 1180.6576092933126, 1184.6090790039266, 6186.566940314225, 6187.907181392283, 6198.535109866778, 6207.844803879939, 6230.813075607739, 6527.0, 6580.341965803382, 6641.734330626818, 6650.96909978954, 6653.367930046637, 6150.907736383958, 6204.286507051656, 6216.937830621636, 6232.532560058014, 6265.4361107500545, 3472.5485686860548, 3500.984714432837, 3516.6834984851484, 3533.4876442915634, 3533.6289689582222, 6917.654117294115, 6966.721331146698, 6990.300969902969, 6991.335823096798, 7012.088428504364, 6753.189617245962, 6807.625580593016, 6822.317768223138, 6822.454203663695, 6871.5189936703955, 6845.075914751545, 6905.896411553931, 6959.930400696029, 6973.58158510491, 6980.371766541036, 6454.67726613658, 6484.438646734608, 6564.4748420127235, 6642.734290628321, 6653.367930046637, 6443.710033048618, 6496.935030649633, 6520.9347906520325, 6555.4100130986535, 6577.2570268879745, 6971.44228461732, 6975.686094125878, 6979.464517806075, 6997.510174287954, 7019.227884932756, 4507.703036835036, 4981.900361992813, 4982.302477653059, 4986.15235409974, 4999.200127979506, 6464.935350646433, 6490.188726409199, 6651.567648102858, 6665.166854143232, 6692.899606505809, 6370.872582548416, 6454.41910228063, 6462.321456247027, 6479.902801457888, 6499.3175716549085, 6381.904271435839, 6401.743930242738, 6418.229812422539, 6427.807165785034, 6470.094186813944, 6324.557280990287, 6334.334894835976, 6417.197850268716, 6430.3891130342545, 6488.0, 6444.677766111582, 6464.4828413725845, 6472.870542589216, 6476.514261430506, 6533.346665333429, 6286.717097730704, 6326.912119000811, 6327.778527751507, 6349.856820873697, 6353.428191462791], "value": 5001.67924187659, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [939.6573131363298, 939.7650587353162, 952.1573407534335, 972.572068289952, 984.1978787288359, 17996.820031799678, 18928.242870285172, 18944.24223031077, 18955.905220473913, 18958.620827583458, 21128.049237784297, 21642.458938526506, 21658.566828663417, 21848.12607495698, 21939.890300548515, 1046.4715318764033, 1051.2220956492179, 1057.6245432871335, 1059.9258051936367, 1060.241927022179, 1018.684207895551, 1086.1799341497158, 1086.9565217391296, 1114.4873358255172, 1118.8265818798059, 1165.9300441973467, 1167.112994124463, 1167.2587906679234, 1167.597178973257, 1167.6380322100176, 1151.0446329546498, 1153.9192256542046, 1156.9884301156965, 1161.3554477265116, 1162.8546431696038, 851.535912927456, 851.5954921412341, 851.7955690634266, 852.4714676900361, 852.7015544559416, 19974.60050798976, 19982.80017199824, 20047.298344557872, 20189.697154542693, 20408.89795551013, 21031.05360258792, 21117.894410528002, 21322.53711201083, 21518.569628607496, 21596.56806863854, 15943.760843587355, 16215.0, 16221.837781622151, 16349.754753678704, 16388.75416868748, 3618.5657721073376, 3647.2705458908326, 3647.6352364763575, 3649.051246675857, 3650.9634903651154, 130909.34545327308, 134201.0, 135167.32416337953, 138045.0, 138056.30971845178, 16473.258703358377, 17015.829841701423, 17183.914080429517, 17337.393191238247, 17558.20988055515, 31296.687033129834, 31856.362872742415, 32087.197820054684, 32221.51667724986, 32349.191270218435, 8797.252233560219, 9013.098690130935, 9029.097090290918, 9064.184223419923, 9083.772905677411, 4217.0, 4296.7851607420125, 4297.076128632359, 4300.376445415397, 4309.332053531708, 5301.761420736076, 5506.174073888948, 5518.310211223597, 6290.433860952537, 6599.703013364314, 1177.4289469607234, 1177.4289469607234, 1198.406788639629, 1202.1825158891863, 1206.7284860906225, 697.616311028932, 741.8775901976113, 746.0301607909696, 750.1785544828405, 751.0574229342141, 12035.638930832089, 14570.0, 14812.777808332883, 14886.404543818126, 15021.549353519413, 669.6283562622693, 673.6126727131821, 685.0785693242581, 692.6121372031679, 700.2927043685914, 5689.203511508392, 5877.941220587825, 5954.166416701665, 6258.43674069336, 6263.843403914939, 115525.4223728876, 118009.0, 119884.0, 122515.0, 122701.38649306876, 105520.0, 107810.0, 108949.45525272323, 110796.0, 113185.43407282911, 92501.53749231211, 94338.0, 98618.50690746501, 100402.99597004082, 101167.0, 12300.815487767512, 12548.121631485708, 12675.30285834288, 13053.477860885458, 13297.933510332387, 46155.07689846117, 46994.76502617465, 48033.0, 48892.511074890215, 49169.26246106383, 59674.403255966885, 60017.39982600118, 60680.69659651673, 60828.39171608404, 63068.0, 19368.4189474316, 19592.51018724486, 19779.0, 19784.30754923571, 20540.17839286412, 20491.79508204899, 20825.583488330452, 20826.895865520575, 20890.164393424093, 21247.468813279793, 21201.363959081253, 21338.35984920455, 21481.355559333246, 21519.354419367442, 21526.0, 17918.283268669627, 17950.730739038663, 18345.54136146607, 18417.98701071454, 18628.06859657039, 18148.909255453636, 18442.631147377244, 18452.26190952347, 20428.489287767923, 20762.961851907043, 11652.242604230698, 13145.868541314465, 13277.867221327662, 13310.068295219242, 13849.515266965607, 14710.19093949843, 14951.626209344853, 15071.020383675026, 15203.619909502351, 15310.157941313335], "value": 9692.833206154433, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1483.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 106.0, 95.0, 106.0, 107.0, 107.0, 107.0, 110.0, 107.0, 108.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 135.0, 173.0, 119.0, 143.0, 140.0, 124.0, 173.0, 121.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 163.0, 167.0, 162.0, 163.0, 162.0, 173.0, 165.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 75.0, 178.0, 78.0, 76.0, 74.0, 89.0, 95.0, 75.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 122.0, 79.0, 78.0, 79.0, 123.0, 78.0, 77.0, 135.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 118.0, 114.0, 115.0, 116.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 148.0, 148.0, 148.0, 150.0, 150.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 48.0, 48.0, 47.0, 47.0, 52.0, 48.0, 50.0, 48.0], "value": 48.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 55.0, 55.0, 56.0, 56.0, 54.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 74.0, 75.0, 75.0, 74.0, 75.0, 82.0, 73.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 130.0, 122.0, 115.0, 127.0, 119.0, 120.0, 120.0, 122.0, 156.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 163.0, 174.0, 163.0, 173.0, 164.0, 168.0, 170.0, 167.0, 160.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 60.0, 62.0, 61.0, 61.0, 60.0, 62.0, 61.0, 71.0], "value": 62.2, "unit": "score"}]}]} 20:40:20 INFO - Return code: 0 20:40:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:40:20 INFO - # TBPL SUCCESS # 20:40:20 INFO - Running post-action listener: _package_coverage_data 20:40:20 INFO - Running post-action listener: _resource_record_post_action 20:40:20 INFO - [mozharness: 2017-07-26 03:40:20.823694Z] Finished run-tests step (success) 20:40:20 INFO - Running post-run listener: _resource_record_post_run 20:40:20 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432193536; Read time: 8; Write time: 419220 20:40:20 INFO - TinderboxPrint: CPU usage
13.1% 20:40:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 20:40:20 INFO - TinderboxPrint: I/O write bytes / time
432,193,536 / 419,220 20:40:20 INFO - TinderboxPrint: CPU idle
8,241.0 (86.9%) 20:40:20 INFO - TinderboxPrint: CPU user
1,190.3 (12.6%) 20:40:20 INFO - TinderboxPrint: Swap in / out
0 / 0 20:40:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108482560; Read time: 0; Write time: 161176 20:40:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:40:20 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 323710976; Read time: 0; Write time: 258044 20:40:21 INFO - Running post-run listener: _upload_blobber_files 20:40:21 INFO - Blob upload gear active. 20:40:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:40:21 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 20:40:21 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'] 20:40:21 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 20:40:21 INFO - (blobuploader) - INFO - Open directory for files ... 20:40:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:40:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:40:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:22 INFO - (blobuploader) - INFO - Done attempting. 20:40:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:40:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:40:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:23 INFO - (blobuploader) - INFO - Done attempting. 20:40:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:40:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:40:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:24 INFO - (blobuploader) - INFO - Done attempting. 20:40:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:40:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:40:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:31 INFO - (blobuploader) - INFO - Done attempting. 20:40:31 INFO - (blobuploader) - INFO - Iteration through files over. 20:40:31 INFO - Return code: 0 20:40:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:40:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:40:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9420c4046a91a79a248ee6734de2c276a1728e89cc6efdec70e6ea01dc32be0b2a18029dd9bcba2fc26a3141cda7d392d30126ef359772001b34f7f820e8fa06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee7b95442d7c16e51f2473bd4a69750d6d6219f0e15671b2646acafd9f0e66363d7927ae9ab68304a3404f0c8013e1358b55376ced512be24c890caeebd987fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4c54a60d3c33bf37df1b69255f5b9e0ce2426c95bd8c8a807845c9b7faa419da2440ecb82cf447e39ef75943b9870fb130efed1c776c91a99f0d138ced528b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2eddc39f252938973ad0720534dff658df26ef1b902fc59aa504e5dd587084ce75a092eaf71a50437ba6747d58e755ddd539a5ec1f51c20b9f10792ba4b144ae"} 20:40:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:40:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:40:31 INFO - Contents: 20:40:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9420c4046a91a79a248ee6734de2c276a1728e89cc6efdec70e6ea01dc32be0b2a18029dd9bcba2fc26a3141cda7d392d30126ef359772001b34f7f820e8fa06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee7b95442d7c16e51f2473bd4a69750d6d6219f0e15671b2646acafd9f0e66363d7927ae9ab68304a3404f0c8013e1358b55376ced512be24c890caeebd987fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4c54a60d3c33bf37df1b69255f5b9e0ce2426c95bd8c8a807845c9b7faa419da2440ecb82cf447e39ef75943b9870fb130efed1c776c91a99f0d138ced528b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2eddc39f252938973ad0720534dff658df26ef1b902fc59aa504e5dd587084ce75a092eaf71a50437ba6747d58e755ddd539a5ec1f51c20b9f10792ba4b144ae"} 20:40:31 INFO - Running post-run listener: copy_logs_to_upload_dir 20:40:31 INFO - Copying logs to upload dir... 20:40:31 INFO - mkdir: /builds/slave/test/build/upload/logs 20:40:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.730715 ========= master_lag: -0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-07-25 20:40:30.799966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 20:40:30.807898) ========= 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=c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9420c4046a91a79a248ee6734de2c276a1728e89cc6efdec70e6ea01dc32be0b2a18029dd9bcba2fc26a3141cda7d392d30126ef359772001b34f7f820e8fa06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee7b95442d7c16e51f2473bd4a69750d6d6219f0e15671b2646acafd9f0e66363d7927ae9ab68304a3404f0c8013e1358b55376ced512be24c890caeebd987fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4c54a60d3c33bf37df1b69255f5b9e0ce2426c95bd8c8a807845c9b7faa419da2440ecb82cf447e39ef75943b9870fb130efed1c776c91a99f0d138ced528b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2eddc39f252938973ad0720534dff658df26ef1b902fc59aa504e5dd587084ce75a092eaf71a50437ba6747d58e755ddd539a5ec1f51c20b9f10792ba4b144ae"} build_url:https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/DMqhmBp3Qdy3GrLt7kLPxA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9420c4046a91a79a248ee6734de2c276a1728e89cc6efdec70e6ea01dc32be0b2a18029dd9bcba2fc26a3141cda7d392d30126ef359772001b34f7f820e8fa06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee7b95442d7c16e51f2473bd4a69750d6d6219f0e15671b2646acafd9f0e66363d7927ae9ab68304a3404f0c8013e1358b55376ced512be24c890caeebd987fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4c54a60d3c33bf37df1b69255f5b9e0ce2426c95bd8c8a807845c9b7faa419da2440ecb82cf447e39ef75943b9870fb130efed1c776c91a99f0d138ced528b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2eddc39f252938973ad0720534dff658df26ef1b902fc59aa504e5dd587084ce75a092eaf71a50437ba6747d58e755ddd539a5ec1f51c20b9f10792ba4b144ae"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 20:40:30.837335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 20:40:30.837674) ========= 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=c6927cf182745ad25b1d38b9000001fe-1501024315.175140-136432605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 20:40:30.922454) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 20:40:30.922816) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 20:40:30.923136) ========= ========= Total master_lag: 0.09 =========