builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1505508650.7 results: success (0) revision: 6be5c7d30d2def62a762ac187252eba626b23a92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 13:50:50.699939) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 13:50:50.700340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 13:50:50.700619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 13:50:51.286604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:50:51.286876) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 13:50:51-- 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% 224M=0s 2017-09-15 13:50:51 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120475 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:50:51.424133) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:50:51.424573) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015861 ========= master_lag: 0.18 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:50:51.624849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-15 13:50:51.625148) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6be5c7d30d2def62a762ac187252eba626b23a92 --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 6be5c7d30d2def62a762ac187252eba626b23a92 --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=82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 13:50:51,686 truncating revision to first 12 chars 2017-09-15 13:50:51,686 Setting DEBUG logging. 2017-09-15 13:50:51,686 attempt 1/10 2017-09-15 13:50:51,686 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6be5c7d30d2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 13:50:52,816 unpacking tar archive at: mozilla-central-6be5c7d30d2d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.451217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-15 13:50:53.098230) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 13:50:53.098532) ========= script_repo_revision: 6be5c7d30d2def62a762ac187252eba626b23a92 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 13:50:53.098927) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 13:50:53.099195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 13:50:53.114725) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-15 13:50:53.115091) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:50:53 INFO - MultiFileLogger online at 20170915 13:50:53 in /builds/slave/test 13:50:53 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 13:50:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:53 INFO - {'append_to_log': False, 13:50:53 INFO - 'base_work_dir': '/builds/slave/test', 13:50:53 INFO - 'blob_upload_branch': 'Firefox', 13:50:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:53 INFO - 'branch': 'Firefox', 13:50:53 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:53 INFO - 'code_coverage': False, 13:50:53 INFO - 'config_files': ('talos/linux_config.py',), 13:50:53 INFO - 'default_actions': ('clobber', 13:50:53 INFO - 'read-buildbot-config', 13:50:53 INFO - 'download-and-extract', 13:50:53 INFO - 'populate-webroot', 13:50:53 INFO - 'create-virtualenv', 13:50:53 INFO - 'install', 13:50:53 INFO - 'setup-mitmproxy', 13:50:53 INFO - 'run-tests'), 13:50:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:53 INFO - 'disable_ccov_upload': False, 13:50:53 INFO - 'disable_stylo': False, 13:50:53 INFO - 'download_minidump_stackwalk': True, 13:50:53 INFO - 'download_symbols': 'ondemand', 13:50:53 INFO - 'enable_stylo': False, 13:50:53 INFO - 'enable_webrender': False, 13:50:53 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:50:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:53 INFO - 'gecko_profile': False, 13:50:53 INFO - 'gecko_profile_interval': 0, 13:50:53 INFO - 'installer_path': 'installer.exe', 13:50:53 INFO - 'log_level': 'info', 13:50:53 INFO - 'log_name': 'talos', 13:50:53 INFO - 'log_to_console': True, 13:50:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:50:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:50:53 INFO - 'opt_config_files': (), 13:50:53 INFO - 'pip_index': False, 13:50:53 INFO - 'suite': 'dromaeojs-e10s', 13:50:53 INFO - 'system_bits': '32', 13:50:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:53 INFO - 'title': 'talos-linux64-ix-066', 13:50:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:53 INFO - 'use_talos_json': True, 13:50:53 INFO - 'verify': 'False', 13:50:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:53 INFO - 'work_dir': 'build'} 13:50:53 INFO - [mozharness: 2017-09-15 20:50:53.316095Z] Running clobber step. 13:50:53 INFO - Running pre-action listener: _resource_record_pre_action 13:50:53 INFO - Running main action method: clobber 13:50:53 INFO - rmtree: /builds/slave/test/build 13:50:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:54 INFO - Running post-action listener: _resource_record_post_action 13:50:54 INFO - [mozharness: 2017-09-15 20:50:54.838063Z] Finished clobber step (success) 13:50:54 INFO - [mozharness: 2017-09-15 20:50:54.838162Z] Running read-buildbot-config step. 13:50:54 INFO - Running pre-action listener: _resource_record_pre_action 13:50:54 INFO - Running main action method: read_buildbot_config 13:50:54 INFO - Using buildbot properties: 13:50:54 INFO - { 13:50:54 INFO - "project": "", 13:50:54 INFO - "product": "firefox", 13:50:54 INFO - "who": "archaeopteryx@coole-files.de", 13:50:54 INFO - "installer_path": "public/build/target.tar.bz2", 13:50:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:50:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:50:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 13:50:54 INFO - "stage_platform": "linux64-pgo", 13:50:54 INFO - "basedir": "/builds/slave/test", 13:50:54 INFO - "buildnumber": 187, 13:50:54 INFO - "platform": "ubuntu64_hw", 13:50:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:50:54 INFO - "slavebuilddir": "test", 13:50:54 INFO - "taskId": "f7-rNx2bQm-kX5pkhJXL4A", 13:50:54 INFO - "branch": "mozilla-central", 13:50:54 INFO - "script_repo_revision": "production", 13:50:54 INFO - "revision": "6be5c7d30d2def62a762ac187252eba626b23a92", 13:50:54 INFO - "slavename": "talos-linux64-ix-066", 13:50:54 INFO - "repo_path": "mozilla-central" 13:50:54 INFO - } 13:50:54 INFO - Finding installer, test and symbols from parent task. 13:50:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f7-rNx2bQm-kX5pkhJXL4A'}, attempt #1 13:50:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f7-rNx2bQm-kX5pkhJXL4A'}, attempt #1 13:50:55 INFO - Task dependencies: Bri49bEOQiqNFL-HH0pFlw 13:50:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw'}, attempt #1 13:50:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.tar.bz2 13:50:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.test_packages.json 13:50:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.crashreporter-symbols.zip 13:50:56 INFO - Running post-action listener: _resource_record_post_action 13:50:56 INFO - [mozharness: 2017-09-15 20:50:56.255952Z] Finished read-buildbot-config step (success) 13:50:56 INFO - [mozharness: 2017-09-15 20:50:56.256172Z] Running download-and-extract step. 13:50:56 INFO - Running pre-action listener: _resource_record_pre_action 13:50:56 INFO - Running main action method: download_and_extract 13:50:56 INFO - mkdir: /builds/slave/test/build/tests 13:50:56 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')]} 13:50:56 INFO - trying https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.test_packages.json 13:50:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:50:56 INFO - Downloaded 989 bytes. 13:50:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:50:56 INFO - Using the following test package requirements: 13:50:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:50:56 INFO - u'common': [u'target.common.tests.zip'], 13:50:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:50:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:50:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:50:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:50:56 INFO - u'mozbase': [u'target.common.tests.zip'], 13:50:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:50:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:50:56 INFO - u'web-platform': [u'target.common.tests.zip', 13:50:56 INFO - u'target.web-platform.tests.tar.gz'], 13:50:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:50:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 13:50:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.common.tests.zip 13:50:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:50:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.common.tests.zip into memory 13:50:58 INFO - Content-Length response header: 55325672 13:50:58 INFO - Bytes received: 55325672 13:51:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.talos.tests.zip 13:51:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:51:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.talos.tests.zip into memory 13:51:09 INFO - Content-Length response header: 14508749 13:51:09 INFO - Bytes received: 14508749 13:51: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')]} 13:51:10 INFO - trying https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.tar.bz2 13:51:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:51:13 INFO - Downloaded 62208337 bytes. 13:51:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.tar.bz2 13:51:13 INFO - mkdir: /builds/slave/test/properties 13:51:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:51:13 INFO - Writing to file /builds/slave/test/properties/build_url 13:51:13 INFO - Contents: 13:51:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.tar.bz2 13:51:13 INFO - Running post-action listener: _resource_record_post_action 13:51:13 INFO - Running post-action listener: find_tests_for_verification 13:51:13 INFO - Running post-action listener: set_extra_try_arguments 13:51:13 INFO - [mozharness: 2017-09-15 20:51:13.655244Z] Finished download-and-extract step (success) 13:51:13 INFO - [mozharness: 2017-09-15 20:51:13.655378Z] Running populate-webroot step. 13:51:13 INFO - Running pre-action listener: _resource_record_pre_action 13:51:13 INFO - Running main action method: populate_webroot 13:51:13 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:51:13 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:13 INFO - 'tests': ['tresize', 13:51:13 INFO - 'tcanvasmark']}, 13:51:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:51:13 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:13 INFO - 'tests': ['dromaeo_css', 13:51:13 INFO - 'kraken']}, 13:51:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:51:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:13 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:51:13 INFO - 'talos_options': ['--disable-stylo'], 13:51:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:51:13 INFO - 'tests': ['damp', 'tps']}, 13:51:13 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:51:13 INFO - 'talos_options': ['--disable-stylo'], 13:51:13 INFO - 'tests': ['damp', 'tps']}, 13:51:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:51:13 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:13 INFO - 'tests': ['dromaeo_dom']}, 13:51:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:51:13 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:13 INFO - 'tests': ['basic_compositor_video', 13:51:13 INFO - 'glvideo']}, 13:51:13 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:51:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:51:13 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:51:13 INFO - 'talos_options': ['--disable-stylo'], 13:51:13 INFO - 'tests': ['ts_paint_webext', 13:51:13 INFO - 'tp5o_webext']}, 13:51:13 INFO - 'other-e10s': {'tests': ['a11yr', 13:51:13 INFO - 'ts_paint', 13:51:13 INFO - 'tpaint', 13:51:13 INFO - 'sessionrestore', 13:51:13 INFO - 'sessionrestore_many_windows', 13:51:13 INFO - 'sessionrestore_no_auto_restore', 13:51:13 INFO - 'tabpaint']}, 13:51:13 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:13 INFO - 'tests': ['a11yr', 13:51:13 INFO - 'ts_paint', 13:51:13 INFO - 'tpaint', 13:51:13 INFO - 'sessionrestore', 13:51:13 INFO - 'sessionrestore_many_windows', 13:51:13 INFO - 'sessionrestore_no_auto_restore', 13:51:13 INFO - 'tabpaint']}, 13:51:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:51:13 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 13:51:13 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:13 INFO - 'tests': ['perf_reftest_singletons']}, 13:51:13 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:13 INFO - 'tests': ['bloom_basic']}, 13:51:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:51:13 INFO - 'tsvgr_opacity', 13:51:13 INFO - 'tart', 13:51:13 INFO - 'tscrollx', 13:51:13 INFO - 'tsvg_static']}, 13:51:13 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:13 INFO - 'tests': ['tsvgx', 13:51:13 INFO - 'tsvgr_opacity', 13:51:13 INFO - 'tart', 13:51:13 INFO - 'tscrollx', 13:51:13 INFO - 'tsvg_static']}, 13:51:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:51:13 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:51:13 INFO - 'talos_options': ['--disable-stylo'], 13:51:13 INFO - 'tests': ['tp5o']}, 13:51:13 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:51:13 INFO - 'talos_options': ['--mitmproxy', 13:51:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:51:13 INFO - '--firstNonBlankPaint'], 13:51:13 INFO - 'tests': ['tp6_google', 13:51:13 INFO - 'tp6_youtube', 13:51:13 INFO - 'tp6_amazon', 13:51:13 INFO - 'tp6_facebook']}, 13:51:13 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:51:13 INFO - 'talos_options': ['--disable-stylo', 13:51:13 INFO - '--mitmproxy', 13:51:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:51:13 INFO - '--firstNonBlankPaint'], 13:51:13 INFO - 'tests': ['tp6_google', 13:51:13 INFO - 'tp6_youtube', 13:51:13 INFO - 'tp6_amazon', 13:51:13 INFO - 'tp6_facebook']}, 13:51:13 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:51:13 INFO - 'talos_options': ['--stylo-threads=1', 13:51:13 INFO - '--mitmproxy', 13:51:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:51:13 INFO - '--firstNonBlankPaint'], 13:51:13 INFO - 'tests': ['tp6_google', 13:51:13 INFO - 'tp6_youtube', 13:51:13 INFO - 'tp6_amazon', 13:51:13 INFO - 'tp6_facebook']}, 13:51:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:51:13 INFO - 'talos_options': ['--xperf_path', 13:51:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:13 INFO - 'tests': ['tp5n']}, 13:51:13 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:51:13 INFO - 'talos_options': ['--disable-stylo', 13:51:13 INFO - '--xperf_path', 13:51:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:13 INFO - 'tests': ['tp5n']}}} 13:51:13 INFO - Running post-action listener: _resource_record_post_action 13:51:13 INFO - [mozharness: 2017-09-15 20:51:13.677783Z] Finished populate-webroot step (success) 13:51:13 INFO - [mozharness: 2017-09-15 20:51:13.677873Z] Running create-virtualenv step. 13:51:13 INFO - Running pre-action listener: _resource_record_pre_action 13:51:13 INFO - Running main action method: create_virtualenv 13:51:13 INFO - Creating virtualenv /builds/slave/test/build/venv 13:51:13 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:51:13 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:51:13 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:51:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:51:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:51:14 INFO - Installing distribute.............................................................................................................................................................................................done. 13:51:14 INFO - Installing pip...............done. 13:51:14 INFO - Return code: 0 13:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:51:14 INFO - Reading from file tmpfile_stdout 13:51:14 INFO - Output received: 13:51:14 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:51:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51: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')]} 13:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51: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 0x1af61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66090>, '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 0x1e66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e60f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', '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 13:51: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 13:51: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 13:51:14 INFO - Using env: {'DISPLAY': ':0', 13:51:14 INFO - 'HOME': '/home/cltbld', 13:51:14 INFO - 'LANG': 'en_US.UTF-8', 13:51:14 INFO - 'LANGUAGE': 'en_US:en', 13:51:14 INFO - 'LOGNAME': 'cltbld', 13:51:14 INFO - 'MAIL': '/var/mail/cltbld', 13:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:14 INFO - 'MOZ_NO_REMOTE': '1', 13:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:14 INFO - 'NO_EM_RESTART': '1', 13:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:14 INFO - 'PWD': '/builds/slave/test', 13:51:14 INFO - 'SHELL': '/bin/bash', 13:51:14 INFO - 'SHLVL': '1', 13:51:14 INFO - 'TERM': 'linux', 13:51:14 INFO - 'TMOUT': '86400', 13:51:14 INFO - 'USER': 'cltbld', 13:51:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 13:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:14 INFO - '_': '/tools/buildbot/bin/python'} 13:51:15 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:51:15 INFO - Downloading/unpacking pip>=1.5 13:51:15 INFO - Running setup.py egg_info for package pip 13:51:15 INFO - warning: no files found matching 'pip/cacert.pem' 13:51:15 INFO - warning: no files found matching '*.html' under directory 'docs' 13:51:15 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:51:15 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:51:15 INFO - Installing collected packages: pip 13:51:15 INFO - Found existing installation: pip 1.1 13:51:15 INFO - Uninstalling pip: 13:51:15 INFO - Successfully uninstalled pip 13:51:15 INFO - Running setup.py install for pip 13:51:15 INFO - warning: no files found matching 'pip/cacert.pem' 13:51:15 INFO - warning: no files found matching '*.html' under directory 'docs' 13:51:15 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:51:15 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:51:15 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:51:15 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:51:15 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:51:15 INFO - Successfully installed pip 13:51:15 INFO - Cleaning up... 13:51:15 INFO - Return code: 0 13:51:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:51:15 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')]} 13:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:15 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')]} 13:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:15 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 0x1af61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66090>, '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 0x1e66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e60f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', '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 13:51:15 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 13:51:15 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 13:51:15 INFO - Using env: {'DISPLAY': ':0', 13:51:15 INFO - 'HOME': '/home/cltbld', 13:51:15 INFO - 'LANG': 'en_US.UTF-8', 13:51:15 INFO - 'LANGUAGE': 'en_US:en', 13:51:15 INFO - 'LOGNAME': 'cltbld', 13:51:15 INFO - 'MAIL': '/var/mail/cltbld', 13:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:15 INFO - 'MOZ_NO_REMOTE': '1', 13:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:15 INFO - 'NO_EM_RESTART': '1', 13:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:15 INFO - 'PWD': '/builds/slave/test', 13:51:15 INFO - 'SHELL': '/bin/bash', 13:51:15 INFO - 'SHLVL': '1', 13:51:15 INFO - 'TERM': 'linux', 13:51:15 INFO - 'TMOUT': '86400', 13:51:15 INFO - 'USER': 'cltbld', 13:51:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 13:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:15 INFO - '_': '/tools/buildbot/bin/python'} 13:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:16 INFO - Downloading/unpacking psutil>=3.1.1 13:51: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 13:51: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 13:51: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 13:51: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 13:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:51:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:17 INFO - Installing collected packages: psutil 13:51:17 INFO - Running setup.py install for psutil 13:51:17 INFO - building 'psutil._psutil_linux' extension 13:51:17 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 13:51:17 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 13:51:17 INFO - building 'psutil._psutil_posix' extension 13:51:17 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 13:51:17 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 13:51:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:17 INFO - Successfully installed psutil 13:51:17 INFO - Cleaning up... 13:51:17 INFO - Return code: 0 13:51:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51: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')]} 13:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66090>, '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 0x1e66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e60f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', '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 13:51: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:51: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 mozsystemmonitor==0.3 13:51:17 INFO - Using env: {'DISPLAY': ':0', 13:51:17 INFO - 'HOME': '/home/cltbld', 13:51:17 INFO - 'LANG': 'en_US.UTF-8', 13:51:17 INFO - 'LANGUAGE': 'en_US:en', 13:51:17 INFO - 'LOGNAME': 'cltbld', 13:51:17 INFO - 'MAIL': '/var/mail/cltbld', 13:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:17 INFO - 'MOZ_NO_REMOTE': '1', 13:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:17 INFO - 'NO_EM_RESTART': '1', 13:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:17 INFO - 'PWD': '/builds/slave/test', 13:51:17 INFO - 'SHELL': '/bin/bash', 13:51:17 INFO - 'SHLVL': '1', 13:51:17 INFO - 'TERM': 'linux', 13:51:17 INFO - 'TMOUT': '86400', 13:51:17 INFO - 'USER': 'cltbld', 13:51:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 13:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:17 INFO - '_': '/tools/buildbot/bin/python'} 13:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:51: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 13:51: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 13:51: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 13:51: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 13:51:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:51:19 INFO - Installing collected packages: mozsystemmonitor 13:51:19 INFO - Running setup.py install for mozsystemmonitor 13:51:19 INFO - Successfully installed mozsystemmonitor 13:51:19 INFO - Cleaning up... 13:51:20 INFO - Return code: 0 13:51:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:51:20 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')]} 13:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:20 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')]} 13:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:20 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 0x1af61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66090>, '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 0x1e66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e60f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', '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 13:51:20 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 13:51:20 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 13:51:20 INFO - Using env: {'DISPLAY': ':0', 13:51:20 INFO - 'HOME': '/home/cltbld', 13:51:20 INFO - 'LANG': 'en_US.UTF-8', 13:51:20 INFO - 'LANGUAGE': 'en_US:en', 13:51:20 INFO - 'LOGNAME': 'cltbld', 13:51:20 INFO - 'MAIL': '/var/mail/cltbld', 13:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:20 INFO - 'MOZ_NO_REMOTE': '1', 13:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:20 INFO - 'NO_EM_RESTART': '1', 13:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:20 INFO - 'PWD': '/builds/slave/test', 13:51:20 INFO - 'SHELL': '/bin/bash', 13:51:20 INFO - 'SHLVL': '1', 13:51:20 INFO - 'TERM': 'linux', 13:51:20 INFO - 'TMOUT': '86400', 13:51:20 INFO - 'USER': 'cltbld', 13:51:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 13:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:20 INFO - '_': '/tools/buildbot/bin/python'} 13:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:20 INFO - Downloading/unpacking jsonschema==2.5.1 13:51: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 13:51: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 13:51: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 13:51: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 13:51:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:51:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:51: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 13:51: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 13:51: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 13:51: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 13:51:21 INFO - Downloading functools32-3.2.3-2.tar.gz 13:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:51:21 INFO - warning: no files found matching '*.txt' 13:51:21 INFO - no previously-included directories found matching 'build' 13:51:21 INFO - no previously-included directories found matching 'dist' 13:51:21 INFO - no previously-included directories found matching '.git*' 13:51:21 INFO - Installing collected packages: jsonschema, functools32 13:51:22 INFO - Running setup.py install for functools32 13:51:24 INFO - warning: no files found matching '*.txt' 13:51:24 INFO - no previously-included directories found matching 'build' 13:51:24 INFO - no previously-included directories found matching 'dist' 13:51:24 INFO - no previously-included directories found matching '.git*' 13:51:24 INFO - Successfully installed jsonschema functools32 13:51:24 INFO - Cleaning up... 13:51:24 INFO - Return code: 0 13:51:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:51:24 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')]} 13:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:24 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')]} 13:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:24 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 0x1af61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66090>, '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 0x1e66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e60f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', '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 13:51:24 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 13:51:24 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 13:51:24 INFO - Using env: {'DISPLAY': ':0', 13:51:24 INFO - 'HOME': '/home/cltbld', 13:51:24 INFO - 'LANG': 'en_US.UTF-8', 13:51:24 INFO - 'LANGUAGE': 'en_US:en', 13:51:24 INFO - 'LOGNAME': 'cltbld', 13:51:24 INFO - 'MAIL': '/var/mail/cltbld', 13:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:24 INFO - 'MOZ_NO_REMOTE': '1', 13:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:24 INFO - 'NO_EM_RESTART': '1', 13:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:24 INFO - 'PWD': '/builds/slave/test', 13:51:24 INFO - 'SHELL': '/bin/bash', 13:51:24 INFO - 'SHLVL': '1', 13:51:24 INFO - 'TERM': 'linux', 13:51:24 INFO - 'TMOUT': '86400', 13:51:24 INFO - 'USER': 'cltbld', 13:51:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 13:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:24 INFO - '_': '/tools/buildbot/bin/python'} 13:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:51:24 INFO - Cleaning up... 13:51:24 INFO - Return code: 0 13:51:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:51:24 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')]} 13:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:24 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')]} 13:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:24 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 0x1af61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66090>, '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 0x1e66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e60f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', '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 13:51:24 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 13:51:24 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 13:51:24 INFO - Using env: {'DISPLAY': ':0', 13:51:24 INFO - 'HOME': '/home/cltbld', 13:51:24 INFO - 'LANG': 'en_US.UTF-8', 13:51:24 INFO - 'LANGUAGE': 'en_US:en', 13:51:24 INFO - 'LOGNAME': 'cltbld', 13:51:24 INFO - 'MAIL': '/var/mail/cltbld', 13:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:24 INFO - 'MOZ_NO_REMOTE': '1', 13:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:24 INFO - 'NO_EM_RESTART': '1', 13:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:24 INFO - 'PWD': '/builds/slave/test', 13:51:24 INFO - 'SHELL': '/bin/bash', 13:51:24 INFO - 'SHLVL': '1', 13:51:24 INFO - 'TERM': 'linux', 13:51:24 INFO - 'TMOUT': '86400', 13:51:24 INFO - 'USER': 'cltbld', 13:51:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 13:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:24 INFO - '_': '/tools/buildbot/bin/python'} 13:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:24 INFO - Downloading/unpacking blobuploader==1.2.4 13:51:24 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 13:51:24 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 13:51:24 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 13:51:24 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 13:51:26 INFO - Downloading blobuploader-1.2.4.tar.gz 13:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:51:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:26 INFO - Downloading docopt-0.6.1.tar.gz 13:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:26 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:26 INFO - Running setup.py install for blobuploader 13:51:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:26 INFO - Running setup.py install for requests 13:51:27 INFO - Running setup.py install for docopt 13:51:27 INFO - Successfully installed blobuploader requests docopt 13:51:27 INFO - Cleaning up... 13:51:27 INFO - Return code: 0 13:51:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:27 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')]} 13:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:27 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')]} 13:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:27 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 0x1af61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66090>, '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 0x1e66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e60f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', '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 13:51:27 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 13:51:27 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 13:51:27 INFO - Using env: {'DISPLAY': ':0', 13:51:27 INFO - 'HOME': '/home/cltbld', 13:51:27 INFO - 'LANG': 'en_US.UTF-8', 13:51:27 INFO - 'LANGUAGE': 'en_US:en', 13:51:27 INFO - 'LOGNAME': 'cltbld', 13:51:27 INFO - 'MAIL': '/var/mail/cltbld', 13:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:27 INFO - 'MOZ_NO_REMOTE': '1', 13:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:27 INFO - 'NO_EM_RESTART': '1', 13:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:27 INFO - 'PWD': '/builds/slave/test', 13:51:27 INFO - 'SHELL': '/bin/bash', 13:51:27 INFO - 'SHLVL': '1', 13:51:27 INFO - 'TERM': 'linux', 13:51:27 INFO - 'TMOUT': '86400', 13:51:27 INFO - 'USER': 'cltbld', 13:51:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 13:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:27 INFO - '_': '/tools/buildbot/bin/python'} 13:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:27 INFO - Running setup.py (path:/tmp/pip-tbicGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:27 INFO - Running setup.py (path:/tmp/pip-JRLNyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:27 INFO - Running setup.py (path:/tmp/pip-zaeaub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:27 INFO - Running setup.py (path:/tmp/pip-sKbQgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:27 INFO - Running setup.py (path:/tmp/pip-4GZZbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:27 INFO - Running setup.py (path:/tmp/pip-Yyg0N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:27 INFO - Running setup.py (path:/tmp/pip-_9jGKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:27 INFO - Running setup.py (path:/tmp/pip-Dn_IqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:28 INFO - Running setup.py (path:/tmp/pip-MGCb7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:28 INFO - Running setup.py (path:/tmp/pip-BRvPhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:28 INFO - Running setup.py (path:/tmp/pip-mURi3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:28 INFO - Running setup.py (path:/tmp/pip-YsSMXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:28 INFO - Running setup.py (path:/tmp/pip-hyHhb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:28 INFO - Running setup.py (path:/tmp/pip-2kLT0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:28 INFO - Running setup.py (path:/tmp/pip-0HjYYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:28 INFO - Running setup.py (path:/tmp/pip-DCcDv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:28 INFO - Running setup.py (path:/tmp/pip-LVlXg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:28 INFO - Running setup.py install for manifestparser 13:51:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:28 INFO - Running setup.py install for mozcrash 13:51:28 INFO - Running setup.py install for mozdebug 13:51:28 INFO - Running setup.py install for mozdevice 13:51:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:29 INFO - Running setup.py install for mozfile 13:51:29 INFO - Running setup.py install for mozhttpd 13:51:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:29 INFO - Running setup.py install for mozinfo 13:51:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:29 INFO - Running setup.py install for mozInstall 13:51:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:29 INFO - Running setup.py install for mozleak 13:51:29 INFO - Running setup.py install for mozlog 13:51:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:29 INFO - Running setup.py install for moznetwork 13:51:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:29 INFO - Running setup.py install for mozprocess 13:51:29 INFO - Running setup.py install for mozprofile 13:51:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:30 INFO - Running setup.py install for mozrunner 13:51:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:30 INFO - Running setup.py install for mozscreenshot 13:51:30 INFO - Running setup.py install for moztest 13:51:30 INFO - Running setup.py install for mozversion 13:51:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:30 INFO - Cleaning up... 13:51:30 INFO - Return code: 0 13:51:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:30 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')]} 13:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:30 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')]} 13:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:30 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 0x1af61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66090>, '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 0x1e66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e60f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', '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 13:51:30 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 13:51:30 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 13:51:30 INFO - Using env: {'DISPLAY': ':0', 13:51:30 INFO - 'HOME': '/home/cltbld', 13:51:30 INFO - 'LANG': 'en_US.UTF-8', 13:51:30 INFO - 'LANGUAGE': 'en_US:en', 13:51:30 INFO - 'LOGNAME': 'cltbld', 13:51:30 INFO - 'MAIL': '/var/mail/cltbld', 13:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:30 INFO - 'MOZ_NO_REMOTE': '1', 13:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:30 INFO - 'NO_EM_RESTART': '1', 13:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:30 INFO - 'PWD': '/builds/slave/test', 13:51:30 INFO - 'SHELL': '/bin/bash', 13:51:30 INFO - 'SHLVL': '1', 13:51:30 INFO - 'TERM': 'linux', 13:51:30 INFO - 'TMOUT': '86400', 13:51:30 INFO - 'USER': 'cltbld', 13:51:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 13:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:30 INFO - '_': '/tools/buildbot/bin/python'} 13:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:30 INFO - Running setup.py (path:/tmp/pip-rtEzzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:30 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)) 13:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:30 INFO - Running setup.py (path:/tmp/pip-LZASO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:30 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)) 13:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:30 INFO - Running setup.py (path:/tmp/pip-ZsI2TU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:30 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)) 13:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:30 INFO - Running setup.py (path:/tmp/pip-nmx5wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:30 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)) 13:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:30 INFO - Running setup.py (path:/tmp/pip-zkVL5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:31 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)) 13:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:31 INFO - Running setup.py (path:/tmp/pip-GG2T3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:31 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)) 13:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:31 INFO - Running setup.py (path:/tmp/pip-qDxpq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:31 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)) 13:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:31 INFO - Running setup.py (path:/tmp/pip-ZppdIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:31 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)) 13:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:31 INFO - Running setup.py (path:/tmp/pip-tznU3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:31 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)) 13:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:31 INFO - Running setup.py (path:/tmp/pip-hlCsWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:31 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)) 13:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:31 INFO - Running setup.py (path:/tmp/pip-uIN79t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:31 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)) 13:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:31 INFO - Running setup.py (path:/tmp/pip-joWjbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:31 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)) 13:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:31 INFO - Running setup.py (path:/tmp/pip-PgSsk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:31 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)) 13:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:31 INFO - Running setup.py (path:/tmp/pip-JePxyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:31 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)) 13:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:31 INFO - Running setup.py (path:/tmp/pip-l3KUyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:31 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)) 13:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:31 INFO - Running setup.py (path:/tmp/pip-7UeI2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:31 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)) 13:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:31 INFO - Running setup.py (path:/tmp/pip-puaU3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:31 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)) 13:51:31 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)) 13:51:31 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)) 13:51:31 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)) 13:51:31 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)) 13:51:31 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)) 13:51:31 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)) 13:51:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:31 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 13:51:31 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 13:51:31 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 13:51:31 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 13:51:32 INFO - Downloading blessings-1.6.tar.gz 13:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:33 INFO - Installing collected packages: blessings 13:51:33 INFO - Running setup.py install for blessings 13:51:33 INFO - Successfully installed blessings 13:51:33 INFO - Cleaning up... 13:51:33 INFO - Return code: 0 13:51:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:33 INFO - Reading from file tmpfile_stdout 13:51:33 INFO - Current package versions: 13:51:33 INFO - argparse == 1.2.1 13:51:33 INFO - blessings == 1.6 13:51:33 INFO - blobuploader == 1.2.4 13:51:33 INFO - docopt == 0.6.1 13:51:33 INFO - functools32 == 3.2.3-2 13:51:33 INFO - jsonschema == 2.5.1 13:51:33 INFO - manifestparser == 1.1 13:51:33 INFO - mozInstall == 1.13 13:51:33 INFO - mozcrash == 1.0 13:51:33 INFO - mozdebug == 0.1 13:51:33 INFO - mozdevice == 0.51 13:51:33 INFO - mozfile == 1.2 13:51:33 INFO - mozhttpd == 0.7 13:51:33 INFO - mozinfo == 0.10 13:51:33 INFO - mozleak == 0.1 13:51:33 INFO - mozlog == 3.5 13:51:33 INFO - moznetwork == 0.27 13:51:33 INFO - mozprocess == 0.25 13:51:33 INFO - mozprofile == 0.28 13:51:33 INFO - mozrunner == 6.13 13:51:33 INFO - mozscreenshot == 0.1 13:51:33 INFO - mozsystemmonitor == 0.3 13:51:33 INFO - moztest == 0.8 13:51:33 INFO - mozversion == 1.4 13:51:33 INFO - psutil == 3.1.1 13:51:33 INFO - requests == 1.2.3 13:51:33 INFO - wsgiref == 0.1.2 13:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:33 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 0x1af61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66090>, '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 0x1e66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e60f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', '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 13:51:33 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 13:51:33 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 13:51:33 INFO - Using env: {'DISPLAY': ':0', 13:51:33 INFO - 'HOME': '/home/cltbld', 13:51:33 INFO - 'LANG': 'en_US.UTF-8', 13:51:33 INFO - 'LANGUAGE': 'en_US:en', 13:51:33 INFO - 'LOGNAME': 'cltbld', 13:51:33 INFO - 'MAIL': '/var/mail/cltbld', 13:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:33 INFO - 'MOZ_NO_REMOTE': '1', 13:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:33 INFO - 'NO_EM_RESTART': '1', 13:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:33 INFO - 'PWD': '/builds/slave/test', 13:51:33 INFO - 'SHELL': '/bin/bash', 13:51:33 INFO - 'SHLVL': '1', 13:51:33 INFO - 'TERM': 'linux', 13:51:33 INFO - 'TMOUT': '86400', 13:51:33 INFO - 'USER': 'cltbld', 13:51:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 13:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:33 INFO - '_': '/tools/buildbot/bin/python'} 13:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:33 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)) 13:51:33 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)) 13:51:33 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)) 13:51:33 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)) 13:51:33 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)) 13:51:33 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)) 13:51:33 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)) 13:51:33 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)) 13:51:33 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)) 13:51:33 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:51:34 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)) 13:51:34 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)) 13:51:34 INFO - Installing collected packages: simplejson 13:51:34 INFO - Running setup.py install for simplejson 13:51:34 INFO - building 'simplejson._speedups' extension 13:51:34 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 13:51:35 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 13:51:35 INFO - Successfully installed simplejson 13:51:35 INFO - Cleaning up... 13:51:35 INFO - Return code: 0 13:51:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:35 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')]} 13:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:35 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')]} 13:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:35 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 0x1af61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66090>, '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 0x1e66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e60f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', '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 13:51:35 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 13:51:35 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 13:51:35 INFO - Using env: {'DISPLAY': ':0', 13:51:35 INFO - 'HOME': '/home/cltbld', 13:51:35 INFO - 'LANG': 'en_US.UTF-8', 13:51:35 INFO - 'LANGUAGE': 'en_US:en', 13:51:35 INFO - 'LOGNAME': 'cltbld', 13:51:35 INFO - 'MAIL': '/var/mail/cltbld', 13:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:35 INFO - 'MOZ_NO_REMOTE': '1', 13:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:35 INFO - 'NO_EM_RESTART': '1', 13:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:35 INFO - 'PWD': '/builds/slave/test', 13:51:35 INFO - 'SHELL': '/bin/bash', 13:51:35 INFO - 'SHLVL': '1', 13:51:35 INFO - 'TERM': 'linux', 13:51:35 INFO - 'TMOUT': '86400', 13:51:35 INFO - 'USER': 'cltbld', 13:51:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 13:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:35 INFO - '_': '/tools/buildbot/bin/python'} 13:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:36 INFO - Cleaning up... 13:51:36 INFO - Return code: 0 13:51:36 INFO - Running post-action listener: _resource_record_post_action 13:51:36 INFO - Running post-action listener: _start_resource_monitoring 13:51:36 INFO - Starting resource monitoring. 13:51:36 INFO - [mozharness: 2017-09-15 20:51:36.166269Z] Finished create-virtualenv step (success) 13:51:36 INFO - [mozharness: 2017-09-15 20:51:36.166781Z] Running install step. 13:51:36 INFO - Running pre-action listener: _resource_record_pre_action 13:51:36 INFO - Running main action method: install 13:51:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:36 INFO - Reading from file tmpfile_stdout 13:51:36 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:36 INFO - Reading from file tmpfile_stdout 13:51:36 INFO - Output received: 13:51:36 INFO - Usage: mozinstall [options] installer 13:51:36 INFO - Options: 13:51:36 INFO - -h, --help show this help message and exit 13:51:36 INFO - -d DEST, --destination=DEST 13:51:36 INFO - Directory to install application into. [default: 13:51:36 INFO - "/builds/slave/test"] 13:51:36 INFO - --app=APP Application being installed. [default: firefox] 13:51:36 INFO - mkdir: /builds/slave/test/build/application 13:51:36 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'] 13:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:51:54 INFO - Reading from file tmpfile_stdout 13:51:54 INFO - Output received: 13:51:54 INFO - /builds/slave/test/build/application/firefox/firefox 13:51:54 INFO - Running post-action listener: _resource_record_post_action 13:51:54 INFO - [mozharness: 2017-09-15 20:51:54.195867Z] Finished install step (success) 13:51:54 INFO - [mozharness: 2017-09-15 20:51:54.196206Z] Running setup-mitmproxy step. 13:51:54 INFO - Running pre-action listener: _resource_record_pre_action 13:51:54 INFO - Running main action method: setup_mitmproxy 13:51:54 INFO - Skipping: mitmproxy is not required 13:51:54 INFO - Running post-action listener: _resource_record_post_action 13:51:54 INFO - [mozharness: 2017-09-15 20:51:54.197877Z] Finished setup-mitmproxy step (success) 13:51:54 INFO - [mozharness: 2017-09-15 20:51:54.198189Z] Running run-tests step. 13:51:54 INFO - Running pre-action listener: _resource_record_pre_action 13:51:54 INFO - Running pre-action listener: _set_gcov_prefix 13:51:54 INFO - Running main action method: run_tests 13:51:54 WARNING - Try message not found. 13:51:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:51:54 INFO - Python 2.7.3 13:51:54 INFO - Return code: 0 13:51:54 INFO - grabbing minidump binary from tooltool 13:51:54 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')]} 13:51:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x1e66090>, '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 0x1e66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e60f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:51:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 13:51:54 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:51:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 13:51:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:51:54 INFO - Return code: 0 13:51:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:51:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:51:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:51:54 INFO - ENV: RUST_BACKTRACE is now full 13:51:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:51:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:51:54 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/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 13:51:54 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/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 13:51:54 INFO - Using env: {'DISPLAY': ':0', 13:51:54 INFO - 'HOME': '/home/cltbld', 13:51:54 INFO - 'LANG': 'en_US.UTF-8', 13:51:54 INFO - 'LANGUAGE': 'en_US:en', 13:51:54 INFO - 'LOGNAME': 'cltbld', 13:51:54 INFO - 'MAIL': '/var/mail/cltbld', 13:51:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:51:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:54 INFO - 'MOZ_NO_REMOTE': '1', 13:51:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:54 INFO - 'NO_EM_RESTART': '1', 13:51:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:54 INFO - 'PWD': '/builds/slave/test', 13:51:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:51:54 INFO - 'RUST_BACKTRACE': 'full', 13:51:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:51:54 INFO - 'SHELL': '/bin/bash', 13:51:54 INFO - 'SHLVL': '1', 13:51:54 INFO - 'TERM': 'linux', 13:51:54 INFO - 'TMOUT': '86400', 13:51:54 INFO - 'USER': 'cltbld', 13:51:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 13:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:54 INFO - '_': '/tools/buildbot/bin/python'} 13:51:54 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/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 13:51:54 INFO - mozversion application_buildid: 20170915193347 13:51:54 INFO - mozversion application_changeset: 6be5c7d30d2def62a762ac187252eba626b23a92 13:51:54 INFO - mozversion application_display_name: Nightly 13:51:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:51:54 INFO - mozversion application_name: Firefox 13:51:54 INFO - mozversion application_remotingname: firefox 13:51:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:51:54 INFO - mozversion application_vendor: Mozilla 13:51:54 INFO - mozversion application_version: 57.0a1 13:51:54 INFO - mozversion platform_buildid: 20170915193347 13:51:54 INFO - mozversion platform_changeset: 6be5c7d30d2def62a762ac187252eba626b23a92 13:51:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:51:54 INFO - mozversion platform_version: 57.0a1 13:51:54 INFO - using testdate: 1505508714 13:51:54 INFO - actual date: 1505508714 13:51:54 INFO - starting webserver on 'localhost:51818' 13:51:54 INFO - SUITE-START | Running 2 tests 13:51:54 INFO - TEST-START | dromaeo_css 13:51:54 INFO - Initialising browser for dromaeo_css test... 13:51:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51818/getInfo.html -profile /tmp/tmpZGTKnv/profile 13:51:54 INFO - TEST-INFO | started process 5758 (/builds/slave/test/build/application/firefox/firefox http://localhost:51818/getInfo.html) 13:52:00 INFO - TEST-INFO | 5758: exit 0 13:52:00 INFO - Browser initialized. 13:52:00 INFO - Running cycle 1/1 for dromaeo_css test... 13:52:00 INFO - Using env: {'DISPLAY': ':0', 13:52:00 INFO - 'HOME': '/home/cltbld', 13:52:00 INFO - 'JSGC_DISABLE_POISONING': '1', 13:52:00 INFO - 'LANG': 'en_US.UTF-8', 13:52:00 INFO - 'LANGUAGE': 'en_US:en', 13:52:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:52:00 INFO - 'LOGNAME': 'cltbld', 13:52:00 INFO - 'MAIL': '/var/mail/cltbld', 13:52:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:52:00 INFO - 'MOZ_CRASHREPORTER': '1', 13:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:52:00 INFO - 'MOZ_NO_REMOTE': '1', 13:52:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:00 INFO - 'NO_EM_RESTART': '1', 13:52:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:00 INFO - 'PWD': '/builds/slave/test', 13:52:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:00 INFO - 'RUST_BACKTRACE': 'full', 13:52:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:52:00 INFO - 'SHELL': '/bin/bash', 13:52:00 INFO - 'SHLVL': '1', 13:52:00 INFO - 'TERM': 'linux', 13:52:00 INFO - 'TMOUT': '86400', 13:52:00 INFO - 'USER': 'cltbld', 13:52:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 13:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:00 INFO - '_': '/tools/buildbot/bin/python'} 13:52:00 INFO - TEST-INFO | started process 5995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZGTKnv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:01 INFO - PID 5995 | 13:52:01 INFO - PID 5995 | (/builds/slave/test/build/application/firefox/firefox:6044): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:52:01 INFO - PID 5995 | 13:52:12 INFO - PID 5995 | RSS: Main: 164929536 13:52:12 INFO - PID 5995 | 13:55:09 INFO - PID 5995 | Cycle 1(1): loaded http://localhost:51818/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51818/tests/dromaeo/cssquery-ext.html) 13:55:10 INFO - PID 5995 | RSS: Main: 168808448 13:55:10 INFO - PID 5995 | 13:58:11 INFO - PID 5995 | Cycle 1(1): loaded http://localhost:51818/tests/dromaeo/cssquery-ext.html (next: http://localhost:51818/tests/dromaeo/cssquery-jquery.html) 13:58:12 INFO - PID 5995 | RSS: Main: 164532224 13:58:12 INFO - PID 5995 | 14:01:14 INFO - PID 5995 | Cycle 1(1): loaded http://localhost:51818/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51818/tests/dromaeo/cssquery-mootools.html) 14:01:14 INFO - PID 5995 | RSS: Main: 167288832 14:01:14 INFO - PID 5995 | 14:04:16 INFO - PID 5995 | Cycle 1(1): loaded http://localhost:51818/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51818/tests/dromaeo/cssquery-prototype.html) 14:04:17 INFO - PID 5995 | RSS: Main: 165076992 14:04:17 INFO - PID 5995 | 14:07:20 INFO - PID 5995 | Cycle 1(1): loaded http://localhost:51818/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51818/tests/dromaeo/cssquery-yui.html) 14:07:20 INFO - PID 5995 | RSS: Main: 166490112 14:07:20 INFO - PID 5995 | 14:10:22 INFO - PID 5995 | Cycle 1(1): loaded http://localhost:51818/tests/dromaeo/cssquery-yui.html (next: http://localhost:51818/tests/dromaeo/cssquery-dojo.html) 14:10:22 INFO - PID 5995 | RSS: Main: 169811968 14:10:22 INFO - PID 5995 | 14:10:22 INFO - PID 5995 | __start_tp_report 14:10:22 INFO - PID 5995 | _x_x_mozilla_page_load 14:10:22 INFO - PID 5995 | _x_x_mozilla_page_load_details 14:10:22 INFO - PID 5995 | |i|pagename|runs| 14:10:22 INFO - PID 5995 | |0;dojo.html;3799.1641838795454;3803.7527560708536;3868.3230434673933;3893.4743809585734;3907.4529565860785;6233.501319894409;6270.561060725751;6277.5605707600425;6286.591371560851;6397.456216221615;6250.40621140992;6293.087502312162;6321.620702757827;6345.397187267202;6371.776987805428;5646.632968857031;5726.685032323241;5733.082706766918;5760.4815566599;5773.971130144364;142.03743768225;5705.2012718219485;5750.482456578907;5794.855128621776;5801.419858014207;5693.032184528619;5695.572832037593;5707.571932105088;5725.026745453283;5726.455986681259;5611.494965453088;5614;5691.174779656926;5702.800401985952;5715.742791574347;5613.4386561343945;5619.719014049322;5690.231818704505;5705.77176912923;5706;6263.24841019076;6265.279492858334;6273.05904114382;6319.778807741707;6342.985122380397;6763.526553141282;6796.966015169893;6801.523893327469;6852.828679283008;6893.7931862044215;6827.283135270774;6891.104156459628;6892.965535172292;6903.9989201565495;6905.343992320722;6336.746530138835;6339.0808332791485;6389.073584330246;6424.614523128627;6434.099226108348;6982.685779139951;7026.683799229047;7076.540024898468;7081.433485321162;7090.042844216068;6702.597844129368;6723.294054124344;6737.663116844138;6739.056532085512;6808.080909077211;6848.7260509579055;6852.588844669336;6853.965730171317;6857.451403887677;6861.656917154122;6765.188177418643;6818.147731533559;6837.453003759687;6847.657617119125;6855.760048398282;6727.293634168342;6728.629925354055;6748.460123190133;6804.421624161902;6839;4889.828855990095;4946.060248552763;4957.950420495821;4967.751612419437;4968.801247950114;4475.060237350128;4512.481064677539;4555.066211426716;4558.680892337571;4559.110973360163;6229.750809967551;6233.438990490878;6302.684865756693;6321.115043893767;6326.810195694136;6721.563098398588;6729.899051514231;6806.591604503746;6810.761623343258;6811.557248778813;6211.211036844169;6259.123722678738;6261.78083767066;6296.748130074746;6333.714982825784;5483.725813709379;5491.066518691832;5501.669899806025;5514;5519.337679478488;6988.161420629557;6993.685284162225;7108.644567771591;7109.8933515997305;7114.430845532345;6740.191177058784;6743.797686069426;6753.86492270142;6845.315468453115;6846.486513511407;7017.614031228127;7054.823629409306;7091.432685385053;7119.537230080028;7127.536710113826;6751.831204219934;6754.696038678369;6779.796606101825;6792.93207067923;6805.829854253683;6815.250322464426;6816.113905192294;6889.276625954202;6893.931060689329;6925.272846351262;6545.410913017851;6550.967245163743;6570.737170513317;6635.402813746786;6659.467242620675;6497.772577959749;6559.048937904073;6621;6641.369069938348;6653.301403352772;6384.297727249906;6448.097266382804;6534.803955881332;6548.83627909287;6554.672266386757;6558.672066396756;6608.207015158212;6627.900581491378;6652.567583107082;6684.06423100776;6321.652309122858;6346.2067241594805;6426.518011149089;6430.164078669743;6460.095586617783 14:10:22 INFO - PID 5995 | |1;ext.html;944.8866136063673;946.191006689281;970.8543718442232;987.8024395120977;995.2734503812214;44292.11415771687;44704.55295447045;44706.776466117706;44894.775526122365;45153.322700159486;42881.57118428822;43039.78480107603;43056;43079.56920430795;43107.35338969918;7574.053243344596;7735.30382265596;7736.613169341538;7765.767026989171;7768.65041073153;7536.321731044205;7587.317141457268;7598.9620051899665;7604.391648668094;7617.085949686046;7584.203658615821;7603.163651998276;7605.695772169107;8214.794630134265;8410.201030902055;8318.83362332753;8372.41393102483;8375.62309696062;8393.53835539045;8407.285380742644;7980.600969951479;8167.183281671785;8168.469049511763;8250.834983300361;8255.215754503373;40763.38854917179;40895.59104408947;41114;41283.174336513104;41309;3758.229562939591;3790.9431358529646;3805.4101614249835;3836.673882719972;3852.191039881628;33966.83016584926;34115.31769364623;34187.31625367504;34218.82890585556;34222.315553688786;5452.836414907559;5498.642588231752;5511.311086114236;5554.888902221933;5566.332040155207;212513;213181;214770;214781;215559;51723.482765171866;52280.47719522756;52430.47569524332;52743.73628131835;52868.471315287126;54302.45697543053;54413.72793136009;54482;54511.45488545143;54535.45464545383;16648.833511664972;16853.073080980663;16881.577960551083;16905.49283521496;16926.576835578962;13667.658308542366;13670.17978921268;13677.726445471035;13761.724765504834;13772.655683607789;14518.491852785102;14782.334794934253;14786.408543658134;14832.851671483148;15015.699686006219;5729.140628905698;5893.469587737124;5931.703414829241;5934.495567876779;5952.255968003999;1091.6343025086685;1106.5076041161606;1111.3165403277087;1124.3984468309416;1130.0846314485293;25160;25216.621750673756;25230.304757049274;25322.1137260195;25415.959252971064;1205.7528206717602;1207.9939600301943;1220.9206401584047;1223.5411720604773;1238.120934136773;13313.293319884531;13392;13550.45798168082;13576.932115339558;13700.45198192081;282855;284710;285989;286328;286359;58450;59588.10617840736;62801;62963;63198.368016320164;1489.7541905585674;1496.7156240314523;1519.6188480630728;1520.2246854104264;1522.7335216337096;29299;29648;29708;29748.405031899674;29932;40889;40906.18187636171;40916.38625420681;40940;41015;227430;228695;228767;228791;229918;33690.83154584211;34287.65712342845;34790.47814282737;35001.824990874884;35090.47364289487;43594;45257;45295.320570190815;45502;45553.77223113863;33307;34120.317593648484;34131.317373651895;34205.31589368149;34235.657643424245;33113;33398.833005834815;33680.83159584186;33744.83127584346;34123.829380852934;38919.6108038916;39844.203115936936;40105.39841902316;40155.59844401519;40162.79918600505;32978.835105825274;33030.5045424314;33111.83444082764;33279;33939;24534.50930981406;24624.753752462246;24839.50320993606;25027.624585630867;25547.74452255528 14:10:22 INFO - PID 5995 | |2;jquery.html;598.5690302981851;599.2180204832695;606.481458353108;614.6360838049847;615.2954866677657;23436.179733709323;24174.27477175683;24235;24283;24285.15001974931;21898.343049708536;22649.433764155903;22939.082436702553;22959.42601434965;22982.425439364026;6449.48404127671;6532.477401807868;6559.737610495575;6568.901466478007;6608.107905432753;6431.260405053432;6528.37980391862;6568.540202185849;6808.489363297747;6833.316668333152;6793.626350550718;6795.388415042645;6797.694103765342;6798.762043328485;6799.830004249884;6784.118064651589;6786.355296246848;6800.251972283045;6804.3876051155385;6808.455323574102;6017.308009578911;6207.193064901534;6207.6585787782105;6211.34780848009;6326.620402775802;30318.242043948856;30722.846385768153;30755;30773.692263077308;30813.229669258224;2195.1548653768255;2216.9113235470563;2218.2457964292216;2219.87790671513;2223.755386907439;19701;20313.390598282076;20849.166033358648;21075.683864741888;21239.044243009103;2516.509280690266;2546.337952132459;2578.7292334304816;2581.070814506776;2608.0610980047168;138664;144018;146270.26864865713;151588;151658;15308.770368444482;15603.141827199614;15770.76343854843;15812.841871581368;16541.751873721903;25496.872515637675;25544.10595629144;25605.743942560337;25644.48711025769;25816;10429.582816687247;10845.83731244032;10872.85834987315;10925.945370273097;10972.506237219344;9913.454759988126;9914.80170396588;9959.55182016811;9984.750381240527;10031.648892288735;9497.43015419077;9558.90441095594;9716.708498745049;9720.805583888283;9763.900761336346;2992.7755418343713;2994.940101197964;3004.8647810848565;3022.9395412092076;3026.379592183597;1034.3483605328595;1044.587387981743;1045.383223897904;1052.394872948058;1054.5728979763207;20555.691664625043;20601.793982060288;20722.171113155306;21320.573588528452;21557.137714491244;1107.2470719910539;1111.127764704703;1112.1214240749878;1120.6694025262568;1131.6322195286564;11554.422278886022;11644.126690498246;11680.415979201176;11753.294802311888;11762.411879405996;638646;640140;640981;662697.4325641898;671795;129989.35005325102;130206;131739;132646;133014.3349283267;1240.5968060380412;1259.8929091027182;1310.6199202231437;1313.7897936330332;1334.8665133486768;22209.666854996864;22223.888880555493;22229.444263893532;22292.331230063122;22650.093996239964;63115;64443.67778161079;65776;66154;68577.65711171413;83616.16383836084;83735;83864.58067709622;84726;84995;15407.69184616279;15539.45611903578;15539.84460155384;15661.295241713922;15712;23353.76646233516;23507.294781156594;23983;24235.151769687975;24453.87773061123;18324.677986094775;19583;19687.70468443003;19849.900750496156;19931.501712457306;17446.563835904202;17551.473455796346;17647;17687.292508300037;18146.727799083288;18422.723659144856;18542.907285463487;18634.161462733937;18799.436016919513;20290.79709202889;15412.845871541589;15624.687506250038;15634.9218253908;15638.687226255184;15649.765253520978;19528.21887124556;19822;19933.900330498254;20029.29897453582;20085.09617067265 14:10:22 INFO - PID 5995 | |3;mootools.html;1403.1370707015185;1471.8013068235784;1476.3504058214392;1480;1487.4347747855813;17139.48581542554;17775.64448711025;17892.64214715705;17910.37313694021;17914.910425447855;17431.47705568832;17501.212445439953;17541.12294385282;17579.38472153475;17591.82408175918;2833.7896048590437;2862.2558134884925;2882.106546970446;2888.610037644912;2893.7684985201136;2608.8956441742307;2655.548556745358;2659.5079910216573;2662.068276103358;2683.3962358469284;2782.3461486550646;2894.0594306850253;2894.2474956511355;2903.3612605226817;2909.054557268896;2673.2514895829004;2679.3435608275904;2691.3137150026714;2694.7709444697125;2718.7553120219177;2796.790240731933;2799.0623141247706;2802.243394283532;2819.915402537927;2827.2507785436874;16299.91850040754;16576.6684666306;16682.082485463296;16711.331546738114;16728.581785455463;7980.521168729895;8127.431079824415;8203.343732501386;8225.383096267804;8231.547264900428;5646.124850648156;5769.769209231626;5866.6480011199465;5940.881182376328;5942.019566771478;2145.6674215496623;2150.0969592771075;2153.967690484644;2173.532690471556;2209.0501084533644;30298;30593;30622.08133755991;30655.386892262253;30675.539866902014;7196.568205907663;7576;7720;7934.880976785353;7980.4812687175145;20067.698984515246;20254;20304;20309;20345.694814577793;8354.8329033419;8565.314774818124;8566.443181193203;8585.742427727178;8586.65653373858;7702.845943081219;7773.805654858674;7829.099653539802;7831.2560306770765;7839.02012248469;5477.123660214346;5587.888242235133;5596.552275817925;5653.208550802891;5821.243238379068;1439.3163247457583;1520.2094910646401;1595.4563313456506;1614.136437006196;1638.696841084403;855.8031652719785;949.5347279832832;975.4244995452717;981.1905178227847;988.8220120378257;8365.707200247962;8373.95813020931;8374.70688525911;8451.577421128919;8633.784155396166;1066.3122286125406;1068.941208233539;1084;1090.8472813806075;1092.306385445248;5200.609954253446;5287.418383977836;5310.044192045469;5315.229291752674;5354.303940487712;24517.38706532351;24910.875445622656;24914.12800551972;25136;25182.622260666103;24149.517009659707;24276.393090172885;24446.388840279134;24606;24806.37984050413;12008.519659213709;12347.135700501058;12484.875151248552;12486.12597118193;12488;9584.568694408908;9612.1829644481;9648.179904708179;9777.266704997011;9807.460589667637;20838;21154.78845211528;21499.14003439845;21584.892075539523;21633.891830541375;21906;21996.120155194254;22154.113835446402;22266.22068227604;22475.662865057366;11817;11989.22070065443;12185.69535761613;12224.38878056076;12227.266364018187;15391.923040384727;15768.369265229263;15970.60073498172;15980.360785568912;16030.27863746111;12270.938645306716;12775.425105870072;12787.424565894371;13005.804912926504;13192.274424906722;12631.431585578855;12748.171368860994;12763.553275635308;13083.672908177372;13148.079634425882;10568.471576421302;10649.254552181274;10735.624253151102;10881.292715973437;10882.673519794418;7951.801204969922;7964.00449943757;8006.439549231498;8007.199280071946;8087.676492940216;8297.875531867148;8328.708495202638;8415.831683366421;8425.662973480992;8430.367722420966 14:10:22 INFO - PID 5995 | |4;prototype.html;534.5029122915687;563.8421242052226;568.4741614007048;580.5268706004604;581.3430823169818;6294.150289710893;6319.905201421982;6344.1451346893855;6397.904031439526;6400;6243.282022567406;6310.422394401399;6317.905231421532;6347.143135676693;6366.458850997659;5139.948600514003;5166.664166829163;5171.87070323243;5184.844454666366;5195.480451954793;4879.853604391874;5093.236014597803;5110.412302585194;5137.38351397831;5149.665271757323;4995.250712393134;4997.725125118117;5021.1213037718435;5042.546170844624;5044.369453818273;5003.4246061702825;5003.724795136266;5015.247712843103;5033.84898453047;5044.697318160904;4554.567316104964;4557.726536407793;4559.17934771741;4839.153148199086;4945.23348880924;6260.057772846801;6277.686115694197;6298.968505157445;6312.747490100391;6315.905261421082;6223.1287619733275;6247.750089996394;6251.593646412968;6260.593061451037;6282.465990390822;6863.965680171567;6878.521117959613;6883.483738719566;6898.586084834926;6900.930990690079;5554.888902221974;5557.527610153102;5564.054110801174;5575.581831362664;5591.3569939456665;6923.169219693618;6926.515143939876;7069.293070692941;7077.893831592582;7104.786856394317;5724.5956698186865;5727.31272247333;5731.971340143273;5763.971180144156;5779.190913272145;5799.8550036249435;5844.26946631671;5857.707114644336;5869.148973398833;5889.146073819272;6188.938110618927;6255.718492667841;6271.122042913996;6275.435210831047;6278.591891527036;6796.35434633709;6855.6572171391235;6869.931300687029;6875.621840798804;6881.690323935435;1958;1980.8910509922093;2001.119507416732;2013.385917295239;2016.9596608067757;1451.5790420777855;1481.3852251315584;1496.416397604935;1501.9173945433106;1531.8161820581602;6051.304100028465;6177.660228687465;6216.813495595139;6218.19163508741;6240.719167637467;6605.192793062929;6741.168709142172;6785.93214067853;6890.346316884012;6962.268961758942;6266.216722909637;6319.210098737658;6328.082428047907;6357.396047375492;6363.777267795697;3637.3998290281806;3643.143861192618;3646.872359467406;3664.486971823947;3708.7589306694977;7086.362227399559;7106.857862842818;7160.355567998905;7166.570005799565;7172.390346820474;6996.230414654384;7000.824979375455;7045.295470452914;7097.325754053357;7122.18094919091;7008.929910700827;7034.296570343027;7151.106111736033;7169.426445884421;7169.605671688003;6813.7615183470325;6868.175818901764;6911.7926462206215;6936.687849046704;6946.548474349152;6820.693068811816;6867.3476019778045;6876.553024053421;6876.905392573262;6903.413209877217;7099.574025558483;7153.642317884189;7182.497225194186;7188.4968052235845;7190.928090719026;5218.530332270114;5222.321098257202;5240.423553409046;5251.159814429673;5256.684598924076;6659.467242620482;6864.450843932374;6875.140607424072;6893.414059804973;6898.1377327834025;6506.512011599054;6613.537052406477;6670.866582668416;6687.431568316748;6706.423990362358;6635.303293154149;6644.435223006099;6646.969719693455;6690.59856408617;6702.597844129368;6519.250286216956;6552.198145510023;6582.308857569887;6596.472282217315;6603.405693487609;6634.369734875179;6687.264400915798;6713.227978782307;6717.630530320879;6750.223724271772;6453.9354606453335;6496.252930913006;6538.313477085027;6541.803745887631;6556.147700798866 14:10:22 INFO - PID 5995 | |5;yui.html;839.1063517354014;861.5003298087111;865.952372619506;990.2869933647775;1008.3312118443973;19986.3004794832;20880.582388352243;20893.164273429084;20933.895330523363;20938.37184884454;18224.544386390346;18554.72167917479;18759.155837987288;19658.410247692555;19699.40901772949;1041.1670663469233;1062.7396287909473;1064.435849000031;1066.7119877633074;1067.3489171605315;1018.7707765752721;1038.4703801061437;1057.1014637558092;1057.820170571001;1058.354403813677;1115.8103122469158;1121.461698384776;1122.6239209864664;1124.8537690100275;1137.0505627800796;1110.777844431117;1113.799516087104;1116.983245251322;1118.7650593375402;1121.3496172220093;821.7986593284623;823.1603764160583;823.1932705948144;825.7275099217244;836.523181786382;19356.903215483973;19538.70691939622;19763.802361976483;19784.505387365287;21102.472438189016;21591.568168636695;21901.123955041778;21991.890040549853;22034.4491387715;22129.33611991643;17882.642347152985;18174.727379089323;18221.7266740999;18258.087095645165;18263.72604410935;3736.3834967230373;3840.481534992768;3896.902577435558;3922.9604154898975;3965.524137103537;140015;157664;158206;159410;159727;18564.907175464035;18630.068496575117;18973.146208420654;19054.61890762177;19073.237070517025;30842.84578577093;30844.845775771428;31367.529487057713;31444.842775785975;31535;9114.316426268057;9177.816443671089;9188.081191880758;9197.310201734897;9201.49391783445;4206.305959516707;4232.682548808852;4299.806508707115;4320.3519472078815;4331.7184383015;6039.63762174271;6122;6132.294786099566;6158.876822463526;6173.444390004921;1206.85517737872;1243.5647523366931;1247.0273186914221;1256.5350820196586;1258.7671280813079;675.8344205669642;682.3722175598461;696.4637229333385;699.919509256442;705.7247673407376;12414.937925310496;13180.472781088649;13608.319584020759;14153.787693184611;14248.85751142496;680.4760334542375;693.9028536004963;694.447913908444;711.1572786248312;711.8220444888777;5726.79956201531;5836.358000619928;5893.882122357529;5951.9107213391835;5959.910601340984;132695;136329;137117;137180;142261;120638.39680801715;122010.38994804969;122960;124235;125662;109340.4532977346;109889;110501;111519;112362.43818780854;11268.943655281671;11326.433678315887;11374;11471.827922581335;11631.88368116308;54513;54818.45181548293;55217.723911380184;55510.72244638751;56258;67496.66251668907;68276;68300;69052;70782.29217707757;15921;16059.919700401424;16064.196790160211;16114.355425782838;16204.594885127966;18121.184546695167;18538.907305463385;18628.348007819663;18779.530511736768;18782.154803033623;16169.434069807501;16254.67490650204;16325.83674163243;16430.67138657196;16462.917685411976;16220.432284869972;16228.918855405647;16353.182340883146;16526.173691315627;16549;16935.66128677444;16987.575310617332;16991.40530081441;17037.48887533376;17120.400785972928;12288.38558072075;12327.93836030814;12401.193922395016;12523.37383130858;12607.747845043232;12241.571544995883;12350.81473777876;12482.875171248534;12518.311492867979;12695.80956285675 14:10:22 INFO - PID 5995 | __end_tp_report 14:10:22 INFO - PID 5995 | __start_cc_report 14:10:22 INFO - PID 5995 | _x_x_mozilla_cycle_collect,367 14:10:22 INFO - PID 5995 | __end_cc_report 14:10:22 INFO - PID 5995 | __startTimestamp1505509822474__endTimestamp 14:10:22 INFO - PID 5995 | 14:10:22 INFO - PID 5995 | ------- Summary: start ------- 14:10:22 INFO - PID 5995 | Number of tests: 6 14:10:22 INFO - PID 5995 | 14:10:22 INFO - PID 5995 | [#0] dojo.html Cycles:165 Average:6245.23 Median:6497.77 stddev:882.51 (13.6%) stddev-sans-first:864.10 14:10:22 INFO - PID 5995 | Values: 3799.2 3803.8 3868.3 3893.5 3907.5 6233.5 6270.6 6277.6 6286.6 6397.5 6250.4 6293.1 6321.6 6345.4 6371.8 5646.6 5726.7 5733.1 5760.5 5774.0 142.0 5705.2 5750.5 5794.9 5801.4 5693.0 5695.6 5707.6 5725.0 5726.5 5611.5 5614.0 5691.2 5702.8 5715.7 5613.4 5619.7 5690.2 5705.8 5706.0 6263.2 6265.3 6273.1 6319.8 6343.0 6763.5 6797.0 6801.5 6852.8 6893.8 6827.3 6891.1 6893.0 6904.0 6905.3 6336.7 6339.1 6389.1 6424.6 6434.1 6982.7 7026.7 7076.5 7081.4 7090.0 6702.6 6723.3 6737.7 6739.1 6808.1 6848.7 6852.6 6854.0 6857.5 6861.7 6765.2 6818.1 6837.5 6847.7 6855.8 6727.3 6728.6 6748.5 6804.4 6839.0 4889.8 4946.1 4958.0 4967.8 4968.8 4475.1 4512.5 4555.1 4558.7 4559.1 6229.8 6233.4 6302.7 6321.1 6326.8 6721.6 6729.9 6806.6 6810.8 6811.6 6211.2 6259.1 6261.8 6296.7 6333.7 5483.7 5491.1 5501.7 5514.0 5519.3 6988.2 6993.7 7108.6 7109.9 7114.4 6740.2 6743.8 6753.9 6845.3 6846.5 7017.6 7054.8 7091.4 7119.5 7127.5 6751.8 6754.7 6779.8 6792.9 6805.8 6815.3 6816.1 6889.3 6893.9 6925.3 6545.4 6551.0 6570.7 6635.4 6659.5 6497.8 6559.0 6621.0 6641.4 6653.3 6384.3 6448.1 6534.8 6548.8 6554.7 6558.7 6608.2 6627.9 6652.6 6684.1 6321.7 6346.2 6426.5 6430.2 6460.1 14:10:22 INFO - PID 5995 | 14:10:22 INFO - PID 5995 | [#1] ext.html Cycles:180 Average:42197.18 Median:3774.59 stddev:63627.23 (1685.7%) stddev-sans-first:63730.33 14:10:22 INFO - PID 5995 | Values: 944.9 946.2 970.9 987.8 995.3 44292.1 44704.6 44706.8 44894.8 45153.3 42881.6 43039.8 43056.0 43079.6 43107.4 7574.1 7735.3 7736.6 7765.8 7768.7 7536.3 7587.3 7599.0 7604.4 7617.1 7584.2 7603.2 7605.7 8214.8 8410.2 8318.8 8372.4 8375.6 8393.5 8407.3 7980.6 8167.2 8168.5 8250.8 8255.2 40763.4 40895.6 41114.0 41283.2 41309.0 3758.2 3790.9 3805.4 3836.7 3852.2 33966.8 34115.3 34187.3 34218.8 34222.3 5452.8 5498.6 5511.3 5554.9 5566.3 212513.0 213181.0 214770.0 214781.0 215559.0 51723.5 52280.5 52430.5 52743.7 52868.5 54302.5 54413.7 54482.0 54511.5 54535.5 16648.8 16853.1 16881.6 16905.5 16926.6 13667.7 13670.2 13677.7 13761.7 13772.7 14518.5 14782.3 14786.4 14832.9 15015.7 5729.1 5893.5 5931.7 5934.5 5952.3 1091.6 1106.5 1111.3 1124.4 1130.1 25160.0 25216.6 25230.3 25322.1 25416.0 1205.8 1208.0 1220.9 1223.5 1238.1 13313.3 13392.0 13550.5 13576.9 13700.5 282855.0 284710.0 285989.0 286328.0 286359.0 58450.0 59588.1 62801.0 62963.0 63198.4 1489.8 1496.7 1519.6 1520.2 1522.7 29299.0 29648.0 29708.0 29748.4 29932.0 40889.0 40906.2 40916.4 40940.0 41015.0 227430.0 228695.0 228767.0 228791.0 229918.0 33690.8 34287.7 34790.5 35001.8 35090.5 43594.0 45257.0 45295.3 45502.0 45553.8 33307.0 34120.3 34131.3 34205.3 34235.7 33113.0 33398.8 33680.8 33744.8 34123.8 38919.6 39844.2 40105.4 40155.6 40162.8 32978.8 33030.5 33111.8 33279.0 33939.0 24534.5 24624.8 24839.5 25027.6 25547.7 14:10:22 INFO - PID 5995 | 14:10:22 INFO - PID 5995 | [#2] jquery.html Cycles:180 Average:41093.61 Median:22470.88 stddev:108399.47 (482.4%) stddev-sans-first:108660.91 14:10:22 INFO - PID 5995 | Values: 598.6 599.2 606.5 614.6 615.3 23436.2 24174.3 24235.0 24283.0 24285.2 21898.3 22649.4 22939.1 22959.4 22982.4 6449.5 6532.5 6559.7 6568.9 6608.1 6431.3 6528.4 6568.5 6808.5 6833.3 6793.6 6795.4 6797.7 6798.8 6799.8 6784.1 6786.4 6800.3 6804.4 6808.5 6017.3 6207.2 6207.7 6211.3 6326.6 30318.2 30722.8 30755.0 30773.7 30813.2 2195.2 2216.9 2218.2 2219.9 2223.8 19701.0 20313.4 20849.2 21075.7 21239.0 2516.5 2546.3 2578.7 2581.1 2608.1 138664.0 144018.0 146270.3 151588.0 151658.0 15308.8 15603.1 15770.8 15812.8 16541.8 25496.9 25544.1 25605.7 25644.5 25816.0 10429.6 10845.8 10872.9 10925.9 10972.5 9913.5 9914.8 9959.6 9984.8 10031.6 9497.4 9558.9 9716.7 9720.8 9763.9 2992.8 2994.9 3004.9 3022.9 3026.4 1034.3 1044.6 1045.4 1052.4 1054.6 20555.7 20601.8 20722.2 21320.6 21557.1 1107.2 1111.1 1112.1 1120.7 1131.6 11554.4 11644.1 11680.4 11753.3 11762.4 638646.0 640140.0 640981.0 662697.4 671795.0 129989.4 130206.0 131739.0 132646.0 133014.3 1240.6 1259.9 1310.6 1313.8 1334.9 22209.7 22223.9 22229.4 22292.3 22650.1 63115.0 64443.7 65776.0 66154.0 68577.7 83616.2 83735.0 83864.6 84726.0 84995.0 15407.7 15539.5 15539.8 15661.3 15712.0 23353.8 23507.3 23983.0 24235.2 24453.9 18324.7 19583.0 19687.7 19849.9 19931.5 17446.6 17551.5 17647.0 17687.3 18146.7 18422.7 18542.9 18634.2 18799.4 20290.8 15412.8 15624.7 15634.9 15638.7 15649.8 19528.2 19822.0 19933.9 20029.3 20085.1 14:10:22 INFO - PID 5995 | 14:10:22 INFO - PID 5995 | [#3] mootools.html Cycles:180 Average:10467.40 Median:2632.22 stddev:7770.02 (295.2%) stddev-sans-first:7761.97 14:10:22 INFO - PID 5995 | Values: 1403.1 1471.8 1476.4 1480.0 1487.4 17139.5 17775.6 17892.6 17910.4 17914.9 17431.5 17501.2 17541.1 17579.4 17591.8 2833.8 2862.3 2882.1 2888.6 2893.8 2608.9 2655.5 2659.5 2662.1 2683.4 2782.3 2894.1 2894.2 2903.4 2909.1 2673.3 2679.3 2691.3 2694.8 2718.8 2796.8 2799.1 2802.2 2819.9 2827.3 16299.9 16576.7 16682.1 16711.3 16728.6 7980.5 8127.4 8203.3 8225.4 8231.5 5646.1 5769.8 5866.6 5940.9 5942.0 2145.7 2150.1 2154.0 2173.5 2209.1 30298.0 30593.0 30622.1 30655.4 30675.5 7196.6 7576.0 7720.0 7934.9 7980.5 20067.7 20254.0 20304.0 20309.0 20345.7 8354.8 8565.3 8566.4 8585.7 8586.7 7702.8 7773.8 7829.1 7831.3 7839.0 5477.1 5587.9 5596.6 5653.2 5821.2 1439.3 1520.2 1595.5 1614.1 1638.7 855.8 949.5 975.4 981.2 988.8 8365.7 8374.0 8374.7 8451.6 8633.8 1066.3 1068.9 1084.0 1090.8 1092.3 5200.6 5287.4 5310.0 5315.2 5354.3 24517.4 24910.9 24914.1 25136.0 25182.6 24149.5 24276.4 24446.4 24606.0 24806.4 12008.5 12347.1 12484.9 12486.1 12488.0 9584.6 9612.2 9648.2 9777.3 9807.5 20838.0 21154.8 21499.1 21584.9 21633.9 21906.0 21996.1 22154.1 22266.2 22475.7 11817.0 11989.2 12185.7 12224.4 12227.3 15391.9 15768.4 15970.6 15980.4 16030.3 12270.9 12775.4 12787.4 13005.8 13192.3 12631.4 12748.2 12763.6 13083.7 13148.1 10568.5 10649.3 10735.6 10881.3 10882.7 7951.8 7964.0 8006.4 8007.2 8087.7 8297.9 8328.7 8415.8 8425.7 8430.4 14:10:22 INFO - PID 5995 | 14:10:22 INFO - PID 5995 | [#4] prototype.html Cycles:180 Average:5799.47 Median:6319.56 stddev:1576.73 (24.9%) stddev-sans-first:1530.83 14:10:22 INFO - PID 5995 | Values: 534.5 563.8 568.5 580.5 581.3 6294.2 6319.9 6344.1 6397.9 6400.0 6243.3 6310.4 6317.9 6347.1 6366.5 5139.9 5166.7 5171.9 5184.8 5195.5 4879.9 5093.2 5110.4 5137.4 5149.7 4995.3 4997.7 5021.1 5042.5 5044.4 5003.4 5003.7 5015.2 5033.8 5044.7 4554.6 4557.7 4559.2 4839.2 4945.2 6260.1 6277.7 6299.0 6312.7 6315.9 6223.1 6247.8 6251.6 6260.6 6282.5 6864.0 6878.5 6883.5 6898.6 6900.9 5554.9 5557.5 5564.1 5575.6 5591.4 6923.2 6926.5 7069.3 7077.9 7104.8 5724.6 5727.3 5732.0 5764.0 5779.2 5799.9 5844.3 5857.7 5869.1 5889.1 6188.9 6255.7 6271.1 6275.4 6278.6 6796.4 6855.7 6869.9 6875.6 6881.7 1958.0 1980.9 2001.1 2013.4 2017.0 1451.6 1481.4 1496.4 1501.9 1531.8 6051.3 6177.7 6216.8 6218.2 6240.7 6605.2 6741.2 6785.9 6890.3 6962.3 6266.2 6319.2 6328.1 6357.4 6363.8 3637.4 3643.1 3646.9 3664.5 3708.8 7086.4 7106.9 7160.4 7166.6 7172.4 6996.2 7000.8 7045.3 7097.3 7122.2 7008.9 7034.3 7151.1 7169.4 7169.6 6813.8 6868.2 6911.8 6936.7 6946.5 6820.7 6867.3 6876.6 6876.9 6903.4 7099.6 7153.6 7182.5 7188.5 7190.9 5218.5 5222.3 5240.4 5251.2 5256.7 6659.5 6864.5 6875.1 6893.4 6898.1 6506.5 6613.5 6670.9 6687.4 6706.4 6635.3 6644.4 6647.0 6690.6 6702.6 6519.3 6552.2 6582.3 6596.5 6603.4 6634.4 6687.3 6713.2 6717.6 6750.2 6453.9 6496.3 6538.3 6541.8 6556.1 14:10:22 INFO - PID 5995 | 14:10:22 INFO - PID 5995 | [#5] yui.html Cycles:180 Average:26999.73 Median:18241.32 stddev:40052.57 (219.6%) stddev-sans-first:40116.76 14:10:22 INFO - PID 5995 | Values: 839.1 861.5 866.0 990.3 1008.3 19986.3 20880.6 20893.2 20933.9 20938.4 18224.5 18554.7 18759.2 19658.4 19699.4 1041.2 1062.7 1064.4 1066.7 1067.3 1018.8 1038.5 1057.1 1057.8 1058.4 1115.8 1121.5 1122.6 1124.9 1137.1 1110.8 1113.8 1117.0 1118.8 1121.3 821.8 823.2 823.2 825.7 836.5 19356.9 19538.7 19763.8 19784.5 21102.5 21591.6 21901.1 21991.9 22034.4 22129.3 17882.6 18174.7 18221.7 18258.1 18263.7 3736.4 3840.5 3896.9 3923.0 3965.5 140015.0 157664.0 158206.0 159410.0 159727.0 18564.9 18630.1 18973.1 19054.6 19073.2 30842.8 30844.8 31367.5 31444.8 31535.0 9114.3 9177.8 9188.1 9197.3 9201.5 4206.3 4232.7 4299.8 4320.4 4331.7 6039.6 6122.0 6132.3 6158.9 6173.4 1206.9 1243.6 1247.0 1256.5 1258.8 675.8 682.4 696.5 699.9 705.7 12414.9 13180.5 13608.3 14153.8 14248.9 680.5 693.9 694.4 711.2 711.8 5726.8 5836.4 5893.9 5951.9 5959.9 132695.0 136329.0 137117.0 137180.0 142261.0 120638.4 122010.4 122960.0 124235.0 125662.0 109340.5 109889.0 110501.0 111519.0 112362.4 11268.9 11326.4 11374.0 11471.8 11631.9 54513.0 54818.5 55217.7 55510.7 56258.0 67496.7 68276.0 68300.0 69052.0 70782.3 15921.0 16059.9 16064.2 16114.4 16204.6 18121.2 18538.9 18628.3 18779.5 18782.2 16169.4 16254.7 16325.8 16430.7 16462.9 16220.4 16228.9 16353.2 16526.2 16549.0 16935.7 16987.6 16991.4 17037.5 17120.4 12288.4 12327.9 12401.2 12523.4 12607.7 12241.6 12350.8 12482.9 12518.3 12695.8 14:10:22 INFO - PID 5995 | -------- Summary: end -------- 14:10:22 INFO - PID 5995 | 14:10:23 INFO - TEST-INFO | 5995: exit 0 14:10:23 INFO - TEST-OK | dromaeo_css | took 1108608ms 14:10:23 INFO - TEST-START | kraken 14:10:23 INFO - Initialising browser for kraken test... 14:10:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51818/getInfo.html -profile /tmp/tmpt6GqUu/profile 14:10:23 INFO - TEST-INFO | started process 6369 (/builds/slave/test/build/application/firefox/firefox http://localhost:51818/getInfo.html) 14:10:28 INFO - TEST-INFO | 6369: exit 0 14:10:28 INFO - Browser initialized. 14:10:28 INFO - Running cycle 1/1 for kraken test... 14:10:28 INFO - Using env: {'DISPLAY': ':0', 14:10:28 INFO - 'HOME': '/home/cltbld', 14:10:28 INFO - 'JSGC_DISABLE_POISONING': '1', 14:10:28 INFO - 'LANG': 'en_US.UTF-8', 14:10:28 INFO - 'LANGUAGE': 'en_US:en', 14:10:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:10:28 INFO - 'LOGNAME': 'cltbld', 14:10:28 INFO - 'MAIL': '/var/mail/cltbld', 14:10:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:10:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:10:28 INFO - 'MOZ_CRASHREPORTER': '1', 14:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:10:28 INFO - 'MOZ_NO_REMOTE': '1', 14:10:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:28 INFO - 'NO_EM_RESTART': '1', 14:10:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:28 INFO - 'PWD': '/builds/slave/test', 14:10:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:10:28 INFO - 'RUST_BACKTRACE': 'full', 14:10:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:10:28 INFO - 'SHELL': '/bin/bash', 14:10:28 INFO - 'SHLVL': '1', 14:10:28 INFO - 'TERM': 'linux', 14:10:28 INFO - 'TMOUT': '86400', 14:10:28 INFO - 'USER': 'cltbld', 14:10:28 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800', 14:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:28 INFO - '_': '/tools/buildbot/bin/python'} 14:10:28 INFO - TEST-INFO | started process 6609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt6GqUu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:29 INFO - PID 6609 | 14:10:29 INFO - PID 6609 | (/builds/slave/test/build/application/firefox/firefox:6659): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:10:29 INFO - PID 6609 | 14:10:40 INFO - PID 6609 | RSS: Main: 164888576 14:10:40 INFO - PID 6609 | 14:10:42 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51818/tests/kraken/driver.html?testName=audio-beat-detection) 14:10:43 INFO - PID 6609 | RSS: Main: 170373120 14:10:43 INFO - PID 6609 | 14:10:46 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51818/tests/kraken/driver.html?testName=audio-dft) 14:10:46 INFO - PID 6609 | RSS: Main: 170389504 14:10:46 INFO - PID 6609 | 14:10:49 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51818/tests/kraken/driver.html?testName=audio-fft) 14:10:50 INFO - PID 6609 | RSS: Main: 165318656 14:10:50 INFO - PID 6609 | 14:10:52 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51818/tests/kraken/driver.html?testName=audio-oscillator) 14:10:53 INFO - PID 6609 | RSS: Main: 166821888 14:10:53 INFO - PID 6609 | 14:10:55 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51818/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:10:55 INFO - PID 6609 | RSS: Main: 166977536 14:10:55 INFO - PID 6609 | 14:10:58 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51818/tests/kraken/driver.html?testName=imaging-darkroom) 14:10:59 INFO - PID 6609 | RSS: Main: 170156032 14:10:59 INFO - PID 6609 | 14:11:03 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51818/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:03 INFO - PID 6609 | RSS: Main: 169906176 14:11:03 INFO - PID 6609 | 14:11:06 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51818/tests/kraken/driver.html?testName=json-parse-financial) 14:11:07 INFO - PID 6609 | RSS: Main: 169820160 14:11:07 INFO - PID 6609 | 14:11:08 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51818/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:09 INFO - PID 6609 | RSS: Main: 170291200 14:11:09 INFO - PID 6609 | 14:11:10 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51818/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:11 INFO - PID 6609 | RSS: Main: 170127360 14:11:11 INFO - PID 6609 | 14:11:13 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51818/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:14 INFO - PID 6609 | RSS: Main: 167096320 14:11:14 INFO - PID 6609 | 14:11:16 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51818/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:17 INFO - PID 6609 | RSS: Main: 166551552 14:11:17 INFO - PID 6609 | 14:11:20 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51818/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:11:20 INFO - PID 6609 | RSS: Main: 167247872 14:11:20 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | Cycle 1(1): loaded http://localhost:51818/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51818/tests/kraken/driver.html?testName=ai-astar) 14:11:22 INFO - PID 6609 | RSS: Main: 169000960 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | __start_tp_report 14:11:22 INFO - PID 6609 | _x_x_mozilla_page_load 14:11:22 INFO - PID 6609 | _x_x_mozilla_page_load_details 14:11:22 INFO - PID 6609 | |i|pagename|runs| 14:11:22 INFO - PID 6609 | |0;ai-astar;108;106;106;108;106;108;107;106;106;107 14:11:22 INFO - PID 6609 | |1;audio-beat-detection;112;113;114;113;112;116;112;113;111;116 14:11:22 INFO - PID 6609 | |2;audio-dft;162;162;167;161;163;161;163;171;165;167 14:11:22 INFO - PID 6609 | |3;audio-fft;73;77;72;75;73;71;73;73;73;77 14:11:22 INFO - PID 6609 | |4;audio-oscillator;79;79;77;78;79;78;80;78;78;77 14:11:22 INFO - PID 6609 | |5;imaging-gaussian-blur;114;113;110;114;115;115;114;111;114;115 14:11:22 INFO - PID 6609 | |6;imaging-darkroom;149;154;151;151;150;148;153;150;150;150 14:11:22 INFO - PID 6609 | |7;imaging-desaturate;93;93;94;94;94;94;93;96;94;94 14:11:22 INFO - PID 6609 | |8;json-parse-financial;44;46;45;44;44;45;46;44;46;46 14:11:22 INFO - PID 6609 | |9;json-stringify-tinderbox;39;39;39;39;38;38;39;38;38;38 14:11:22 INFO - PID 6609 | |10;stanford-crypto-aes;72;72;72;72;74;72;73;72;73;71 14:11:22 INFO - PID 6609 | |11;stanford-crypto-ccm;110;107;103;114;107;110;107;103;107;109 14:11:22 INFO - PID 6609 | |12;stanford-crypto-pbkdf2;166;151;151;150;158;156;152;155;152;152 14:11:22 INFO - PID 6609 | |13;stanford-crypto-sha256-iterative;63;63;62;60;60;58;65;68;61;61 14:11:22 INFO - PID 6609 | __end_tp_report 14:11:22 INFO - PID 6609 | __start_cc_report 14:11:22 INFO - PID 6609 | _x_x_mozilla_cycle_collect,902 14:11:22 INFO - PID 6609 | __end_cc_report 14:11:22 INFO - PID 6609 | __startTimestamp1505509882600__endTimestamp 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | ------- Summary: start ------- 14:11:22 INFO - PID 6609 | Number of tests: 14 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#0] ai-astar Cycles:10 Average:106.80 Median:107.00 stddev:0.92 (0.9%) stddev-sans-first:0.87 14:11:22 INFO - PID 6609 | Values: 108.0 106.0 106.0 108.0 106.0 108.0 107.0 106.0 106.0 107.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#1] audio-beat-detection Cycles:10 Average:113.20 Median:113.00 stddev:1.69 (1.5%) stddev-sans-first:1.73 14:11:22 INFO - PID 6609 | Values: 112.0 113.0 114.0 113.0 112.0 116.0 112.0 113.0 111.0 116.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.26 (2.0%) stddev-sans-first:3.36 14:11:22 INFO - PID 6609 | Values: 162.0 162.0 167.0 161.0 163.0 161.0 163.0 171.0 165.0 167.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#3] audio-fft Cycles:10 Average:73.70 Median:73.00 stddev:2.00 (2.7%) stddev-sans-first:2.11 14:11:22 INFO - PID 6609 | Values: 73.0 77.0 72.0 75.0 73.0 71.0 73.0 73.0 73.0 77.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#4] audio-oscillator Cycles:10 Average:78.30 Median:78.50 stddev:0.95 (1.2%) stddev-sans-first:0.97 14:11:22 INFO - PID 6609 | Values: 79.0 79.0 77.0 78.0 79.0 78.0 80.0 78.0 78.0 77.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:1.72 (1.5%) stddev-sans-first:1.81 14:11:22 INFO - PID 6609 | Values: 114.0 113.0 110.0 114.0 115.0 115.0 114.0 111.0 114.0 115.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.50 stddev:1.78 (1.2%) stddev-sans-first:1.79 14:11:22 INFO - PID 6609 | Values: 149.0 154.0 151.0 151.0 150.0 148.0 153.0 150.0 150.0 150.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 14:11:22 INFO - PID 6609 | Values: 93.0 93.0 94.0 94.0 94.0 94.0 93.0 96.0 94.0 94.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#8] json-parse-financial Cycles:10 Average:45.00 Median:45.50 stddev:0.94 (2.1%) stddev-sans-first:0.93 14:11:22 INFO - PID 6609 | Values: 44.0 46.0 45.0 44.0 44.0 45.0 46.0 44.0 46.0 46.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:39.00 stddev:0.53 (1.4%) stddev-sans-first:0.53 14:11:22 INFO - PID 6609 | Values: 39.0 39.0 39.0 39.0 38.0 38.0 39.0 38.0 38.0 38.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 14:11:22 INFO - PID 6609 | Values: 72.0 72.0 72.0 72.0 74.0 72.0 73.0 72.0 73.0 71.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#11] stanford-crypto-ccm Cycles:10 Average:107.70 Median:108.00 stddev:3.30 (3.1%) stddev-sans-first:3.40 14:11:22 INFO - PID 6609 | Values: 110.0 107.0 103.0 114.0 107.0 110.0 107.0 103.0 107.0 109.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:153.50 stddev:4.83 (3.1%) stddev-sans-first:2.69 14:11:22 INFO - PID 6609 | Values: 166.0 151.0 151.0 150.0 158.0 156.0 152.0 155.0 152.0 152.0 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.50 stddev:2.85 (4.6%) stddev-sans-first:3.00 14:11:22 INFO - PID 6609 | Values: 63.0 63.0 62.0 60.0 60.0 58.0 65.0 68.0 61.0 61.0 14:11:22 INFO - PID 6609 | -------- Summary: end -------- 14:11:22 INFO - PID 6609 | 14:11:22 INFO - PID 6609 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:11:23 INFO - TEST-INFO | 6609: exit 0 14:11:23 INFO - TEST-OK | kraken | took 60061ms 14:11:23 INFO - SUITE-END | took 1168s 14:11:23 INFO - Completed test suite (00:19:28) 14:11:23 INFO - javascript benchmark 14:11:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9060.211750906434, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3799.1641838795454, 3803.7527560708536, 3868.3230434673933, 3893.4743809585734, 3907.4529565860785, 6233.501319894409, 6270.561060725751, 6277.5605707600425, 6286.591371560851, 6397.456216221615, 6250.40621140992, 6293.087502312162, 6321.620702757827, 6345.397187267202, 6371.776987805428, 5646.632968857031, 5726.685032323241, 5733.082706766918, 5760.4815566599, 5773.971130144364, 142.03743768225, 5705.2012718219485, 5750.482456578907, 5794.855128621776, 5801.419858014207, 5693.032184528619, 5695.572832037593, 5707.571932105088, 5725.026745453283, 5726.455986681259, 5611.494965453088, 5614.0, 5691.174779656926, 5702.800401985952, 5715.742791574347, 5613.4386561343945, 5619.719014049322, 5690.231818704505, 5705.77176912923, 5706.0, 6263.24841019076, 6265.279492858334, 6273.05904114382, 6319.778807741707, 6342.985122380397, 6763.526553141282, 6796.966015169893, 6801.523893327469, 6852.828679283008, 6893.7931862044215, 6827.283135270774, 6891.104156459628, 6892.965535172292, 6903.9989201565495, 6905.343992320722, 6336.746530138835, 6339.0808332791485, 6389.073584330246, 6424.614523128627, 6434.099226108348, 6982.685779139951, 7026.683799229047, 7076.540024898468, 7081.433485321162, 7090.042844216068, 6702.597844129368, 6723.294054124344, 6737.663116844138, 6739.056532085512, 6808.080909077211, 6848.7260509579055, 6852.588844669336, 6853.965730171317, 6857.451403887677, 6861.656917154122, 6765.188177418643, 6818.147731533559, 6837.453003759687, 6847.657617119125, 6855.760048398282, 6727.293634168342, 6728.629925354055, 6748.460123190133, 6804.421624161902, 6839.0, 4889.828855990095, 4946.060248552763, 4957.950420495821, 4967.751612419437, 4968.801247950114, 4475.060237350128, 4512.481064677539, 4555.066211426716, 4558.680892337571, 4559.110973360163, 6229.750809967551, 6233.438990490878, 6302.684865756693, 6321.115043893767, 6326.810195694136, 6721.563098398588, 6729.899051514231, 6806.591604503746, 6810.761623343258, 6811.557248778813, 6211.211036844169, 6259.123722678738, 6261.78083767066, 6296.748130074746, 6333.714982825784, 5483.725813709379, 5491.066518691832, 5501.669899806025, 5514.0, 5519.337679478488, 6988.161420629557, 6993.685284162225, 7108.644567771591, 7109.8933515997305, 7114.430845532345, 6740.191177058784, 6743.797686069426, 6753.86492270142, 6845.315468453115, 6846.486513511407, 7017.614031228127, 7054.823629409306, 7091.432685385053, 7119.537230080028, 7127.536710113826, 6751.831204219934, 6754.696038678369, 6779.796606101825, 6792.93207067923, 6805.829854253683, 6815.250322464426, 6816.113905192294, 6889.276625954202, 6893.931060689329, 6925.272846351262, 6545.410913017851, 6550.967245163743, 6570.737170513317, 6635.402813746786, 6659.467242620675, 6497.772577959749, 6559.048937904073, 6621.0, 6641.369069938348, 6653.301403352772, 6384.297727249906, 6448.097266382804, 6534.803955881332, 6548.83627909287, 6554.672266386757, 6558.672066396756, 6608.207015158212, 6627.900581491378, 6652.567583107082, 6684.06423100776, 6321.652309122858, 6346.2067241594805, 6426.518011149089, 6430.164078669743, 6460.095586617783], "value": 6187.840807705732, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [944.8866136063673, 946.191006689281, 970.8543718442232, 987.8024395120977, 995.2734503812214, 44292.11415771687, 44704.55295447045, 44706.776466117706, 44894.775526122365, 45153.322700159486, 42881.57118428822, 43039.78480107603, 43056.0, 43079.56920430795, 43107.35338969918, 7574.053243344596, 7735.30382265596, 7736.613169341538, 7765.767026989171, 7768.65041073153, 7536.321731044205, 7587.317141457268, 7598.9620051899665, 7604.391648668094, 7617.085949686046, 7584.203658615821, 7603.163651998276, 7605.695772169107, 8214.794630134265, 8410.201030902055, 8318.83362332753, 8372.41393102483, 8375.62309696062, 8393.53835539045, 8407.285380742644, 7980.600969951479, 8167.183281671785, 8168.469049511763, 8250.834983300361, 8255.215754503373, 40763.38854917179, 40895.59104408947, 41114.0, 41283.174336513104, 41309.0, 3758.229562939591, 3790.9431358529646, 3805.4101614249835, 3836.673882719972, 3852.191039881628, 33966.83016584926, 34115.31769364623, 34187.31625367504, 34218.82890585556, 34222.315553688786, 5452.836414907559, 5498.642588231752, 5511.311086114236, 5554.888902221933, 5566.332040155207, 212513.0, 213181.0, 214770.0, 214781.0, 215559.0, 51723.482765171866, 52280.47719522756, 52430.47569524332, 52743.73628131835, 52868.471315287126, 54302.45697543053, 54413.72793136009, 54482.0, 54511.45488545143, 54535.45464545383, 16648.833511664972, 16853.073080980663, 16881.577960551083, 16905.49283521496, 16926.576835578962, 13667.658308542366, 13670.17978921268, 13677.726445471035, 13761.724765504834, 13772.655683607789, 14518.491852785102, 14782.334794934253, 14786.408543658134, 14832.851671483148, 15015.699686006219, 5729.140628905698, 5893.469587737124, 5931.703414829241, 5934.495567876779, 5952.255968003999, 1091.6343025086685, 1106.5076041161606, 1111.3165403277087, 1124.3984468309416, 1130.0846314485293, 25160.0, 25216.621750673756, 25230.304757049274, 25322.1137260195, 25415.959252971064, 1205.7528206717602, 1207.9939600301943, 1220.9206401584047, 1223.5411720604773, 1238.120934136773, 13313.293319884531, 13392.0, 13550.45798168082, 13576.932115339558, 13700.45198192081, 282855.0, 284710.0, 285989.0, 286328.0, 286359.0, 58450.0, 59588.10617840736, 62801.0, 62963.0, 63198.368016320164, 1489.7541905585674, 1496.7156240314523, 1519.6188480630728, 1520.2246854104264, 1522.7335216337096, 29299.0, 29648.0, 29708.0, 29748.405031899674, 29932.0, 40889.0, 40906.18187636171, 40916.38625420681, 40940.0, 41015.0, 227430.0, 228695.0, 228767.0, 228791.0, 229918.0, 33690.83154584211, 34287.65712342845, 34790.47814282737, 35001.824990874884, 35090.47364289487, 43594.0, 45257.0, 45295.320570190815, 45502.0, 45553.77223113863, 33307.0, 34120.317593648484, 34131.317373651895, 34205.31589368149, 34235.657643424245, 33113.0, 33398.833005834815, 33680.83159584186, 33744.83127584346, 34123.829380852934, 38919.6108038916, 39844.203115936936, 40105.39841902316, 40155.59844401519, 40162.79918600505, 32978.835105825274, 33030.5045424314, 33111.83444082764, 33279.0, 33939.0, 24534.50930981406, 24624.753752462246, 24839.50320993606, 25027.624585630867, 25547.74452255528], "value": 18515.204287712007, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.5690302981851, 599.2180204832695, 606.481458353108, 614.6360838049847, 615.2954866677657, 23436.179733709323, 24174.27477175683, 24235.0, 24283.0, 24285.15001974931, 21898.343049708536, 22649.433764155903, 22939.082436702553, 22959.42601434965, 22982.425439364026, 6449.48404127671, 6532.477401807868, 6559.737610495575, 6568.901466478007, 6608.107905432753, 6431.260405053432, 6528.37980391862, 6568.540202185849, 6808.489363297747, 6833.316668333152, 6793.626350550718, 6795.388415042645, 6797.694103765342, 6798.762043328485, 6799.830004249884, 6784.118064651589, 6786.355296246848, 6800.251972283045, 6804.3876051155385, 6808.455323574102, 6017.308009578911, 6207.193064901534, 6207.6585787782105, 6211.34780848009, 6326.620402775802, 30318.242043948856, 30722.846385768153, 30755.0, 30773.692263077308, 30813.229669258224, 2195.1548653768255, 2216.9113235470563, 2218.2457964292216, 2219.87790671513, 2223.755386907439, 19701.0, 20313.390598282076, 20849.166033358648, 21075.683864741888, 21239.044243009103, 2516.509280690266, 2546.337952132459, 2578.7292334304816, 2581.070814506776, 2608.0610980047168, 138664.0, 144018.0, 146270.26864865713, 151588.0, 151658.0, 15308.770368444482, 15603.141827199614, 15770.76343854843, 15812.841871581368, 16541.751873721903, 25496.872515637675, 25544.10595629144, 25605.743942560337, 25644.48711025769, 25816.0, 10429.582816687247, 10845.83731244032, 10872.85834987315, 10925.945370273097, 10972.506237219344, 9913.454759988126, 9914.80170396588, 9959.55182016811, 9984.750381240527, 10031.648892288735, 9497.43015419077, 9558.90441095594, 9716.708498745049, 9720.805583888283, 9763.900761336346, 2992.7755418343713, 2994.940101197964, 3004.8647810848565, 3022.9395412092076, 3026.379592183597, 1034.3483605328595, 1044.587387981743, 1045.383223897904, 1052.394872948058, 1054.5728979763207, 20555.691664625043, 20601.793982060288, 20722.171113155306, 21320.573588528452, 21557.137714491244, 1107.2470719910539, 1111.127764704703, 1112.1214240749878, 1120.6694025262568, 1131.6322195286564, 11554.422278886022, 11644.126690498246, 11680.415979201176, 11753.294802311888, 11762.411879405996, 638646.0, 640140.0, 640981.0, 662697.4325641898, 671795.0, 129989.35005325102, 130206.0, 131739.0, 132646.0, 133014.3349283267, 1240.5968060380412, 1259.8929091027182, 1310.6199202231437, 1313.7897936330332, 1334.8665133486768, 22209.666854996864, 22223.888880555493, 22229.444263893532, 22292.331230063122, 22650.093996239964, 63115.0, 64443.67778161079, 65776.0, 66154.0, 68577.65711171413, 83616.16383836084, 83735.0, 83864.58067709622, 84726.0, 84995.0, 15407.69184616279, 15539.45611903578, 15539.84460155384, 15661.295241713922, 15712.0, 23353.76646233516, 23507.294781156594, 23983.0, 24235.151769687975, 24453.87773061123, 18324.677986094775, 19583.0, 19687.70468443003, 19849.900750496156, 19931.501712457306, 17446.563835904202, 17551.473455796346, 17647.0, 17687.292508300037, 18146.727799083288, 18422.723659144856, 18542.907285463487, 18634.161462733937, 18799.436016919513, 20290.79709202889, 15412.845871541589, 15624.687506250038, 15634.9218253908, 15638.687226255184, 15649.765253520978, 19528.21887124556, 19822.0, 19933.900330498254, 20029.29897453582, 20085.09617067265], "value": 12840.195728639252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.1370707015185, 1471.8013068235784, 1476.3504058214392, 1480.0, 1487.4347747855813, 17139.48581542554, 17775.64448711025, 17892.64214715705, 17910.37313694021, 17914.910425447855, 17431.47705568832, 17501.212445439953, 17541.12294385282, 17579.38472153475, 17591.82408175918, 2833.7896048590437, 2862.2558134884925, 2882.106546970446, 2888.610037644912, 2893.7684985201136, 2608.8956441742307, 2655.548556745358, 2659.5079910216573, 2662.068276103358, 2683.3962358469284, 2782.3461486550646, 2894.0594306850253, 2894.2474956511355, 2903.3612605226817, 2909.054557268896, 2673.2514895829004, 2679.3435608275904, 2691.3137150026714, 2694.7709444697125, 2718.7553120219177, 2796.790240731933, 2799.0623141247706, 2802.243394283532, 2819.915402537927, 2827.2507785436874, 16299.91850040754, 16576.6684666306, 16682.082485463296, 16711.331546738114, 16728.581785455463, 7980.521168729895, 8127.431079824415, 8203.343732501386, 8225.383096267804, 8231.547264900428, 5646.124850648156, 5769.769209231626, 5866.6480011199465, 5940.881182376328, 5942.019566771478, 2145.6674215496623, 2150.0969592771075, 2153.967690484644, 2173.532690471556, 2209.0501084533644, 30298.0, 30593.0, 30622.08133755991, 30655.386892262253, 30675.539866902014, 7196.568205907663, 7576.0, 7720.0, 7934.880976785353, 7980.4812687175145, 20067.698984515246, 20254.0, 20304.0, 20309.0, 20345.694814577793, 8354.8329033419, 8565.314774818124, 8566.443181193203, 8585.742427727178, 8586.65653373858, 7702.845943081219, 7773.805654858674, 7829.099653539802, 7831.2560306770765, 7839.02012248469, 5477.123660214346, 5587.888242235133, 5596.552275817925, 5653.208550802891, 5821.243238379068, 1439.3163247457583, 1520.2094910646401, 1595.4563313456506, 1614.136437006196, 1638.696841084403, 855.8031652719785, 949.5347279832832, 975.4244995452717, 981.1905178227847, 988.8220120378257, 8365.707200247962, 8373.95813020931, 8374.70688525911, 8451.577421128919, 8633.784155396166, 1066.3122286125406, 1068.941208233539, 1084.0, 1090.8472813806075, 1092.306385445248, 5200.609954253446, 5287.418383977836, 5310.044192045469, 5315.229291752674, 5354.303940487712, 24517.38706532351, 24910.875445622656, 24914.12800551972, 25136.0, 25182.622260666103, 24149.517009659707, 24276.393090172885, 24446.388840279134, 24606.0, 24806.37984050413, 12008.519659213709, 12347.135700501058, 12484.875151248552, 12486.12597118193, 12488.0, 9584.568694408908, 9612.1829644481, 9648.179904708179, 9777.266704997011, 9807.460589667637, 20838.0, 21154.78845211528, 21499.14003439845, 21584.892075539523, 21633.891830541375, 21906.0, 21996.120155194254, 22154.113835446402, 22266.22068227604, 22475.662865057366, 11817.0, 11989.22070065443, 12185.69535761613, 12224.38878056076, 12227.266364018187, 15391.923040384727, 15768.369265229263, 15970.60073498172, 15980.360785568912, 16030.27863746111, 12270.938645306716, 12775.425105870072, 12787.424565894371, 13005.804912926504, 13192.274424906722, 12631.431585578855, 12748.171368860994, 12763.553275635308, 13083.672908177372, 13148.079634425882, 10568.471576421302, 10649.254552181274, 10735.624253151102, 10881.292715973437, 10882.673519794418, 7951.801204969922, 7964.00449943757, 8006.439549231498, 8007.199280071946, 8087.676492940216, 8297.875531867148, 8328.708495202638, 8415.831683366421, 8425.662973480992, 8430.367722420966], "value": 7315.204229186489, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.5029122915687, 563.8421242052226, 568.4741614007048, 580.5268706004604, 581.3430823169818, 6294.150289710893, 6319.905201421982, 6344.1451346893855, 6397.904031439526, 6400.0, 6243.282022567406, 6310.422394401399, 6317.905231421532, 6347.143135676693, 6366.458850997659, 5139.948600514003, 5166.664166829163, 5171.87070323243, 5184.844454666366, 5195.480451954793, 4879.853604391874, 5093.236014597803, 5110.412302585194, 5137.38351397831, 5149.665271757323, 4995.250712393134, 4997.725125118117, 5021.1213037718435, 5042.546170844624, 5044.369453818273, 5003.4246061702825, 5003.724795136266, 5015.247712843103, 5033.84898453047, 5044.697318160904, 4554.567316104964, 4557.726536407793, 4559.17934771741, 4839.153148199086, 4945.23348880924, 6260.057772846801, 6277.686115694197, 6298.968505157445, 6312.747490100391, 6315.905261421082, 6223.1287619733275, 6247.750089996394, 6251.593646412968, 6260.593061451037, 6282.465990390822, 6863.965680171567, 6878.521117959613, 6883.483738719566, 6898.586084834926, 6900.930990690079, 5554.888902221974, 5557.527610153102, 5564.054110801174, 5575.581831362664, 5591.3569939456665, 6923.169219693618, 6926.515143939876, 7069.293070692941, 7077.893831592582, 7104.786856394317, 5724.5956698186865, 5727.31272247333, 5731.971340143273, 5763.971180144156, 5779.190913272145, 5799.8550036249435, 5844.26946631671, 5857.707114644336, 5869.148973398833, 5889.146073819272, 6188.938110618927, 6255.718492667841, 6271.122042913996, 6275.435210831047, 6278.591891527036, 6796.35434633709, 6855.6572171391235, 6869.931300687029, 6875.621840798804, 6881.690323935435, 1958.0, 1980.8910509922093, 2001.119507416732, 2013.385917295239, 2016.9596608067757, 1451.5790420777855, 1481.3852251315584, 1496.416397604935, 1501.9173945433106, 1531.8161820581602, 6051.304100028465, 6177.660228687465, 6216.813495595139, 6218.19163508741, 6240.719167637467, 6605.192793062929, 6741.168709142172, 6785.93214067853, 6890.346316884012, 6962.268961758942, 6266.216722909637, 6319.210098737658, 6328.082428047907, 6357.396047375492, 6363.777267795697, 3637.3998290281806, 3643.143861192618, 3646.872359467406, 3664.486971823947, 3708.7589306694977, 7086.362227399559, 7106.857862842818, 7160.355567998905, 7166.570005799565, 7172.390346820474, 6996.230414654384, 7000.824979375455, 7045.295470452914, 7097.325754053357, 7122.18094919091, 7008.929910700827, 7034.296570343027, 7151.106111736033, 7169.426445884421, 7169.605671688003, 6813.7615183470325, 6868.175818901764, 6911.7926462206215, 6936.687849046704, 6946.548474349152, 6820.693068811816, 6867.3476019778045, 6876.553024053421, 6876.905392573262, 6903.413209877217, 7099.574025558483, 7153.642317884189, 7182.497225194186, 7188.4968052235845, 7190.928090719026, 5218.530332270114, 5222.321098257202, 5240.423553409046, 5251.159814429673, 5256.684598924076, 6659.467242620482, 6864.450843932374, 6875.140607424072, 6893.414059804973, 6898.1377327834025, 6506.512011599054, 6613.537052406477, 6670.866582668416, 6687.431568316748, 6706.423990362358, 6635.303293154149, 6644.435223006099, 6646.969719693455, 6690.59856408617, 6702.597844129368, 6519.250286216956, 6552.198145510023, 6582.308857569887, 6596.472282217315, 6603.405693487609, 6634.369734875179, 6687.264400915798, 6713.227978782307, 6717.630530320879, 6750.223724271772, 6453.9354606453335, 6496.252930913006, 6538.313477085027, 6541.803745887631, 6556.147700798866], "value": 5355.135852171912, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.1063517354014, 861.5003298087111, 865.952372619506, 990.2869933647775, 1008.3312118443973, 19986.3004794832, 20880.582388352243, 20893.164273429084, 20933.895330523363, 20938.37184884454, 18224.544386390346, 18554.72167917479, 18759.155837987288, 19658.410247692555, 19699.40901772949, 1041.1670663469233, 1062.7396287909473, 1064.435849000031, 1066.7119877633074, 1067.3489171605315, 1018.7707765752721, 1038.4703801061437, 1057.1014637558092, 1057.820170571001, 1058.354403813677, 1115.8103122469158, 1121.461698384776, 1122.6239209864664, 1124.8537690100275, 1137.0505627800796, 1110.777844431117, 1113.799516087104, 1116.983245251322, 1118.7650593375402, 1121.3496172220093, 821.7986593284623, 823.1603764160583, 823.1932705948144, 825.7275099217244, 836.523181786382, 19356.903215483973, 19538.70691939622, 19763.802361976483, 19784.505387365287, 21102.472438189016, 21591.568168636695, 21901.123955041778, 21991.890040549853, 22034.4491387715, 22129.33611991643, 17882.642347152985, 18174.727379089323, 18221.7266740999, 18258.087095645165, 18263.72604410935, 3736.3834967230373, 3840.481534992768, 3896.902577435558, 3922.9604154898975, 3965.524137103537, 140015.0, 157664.0, 158206.0, 159410.0, 159727.0, 18564.907175464035, 18630.068496575117, 18973.146208420654, 19054.61890762177, 19073.237070517025, 30842.84578577093, 30844.845775771428, 31367.529487057713, 31444.842775785975, 31535.0, 9114.316426268057, 9177.816443671089, 9188.081191880758, 9197.310201734897, 9201.49391783445, 4206.305959516707, 4232.682548808852, 4299.806508707115, 4320.3519472078815, 4331.7184383015, 6039.63762174271, 6122.0, 6132.294786099566, 6158.876822463526, 6173.444390004921, 1206.85517737872, 1243.5647523366931, 1247.0273186914221, 1256.5350820196586, 1258.7671280813079, 675.8344205669642, 682.3722175598461, 696.4637229333385, 699.919509256442, 705.7247673407376, 12414.937925310496, 13180.472781088649, 13608.319584020759, 14153.787693184611, 14248.85751142496, 680.4760334542375, 693.9028536004963, 694.447913908444, 711.1572786248312, 711.8220444888777, 5726.79956201531, 5836.358000619928, 5893.882122357529, 5951.9107213391835, 5959.910601340984, 132695.0, 136329.0, 137117.0, 137180.0, 142261.0, 120638.39680801715, 122010.38994804969, 122960.0, 124235.0, 125662.0, 109340.4532977346, 109889.0, 110501.0, 111519.0, 112362.43818780854, 11268.943655281671, 11326.433678315887, 11374.0, 11471.827922581335, 11631.88368116308, 54513.0, 54818.45181548293, 55217.723911380184, 55510.72244638751, 56258.0, 67496.66251668907, 68276.0, 68300.0, 69052.0, 70782.29217707757, 15921.0, 16059.919700401424, 16064.196790160211, 16114.355425782838, 16204.594885127966, 18121.184546695167, 18538.907305463385, 18628.348007819663, 18779.530511736768, 18782.154803033623, 16169.434069807501, 16254.67490650204, 16325.83674163243, 16430.67138657196, 16462.917685411976, 16220.432284869972, 16228.918855405647, 16353.182340883146, 16526.173691315627, 16549.0, 16935.66128677444, 16987.575310617332, 16991.40530081441, 17037.48887533376, 17120.400785972928, 12288.38558072075, 12327.93836030814, 12401.193922395016, 12523.37383130858, 12607.747845043232, 12241.571544995883, 12350.81473777876, 12482.875171248534, 12518.311492867979, 12695.80956285675], "value": 9597.724616481844, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1374.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 106.0, 108.0, 106.0, 108.0, 107.0, 106.0, 106.0, 107.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 114.0, 113.0, 112.0, 116.0, 112.0, 113.0, 111.0, 116.0], "value": 113.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 167.0, 161.0, 163.0, 161.0, 163.0, 171.0, 165.0, 167.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 72.0, 75.0, 73.0, 71.0, 73.0, 73.0, 73.0, 77.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 78.0, 79.0, 78.0, 80.0, 78.0, 78.0, 77.0], "value": 78.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 110.0, 114.0, 115.0, 115.0, 114.0, 111.0, 114.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 154.0, 151.0, 151.0, 150.0, 148.0, 153.0, 150.0, 150.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 96.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 46.0, 45.0, 44.0, 44.0, 45.0, 46.0, 44.0, 46.0, 46.0], "value": 45.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 39.0, 39.0, 38.0, 38.0, 39.0, 38.0, 38.0, 38.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 72.0, 74.0, 72.0, 73.0, 72.0, 73.0, 71.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 103.0, 114.0, 107.0, 110.0, 107.0, 103.0, 107.0, 109.0], "value": 107.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 151.0, 151.0, 150.0, 158.0, 156.0, 152.0, 155.0, 152.0, 152.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 60.0, 60.0, 58.0, 65.0, 68.0, 61.0, 61.0], "value": 62.1, "unit": "score"}]}]} 14:11:23 INFO - Return code: 0 14:11:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:11:23 INFO - # TBPL SUCCESS # 14:11:23 INFO - Running post-action listener: _package_coverage_data 14:11:23 INFO - Running post-action listener: _resource_record_post_action 14:11:23 INFO - [mozharness: 2017-09-15 21:11:23.385987Z] Finished run-tests step (success) 14:11:23 INFO - Running post-run listener: _resource_record_post_run 14:11:23 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 342732800; Read time: 0; Write time: 220276 14:11:23 INFO - TinderboxPrint: CPU usage
13.1% 14:11:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:11:23 INFO - TinderboxPrint: I/O write bytes / time
342,732,800 / 220,276 14:11:23 INFO - TinderboxPrint: CPU idle
8,225.6 (86.9%) 14:11:23 INFO - TinderboxPrint: CPU user
1,188.1 (12.6%) 14:11:23 INFO - TinderboxPrint: Swap in / out
0 / 0 14:11:23 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13774848; Read time: 0; Write time: 1364 14:11:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:11:23 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 328536064; Read time: 0; Write time: 218900 14:11:24 INFO - Running post-run listener: _upload_blobber_files 14:11:24 INFO - Blob upload gear active. 14:11:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:11:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:11:24 INFO - (blobuploader) - INFO - Open directory for files ... 14:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:11:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:25 INFO - (blobuploader) - INFO - Done attempting. 14:11:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:11:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:11:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:26 INFO - (blobuploader) - INFO - Done attempting. 14:11:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:11:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:11:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:33 INFO - (blobuploader) - INFO - Done attempting. 14:11:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:11:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:11:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:35 INFO - (blobuploader) - INFO - Done attempting. 14:11:35 INFO - (blobuploader) - INFO - Iteration through files over. 14:11:35 INFO - Return code: 0 14:11:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:11:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:11:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48a7d10247a241774710221d1b8dad3c87f42ec4254ca8eb597489ef70f34ade55246fa765363b88af0ac511d7fa04e0591b6ad14e30a9db2907269e947c07ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bb2be971282b6a6b2b41ce2b58980d2fbfb509c7938357ca6c27f757a54ff1f4429aaf659cf89c4f64ea8dbacc49c3aa910122277180bc6708ad3492eab0b0e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/326fcc7dcc6b6c3c30e054c07b3df760b7a5ea73ea9befc39c4c028c5bbc80ebb75a952ab06564d6b83e5a75f4d5521e6f12ab1292c26b858e4f62412b6fa31d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48104acafb2564071454f8762e57f2ce8d710ad0ea71cb2dff36b38eccd1f76c0e9398c3121a5a13810c9a7671652ad262fe82dabd9d25fb83162ad4f261010a"} 14:11:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:11:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:11:35 INFO - Contents: 14:11:35 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48a7d10247a241774710221d1b8dad3c87f42ec4254ca8eb597489ef70f34ade55246fa765363b88af0ac511d7fa04e0591b6ad14e30a9db2907269e947c07ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bb2be971282b6a6b2b41ce2b58980d2fbfb509c7938357ca6c27f757a54ff1f4429aaf659cf89c4f64ea8dbacc49c3aa910122277180bc6708ad3492eab0b0e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/326fcc7dcc6b6c3c30e054c07b3df760b7a5ea73ea9befc39c4c028c5bbc80ebb75a952ab06564d6b83e5a75f4d5521e6f12ab1292c26b858e4f62412b6fa31d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48104acafb2564071454f8762e57f2ce8d710ad0ea71cb2dff36b38eccd1f76c0e9398c3121a5a13810c9a7671652ad262fe82dabd9d25fb83162ad4f261010a"} 14:11:35 INFO - Running post-run listener: copy_logs_to_upload_dir 14:11:35 INFO - Copying logs to upload dir... 14:11:35 INFO - mkdir: /builds/slave/test/build/upload/logs 14:11:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.357559 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-15 14:11:35.504340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 14:11:35.508145) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48a7d10247a241774710221d1b8dad3c87f42ec4254ca8eb597489ef70f34ade55246fa765363b88af0ac511d7fa04e0591b6ad14e30a9db2907269e947c07ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bb2be971282b6a6b2b41ce2b58980d2fbfb509c7938357ca6c27f757a54ff1f4429aaf659cf89c4f64ea8dbacc49c3aa910122277180bc6708ad3492eab0b0e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/326fcc7dcc6b6c3c30e054c07b3df760b7a5ea73ea9befc39c4c028c5bbc80ebb75a952ab06564d6b83e5a75f4d5521e6f12ab1292c26b858e4f62412b6fa31d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48104acafb2564071454f8762e57f2ce8d710ad0ea71cb2dff36b38eccd1f76c0e9398c3121a5a13810c9a7671652ad262fe82dabd9d25fb83162ad4f261010a"} build_url:https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/Bri49bEOQiqNFL-HH0pFlw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48a7d10247a241774710221d1b8dad3c87f42ec4254ca8eb597489ef70f34ade55246fa765363b88af0ac511d7fa04e0591b6ad14e30a9db2907269e947c07ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bb2be971282b6a6b2b41ce2b58980d2fbfb509c7938357ca6c27f757a54ff1f4429aaf659cf89c4f64ea8dbacc49c3aa910122277180bc6708ad3492eab0b0e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/326fcc7dcc6b6c3c30e054c07b3df760b7a5ea73ea9befc39c4c028c5bbc80ebb75a952ab06564d6b83e5a75f4d5521e6f12ab1292c26b858e4f62412b6fa31d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48104acafb2564071454f8762e57f2ce8d710ad0ea71cb2dff36b38eccd1f76c0e9398c3121a5a13810c9a7671652ad262fe82dabd9d25fb83162ad4f261010a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 14:11:35.536330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 14:11:35.536661) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1505508465.316423-1022388800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 14:11:35.619680) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 14:11:35.620092) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 14:11:35.620433) ========= ========= Total master_lag: 0.35 =========