builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-075 starttime: 1505731706.75 results: success (0) revision: 4ef69bbd6816d95ade430640785971f587e2d5bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:26.747434) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:26.747880) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:26.748289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:26.835956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:26.836258) ========= 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=fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 03:48:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.1M=0s 2017-09-18 03:48:26 (69.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140262 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:26.997959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:26.998303) ========= 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=fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017580 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:27.051740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:27.055084) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4ef69bbd6816d95ade430640785971f587e2d5bc --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 4ef69bbd6816d95ade430640785971f587e2d5bc --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=fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 03:48:27,051 truncating revision to first 12 chars 2017-09-18 03:48:27,051 Setting DEBUG logging. 2017-09-18 03:48:27,051 attempt 1/10 2017-09-18 03:48:27,052 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4ef69bbd6816?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 03:48:27,346 unpacking tar archive at: mozilla-central-4ef69bbd6816/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567011 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:27.643870) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:27.647213) ========= script_repo_revision: 4ef69bbd6816d95ade430640785971f587e2d5bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:27.647602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:27.647860) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 03:48:27.660833) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-18 03:48:27.661201) ========= /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=fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:48:27 INFO - MultiFileLogger online at 20170918 03:48:27 in /builds/slave/test 03:48:27 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 03:48:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:48:27 INFO - {'append_to_log': False, 03:48:27 INFO - 'base_work_dir': '/builds/slave/test', 03:48:27 INFO - 'blob_upload_branch': 'Firefox', 03:48:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:48:27 INFO - 'branch': 'Firefox', 03:48:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:48:27 INFO - 'code_coverage': False, 03:48:27 INFO - 'config_files': ('talos/linux_config.py',), 03:48:27 INFO - 'default_actions': ('clobber', 03:48:27 INFO - 'read-buildbot-config', 03:48:27 INFO - 'download-and-extract', 03:48:27 INFO - 'populate-webroot', 03:48:27 INFO - 'create-virtualenv', 03:48:27 INFO - 'install', 03:48:27 INFO - 'setup-mitmproxy', 03:48:27 INFO - 'run-tests'), 03:48:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:48:27 INFO - 'disable_ccov_upload': False, 03:48:27 INFO - 'disable_stylo': False, 03:48:27 INFO - 'download_minidump_stackwalk': True, 03:48:27 INFO - 'download_symbols': 'ondemand', 03:48:27 INFO - 'enable_stylo': False, 03:48:27 INFO - 'enable_webrender': False, 03:48:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:48:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:48:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:48:27 INFO - 'gecko_profile': False, 03:48:27 INFO - 'gecko_profile_interval': 0, 03:48:27 INFO - 'installer_path': 'installer.exe', 03:48:27 INFO - 'log_level': 'info', 03:48:27 INFO - 'log_name': 'talos', 03:48:27 INFO - 'log_to_console': True, 03:48:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:48:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:48:27 INFO - 'opt_config_files': (), 03:48:27 INFO - 'pip_index': False, 03:48:27 INFO - 'suite': 'dromaeojs-e10s', 03:48:27 INFO - 'system_bits': '32', 03:48:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:48:27 INFO - 'title': 'talos-linux64-ix-075', 03:48:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:48:27 INFO - 'use_talos_json': True, 03:48:27 INFO - 'verify': 'False', 03:48:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:48:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:48:27 INFO - 'work_dir': 'build'} 03:48:27 INFO - [mozharness: 2017-09-18 10:48:27.800480Z] Running clobber step. 03:48:27 INFO - Running pre-action listener: _resource_record_pre_action 03:48:27 INFO - Running main action method: clobber 03:48:27 INFO - rmtree: /builds/slave/test/build 03:48:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:48:28 INFO - Running post-action listener: _resource_record_post_action 03:48:28 INFO - [mozharness: 2017-09-18 10:48:28.796433Z] Finished clobber step (success) 03:48:28 INFO - [mozharness: 2017-09-18 10:48:28.796530Z] Running read-buildbot-config step. 03:48:28 INFO - Running pre-action listener: _resource_record_pre_action 03:48:28 INFO - Running main action method: read_buildbot_config 03:48:28 INFO - Using buildbot properties: 03:48:28 INFO - { 03:48:28 INFO - "project": "", 03:48:28 INFO - "product": "firefox", 03:48:28 INFO - "who": "archaeopteryx@coole-files.de", 03:48:28 INFO - "installer_path": "public/build/target.tar.bz2", 03:48:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:48:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:48:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:48:28 INFO - "stage_platform": "linux64-pgo", 03:48:28 INFO - "basedir": "/builds/slave/test", 03:48:28 INFO - "buildnumber": 176, 03:48:28 INFO - "platform": "ubuntu64_hw", 03:48:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:48:28 INFO - "slavebuilddir": "test", 03:48:28 INFO - "taskId": "fTdgTfpdQgOKZMiHoNm_zA", 03:48:28 INFO - "branch": "mozilla-central", 03:48:28 INFO - "script_repo_revision": "production", 03:48:28 INFO - "revision": "4ef69bbd6816d95ade430640785971f587e2d5bc", 03:48:28 INFO - "slavename": "talos-linux64-ix-075", 03:48:28 INFO - "repo_path": "mozilla-central" 03:48:28 INFO - } 03:48:28 INFO - Finding installer, test and symbols from parent task. 03:48:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fTdgTfpdQgOKZMiHoNm_zA'}, attempt #1 03:48:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fTdgTfpdQgOKZMiHoNm_zA'}, attempt #1 03:48:29 INFO - Task dependencies: cW-otTD3QsK5dWc76_Bxuw 03:48:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw'}, attempt #1 03:48:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2 03:48:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.test_packages.json 03:48:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.crashreporter-symbols.zip 03:48:30 INFO - Running post-action listener: _resource_record_post_action 03:48:30 INFO - [mozharness: 2017-09-18 10:48:30.142516Z] Finished read-buildbot-config step (success) 03:48:30 INFO - [mozharness: 2017-09-18 10:48:30.142731Z] Running download-and-extract step. 03:48:30 INFO - Running pre-action listener: _resource_record_pre_action 03:48:30 INFO - Running main action method: download_and_extract 03:48:30 INFO - mkdir: /builds/slave/test/build/tests 03:48: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')]} 03:48:30 INFO - trying https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.test_packages.json 03:48:30 INFO - Downloading https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:48:30 INFO - Downloaded 989 bytes. 03:48:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:48:30 INFO - Using the following test package requirements: 03:48:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:48:30 INFO - u'common': [u'target.common.tests.zip'], 03:48:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:48:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:48:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:48:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:48:30 INFO - u'mozbase': [u'target.common.tests.zip'], 03:48:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:48:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:48:30 INFO - u'web-platform': [u'target.common.tests.zip', 03:48:30 INFO - u'target.web-platform.tests.tar.gz'], 03:48:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:48:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:48:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.common.tests.zip 03:48:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:48:30 INFO - Fetch https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.common.tests.zip into memory 03:48:31 INFO - Content-Length response header: 55325325 03:48:31 INFO - Bytes received: 55325325 03:48:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.talos.tests.zip 03:48:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:48:42 INFO - Fetch https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.talos.tests.zip into memory 03:48:43 INFO - Content-Length response header: 14508748 03:48:43 INFO - Bytes received: 14508748 03:48:43 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')]} 03:48:43 INFO - trying https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2 03:48:43 INFO - Downloading https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:48:46 INFO - Downloaded 62106086 bytes. 03:48:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2 03:48:46 INFO - mkdir: /builds/slave/test/properties 03:48:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:48:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:48:46 INFO - Contents: 03:48:46 INFO - build_url:https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2 03:48:46 INFO - Running post-action listener: _resource_record_post_action 03:48:46 INFO - Running post-action listener: find_tests_for_verification 03:48:46 INFO - Running post-action listener: set_extra_try_arguments 03:48:46 INFO - [mozharness: 2017-09-18 10:48:46.166140Z] Finished download-and-extract step (success) 03:48:46 INFO - [mozharness: 2017-09-18 10:48:46.166366Z] Running populate-webroot step. 03:48:46 INFO - Running pre-action listener: _resource_record_pre_action 03:48:46 INFO - Running main action method: populate_webroot 03:48:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:48:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['tresize', 03:48:46 INFO - 'tcanvasmark']}, 03:48:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:48:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['dromaeo_css', 03:48:46 INFO - 'kraken']}, 03:48:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'tests': ['damp', 'tps']}, 03:48:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['damp', 'tps']}, 03:48:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:48:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['dromaeo_dom']}, 03:48:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:48:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['basic_compositor_video', 03:48:46 INFO - 'glvideo']}, 03:48:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:48:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['ts_paint_webext', 03:48:46 INFO - 'tp5o_webext']}, 03:48:46 INFO - 'other-e10s': {'tests': ['a11yr', 03:48:46 INFO - 'ts_paint', 03:48:46 INFO - 'tpaint', 03:48:46 INFO - 'sessionrestore', 03:48:46 INFO - 'sessionrestore_many_windows', 03:48:46 INFO - 'sessionrestore_no_auto_restore', 03:48:46 INFO - 'tabpaint']}, 03:48:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['a11yr', 03:48:46 INFO - 'ts_paint', 03:48:46 INFO - 'tpaint', 03:48:46 INFO - 'sessionrestore', 03:48:46 INFO - 'sessionrestore_many_windows', 03:48:46 INFO - 'sessionrestore_no_auto_restore', 03:48:46 INFO - 'tabpaint']}, 03:48:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:48:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:48:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['perf_reftest_singletons']}, 03:48:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['bloom_basic']}, 03:48:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:48:46 INFO - 'tsvgr_opacity', 03:48:46 INFO - 'tart', 03:48:46 INFO - 'tscrollx', 03:48:46 INFO - 'tsvg_static']}, 03:48:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['tsvgx', 03:48:46 INFO - 'tsvgr_opacity', 03:48:46 INFO - 'tart', 03:48:46 INFO - 'tscrollx', 03:48:46 INFO - 'tsvg_static']}, 03:48:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:48:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'talos_options': ['--disable-stylo'], 03:48:46 INFO - 'tests': ['tp5o']}, 03:48:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:48:46 INFO - 'talos_options': ['--mitmproxy', 03:48:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:48:46 INFO - '--firstNonBlankPaint'], 03:48:46 INFO - 'tests': ['tp6_google', 03:48:46 INFO - 'tp6_youtube', 03:48:46 INFO - 'tp6_amazon', 03:48:46 INFO - 'tp6_facebook']}, 03:48:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:48:46 INFO - 'talos_options': ['--disable-stylo', 03:48:46 INFO - '--mitmproxy', 03:48:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:48:46 INFO - '--firstNonBlankPaint'], 03:48:46 INFO - 'tests': ['tp6_google', 03:48:46 INFO - 'tp6_youtube', 03:48:46 INFO - 'tp6_amazon', 03:48:46 INFO - 'tp6_facebook']}, 03:48:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:48:46 INFO - 'talos_options': ['--stylo-threads=1', 03:48:46 INFO - '--mitmproxy', 03:48:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:48:46 INFO - '--firstNonBlankPaint'], 03:48:46 INFO - 'tests': ['tp6_google', 03:48:46 INFO - 'tp6_youtube', 03:48:46 INFO - 'tp6_amazon', 03:48:46 INFO - 'tp6_facebook']}, 03:48:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'talos_options': ['--xperf_path', 03:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:46 INFO - 'tests': ['tp5n']}, 03:48:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:48:46 INFO - 'talos_options': ['--disable-stylo', 03:48:46 INFO - '--xperf_path', 03:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:46 INFO - 'tests': ['tp5n']}}} 03:48:46 INFO - Running post-action listener: _resource_record_post_action 03:48:46 INFO - [mozharness: 2017-09-18 10:48:46.181540Z] Finished populate-webroot step (success) 03:48:46 INFO - [mozharness: 2017-09-18 10:48:46.181628Z] Running create-virtualenv step. 03:48:46 INFO - Running pre-action listener: _resource_record_pre_action 03:48:46 INFO - Running main action method: create_virtualenv 03:48:46 INFO - Creating virtualenv /builds/slave/test/build/venv 03:48:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:48:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:48:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:48:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:48:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:48:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:48:47 INFO - Installing pip...............done. 03:48:47 INFO - Return code: 0 03:48:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:48:47 INFO - Reading from file tmpfile_stdout 03:48:47 INFO - Output received: 03:48:47 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:48:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:48:47 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')]} 03:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:47 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')]} 03:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:47 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 0x1a831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1defa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3090>, '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 0x1df3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dedf90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', '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 03:48:47 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 03:48:47 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 03:48:47 INFO - Using env: {'DISPLAY': ':0', 03:48:47 INFO - 'HOME': '/home/cltbld', 03:48:47 INFO - 'LANG': 'en_US.UTF-8', 03:48:47 INFO - 'LANGUAGE': 'en_US:en', 03:48:47 INFO - 'LOGNAME': 'cltbld', 03:48:47 INFO - 'MAIL': '/var/mail/cltbld', 03:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:47 INFO - 'MOZ_NO_REMOTE': '1', 03:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:47 INFO - 'NO_EM_RESTART': '1', 03:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:47 INFO - 'PWD': '/builds/slave/test', 03:48:47 INFO - 'SHELL': '/bin/bash', 03:48:47 INFO - 'SHLVL': '1', 03:48:47 INFO - 'TERM': 'linux', 03:48:47 INFO - 'TMOUT': '86400', 03:48:47 INFO - 'USER': 'cltbld', 03:48:47 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 03:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:47 INFO - '_': '/tools/buildbot/bin/python'} 03:48:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:48:48 INFO - Downloading/unpacking pip>=1.5 03:48:48 INFO - Running setup.py egg_info for package pip 03:48:48 INFO - warning: no files found matching 'pip/cacert.pem' 03:48:48 INFO - warning: no files found matching '*.html' under directory 'docs' 03:48:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:48:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:48:48 INFO - Installing collected packages: pip 03:48:48 INFO - Found existing installation: pip 1.1 03:48:48 INFO - Uninstalling pip: 03:48:48 INFO - Successfully uninstalled pip 03:48:48 INFO - Running setup.py install for pip 03:48:48 INFO - warning: no files found matching 'pip/cacert.pem' 03:48:48 INFO - warning: no files found matching '*.html' under directory 'docs' 03:48:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:48:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:48:48 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Successfully installed pip 03:48:48 INFO - Cleaning up... 03:48:48 INFO - Return code: 0 03:48:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:48 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 0x1a831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1defa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3090>, '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 0x1df3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dedf90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', '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 03:48:48 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 03:48:48 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 03:48:48 INFO - Using env: {'DISPLAY': ':0', 03:48:48 INFO - 'HOME': '/home/cltbld', 03:48:48 INFO - 'LANG': 'en_US.UTF-8', 03:48:48 INFO - 'LANGUAGE': 'en_US:en', 03:48:48 INFO - 'LOGNAME': 'cltbld', 03:48:48 INFO - 'MAIL': '/var/mail/cltbld', 03:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:48 INFO - 'MOZ_NO_REMOTE': '1', 03:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:48 INFO - 'NO_EM_RESTART': '1', 03:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:48 INFO - 'PWD': '/builds/slave/test', 03:48:48 INFO - 'SHELL': '/bin/bash', 03:48:48 INFO - 'SHLVL': '1', 03:48:48 INFO - 'TERM': 'linux', 03:48:48 INFO - 'TMOUT': '86400', 03:48:48 INFO - 'USER': 'cltbld', 03:48:48 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 03:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:48 INFO - '_': '/tools/buildbot/bin/python'} 03:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:48 INFO - Downloading/unpacking psutil>=3.1.1 03:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:48:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:49 INFO - Installing collected packages: psutil 03:48:49 INFO - Running setup.py install for psutil 03:48:49 INFO - building 'psutil._psutil_linux' extension 03:48:49 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 03:48:50 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 03:48:50 INFO - building 'psutil._psutil_posix' extension 03:48:50 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 03:48:50 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 03:48:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:50 INFO - Successfully installed psutil 03:48:50 INFO - Cleaning up... 03:48:50 INFO - Return code: 0 03:48:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1defa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3090>, '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 0x1df3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dedf90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', '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 03:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:48:50 INFO - Using env: {'DISPLAY': ':0', 03:48:50 INFO - 'HOME': '/home/cltbld', 03:48:50 INFO - 'LANG': 'en_US.UTF-8', 03:48:50 INFO - 'LANGUAGE': 'en_US:en', 03:48:50 INFO - 'LOGNAME': 'cltbld', 03:48:50 INFO - 'MAIL': '/var/mail/cltbld', 03:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:50 INFO - 'MOZ_NO_REMOTE': '1', 03:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:50 INFO - 'NO_EM_RESTART': '1', 03:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:50 INFO - 'PWD': '/builds/slave/test', 03:48:50 INFO - 'SHELL': '/bin/bash', 03:48:50 INFO - 'SHLVL': '1', 03:48:50 INFO - 'TERM': 'linux', 03:48:50 INFO - 'TMOUT': '86400', 03:48:50 INFO - 'USER': 'cltbld', 03:48:50 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 03:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:50 INFO - '_': '/tools/buildbot/bin/python'} 03:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:48:50 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 03:48:50 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 03:48:50 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 03:48:50 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 03:48:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:48:51 INFO - Installing collected packages: mozsystemmonitor 03:48:51 INFO - Running setup.py install for mozsystemmonitor 03:48:52 INFO - Successfully installed mozsystemmonitor 03:48:52 INFO - Cleaning up... 03:48:52 INFO - Return code: 0 03:48:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:48:52 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')]} 03:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:52 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')]} 03:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:52 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 0x1a831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1defa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3090>, '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 0x1df3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dedf90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', '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 03:48:52 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 03:48:52 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 03:48:52 INFO - Using env: {'DISPLAY': ':0', 03:48:52 INFO - 'HOME': '/home/cltbld', 03:48:52 INFO - 'LANG': 'en_US.UTF-8', 03:48:52 INFO - 'LANGUAGE': 'en_US:en', 03:48:52 INFO - 'LOGNAME': 'cltbld', 03:48:52 INFO - 'MAIL': '/var/mail/cltbld', 03:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:52 INFO - 'MOZ_NO_REMOTE': '1', 03:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:52 INFO - 'NO_EM_RESTART': '1', 03:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:52 INFO - 'PWD': '/builds/slave/test', 03:48:52 INFO - 'SHELL': '/bin/bash', 03:48:52 INFO - 'SHLVL': '1', 03:48:52 INFO - 'TERM': 'linux', 03:48:52 INFO - 'TMOUT': '86400', 03:48:52 INFO - 'USER': 'cltbld', 03:48:52 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 03:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:52 INFO - '_': '/tools/buildbot/bin/python'} 03:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:53 INFO - Downloading/unpacking jsonschema==2.5.1 03:48:53 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 03:48:53 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 03:48:53 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 03:48:53 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 03:48:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:48:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:48:55 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 03:48:55 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 03:48:55 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 03:48:55 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 03:48:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:48:55 INFO - warning: no files found matching '*.txt' 03:48:55 INFO - no previously-included directories found matching 'build' 03:48:55 INFO - no previously-included directories found matching 'dist' 03:48:55 INFO - no previously-included directories found matching '.git*' 03:48:55 INFO - Installing collected packages: jsonschema, functools32 03:48:55 INFO - Running setup.py install for functools32 03:48:55 INFO - warning: no files found matching '*.txt' 03:48:55 INFO - no previously-included directories found matching 'build' 03:48:55 INFO - no previously-included directories found matching 'dist' 03:48:55 INFO - no previously-included directories found matching '.git*' 03:48:55 INFO - Successfully installed jsonschema functools32 03:48:55 INFO - Cleaning up... 03:48:55 INFO - Return code: 0 03:48:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:48:55 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')]} 03:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:55 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')]} 03:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:55 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 0x1a831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1defa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3090>, '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 0x1df3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dedf90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', '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 03:48:55 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 03:48:55 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 03:48:55 INFO - Using env: {'DISPLAY': ':0', 03:48:55 INFO - 'HOME': '/home/cltbld', 03:48:55 INFO - 'LANG': 'en_US.UTF-8', 03:48:55 INFO - 'LANGUAGE': 'en_US:en', 03:48:55 INFO - 'LOGNAME': 'cltbld', 03:48:55 INFO - 'MAIL': '/var/mail/cltbld', 03:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:55 INFO - 'MOZ_NO_REMOTE': '1', 03:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:55 INFO - 'NO_EM_RESTART': '1', 03:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:55 INFO - 'PWD': '/builds/slave/test', 03:48:55 INFO - 'SHELL': '/bin/bash', 03:48:55 INFO - 'SHLVL': '1', 03:48:55 INFO - 'TERM': 'linux', 03:48:55 INFO - 'TMOUT': '86400', 03:48:55 INFO - 'USER': 'cltbld', 03:48:55 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 03:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:55 INFO - '_': '/tools/buildbot/bin/python'} 03:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:48:55 INFO - Cleaning up... 03:48:55 INFO - Return code: 0 03:48:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:48:55 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')]} 03:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:55 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')]} 03:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:55 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 0x1a831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1defa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3090>, '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 0x1df3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dedf90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', '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 03:48:55 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 03:48:55 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 03:48:55 INFO - Using env: {'DISPLAY': ':0', 03:48:55 INFO - 'HOME': '/home/cltbld', 03:48:55 INFO - 'LANG': 'en_US.UTF-8', 03:48:55 INFO - 'LANGUAGE': 'en_US:en', 03:48:55 INFO - 'LOGNAME': 'cltbld', 03:48:55 INFO - 'MAIL': '/var/mail/cltbld', 03:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:55 INFO - 'MOZ_NO_REMOTE': '1', 03:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:55 INFO - 'NO_EM_RESTART': '1', 03:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:55 INFO - 'PWD': '/builds/slave/test', 03:48:55 INFO - 'SHELL': '/bin/bash', 03:48:55 INFO - 'SHLVL': '1', 03:48:55 INFO - 'TERM': 'linux', 03:48:55 INFO - 'TMOUT': '86400', 03:48:55 INFO - 'USER': 'cltbld', 03:48:55 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 03:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:55 INFO - '_': '/tools/buildbot/bin/python'} 03:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:48:55 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 03:48:55 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 03:48:55 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 03:48:55 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 03:48:56 INFO - Downloading blobuploader-1.2.4.tar.gz 03:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:48:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:48:57 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 03:48:57 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 03:48:57 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 03:48:57 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 03:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:48:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:48:57 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 03:48:57 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 03:48:57 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 03:48:57 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 03:48:57 INFO - Downloading docopt-0.6.1.tar.gz 03:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:57 INFO - Running setup.py install for blobuploader 03:48:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:48:57 INFO - Running setup.py install for requests 03:48:58 INFO - Running setup.py install for docopt 03:48:58 INFO - Successfully installed blobuploader requests docopt 03:48:58 INFO - Cleaning up... 03:48:58 INFO - Return code: 0 03:48:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:58 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 0x1a831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1defa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3090>, '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 0x1df3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dedf90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', '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 03:48:58 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 03:48:58 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 03:48:58 INFO - Using env: {'DISPLAY': ':0', 03:48:58 INFO - 'HOME': '/home/cltbld', 03:48:58 INFO - 'LANG': 'en_US.UTF-8', 03:48:58 INFO - 'LANGUAGE': 'en_US:en', 03:48:58 INFO - 'LOGNAME': 'cltbld', 03:48:58 INFO - 'MAIL': '/var/mail/cltbld', 03:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:58 INFO - 'MOZ_NO_REMOTE': '1', 03:48:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:58 INFO - 'NO_EM_RESTART': '1', 03:48:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:58 INFO - 'PWD': '/builds/slave/test', 03:48:58 INFO - 'SHELL': '/bin/bash', 03:48:58 INFO - 'SHLVL': '1', 03:48:58 INFO - 'TERM': 'linux', 03:48:58 INFO - 'TMOUT': '86400', 03:48:58 INFO - 'USER': 'cltbld', 03:48:58 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 03:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:58 INFO - '_': '/tools/buildbot/bin/python'} 03:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:58 INFO - Running setup.py (path:/tmp/pip-SeQY5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:58 INFO - Running setup.py (path:/tmp/pip-SNxEDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:58 INFO - Running setup.py (path:/tmp/pip-k0gBCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:58 INFO - Running setup.py (path:/tmp/pip-Ie65Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:58 INFO - Running setup.py (path:/tmp/pip-0RQK27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:58 INFO - Running setup.py (path:/tmp/pip-HcoUy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:58 INFO - Running setup.py (path:/tmp/pip-6Sgfak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:58 INFO - Running setup.py (path:/tmp/pip-apxm5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:58 INFO - Running setup.py (path:/tmp/pip-IBKLF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:59 INFO - Running setup.py (path:/tmp/pip-Q4jlmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:59 INFO - Running setup.py (path:/tmp/pip-meA6k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:59 INFO - Running setup.py (path:/tmp/pip-HRSNlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:59 INFO - Running setup.py (path:/tmp/pip-cDF5mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:59 INFO - Running setup.py (path:/tmp/pip-vkTZmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:59 INFO - Running setup.py (path:/tmp/pip-gUa7N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:59 INFO - Running setup.py (path:/tmp/pip-eik7Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:59 INFO - Running setup.py (path:/tmp/pip-9BcesH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:59 INFO - Running setup.py install for manifestparser 03:48:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:48:59 INFO - Running setup.py install for mozcrash 03:48:59 INFO - Running setup.py install for mozdebug 03:48:59 INFO - Running setup.py install for mozdevice 03:48:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:48:59 INFO - Running setup.py install for mozfile 03:49:00 INFO - Running setup.py install for mozhttpd 03:49:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Running setup.py install for mozinfo 03:49:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Running setup.py install for mozInstall 03:49:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Running setup.py install for mozleak 03:49:00 INFO - Running setup.py install for mozlog 03:49:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Running setup.py install for moznetwork 03:49:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Running setup.py install for mozprocess 03:49:00 INFO - Running setup.py install for mozprofile 03:49:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:49:00 INFO - Running setup.py install for mozrunner 03:49:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:49:01 INFO - Running setup.py install for mozscreenshot 03:49:01 INFO - Running setup.py install for moztest 03:49:01 INFO - Running setup.py install for mozversion 03:49:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:49:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:49:01 INFO - Cleaning up... 03:49:01 INFO - Return code: 0 03:49:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:01 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')]} 03:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:01 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')]} 03:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:01 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 0x1a831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1defa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3090>, '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 0x1df3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dedf90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', '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 03:49:01 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 03:49:01 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 03:49:01 INFO - Using env: {'DISPLAY': ':0', 03:49:01 INFO - 'HOME': '/home/cltbld', 03:49:01 INFO - 'LANG': 'en_US.UTF-8', 03:49:01 INFO - 'LANGUAGE': 'en_US:en', 03:49:01 INFO - 'LOGNAME': 'cltbld', 03:49:01 INFO - 'MAIL': '/var/mail/cltbld', 03:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:01 INFO - 'MOZ_NO_REMOTE': '1', 03:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:01 INFO - 'NO_EM_RESTART': '1', 03:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:01 INFO - 'PWD': '/builds/slave/test', 03:49:01 INFO - 'SHELL': '/bin/bash', 03:49:01 INFO - 'SHLVL': '1', 03:49:01 INFO - 'TERM': 'linux', 03:49:01 INFO - 'TMOUT': '86400', 03:49:01 INFO - 'USER': 'cltbld', 03:49:01 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 03:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:01 INFO - '_': '/tools/buildbot/bin/python'} 03:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:49:01 INFO - Running setup.py (path:/tmp/pip-6eGkio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:49:01 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)) 03:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:49:01 INFO - Running setup.py (path:/tmp/pip-Fkr5_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:49:01 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)) 03:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:49:01 INFO - Running setup.py (path:/tmp/pip-Dzxs9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:49:01 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)) 03:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:49:01 INFO - Running setup.py (path:/tmp/pip-ZJhHFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:49:01 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)) 03:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:49:01 INFO - Running setup.py (path:/tmp/pip-9G6DWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:49:01 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)) 03:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:49:01 INFO - Running setup.py (path:/tmp/pip-RhKFvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:49:02 INFO - Running setup.py (path:/tmp/pip-32JONw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:49:02 INFO - Running setup.py (path:/tmp/pip-mCI1zO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:49:02 INFO - Running setup.py (path:/tmp/pip-IuZ5A9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:49:02 INFO - Running setup.py (path:/tmp/pip-cxlxmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:49:02 INFO - Running setup.py (path:/tmp/pip-yISFfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:49:02 INFO - Running setup.py (path:/tmp/pip-JQtf2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:49:02 INFO - Running setup.py (path:/tmp/pip-uLRLbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:49:02 INFO - Running setup.py (path:/tmp/pip-vTBsBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:02 INFO - Running setup.py (path:/tmp/pip-i_Lltz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:49:02 INFO - Running setup.py (path:/tmp/pip-ZKqUqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:49:02 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)) 03:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:49:02 INFO - Running setup.py (path:/tmp/pip-JiRQNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:49:02 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)) 03:49:02 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)) 03:49:02 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)) 03:49:02 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)) 03:49:02 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)) 03:49:02 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)) 03:49:02 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)) 03:49:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:03 INFO - Downloading blessings-1.6.tar.gz 03:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:49:03 INFO - Installing collected packages: blessings 03:49:03 INFO - Running setup.py install for blessings 03:49:04 INFO - Successfully installed blessings 03:49:04 INFO - Cleaning up... 03:49:04 INFO - Return code: 0 03:49:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:49:04 INFO - Reading from file tmpfile_stdout 03:49:04 INFO - Current package versions: 03:49:04 INFO - argparse == 1.2.1 03:49:04 INFO - blessings == 1.6 03:49:04 INFO - blobuploader == 1.2.4 03:49:04 INFO - docopt == 0.6.1 03:49:04 INFO - functools32 == 3.2.3-2 03:49:04 INFO - jsonschema == 2.5.1 03:49:04 INFO - manifestparser == 1.1 03:49:04 INFO - mozInstall == 1.13 03:49:04 INFO - mozcrash == 1.0 03:49:04 INFO - mozdebug == 0.1 03:49:04 INFO - mozdevice == 0.51 03:49:04 INFO - mozfile == 1.2 03:49:04 INFO - mozhttpd == 0.7 03:49:04 INFO - mozinfo == 0.10 03:49:04 INFO - mozleak == 0.1 03:49:04 INFO - mozlog == 3.5 03:49:04 INFO - moznetwork == 0.27 03:49:04 INFO - mozprocess == 0.25 03:49:04 INFO - mozprofile == 0.28 03:49:04 INFO - mozrunner == 6.13 03:49:04 INFO - mozscreenshot == 0.1 03:49:04 INFO - mozsystemmonitor == 0.3 03:49:04 INFO - moztest == 0.8 03:49:04 INFO - mozversion == 1.4 03:49:04 INFO - psutil == 3.1.1 03:49:04 INFO - requests == 1.2.3 03:49:04 INFO - wsgiref == 0.1.2 03:49:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:04 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 0x1a831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1defa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3090>, '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 0x1df3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dedf90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', '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 03:49:04 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 03:49:04 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 03:49:04 INFO - Using env: {'DISPLAY': ':0', 03:49:04 INFO - 'HOME': '/home/cltbld', 03:49:04 INFO - 'LANG': 'en_US.UTF-8', 03:49:04 INFO - 'LANGUAGE': 'en_US:en', 03:49:04 INFO - 'LOGNAME': 'cltbld', 03:49:04 INFO - 'MAIL': '/var/mail/cltbld', 03:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:04 INFO - 'MOZ_NO_REMOTE': '1', 03:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:04 INFO - 'NO_EM_RESTART': '1', 03:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:04 INFO - 'PWD': '/builds/slave/test', 03:49:04 INFO - 'SHELL': '/bin/bash', 03:49:04 INFO - 'SHLVL': '1', 03:49:04 INFO - 'TERM': 'linux', 03:49:04 INFO - 'TMOUT': '86400', 03:49:04 INFO - 'USER': 'cltbld', 03:49:04 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 03:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:04 INFO - '_': '/tools/buildbot/bin/python'} 03:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:04 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)) 03:49:04 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)) 03:49:04 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)) 03:49:04 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)) 03:49:04 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)) 03:49:04 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)) 03:49:04 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)) 03:49:04 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)) 03:49:04 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)) 03:49:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:49:05 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)) 03:49:05 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)) 03:49:05 INFO - Installing collected packages: simplejson 03:49:05 INFO - Running setup.py install for simplejson 03:49:05 INFO - building 'simplejson._speedups' extension 03:49:05 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 03:49:06 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 03:49:06 INFO - Successfully installed simplejson 03:49:06 INFO - Cleaning up... 03:49:06 INFO - Return code: 0 03:49:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1defa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3090>, '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 0x1df3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dedf90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', '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 03:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:49:06 INFO - Using env: {'DISPLAY': ':0', 03:49:06 INFO - 'HOME': '/home/cltbld', 03:49:06 INFO - 'LANG': 'en_US.UTF-8', 03:49:06 INFO - 'LANGUAGE': 'en_US:en', 03:49:06 INFO - 'LOGNAME': 'cltbld', 03:49:06 INFO - 'MAIL': '/var/mail/cltbld', 03:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:06 INFO - 'MOZ_NO_REMOTE': '1', 03:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:06 INFO - 'NO_EM_RESTART': '1', 03:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:06 INFO - 'PWD': '/builds/slave/test', 03:49:06 INFO - 'SHELL': '/bin/bash', 03:49:06 INFO - 'SHLVL': '1', 03:49:06 INFO - 'TERM': 'linux', 03:49:06 INFO - 'TMOUT': '86400', 03:49:06 INFO - 'USER': 'cltbld', 03:49:06 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 03:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:06 INFO - '_': '/tools/buildbot/bin/python'} 03:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:49:07 INFO - Cleaning up... 03:49:07 INFO - Return code: 0 03:49:07 INFO - Running post-action listener: _resource_record_post_action 03:49:07 INFO - Running post-action listener: _start_resource_monitoring 03:49:07 INFO - Starting resource monitoring. 03:49:07 INFO - [mozharness: 2017-09-18 10:49:07.098077Z] Finished create-virtualenv step (success) 03:49:07 INFO - [mozharness: 2017-09-18 10:49:07.098547Z] Running install step. 03:49:07 INFO - Running pre-action listener: _resource_record_pre_action 03:49:07 INFO - Running main action method: install 03:49:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:49:07 INFO - Reading from file tmpfile_stdout 03:49:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:49:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:49:07 INFO - Reading from file tmpfile_stdout 03:49:07 INFO - Output received: 03:49:07 INFO - Usage: mozinstall [options] installer 03:49:07 INFO - Options: 03:49:07 INFO - -h, --help show this help message and exit 03:49:07 INFO - -d DEST, --destination=DEST 03:49:07 INFO - Directory to install application into. [default: 03:49:07 INFO - "/builds/slave/test"] 03:49:07 INFO - --app=APP Application being installed. [default: firefox] 03:49:07 INFO - mkdir: /builds/slave/test/build/application 03:49:07 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'] 03:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:49:25 INFO - Reading from file tmpfile_stdout 03:49:25 INFO - Output received: 03:49:25 INFO - /builds/slave/test/build/application/firefox/firefox 03:49:25 INFO - Running post-action listener: _resource_record_post_action 03:49:25 INFO - [mozharness: 2017-09-18 10:49:25.058725Z] Finished install step (success) 03:49:25 INFO - [mozharness: 2017-09-18 10:49:25.058891Z] Running setup-mitmproxy step. 03:49:25 INFO - Running pre-action listener: _resource_record_pre_action 03:49:25 INFO - Running main action method: setup_mitmproxy 03:49:25 INFO - Skipping: mitmproxy is not required 03:49:25 INFO - Running post-action listener: _resource_record_post_action 03:49:25 INFO - [mozharness: 2017-09-18 10:49:25.060028Z] Finished setup-mitmproxy step (success) 03:49:25 INFO - [mozharness: 2017-09-18 10:49:25.060246Z] Running run-tests step. 03:49:25 INFO - Running pre-action listener: _resource_record_pre_action 03:49:25 INFO - Running pre-action listener: _set_gcov_prefix 03:49:25 INFO - Running main action method: run_tests 03:49:25 WARNING - Try message not found. 03:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:49:25 INFO - Python 2.7.3 03:49:25 INFO - Return code: 0 03:49:25 INFO - grabbing minidump binary from tooltool 03:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:25 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 0x1df3090>, '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 0x1df3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dedf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:49:25 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 03:49:25 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 03:49:25 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 03:49:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:49:25 INFO - Return code: 0 03:49:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:49:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:49:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:49:25 INFO - ENV: RUST_BACKTRACE is now full 03:49:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:49:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:49:25 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/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 03:49:25 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/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --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 03:49:25 INFO - Using env: {'DISPLAY': ':0', 03:49:25 INFO - 'HOME': '/home/cltbld', 03:49:25 INFO - 'LANG': 'en_US.UTF-8', 03:49:25 INFO - 'LANGUAGE': 'en_US:en', 03:49:25 INFO - 'LOGNAME': 'cltbld', 03:49:25 INFO - 'MAIL': '/var/mail/cltbld', 03:49:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:25 INFO - 'MOZ_NO_REMOTE': '1', 03:49:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:25 INFO - 'NO_EM_RESTART': '1', 03:49:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:25 INFO - 'PWD': '/builds/slave/test', 03:49:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:25 INFO - 'RUST_BACKTRACE': 'full', 03:49:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:49:25 INFO - 'SHELL': '/bin/bash', 03:49:25 INFO - 'SHLVL': '1', 03:49:25 INFO - 'TERM': 'linux', 03:49:25 INFO - 'TMOUT': '86400', 03:49:25 INFO - 'USER': 'cltbld', 03:49:25 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 03:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:25 INFO - '_': '/tools/buildbot/bin/python'} 03:49:25 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/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 03:49:25 INFO - mozversion application_buildid: 20170918093138 03:49:25 INFO - mozversion application_changeset: 4ef69bbd6816d95ade430640785971f587e2d5bc 03:49:25 INFO - mozversion application_display_name: Nightly 03:49:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:49:25 INFO - mozversion application_name: Firefox 03:49:25 INFO - mozversion application_remotingname: firefox 03:49:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:49:25 INFO - mozversion application_vendor: Mozilla 03:49:25 INFO - mozversion application_version: 57.0a1 03:49:25 INFO - mozversion platform_buildid: 20170918093138 03:49:25 INFO - mozversion platform_changeset: 4ef69bbd6816d95ade430640785971f587e2d5bc 03:49:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:49:25 INFO - mozversion platform_version: 57.0a1 03:49:25 INFO - using testdate: 1505731765 03:49:25 INFO - actual date: 1505731765 03:49:25 INFO - starting webserver on 'localhost:45577' 03:49:25 INFO - SUITE-START | Running 2 tests 03:49:25 INFO - TEST-START | dromaeo_css 03:49:25 INFO - Initialising browser for dromaeo_css test... 03:49:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45577/getInfo.html -profile /tmp/tmpSuyRCY/profile 03:49:25 INFO - TEST-INFO | started process 29957 (/builds/slave/test/build/application/firefox/firefox http://localhost:45577/getInfo.html) 03:49:31 INFO - TEST-INFO | 29957: exit 0 03:49:31 INFO - Browser initialized. 03:49:31 INFO - Running cycle 1/1 for dromaeo_css test... 03:49:31 INFO - Using env: {'DISPLAY': ':0', 03:49:31 INFO - 'HOME': '/home/cltbld', 03:49:31 INFO - 'JSGC_DISABLE_POISONING': '1', 03:49:31 INFO - 'LANG': 'en_US.UTF-8', 03:49:31 INFO - 'LANGUAGE': 'en_US:en', 03:49:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:49:31 INFO - 'LOGNAME': 'cltbld', 03:49:31 INFO - 'MAIL': '/var/mail/cltbld', 03:49:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:49:31 INFO - 'MOZ_CRASHREPORTER': '1', 03:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:49:31 INFO - 'MOZ_NO_REMOTE': '1', 03:49:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:31 INFO - 'NO_EM_RESTART': '1', 03:49:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:31 INFO - 'PWD': '/builds/slave/test', 03:49:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:31 INFO - 'RUST_BACKTRACE': 'full', 03:49:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:49:31 INFO - 'SHELL': '/bin/bash', 03:49:31 INFO - 'SHLVL': '1', 03:49:31 INFO - 'TERM': 'linux', 03:49:31 INFO - 'TMOUT': '86400', 03:49:31 INFO - 'USER': 'cltbld', 03:49:31 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 03:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:31 INFO - '_': '/tools/buildbot/bin/python'} 03:49:31 INFO - TEST-INFO | started process 30192 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSuyRCY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:32 INFO - PID 30192 | 03:49:32 INFO - PID 30192 | (/builds/slave/test/build/application/firefox/firefox:30242): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:49:32 INFO - PID 30192 | 03:49:42 INFO - PID 30192 | RSS: Main: 144154624 03:49:42 INFO - PID 30192 | 03:52:40 INFO - PID 30192 | Cycle 1(1): loaded http://localhost:45577/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45577/tests/dromaeo/cssquery-ext.html) 03:52:41 INFO - PID 30192 | RSS: Main: 148353024 03:52:41 INFO - PID 30192 | 03:55:43 INFO - PID 30192 | Cycle 1(1): loaded http://localhost:45577/tests/dromaeo/cssquery-ext.html (next: http://localhost:45577/tests/dromaeo/cssquery-jquery.html) 03:55:43 INFO - PID 30192 | RSS: Main: 148717568 03:55:43 INFO - PID 30192 | 03:58:45 INFO - PID 30192 | Cycle 1(1): loaded http://localhost:45577/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45577/tests/dromaeo/cssquery-mootools.html) 03:58:46 INFO - PID 30192 | RSS: Main: 150679552 03:58:46 INFO - PID 30192 | 04:01:47 INFO - PID 30192 | Cycle 1(1): loaded http://localhost:45577/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45577/tests/dromaeo/cssquery-prototype.html) 04:01:48 INFO - PID 30192 | RSS: Main: 149012480 04:01:48 INFO - PID 30192 | 04:04:51 INFO - PID 30192 | Cycle 1(1): loaded http://localhost:45577/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45577/tests/dromaeo/cssquery-yui.html) 04:04:51 INFO - PID 30192 | RSS: Main: 150425600 04:04:51 INFO - PID 30192 | 04:07:53 INFO - PID 30192 | Cycle 1(1): loaded http://localhost:45577/tests/dromaeo/cssquery-yui.html (next: http://localhost:45577/tests/dromaeo/cssquery-dojo.html) 04:07:53 INFO - PID 30192 | RSS: Main: 152973312 04:07:53 INFO - PID 30192 | 04:07:53 INFO - PID 30192 | __start_tp_report 04:07:53 INFO - PID 30192 | _x_x_mozilla_page_load 04:07:53 INFO - PID 30192 | _x_x_mozilla_page_load_details 04:07:53 INFO - PID 30192 | |i|pagename|runs| 04:07:53 INFO - PID 30192 | |0;dojo.html;3795.3737633290507;3807.181455986962;3818.6754125899297;3822.44574536692;3860.86486972956;6040.909386359208;6161.383861613836;6228.813135605933;6234.971229747086;6330.683465826707;6182.845428864281;6208.875822483547;6317.589356691812;6334.398232167948;6336.7465301388;5524.1989911462815;5589.329280486348;5642.943570564304;5645.858853528674;5660.150977353389;5475.616706830523;5613.46672066153;5650.576206784487;5700.315962084555;5735.569832262576;5475.534579560742;5575.414581468928;5587.608867379285;5632.35227948787;5707.058335374679;5476.096444086721;5556.249906262643;5562.082256427685;5577.163425486169;5605.075162598167;5606.467385598362;5635.746391412396;5651.350094739076;5658.886822263532;5677.063284558043;6164.137020817089;6249.687515624246;6276.089966954766;6279.780207692755;6329.177206963065;6625.469962402996;6692;6699.799006029827;6716.46268298535;6791.185057793096;6775.525713200078;6822.965885170543;6837.965810170967;6868.862622747567;6874.175098988154;6128.3258841527395;6140.631562106243;6178.196834411498;6190.1952746142715;6327.114204011442;6957.443404527626;7014.789556313319;7043.084399028094;7049.718011279594;7051.576905385693;6693.096431981718;6695.899561506581;6736.797896063126;6775.72897084121;6786.287439818847;6667.19993600771;6754.45964322853;6756.864862702719;6804.863902722017;6806.319368063253;6699.6315202663345;6702.932970670231;6704.530682852153;6781.42357899584;6788.76239331621;6609.173853268341;6739.932600674028;6742.9662851685425;6743.291954344723;6757.8648427031185;4853.80584776605;4886.877828054256;4900.166971614834;4909.631777616693;4928.901421971612;4350.738955662607;4389.3415987601475;4462.085272519126;4465.933011004838;4513.390692256503;6232.688365581703;6243.250809902841;6258.405451482102;6263.843403914848;6270.372962703693;6736.292689267556;6774.695138718769;6779.220389655155;6827.2831352708245;6828.453723702092;6097.878042439215;6156.107364432132;6242.375762423812;6268.153799237136;6270.623762574261;5368.5436737876935;5369.167778994262;5383;5383.488568585978;5390.649607775482;6765.763198288037;6770.356816102462;6773.62745049027;6830.795076147723;6911.2397636259975;6723.663816809238;6724.4620430364475;6763.526553141233;6776.15298087739;6811.625360605016;6930.549514281555;6955.756548520778;7028.8945665814035;7041.049458323061;7041.612711300722;6543.901841472477;6546.443552297917;6616.603003819786;6654.833629159116;6687.063811066552;6613.074169616354;6756.425703815231;6838.658067096725;6857.965710171417;6870.141232345957;6521.543491955707;6552.934470655233;6621.702023409054;6627.834304142435;6641.701123449359;6400.967995160181;6409;6489.221293444817;6493.026046093124;6504.577202481823;6325.082862984934;6349.523785716182;6421.165248517663;6436.452901503425;6445.25879523842;6486.967565162144;6514.511411644051;6592.274849766426;6666.333366663489;6674.232463266787;6464;6470.38531339522;6477.967610161919;6481;6486.962086066207 04:07:53 INFO - PID 30192 | |1;ext.html;939.6100618243429;945.1163162443112;974.2790335151988;994.1599348550477;1003.9347442416242;43559.346609800836;43703;44483.33275000873;44548;44641.55358446415;41544.169116617726;41646;41961.790191049;41990.160196796045;42068.15863682725;7238.312360325774;7312.232215617363;7334;7363.263673632648;7364.963175184116;7431.702731890745;7573.394128469709;7576.166621671612;7578.280063393969;7584.848303033936;8073.394495412838;8285.088640249567;8286.58567071647;8291.378146638996;8297.585120743968;8113.066997295268;8173.386995975326;8233.094359620467;8238.423310368276;8243.299319557846;8079;8152.510849349058;8153;8155.836883262302;8157.347412207009;38990.220195596215;39160.60839391598;39254.214915701814;39929.20141597152;40818;3741.850325986957;3764.9435258471144;3768.566614839301;3769.1707824278615;3771.358868992278;32514;32532.6746732532;32695.673043269737;32756.672433275602;32856;5377.4084850666395;5389.461053894618;5390.56875449967;5409.513143817076;5434.809781657663;209000;210412;210529;210932;212165;51167;51342.14933879974;51416.22875656868;51461;51685.483145168066;54398;54714.45285547093;54909.725451373284;54915.725421373434;54982.72508637431;16813;17154.828451715573;17157.91421042887;17166.227519761393;17191.226394812264;14035.22806245646;14069.788953165711;14077.366518506691;14090;14090.506832260822;14886.925565372103;14931.40274389034;15088.773668394982;15091.622709432351;15189.62025949338;6046.969765151234;6051.273847138284;6103.6032657877095;6160.661163636043;6181.8454538636;1103.2994048779083;1106.4578356605205;1119.7368618374676;1124.696331990358;1127.3630398824637;24771.752282476944;24916.12793552217;24926.252212433657;25281.49437011286;25433;1193.164784650748;1204.3376143121423;1207.3540655749132;1222.608765195129;1226.0926914083514;13193.47226110964;13206.73586528264;13224.47102115924;13408.262545560088;13517.729645407037;275547;275592;276376;276956;277571;56400.43599564034;61696.38303616996;62111.6894415525;62470.68764656148;62523;1507.766296224087;1525.359349073414;1548.775427562997;1549.2950707428092;1565.1469948877889;29480.852595736884;29752.404951901273;30092.24769380783;30345.089647310615;30665.386692266475;40243;40248.597514024485;40263.39604905988;40287.1942561153;40369.192616146924;232351;234378;234404;234785.82607086856;235029;35168.472472912414;35177.296454071286;35554.46668299926;35597;35773.10567235736;43979.34030989474;44552;45678.08643827171;45715.31427028664;45726.54273457223;33670.49494257637;33684;33766.49350259797;33870.83064584661;33906.321873561894;33899.15252118717;34171.31657366888;34547.13632159216;34766.435510401585;35117.82441087778;38813.61186388213;39385.80307098446;39711.411543537935;39790.80104599459;39904.60095399009;32632;32650.673493264763;33346.83326583351;33417.83291083626;33659.14874681916;25448.872755636105;25498.362540936625;25571;26097.608535871597;26252.737472625795 04:07:53 INFO - PID 30192 | |2;jquery.html;583.8803045375698;594.7502049139358;597.4354235247692;598.434479416951;611.5688439650047;23363.415914602145;23835.880820595896;23910.521789564198;23998.88000559995;24026.038958441684;24517.38706532333;25067.74932250677;26007.869960650216;26091.60862587058;26110.73889261107;6552.344765523457;6723.798286051427;6748.190217173946;6750.831229219284;6774;6569.572977756455;6576.93423065768;6643.402093811556;6663.766768163116;6830.180378354605;6813.454923606099;6818.829529261783;6826.351496607815;6826.658667066627;6828.52200345976;6803.897941530881;6811.25076241613;6813.795586132399;6815.488838337095;6825.624590647512;6212.72042758077;6326.810195694136;6451.806445806634;6456.160699109086;6456.741730330781;30737.846310768527;31023.0693079208;31055.378892422024;31060.534091988637;31084;2268.739095004079;2301.160076572056;2302.286291249718;2305.216226483004;2305.7002589663402;19656.115474803668;20607.690884636744;20681;20809.479763005893;20847.957602119986;2503.3366157968153;2525.6716626838393;2554.9105781297753;2575.8454492730307;2592.507423589531;136762.3161884194;141049;141984;150227;154461.99999999886;15775.368985240691;16042.358305667876;16458.670826583402;16698.916505417394;16839.41062062822;25702.871485642452;25720.09979650703;25864.094756683426;25929.61105583418;25960.870195649277;10707.196960228013;10756.784864302826;10763.19276054299;10823.025927666391;11037.39294338803;9598.95200524007;9633.373830700983;9698.806023879482;9747.171490423394;9795.804083918281;9784.037464826757;9919.65281215154;9935.37521736747;10005.699829005142;10141.94929025365;2841.4427015686047;2843.6018957345987;2852.8573571321767;2871.526198177319;2933.7506311963293;1034.7620047389144;1057.6932689520106;1058.216919479595;1060.5676571593262;1065.307550092446;21710.78289217119;21910.89044554799;21980.560388792135;22094.779052209593;22244.77755222427;1119.1941801902617;1120.3166068698088;1122.528538014036;1131.9943400282946;1145.2727518026113;11653.825192622118;11896.821547676791;11928.46321915516;11952.940235298942;12112.454939527743;616401;617553;618137;626371;631928;125779;129246.35376823056;129574;129913;131072;1120.8542889424486;1184.7452797648548;1187.329159025148;1244.7821631214501;1251.2242409706041;22712.772872271726;22881.65677514872;23243.76756232416;23253.302400927998;23263.302100937;61876;63410.36589634229;63431.36568634439;63441.36558634539;64236.35763642491;78239;78999;79011;79816;80835;15590.76613850816;15839.366425342858;16005.279762410486;16026.198690065683;16071.678566428373;24507.754922450546;24783.13259035925;24893.377665557782;25069.749302507473;25246.495070098128;19979.20083196656;20173.798262017193;20599.7640141592;20655.896720516303;20682.276120335715;17427.651446970736;17542.298308067533;17716.11419429049;17812.19845106999;18011.729824052913;19528.31650892212;20894.47763805917;20971.8951405242;21172;21224.25715099964;15834.445794397141;15897.841021589637;15900.363985440454;15985.120818355103;15987.120708361152;20169.294074707315;20242.898785506568;20459.590808183457;20590.073446694634;20603.278885238946 04:07:53 INFO - PID 30192 | |3;mootools.html;1441.5675297410778;1491.9477818276362;1499.0705762427297;1506.8719158871493;1512.1531942112417;16285.51143465695;16934.74597881031;16985.3205871765;16985.49043528696;16991.83008169918;16468.917655411737;16650.83349166508;16661.83338166621;16675.082870442122;16682.749758753627;2771.3764403009313;2812.184466504711;2816.2677703796953;2816.5493521036638;2817.4505971335598;2622.17401518522;2723.305557082941;2725.713800050996;2729.0311939261574;2731.8360898346064;2569.820112592119;2621.6591843060373;2645.8412495250345;2647.2058382485275;2648.0334677842643;2593.701724301711;2596.3249555115713;2622.016743721114;2623.0950322139024;2624.6587943567406;2639.129087401153;2640.485105404447;2643.590243512259;2644.3917898883174;2649.430372469909;15941.202939852961;16009.599760006093;16182.19089045543;16228.51314460568;16242.675146497122;8043.55760433176;8252.793680157984;8258.25675689185;8287.295579875718;8327.292180164693;5243.802103468417;5384.6769193848495;5474;5510.311211098613;5638.40796716343;2057.44448998771;2101.686445971268;2137.7755335689685;2159.7408311002782;2165.8159056480217;27641.861790690917;28437.289067773265;29848.253793655116;30686.232844178852;30711.232219194477;6998.405135563432;7126.6080365579355;7161.3554780069;7250.3112204340505;7259.346658800628;22367.44081397978;22399.88800055989;22444.66333005006;22457.663135052986;22663.546729065325;7769.4561380703935;7779.183185765526;7822.217778222132;7834.686612535549;7875.488093273919;6967.82580435483;7043.542169758949;7653.579053152019;7756.379489640815;7756.883646745303;5378.596605254544;5566.304211973504;5576.442355764472;5592.356878958891;5600.635958662674;1682.444793218235;1690.3745614122608;1690.9577260568585;1702.1914590569381;1718.243972652029;923.8244733500613;933.5192375926267;934.3739694404765;942.9104235097655;946.6781294359951;8495.617697203641;8546.572671366532;8611.48331100136;8649.048604653482;8656.26421754158;757.8597959377422;769.7056597761589;786.41412147949;787.3071696906685;790.4901338636547;4753.83361582343;4796.088743138862;4802.615790736732;4831.299461578122;4857.781399837016;23572.764272357057;23940.760592394203;24834;24920.25877153512;25004.37489062788;24058.037678493016;24304.270871873872;24306;24459.87770061138;24478.510429791306;10619.628313009007;11600.709982250342;11709.473073711704;11730.061595072373;11731.648050558497;8307.667693292442;8452.661893524437;8541.487510749375;8600.78498037554;8833.514156721185;20014.799852001877;21157.461104666923;21262.681059784423;21618.567628647026;21829.999999999363;20722.378328650164;21315.46711332229;21335.359939201848;22252.66621000654;22271.109155633592;13345.532906348231;13563.728725425239;13567.389467474184;13571.59285221445;13581.185128892299;15197.392104315704;15199;15339.386424542894;15340.15629140408;15411.691766164839;12332.938335308625;12429.067819913724;12473.126881118234;12885.162464439782;12949.741005180033;12369.93815030919;12374.566890158801;12398.504059837505;12426.130170888313;12795.168314059556;10779.51492182838;10788.352698838095;10830.566777328819;10903.56385744593;10907.563697452013;7328.1938986712485;7459.962700186465;7473.701051957861;7476.728956077589;7489.925100748923;7156.284371563011;7300.598467084362;7300.890486642598;7317.926820731937;7394.2975417335265 04:07:53 INFO - PID 30192 | |4;prototype.html;533.663791811159;534.6204195021533;562.4656576252561;566.6996491859315;576.5243673968977;6279.529035322352;6320.936790632092;6385.968070159654;6440.355964403558;6464.96767516163;6279.68601569922;6293.213348331458;6326.493880489561;6346.270178929424;6394.456471199954;5145.614078944075;5155.561777248939;5160.458151894035;5175.146100893348;5176.715280659562;5118.28537439958;5139.486051394868;5144.819931302405;5154.74226288686;5205.479452054802;4865.635077369211;4983.352164218646;5070.492950704936;5090.974545127269;5115.4884511548735;5002.349694539723;5009.899802003976;5019.874503137415;5033.823816166417;5042.193249080166;4474.955250447519;4489.1919454498175;4517.93828450314;4544.295634176708;4552.772361381918;6122.8775424491705;6224.9688751556405;6230.470410015154;6275.341089185661;6285.8742825143245;6178.076921155054;6199.287081985584;6228.87542249157;6237.844053898643;6255.874882502325;6688.83277918051;6770.187577490683;6773.864522709568;6806.149231346082;6852.349026842442;5459.508644221999;5519.751611177507;5523.226748255248;5535.391106978229;5542.972285138549;6924.065251191075;6945.027696122496;6958.234594194634;6988.61562614056;7033.859322813566;5654.4062873398525;5680.784494047242;5684.090545512699;5727.255456790591;5746.166805813217;5767;5774.509166720875;5793.362730099686;5828.096645019944;5836.970815145982;6089.756409743649;6137.355577664371;6176.764647070604;6177.887980163614;6181.598196117238;6774.525783195228;6778.661066946633;6788.660566971632;6799.966000169968;6825.69284382204;1993.730846335726;2007.6185524750542;2010.2160157538572;2012.7081573171808;2026.1085122546033;1425.3585886351184;1498.7377208988382;1524.3826250368618;1524.96187595311;1539.7536394177102;6021.488173505213;6027.819165425044;6110.633361998294;6128.448439640454;6153.107799369066;6603.933960660428;6660.167479065117;6685.799426017227;6747.257801641816;6810.659467026629;6027.517798576104;6097.987664070846;6115.663638499836;6135.355787642323;6149.661768602769;3505.2463720300257;3517.5427194464555;3547.379208638478;3548.3790336690977;3553.2893421315325;6925.861482770317;6971.58170509771;6981.301869812978;7008.684609192598;7038.5073044887395;6785.253622101565;6873.140857392826;6922.826929326807;6947.166340039228;6948.756793512304;6916.377526022682;6926.792196234121;6941.167059952838;6969.7909062728195;7005.859882802315;6514.348565143638;6600.940421640752;6713;6730.59146259201;6765.898511522233;6534.640594767334;6572.178477690289;6623.701933412912;6644.76743314001;6651.569912468843;6831.521793474608;6843.7604683835825;6852.931470685229;6896.896546551906;6956.930430695831;5526.22632831412;5651.350094738993;5675.659460432387;5700.971495142498;5733.0540460823495;6664.400203981665;6815.2162501311;6829.89755153683;6876.627563490588;6954.756583519553;6386.808395748135;6559.836004099936;6596.208454985433;6612.404883560503;6665.666716664245;6465.321141280097;6568.343165683394;6594.670266486753;6645.568038077509;6661.4004739573675;6322.557420980487;6387.869943727447;6430.3891130342545;6534.4772418205475;6546.967265163834;6468.838279043061;6510.641914694737;6564.704588293634;6574.53978221539;6606.240282367589;6257.68711564429;6270.2475702915945;6324.715387807468;6342.143810585512;6454.548181627241 04:07:53 INFO - PID 30192 | |5;yui.html;983.3559018842658;998.5656239535803;1003.9849402258967;1004.0461561516561;1008.5763979128765;20133.798662013374;20350.389488315337;20780.168793248253;20820.16719331229;20831.791682083174;19377.90311048443;19829.900850495764;19843.801561984375;19924;19924.800751992476;1020.4693559349134;1027.275770581738;1046.3669479964626;1047.2355180718043;1047.3611097230682;1067.5302866738648;1078.6009176604666;1079.4926384599225;1080.378782200238;1080.95676172953;1120.1263014848432;1120.675004248767;1125.9268147570422;1129.5989923577135;1132.4054871192607;1110.4225802582653;1118.4966764955761;1118.8825173356843;1119.7256672115343;1119.9776004479866;819.7745619954501;821.708293555791;822.5393779483509;825.158338494738;826.099551488874;18973.43079707611;19080.14139363732;19136.712949305773;19312;19327.130279137473;23126.53746925052;23218.3034508965;23825.404364890845;23834;23889.28332150038;18429.723554146698;18451.169697363515;18466.815331846643;18502.629947400976;18505.167267472996;3862.942055869164;3959.5842436544035;3976.1451287973223;3979.303621866162;3999.960000399988;158869;158914;161230;161960;162698.3730162695;17798.46604601864;17983.820161798216;18113;18179.181936812874;18224.908875455538;34028;34651.65348346535;34756.47865282023;34962.82518587442;34979.12552186216;9299.67451139207;9522.571484283224;9533.285003624756;9587.568559414844;9620.422774633544;4550.089982003613;4586.564276393738;4615.538446155358;4615.792289346988;4617.699849509771;5618.129189975561;5721.685307308055;5721.971390143106;5730.971345143247;5733.684647344436;957.7366224288377;999.6551189839494;1002.0080120680474;1009.0313299232672;1012;670.4937771982122;692.5740669488329;694.3299715774302;701.5194591704699;705.4180301251488;12813.743725125445;12992.740145197044;13481.932590336986;14302.713945721236;14448.711025779425;692.9272426395257;698.0750505580127;698.6960672107649;705.5131958948309;716.9928300716927;5857.853553661193;5883.676397798076;5903.940960590425;5929.733162007634;5956.7693953187745;150400;151203;152081;153015;153136;131009;133162;133970.3301483506;134399;138118;114750;117764.41117794356;118375.40812295883;118600;120350.3982480082;11053.83419248728;11250.943745281222;11361.37512436824;11361.886381136082;11423.600173994202;54067.45932540624;55306.170407444726;55638.16542751781;56213.15680264717;56219.43780562142;67511;68654.65672671604;69195.30804691889;70312.64843675954;70965.29034709794;15960.680786384439;16045.438409655606;16113;16195.190240488164;16318.918405408373;15873.206339682738;15997.280122394288;16010.439634612732;16038.599035024217;16101.114438705983;16380.262888170299;16423.096729679983;16550.751738724168;16589.419370321983;16602.169891505135;14205.715885682435;14470.710585788436;14521.201333926736;14612.050216735877;14631.780523292373;15162.3176957035;15504.457343992906;15507.534773956799;15583.610409739847;15622.609434764221;11915.880871063042;12065.457054432396;12073.154879158375;12094;12132.696682583006;11700.648980530597;11748.647540573797;11953.760924781629;12115.575954841539;12183.878161218274 04:07:53 INFO - PID 30192 | __end_tp_report 04:07:53 INFO - PID 30192 | __start_cc_report 04:07:53 INFO - PID 30192 | _x_x_mozilla_cycle_collect,284 04:07:53 INFO - PID 30192 | __end_cc_report 04:07:53 INFO - PID 30192 | __startTimestamp1505732873345__endTimestamp 04:07:53 INFO - PID 30192 | 04:07:53 INFO - PID 30192 | ------- Summary: start ------- 04:07:53 INFO - PID 30192 | Number of tests: 6 04:07:53 INFO - PID 30192 | 04:07:53 INFO - PID 30192 | [#0] dojo.html Cycles:165 Average:6204.43 Median:6464.00 stddev:744.29 (11.5%) stddev-sans-first:722.18 04:07:53 INFO - PID 30192 | Values: 3795.4 3807.2 3818.7 3822.4 3860.9 6040.9 6161.4 6228.8 6235.0 6330.7 6182.8 6208.9 6317.6 6334.4 6336.7 5524.2 5589.3 5642.9 5645.9 5660.2 5475.6 5613.5 5650.6 5700.3 5735.6 5475.5 5575.4 5587.6 5632.4 5707.1 5476.1 5556.2 5562.1 5577.2 5605.1 5606.5 5635.7 5651.4 5658.9 5677.1 6164.1 6249.7 6276.1 6279.8 6329.2 6625.5 6692.0 6699.8 6716.5 6791.2 6775.5 6823.0 6838.0 6868.9 6874.2 6128.3 6140.6 6178.2 6190.2 6327.1 6957.4 7014.8 7043.1 7049.7 7051.6 6693.1 6695.9 6736.8 6775.7 6786.3 6667.2 6754.5 6756.9 6804.9 6806.3 6699.6 6702.9 6704.5 6781.4 6788.8 6609.2 6739.9 6743.0 6743.3 6757.9 4853.8 4886.9 4900.2 4909.6 4928.9 4350.7 4389.3 4462.1 4465.9 4513.4 6232.7 6243.3 6258.4 6263.8 6270.4 6736.3 6774.7 6779.2 6827.3 6828.5 6097.9 6156.1 6242.4 6268.2 6270.6 5368.5 5369.2 5383.0 5383.5 5390.6 6765.8 6770.4 6773.6 6830.8 6911.2 6723.7 6724.5 6763.5 6776.2 6811.6 6930.5 6955.8 7028.9 7041.0 7041.6 6543.9 6546.4 6616.6 6654.8 6687.1 6613.1 6756.4 6838.7 6858.0 6870.1 6521.5 6552.9 6621.7 6627.8 6641.7 6401.0 6409.0 6489.2 6493.0 6504.6 6325.1 6349.5 6421.2 6436.5 6445.3 6487.0 6514.5 6592.3 6666.3 6674.2 6464.0 6470.4 6478.0 6481.0 6487.0 04:07:53 INFO - PID 30192 | 04:07:53 INFO - PID 30192 | [#1] ext.html Cycles:180 Average:41904.89 Median:19757.48 stddev:62870.02 (318.2%) stddev-sans-first:62971.14 04:07:53 INFO - PID 30192 | Values: 939.6 945.1 974.3 994.2 1003.9 43559.3 43703.0 44483.3 44548.0 44641.6 41544.2 41646.0 41961.8 41990.2 42068.2 7238.3 7312.2 7334.0 7363.3 7365.0 7431.7 7573.4 7576.2 7578.3 7584.8 8073.4 8285.1 8286.6 8291.4 8297.6 8113.1 8173.4 8233.1 8238.4 8243.3 8079.0 8152.5 8153.0 8155.8 8157.3 38990.2 39160.6 39254.2 39929.2 40818.0 3741.9 3764.9 3768.6 3769.2 3771.4 32514.0 32532.7 32695.7 32756.7 32856.0 5377.4 5389.5 5390.6 5409.5 5434.8 209000.0 210412.0 210529.0 210932.0 212165.0 51167.0 51342.1 51416.2 51461.0 51685.5 54398.0 54714.5 54909.7 54915.7 54982.7 16813.0 17154.8 17157.9 17166.2 17191.2 14035.2 14069.8 14077.4 14090.0 14090.5 14886.9 14931.4 15088.8 15091.6 15189.6 6047.0 6051.3 6103.6 6160.7 6181.8 1103.3 1106.5 1119.7 1124.7 1127.4 24771.8 24916.1 24926.3 25281.5 25433.0 1193.2 1204.3 1207.4 1222.6 1226.1 13193.5 13206.7 13224.5 13408.3 13517.7 275547.0 275592.0 276376.0 276956.0 277571.0 56400.4 61696.4 62111.7 62470.7 62523.0 1507.8 1525.4 1548.8 1549.3 1565.1 29480.9 29752.4 30092.2 30345.1 30665.4 40243.0 40248.6 40263.4 40287.2 40369.2 232351.0 234378.0 234404.0 234785.8 235029.0 35168.5 35177.3 35554.5 35597.0 35773.1 43979.3 44552.0 45678.1 45715.3 45726.5 33670.5 33684.0 33766.5 33870.8 33906.3 33899.2 34171.3 34547.1 34766.4 35117.8 38813.6 39385.8 39711.4 39790.8 39904.6 32632.0 32650.7 33346.8 33417.8 33659.1 25448.9 25498.4 25571.0 26097.6 26252.7 04:07:53 INFO - PID 30192 | 04:07:53 INFO - PID 30192 | [#2] jquery.html Cycles:180 Average:40288.42 Median:23258.30 stddev:103643.28 (445.6%) stddev-sans-first:103891.15 04:07:53 INFO - PID 30192 | Values: 583.9 594.8 597.4 598.4 611.6 23363.4 23835.9 23910.5 23998.9 24026.0 24517.4 25067.7 26007.9 26091.6 26110.7 6552.3 6723.8 6748.2 6750.8 6774.0 6569.6 6576.9 6643.4 6663.8 6830.2 6813.5 6818.8 6826.4 6826.7 6828.5 6803.9 6811.3 6813.8 6815.5 6825.6 6212.7 6326.8 6451.8 6456.2 6456.7 30737.8 31023.1 31055.4 31060.5 31084.0 2268.7 2301.2 2302.3 2305.2 2305.7 19656.1 20607.7 20681.0 20809.5 20848.0 2503.3 2525.7 2554.9 2575.8 2592.5 136762.3 141049.0 141984.0 150227.0 154462.0 15775.4 16042.4 16458.7 16698.9 16839.4 25702.9 25720.1 25864.1 25929.6 25960.9 10707.2 10756.8 10763.2 10823.0 11037.4 9599.0 9633.4 9698.8 9747.2 9795.8 9784.0 9919.7 9935.4 10005.7 10141.9 2841.4 2843.6 2852.9 2871.5 2933.8 1034.8 1057.7 1058.2 1060.6 1065.3 21710.8 21910.9 21980.6 22094.8 22244.8 1119.2 1120.3 1122.5 1132.0 1145.3 11653.8 11896.8 11928.5 11952.9 12112.5 616401.0 617553.0 618137.0 626371.0 631928.0 125779.0 129246.4 129574.0 129913.0 131072.0 1120.9 1184.7 1187.3 1244.8 1251.2 22712.8 22881.7 23243.8 23253.3 23263.3 61876.0 63410.4 63431.4 63441.4 64236.4 78239.0 78999.0 79011.0 79816.0 80835.0 15590.8 15839.4 16005.3 16026.2 16071.7 24507.8 24783.1 24893.4 25069.7 25246.5 19979.2 20173.8 20599.8 20655.9 20682.3 17427.7 17542.3 17716.1 17812.2 18011.7 19528.3 20894.5 20971.9 21172.0 21224.3 15834.4 15897.8 15900.4 15985.1 15987.1 20169.3 20242.9 20459.6 20590.1 20603.3 04:07:53 INFO - PID 30192 | 04:07:53 INFO - PID 30192 | [#3] mootools.html Cycles:180 Average:10222.93 Median:2622.63 stddev:7731.25 (294.8%) stddev-sans-first:7724.80 04:07:53 INFO - PID 30192 | Values: 1441.6 1491.9 1499.1 1506.9 1512.2 16285.5 16934.7 16985.3 16985.5 16991.8 16468.9 16650.8 16661.8 16675.1 16682.7 2771.4 2812.2 2816.3 2816.5 2817.5 2622.2 2723.3 2725.7 2729.0 2731.8 2569.8 2621.7 2645.8 2647.2 2648.0 2593.7 2596.3 2622.0 2623.1 2624.7 2639.1 2640.5 2643.6 2644.4 2649.4 15941.2 16009.6 16182.2 16228.5 16242.7 8043.6 8252.8 8258.3 8287.3 8327.3 5243.8 5384.7 5474.0 5510.3 5638.4 2057.4 2101.7 2137.8 2159.7 2165.8 27641.9 28437.3 29848.3 30686.2 30711.2 6998.4 7126.6 7161.4 7250.3 7259.3 22367.4 22399.9 22444.7 22457.7 22663.5 7769.5 7779.2 7822.2 7834.7 7875.5 6967.8 7043.5 7653.6 7756.4 7756.9 5378.6 5566.3 5576.4 5592.4 5600.6 1682.4 1690.4 1691.0 1702.2 1718.2 923.8 933.5 934.4 942.9 946.7 8495.6 8546.6 8611.5 8649.0 8656.3 757.9 769.7 786.4 787.3 790.5 4753.8 4796.1 4802.6 4831.3 4857.8 23572.8 23940.8 24834.0 24920.3 25004.4 24058.0 24304.3 24306.0 24459.9 24478.5 10619.6 11600.7 11709.5 11730.1 11731.6 8307.7 8452.7 8541.5 8600.8 8833.5 20014.8 21157.5 21262.7 21618.6 21830.0 20722.4 21315.5 21335.4 22252.7 22271.1 13345.5 13563.7 13567.4 13571.6 13581.2 15197.4 15199.0 15339.4 15340.2 15411.7 12332.9 12429.1 12473.1 12885.2 12949.7 12369.9 12374.6 12398.5 12426.1 12795.2 10779.5 10788.4 10830.6 10903.6 10907.6 7328.2 7460.0 7473.7 7476.7 7489.9 7156.3 7300.6 7300.9 7317.9 7394.3 04:07:53 INFO - PID 30192 | 04:07:53 INFO - PID 30192 | [#4] prototype.html Cycles:180 Average:5727.05 Median:6277.44 stddev:1537.05 (24.5%) stddev-sans-first:1491.11 04:07:53 INFO - PID 30192 | Values: 533.7 534.6 562.5 566.7 576.5 6279.5 6320.9 6386.0 6440.4 6465.0 6279.7 6293.2 6326.5 6346.3 6394.5 5145.6 5155.6 5160.5 5175.1 5176.7 5118.3 5139.5 5144.8 5154.7 5205.5 4865.6 4983.4 5070.5 5091.0 5115.5 5002.3 5009.9 5019.9 5033.8 5042.2 4475.0 4489.2 4517.9 4544.3 4552.8 6122.9 6225.0 6230.5 6275.3 6285.9 6178.1 6199.3 6228.9 6237.8 6255.9 6688.8 6770.2 6773.9 6806.1 6852.3 5459.5 5519.8 5523.2 5535.4 5543.0 6924.1 6945.0 6958.2 6988.6 7033.9 5654.4 5680.8 5684.1 5727.3 5746.2 5767.0 5774.5 5793.4 5828.1 5837.0 6089.8 6137.4 6176.8 6177.9 6181.6 6774.5 6778.7 6788.7 6800.0 6825.7 1993.7 2007.6 2010.2 2012.7 2026.1 1425.4 1498.7 1524.4 1525.0 1539.8 6021.5 6027.8 6110.6 6128.4 6153.1 6603.9 6660.2 6685.8 6747.3 6810.7 6027.5 6098.0 6115.7 6135.4 6149.7 3505.2 3517.5 3547.4 3548.4 3553.3 6925.9 6971.6 6981.3 7008.7 7038.5 6785.3 6873.1 6922.8 6947.2 6948.8 6916.4 6926.8 6941.2 6969.8 7005.9 6514.3 6600.9 6713.0 6730.6 6765.9 6534.6 6572.2 6623.7 6644.8 6651.6 6831.5 6843.8 6852.9 6896.9 6956.9 5526.2 5651.4 5675.7 5701.0 5733.1 6664.4 6815.2 6829.9 6876.6 6954.8 6386.8 6559.8 6596.2 6612.4 6665.7 6465.3 6568.3 6594.7 6645.6 6661.4 6322.6 6387.9 6430.4 6534.5 6547.0 6468.8 6510.6 6564.7 6574.5 6606.2 6257.7 6270.2 6324.7 6342.1 6454.5 04:07:53 INFO - PID 30192 | 04:07:53 INFO - PID 30192 | [#5] yui.html Cycles:180 Average:28046.70 Median:17200.32 stddev:42959.49 (249.8%) stddev-sans-first:43031.94 04:07:53 INFO - PID 30192 | Values: 983.4 998.6 1004.0 1004.0 1008.6 20133.8 20350.4 20780.2 20820.2 20831.8 19377.9 19829.9 19843.8 19924.0 19924.8 1020.5 1027.3 1046.4 1047.2 1047.4 1067.5 1078.6 1079.5 1080.4 1081.0 1120.1 1120.7 1125.9 1129.6 1132.4 1110.4 1118.5 1118.9 1119.7 1120.0 819.8 821.7 822.5 825.2 826.1 18973.4 19080.1 19136.7 19312.0 19327.1 23126.5 23218.3 23825.4 23834.0 23889.3 18429.7 18451.2 18466.8 18502.6 18505.2 3862.9 3959.6 3976.1 3979.3 4000.0 158869.0 158914.0 161230.0 161960.0 162698.4 17798.5 17983.8 18113.0 18179.2 18224.9 34028.0 34651.7 34756.5 34962.8 34979.1 9299.7 9522.6 9533.3 9587.6 9620.4 4550.1 4586.6 4615.5 4615.8 4617.7 5618.1 5721.7 5722.0 5731.0 5733.7 957.7 999.7 1002.0 1009.0 1012.0 670.5 692.6 694.3 701.5 705.4 12813.7 12992.7 13481.9 14302.7 14448.7 692.9 698.1 698.7 705.5 717.0 5857.9 5883.7 5903.9 5929.7 5956.8 150400.0 151203.0 152081.0 153015.0 153136.0 131009.0 133162.0 133970.3 134399.0 138118.0 114750.0 117764.4 118375.4 118600.0 120350.4 11053.8 11250.9 11361.4 11361.9 11423.6 54067.5 55306.2 55638.2 56213.2 56219.4 67511.0 68654.7 69195.3 70312.6 70965.3 15960.7 16045.4 16113.0 16195.2 16318.9 15873.2 15997.3 16010.4 16038.6 16101.1 16380.3 16423.1 16550.8 16589.4 16602.2 14205.7 14470.7 14521.2 14612.1 14631.8 15162.3 15504.5 15507.5 15583.6 15622.6 11915.9 12065.5 12073.2 12094.0 12132.7 11700.6 11748.6 11953.8 12115.6 12183.9 04:07:53 INFO - PID 30192 | -------- Summary: end -------- 04:07:53 INFO - PID 30192 | 04:07:54 INFO - TEST-INFO | 30192: exit 0 04:07:54 INFO - TEST-OK | dromaeo_css | took 1108640ms 04:07:54 INFO - TEST-START | kraken 04:07:54 INFO - Initialising browser for kraken test... 04:07:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45577/getInfo.html -profile /tmp/tmpn3ZI7n/profile 04:07:54 INFO - TEST-INFO | started process 30569 (/builds/slave/test/build/application/firefox/firefox http://localhost:45577/getInfo.html) 04:07:59 INFO - TEST-INFO | 30569: exit 0 04:07:59 INFO - Browser initialized. 04:07:59 INFO - Running cycle 1/1 for kraken test... 04:07:59 INFO - Using env: {'DISPLAY': ':0', 04:07:59 INFO - 'HOME': '/home/cltbld', 04:07:59 INFO - 'JSGC_DISABLE_POISONING': '1', 04:07:59 INFO - 'LANG': 'en_US.UTF-8', 04:07:59 INFO - 'LANGUAGE': 'en_US:en', 04:07:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:07:59 INFO - 'LOGNAME': 'cltbld', 04:07:59 INFO - 'MAIL': '/var/mail/cltbld', 04:07:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:07:59 INFO - 'MOZ_CRASHREPORTER': '1', 04:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:07:59 INFO - 'MOZ_NO_REMOTE': '1', 04:07:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:59 INFO - 'NO_EM_RESTART': '1', 04:07:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:59 INFO - 'PWD': '/builds/slave/test', 04:07:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:59 INFO - 'RUST_BACKTRACE': 'full', 04:07:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:07:59 INFO - 'SHELL': '/bin/bash', 04:07:59 INFO - 'SHLVL': '1', 04:07:59 INFO - 'TERM': 'linux', 04:07:59 INFO - 'TMOUT': '86400', 04:07:59 INFO - 'USER': 'cltbld', 04:07:59 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888', 04:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:59 INFO - '_': '/tools/buildbot/bin/python'} 04:07:59 INFO - TEST-INFO | started process 30808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn3ZI7n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:00 INFO - PID 30808 | 04:08:00 INFO - PID 30808 | (/builds/slave/test/build/application/firefox/firefox:30858): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:08:00 INFO - PID 30808 | 04:08:10 INFO - PID 30808 | RSS: Main: 148283392 04:08:10 INFO - PID 30808 | 04:08:13 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45577/tests/kraken/driver.html?testName=audio-beat-detection) 04:08:14 INFO - PID 30808 | RSS: Main: 153374720 04:08:14 INFO - PID 30808 | 04:08:16 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45577/tests/kraken/driver.html?testName=audio-dft) 04:08:17 INFO - PID 30808 | RSS: Main: 153903104 04:08:17 INFO - PID 30808 | 04:08:20 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45577/tests/kraken/driver.html?testName=audio-fft) 04:08:20 INFO - PID 30808 | RSS: Main: 149946368 04:08:20 INFO - PID 30808 | 04:08:22 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45577/tests/kraken/driver.html?testName=audio-oscillator) 04:08:23 INFO - PID 30808 | RSS: Main: 151060480 04:08:23 INFO - PID 30808 | 04:08:25 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45577/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:08:26 INFO - PID 30808 | RSS: Main: 150917120 04:08:26 INFO - PID 30808 | 04:08:29 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45577/tests/kraken/driver.html?testName=imaging-darkroom) 04:08:29 INFO - PID 30808 | RSS: Main: 150757376 04:08:29 INFO - PID 30808 | 04:08:33 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45577/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:34 INFO - PID 30808 | RSS: Main: 152002560 04:08:34 INFO - PID 30808 | 04:08:36 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45577/tests/kraken/driver.html?testName=json-parse-financial) 04:08:37 INFO - PID 30808 | RSS: Main: 153927680 04:08:37 INFO - PID 30808 | 04:08:38 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45577/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:08:39 INFO - PID 30808 | RSS: Main: 153915392 04:08:39 INFO - PID 30808 | 04:08:41 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45577/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:08:41 INFO - PID 30808 | RSS: Main: 154034176 04:08:41 INFO - PID 30808 | 04:08:43 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45577/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:08:44 INFO - PID 30808 | RSS: Main: 151212032 04:08:44 INFO - PID 30808 | 04:08:46 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:47 INFO - PID 30808 | RSS: Main: 151109632 04:08:47 INFO - PID 30808 | 04:08:50 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:50 INFO - PID 30808 | RSS: Main: 151113728 04:08:50 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | Cycle 1(1): loaded http://localhost:45577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45577/tests/kraken/driver.html?testName=ai-astar) 04:08:52 INFO - PID 30808 | RSS: Main: 153255936 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | __start_tp_report 04:08:52 INFO - PID 30808 | _x_x_mozilla_page_load 04:08:52 INFO - PID 30808 | _x_x_mozilla_page_load_details 04:08:52 INFO - PID 30808 | |i|pagename|runs| 04:08:52 INFO - PID 30808 | |0;ai-astar;107;106;105;105;105;108;106;105;105;105 04:08:52 INFO - PID 30808 | |1;audio-beat-detection;113;113;111;116;116;115;112;117;112;117 04:08:52 INFO - PID 30808 | |2;audio-dft;161;161;161;161;162;164;162;161;165;167 04:08:52 INFO - PID 30808 | |3;audio-fft;73;72;73;74;72;72;73;73;74;73 04:08:52 INFO - PID 30808 | |4;audio-oscillator;82;83;78;78;77;78;78;77;78;78 04:08:52 INFO - PID 30808 | |5;imaging-gaussian-blur;116;114;117;113;113;113;113;113;114;110 04:08:52 INFO - PID 30808 | |6;imaging-darkroom;149;149;150;149;150;150;149;151;149;149 04:08:52 INFO - PID 30808 | |7;imaging-desaturate;95;94;93;94;96;94;94;94;94;94 04:08:52 INFO - PID 30808 | |8;json-parse-financial;44;44;44;47;46;44;44;44;44;46 04:08:52 INFO - PID 30808 | |9;json-stringify-tinderbox;39;39;39;39;39;42;40;39;40;38 04:08:52 INFO - PID 30808 | |10;stanford-crypto-aes;71;71;74;71;71;71;70;75;73;70 04:08:52 INFO - PID 30808 | |11;stanford-crypto-ccm;104;104;108;107;108;112;107;108;104;107 04:08:52 INFO - PID 30808 | |12;stanford-crypto-pbkdf2;152;151;153;152;151;158;165;151;153;150 04:08:52 INFO - PID 30808 | |13;stanford-crypto-sha256-iterative;65;60;67;60;60;59;61;61;61;58 04:08:52 INFO - PID 30808 | __end_tp_report 04:08:52 INFO - PID 30808 | __start_cc_report 04:08:52 INFO - PID 30808 | _x_x_mozilla_cycle_collect,730 04:08:52 INFO - PID 30808 | __end_cc_report 04:08:52 INFO - PID 30808 | __startTimestamp1505732932722__endTimestamp 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | ------- Summary: start ------- 04:08:52 INFO - PID 30808 | Number of tests: 14 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#0] ai-astar Cycles:10 Average:105.70 Median:105.50 stddev:1.06 (1.0%) stddev-sans-first:1.01 04:08:52 INFO - PID 30808 | Values: 107.0 106.0 105.0 105.0 105.0 108.0 106.0 105.0 105.0 105.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#1] audio-beat-detection Cycles:10 Average:114.20 Median:115.50 stddev:2.25 (1.9%) stddev-sans-first:2.35 04:08:52 INFO - PID 30808 | Values: 113.0 113.0 111.0 116.0 116.0 115.0 112.0 117.0 112.0 117.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:2.12 (1.3%) stddev-sans-first:2.18 04:08:52 INFO - PID 30808 | Values: 161.0 161.0 161.0 161.0 162.0 164.0 162.0 161.0 165.0 167.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#3] audio-fft Cycles:10 Average:72.90 Median:73.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 04:08:52 INFO - PID 30808 | Values: 73.0 72.0 73.0 74.0 72.0 72.0 73.0 73.0 74.0 73.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:78.00 stddev:2.06 (2.6%) stddev-sans-first:1.80 04:08:52 INFO - PID 30808 | Values: 82.0 83.0 78.0 78.0 77.0 78.0 78.0 77.0 78.0 78.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:113.50 stddev:1.90 (1.7%) stddev-sans-first:1.80 04:08:52 INFO - PID 30808 | Values: 116.0 114.0 117.0 113.0 113.0 113.0 113.0 113.0 114.0 110.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:08:52 INFO - PID 30808 | Values: 149.0 149.0 150.0 149.0 150.0 150.0 149.0 151.0 149.0 149.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 04:08:52 INFO - PID 30808 | Values: 95.0 94.0 93.0 94.0 96.0 94.0 94.0 94.0 94.0 94.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#8] json-parse-financial Cycles:10 Average:44.70 Median:44.00 stddev:1.16 (2.6%) stddev-sans-first:1.20 04:08:52 INFO - PID 30808 | Values: 44.0 44.0 44.0 47.0 46.0 44.0 44.0 44.0 44.0 46.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#9] json-stringify-tinderbox Cycles:10 Average:39.40 Median:39.00 stddev:1.07 (2.8%) stddev-sans-first:1.13 04:08:52 INFO - PID 30808 | Values: 39.0 39.0 39.0 39.0 39.0 42.0 40.0 39.0 40.0 38.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#10] stanford-crypto-aes Cycles:10 Average:71.70 Median:71.00 stddev:1.70 (2.4%) stddev-sans-first:1.79 04:08:52 INFO - PID 30808 | Values: 71.0 71.0 74.0 71.0 71.0 71.0 70.0 75.0 73.0 70.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#11] stanford-crypto-ccm Cycles:10 Average:106.90 Median:107.50 stddev:2.47 (2.3%) stddev-sans-first:2.39 04:08:52 INFO - PID 30808 | Values: 104.0 104.0 108.0 107.0 108.0 112.0 107.0 108.0 104.0 107.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:152.50 stddev:4.58 (3.0%) stddev-sans-first:4.82 04:08:52 INFO - PID 30808 | Values: 152.0 151.0 153.0 152.0 151.0 158.0 165.0 151.0 153.0 150.0 04:08:52 INFO - PID 30808 | 04:08:52 INFO - PID 30808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.00 stddev:2.74 (4.5%) stddev-sans-first:2.54 04:08:52 INFO - PID 30808 | Values: 65.0 60.0 67.0 60.0 60.0 59.0 61.0 61.0 61.0 58.0 04:08:52 INFO - PID 30808 | -------- Summary: end -------- 04:08:52 INFO - PID 30808 | 04:08:53 INFO - PID 30808 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:08:53 INFO - TEST-INFO | 30808: exit 0 04:08:53 INFO - TEST-OK | kraken | took 59266ms 04:08:53 INFO - SUITE-END | took 1167s 04:08:53 INFO - Completed test suite (00:19:27) 04:08:53 INFO - javascript benchmark 04:08:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8988.812818071829, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3795.3737633290507, 3807.181455986962, 3818.6754125899297, 3822.44574536692, 3860.86486972956, 6040.909386359208, 6161.383861613836, 6228.813135605933, 6234.971229747086, 6330.683465826707, 6182.845428864281, 6208.875822483547, 6317.589356691812, 6334.398232167948, 6336.7465301388, 5524.1989911462815, 5589.329280486348, 5642.943570564304, 5645.858853528674, 5660.150977353389, 5475.616706830523, 5613.46672066153, 5650.576206784487, 5700.315962084555, 5735.569832262576, 5475.534579560742, 5575.414581468928, 5587.608867379285, 5632.35227948787, 5707.058335374679, 5476.096444086721, 5556.249906262643, 5562.082256427685, 5577.163425486169, 5605.075162598167, 5606.467385598362, 5635.746391412396, 5651.350094739076, 5658.886822263532, 5677.063284558043, 6164.137020817089, 6249.687515624246, 6276.089966954766, 6279.780207692755, 6329.177206963065, 6625.469962402996, 6692.0, 6699.799006029827, 6716.46268298535, 6791.185057793096, 6775.525713200078, 6822.965885170543, 6837.965810170967, 6868.862622747567, 6874.175098988154, 6128.3258841527395, 6140.631562106243, 6178.196834411498, 6190.1952746142715, 6327.114204011442, 6957.443404527626, 7014.789556313319, 7043.084399028094, 7049.718011279594, 7051.576905385693, 6693.096431981718, 6695.899561506581, 6736.797896063126, 6775.72897084121, 6786.287439818847, 6667.19993600771, 6754.45964322853, 6756.864862702719, 6804.863902722017, 6806.319368063253, 6699.6315202663345, 6702.932970670231, 6704.530682852153, 6781.42357899584, 6788.76239331621, 6609.173853268341, 6739.932600674028, 6742.9662851685425, 6743.291954344723, 6757.8648427031185, 4853.80584776605, 4886.877828054256, 4900.166971614834, 4909.631777616693, 4928.901421971612, 4350.738955662607, 4389.3415987601475, 4462.085272519126, 4465.933011004838, 4513.390692256503, 6232.688365581703, 6243.250809902841, 6258.405451482102, 6263.843403914848, 6270.372962703693, 6736.292689267556, 6774.695138718769, 6779.220389655155, 6827.2831352708245, 6828.453723702092, 6097.878042439215, 6156.107364432132, 6242.375762423812, 6268.153799237136, 6270.623762574261, 5368.5436737876935, 5369.167778994262, 5383.0, 5383.488568585978, 5390.649607775482, 6765.763198288037, 6770.356816102462, 6773.62745049027, 6830.795076147723, 6911.2397636259975, 6723.663816809238, 6724.4620430364475, 6763.526553141233, 6776.15298087739, 6811.625360605016, 6930.549514281555, 6955.756548520778, 7028.8945665814035, 7041.049458323061, 7041.612711300722, 6543.901841472477, 6546.443552297917, 6616.603003819786, 6654.833629159116, 6687.063811066552, 6613.074169616354, 6756.425703815231, 6838.658067096725, 6857.965710171417, 6870.141232345957, 6521.543491955707, 6552.934470655233, 6621.702023409054, 6627.834304142435, 6641.701123449359, 6400.967995160181, 6409.0, 6489.221293444817, 6493.026046093124, 6504.577202481823, 6325.082862984934, 6349.523785716182, 6421.165248517663, 6436.452901503425, 6445.25879523842, 6486.967565162144, 6514.511411644051, 6592.274849766426, 6666.333366663489, 6674.232463266787, 6464.0, 6470.38531339522, 6477.967610161919, 6481.0, 6486.962086066207], "value": 6153.1957324045625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [939.6100618243429, 945.1163162443112, 974.2790335151988, 994.1599348550477, 1003.9347442416242, 43559.346609800836, 43703.0, 44483.33275000873, 44548.0, 44641.55358446415, 41544.169116617726, 41646.0, 41961.790191049, 41990.160196796045, 42068.15863682725, 7238.312360325774, 7312.232215617363, 7334.0, 7363.263673632648, 7364.963175184116, 7431.702731890745, 7573.394128469709, 7576.166621671612, 7578.280063393969, 7584.848303033936, 8073.394495412838, 8285.088640249567, 8286.58567071647, 8291.378146638996, 8297.585120743968, 8113.066997295268, 8173.386995975326, 8233.094359620467, 8238.423310368276, 8243.299319557846, 8079.0, 8152.510849349058, 8153.0, 8155.836883262302, 8157.347412207009, 38990.220195596215, 39160.60839391598, 39254.214915701814, 39929.20141597152, 40818.0, 3741.850325986957, 3764.9435258471144, 3768.566614839301, 3769.1707824278615, 3771.358868992278, 32514.0, 32532.6746732532, 32695.673043269737, 32756.672433275602, 32856.0, 5377.4084850666395, 5389.461053894618, 5390.56875449967, 5409.513143817076, 5434.809781657663, 209000.0, 210412.0, 210529.0, 210932.0, 212165.0, 51167.0, 51342.14933879974, 51416.22875656868, 51461.0, 51685.483145168066, 54398.0, 54714.45285547093, 54909.725451373284, 54915.725421373434, 54982.72508637431, 16813.0, 17154.828451715573, 17157.91421042887, 17166.227519761393, 17191.226394812264, 14035.22806245646, 14069.788953165711, 14077.366518506691, 14090.0, 14090.506832260822, 14886.925565372103, 14931.40274389034, 15088.773668394982, 15091.622709432351, 15189.62025949338, 6046.969765151234, 6051.273847138284, 6103.6032657877095, 6160.661163636043, 6181.8454538636, 1103.2994048779083, 1106.4578356605205, 1119.7368618374676, 1124.696331990358, 1127.3630398824637, 24771.752282476944, 24916.12793552217, 24926.252212433657, 25281.49437011286, 25433.0, 1193.164784650748, 1204.3376143121423, 1207.3540655749132, 1222.608765195129, 1226.0926914083514, 13193.47226110964, 13206.73586528264, 13224.47102115924, 13408.262545560088, 13517.729645407037, 275547.0, 275592.0, 276376.0, 276956.0, 277571.0, 56400.43599564034, 61696.38303616996, 62111.6894415525, 62470.68764656148, 62523.0, 1507.766296224087, 1525.359349073414, 1548.775427562997, 1549.2950707428092, 1565.1469948877889, 29480.852595736884, 29752.404951901273, 30092.24769380783, 30345.089647310615, 30665.386692266475, 40243.0, 40248.597514024485, 40263.39604905988, 40287.1942561153, 40369.192616146924, 232351.0, 234378.0, 234404.0, 234785.82607086856, 235029.0, 35168.472472912414, 35177.296454071286, 35554.46668299926, 35597.0, 35773.10567235736, 43979.34030989474, 44552.0, 45678.08643827171, 45715.31427028664, 45726.54273457223, 33670.49494257637, 33684.0, 33766.49350259797, 33870.83064584661, 33906.321873561894, 33899.15252118717, 34171.31657366888, 34547.13632159216, 34766.435510401585, 35117.82441087778, 38813.61186388213, 39385.80307098446, 39711.411543537935, 39790.80104599459, 39904.60095399009, 32632.0, 32650.673493264763, 33346.83326583351, 33417.83291083626, 33659.14874681916, 25448.872755636105, 25498.362540936625, 25571.0, 26097.608535871597, 26252.737472625795], "value": 18475.202306338044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.8803045375698, 594.7502049139358, 597.4354235247692, 598.434479416951, 611.5688439650047, 23363.415914602145, 23835.880820595896, 23910.521789564198, 23998.88000559995, 24026.038958441684, 24517.38706532333, 25067.74932250677, 26007.869960650216, 26091.60862587058, 26110.73889261107, 6552.344765523457, 6723.798286051427, 6748.190217173946, 6750.831229219284, 6774.0, 6569.572977756455, 6576.93423065768, 6643.402093811556, 6663.766768163116, 6830.180378354605, 6813.454923606099, 6818.829529261783, 6826.351496607815, 6826.658667066627, 6828.52200345976, 6803.897941530881, 6811.25076241613, 6813.795586132399, 6815.488838337095, 6825.624590647512, 6212.72042758077, 6326.810195694136, 6451.806445806634, 6456.160699109086, 6456.741730330781, 30737.846310768527, 31023.0693079208, 31055.378892422024, 31060.534091988637, 31084.0, 2268.739095004079, 2301.160076572056, 2302.286291249718, 2305.216226483004, 2305.7002589663402, 19656.115474803668, 20607.690884636744, 20681.0, 20809.479763005893, 20847.957602119986, 2503.3366157968153, 2525.6716626838393, 2554.9105781297753, 2575.8454492730307, 2592.507423589531, 136762.3161884194, 141049.0, 141984.0, 150227.0, 154461.99999999886, 15775.368985240691, 16042.358305667876, 16458.670826583402, 16698.916505417394, 16839.41062062822, 25702.871485642452, 25720.09979650703, 25864.094756683426, 25929.61105583418, 25960.870195649277, 10707.196960228013, 10756.784864302826, 10763.19276054299, 10823.025927666391, 11037.39294338803, 9598.95200524007, 9633.373830700983, 9698.806023879482, 9747.171490423394, 9795.804083918281, 9784.037464826757, 9919.65281215154, 9935.37521736747, 10005.699829005142, 10141.94929025365, 2841.4427015686047, 2843.6018957345987, 2852.8573571321767, 2871.526198177319, 2933.7506311963293, 1034.7620047389144, 1057.6932689520106, 1058.216919479595, 1060.5676571593262, 1065.307550092446, 21710.78289217119, 21910.89044554799, 21980.560388792135, 22094.779052209593, 22244.77755222427, 1119.1941801902617, 1120.3166068698088, 1122.528538014036, 1131.9943400282946, 1145.2727518026113, 11653.825192622118, 11896.821547676791, 11928.46321915516, 11952.940235298942, 12112.454939527743, 616401.0, 617553.0, 618137.0, 626371.0, 631928.0, 125779.0, 129246.35376823056, 129574.0, 129913.0, 131072.0, 1120.8542889424486, 1184.7452797648548, 1187.329159025148, 1244.7821631214501, 1251.2242409706041, 22712.772872271726, 22881.65677514872, 23243.76756232416, 23253.302400927998, 23263.302100937, 61876.0, 63410.36589634229, 63431.36568634439, 63441.36558634539, 64236.35763642491, 78239.0, 78999.0, 79011.0, 79816.0, 80835.0, 15590.76613850816, 15839.366425342858, 16005.279762410486, 16026.198690065683, 16071.678566428373, 24507.754922450546, 24783.13259035925, 24893.377665557782, 25069.749302507473, 25246.495070098128, 19979.20083196656, 20173.798262017193, 20599.7640141592, 20655.896720516303, 20682.276120335715, 17427.651446970736, 17542.298308067533, 17716.11419429049, 17812.19845106999, 18011.729824052913, 19528.31650892212, 20894.47763805917, 20971.8951405242, 21172.0, 21224.25715099964, 15834.445794397141, 15897.841021589637, 15900.363985440454, 15985.120818355103, 15987.120708361152, 20169.294074707315, 20242.898785506568, 20459.590808183457, 20590.073446694634, 20603.278885238946], "value": 12953.197352300222, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.5675297410778, 1491.9477818276362, 1499.0705762427297, 1506.8719158871493, 1512.1531942112417, 16285.51143465695, 16934.74597881031, 16985.3205871765, 16985.49043528696, 16991.83008169918, 16468.917655411737, 16650.83349166508, 16661.83338166621, 16675.082870442122, 16682.749758753627, 2771.3764403009313, 2812.184466504711, 2816.2677703796953, 2816.5493521036638, 2817.4505971335598, 2622.17401518522, 2723.305557082941, 2725.713800050996, 2729.0311939261574, 2731.8360898346064, 2569.820112592119, 2621.6591843060373, 2645.8412495250345, 2647.2058382485275, 2648.0334677842643, 2593.701724301711, 2596.3249555115713, 2622.016743721114, 2623.0950322139024, 2624.6587943567406, 2639.129087401153, 2640.485105404447, 2643.590243512259, 2644.3917898883174, 2649.430372469909, 15941.202939852961, 16009.599760006093, 16182.19089045543, 16228.51314460568, 16242.675146497122, 8043.55760433176, 8252.793680157984, 8258.25675689185, 8287.295579875718, 8327.292180164693, 5243.802103468417, 5384.6769193848495, 5474.0, 5510.311211098613, 5638.40796716343, 2057.44448998771, 2101.686445971268, 2137.7755335689685, 2159.7408311002782, 2165.8159056480217, 27641.861790690917, 28437.289067773265, 29848.253793655116, 30686.232844178852, 30711.232219194477, 6998.405135563432, 7126.6080365579355, 7161.3554780069, 7250.3112204340505, 7259.346658800628, 22367.44081397978, 22399.88800055989, 22444.66333005006, 22457.663135052986, 22663.546729065325, 7769.4561380703935, 7779.183185765526, 7822.217778222132, 7834.686612535549, 7875.488093273919, 6967.82580435483, 7043.542169758949, 7653.579053152019, 7756.379489640815, 7756.883646745303, 5378.596605254544, 5566.304211973504, 5576.442355764472, 5592.356878958891, 5600.635958662674, 1682.444793218235, 1690.3745614122608, 1690.9577260568585, 1702.1914590569381, 1718.243972652029, 923.8244733500613, 933.5192375926267, 934.3739694404765, 942.9104235097655, 946.6781294359951, 8495.617697203641, 8546.572671366532, 8611.48331100136, 8649.048604653482, 8656.26421754158, 757.8597959377422, 769.7056597761589, 786.41412147949, 787.3071696906685, 790.4901338636547, 4753.83361582343, 4796.088743138862, 4802.615790736732, 4831.299461578122, 4857.781399837016, 23572.764272357057, 23940.760592394203, 24834.0, 24920.25877153512, 25004.37489062788, 24058.037678493016, 24304.270871873872, 24306.0, 24459.87770061138, 24478.510429791306, 10619.628313009007, 11600.709982250342, 11709.473073711704, 11730.061595072373, 11731.648050558497, 8307.667693292442, 8452.661893524437, 8541.487510749375, 8600.78498037554, 8833.514156721185, 20014.799852001877, 21157.461104666923, 21262.681059784423, 21618.567628647026, 21829.999999999363, 20722.378328650164, 21315.46711332229, 21335.359939201848, 22252.66621000654, 22271.109155633592, 13345.532906348231, 13563.728725425239, 13567.389467474184, 13571.59285221445, 13581.185128892299, 15197.392104315704, 15199.0, 15339.386424542894, 15340.15629140408, 15411.691766164839, 12332.938335308625, 12429.067819913724, 12473.126881118234, 12885.162464439782, 12949.741005180033, 12369.93815030919, 12374.566890158801, 12398.504059837505, 12426.130170888313, 12795.168314059556, 10779.51492182838, 10788.352698838095, 10830.566777328819, 10903.56385744593, 10907.563697452013, 7328.1938986712485, 7459.962700186465, 7473.701051957861, 7476.728956077589, 7489.925100748923, 7156.284371563011, 7300.598467084362, 7300.890486642598, 7317.926820731937, 7394.2975417335265], "value": 7056.033275078281, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.663791811159, 534.6204195021533, 562.4656576252561, 566.6996491859315, 576.5243673968977, 6279.529035322352, 6320.936790632092, 6385.968070159654, 6440.355964403558, 6464.96767516163, 6279.68601569922, 6293.213348331458, 6326.493880489561, 6346.270178929424, 6394.456471199954, 5145.614078944075, 5155.561777248939, 5160.458151894035, 5175.146100893348, 5176.715280659562, 5118.28537439958, 5139.486051394868, 5144.819931302405, 5154.74226288686, 5205.479452054802, 4865.635077369211, 4983.352164218646, 5070.492950704936, 5090.974545127269, 5115.4884511548735, 5002.349694539723, 5009.899802003976, 5019.874503137415, 5033.823816166417, 5042.193249080166, 4474.955250447519, 4489.1919454498175, 4517.93828450314, 4544.295634176708, 4552.772361381918, 6122.8775424491705, 6224.9688751556405, 6230.470410015154, 6275.341089185661, 6285.8742825143245, 6178.076921155054, 6199.287081985584, 6228.87542249157, 6237.844053898643, 6255.874882502325, 6688.83277918051, 6770.187577490683, 6773.864522709568, 6806.149231346082, 6852.349026842442, 5459.508644221999, 5519.751611177507, 5523.226748255248, 5535.391106978229, 5542.972285138549, 6924.065251191075, 6945.027696122496, 6958.234594194634, 6988.61562614056, 7033.859322813566, 5654.4062873398525, 5680.784494047242, 5684.090545512699, 5727.255456790591, 5746.166805813217, 5767.0, 5774.509166720875, 5793.362730099686, 5828.096645019944, 5836.970815145982, 6089.756409743649, 6137.355577664371, 6176.764647070604, 6177.887980163614, 6181.598196117238, 6774.525783195228, 6778.661066946633, 6788.660566971632, 6799.966000169968, 6825.69284382204, 1993.730846335726, 2007.6185524750542, 2010.2160157538572, 2012.7081573171808, 2026.1085122546033, 1425.3585886351184, 1498.7377208988382, 1524.3826250368618, 1524.96187595311, 1539.7536394177102, 6021.488173505213, 6027.819165425044, 6110.633361998294, 6128.448439640454, 6153.107799369066, 6603.933960660428, 6660.167479065117, 6685.799426017227, 6747.257801641816, 6810.659467026629, 6027.517798576104, 6097.987664070846, 6115.663638499836, 6135.355787642323, 6149.661768602769, 3505.2463720300257, 3517.5427194464555, 3547.379208638478, 3548.3790336690977, 3553.2893421315325, 6925.861482770317, 6971.58170509771, 6981.301869812978, 7008.684609192598, 7038.5073044887395, 6785.253622101565, 6873.140857392826, 6922.826929326807, 6947.166340039228, 6948.756793512304, 6916.377526022682, 6926.792196234121, 6941.167059952838, 6969.7909062728195, 7005.859882802315, 6514.348565143638, 6600.940421640752, 6713.0, 6730.59146259201, 6765.898511522233, 6534.640594767334, 6572.178477690289, 6623.701933412912, 6644.76743314001, 6651.569912468843, 6831.521793474608, 6843.7604683835825, 6852.931470685229, 6896.896546551906, 6956.930430695831, 5526.22632831412, 5651.350094738993, 5675.659460432387, 5700.971495142498, 5733.0540460823495, 6664.400203981665, 6815.2162501311, 6829.89755153683, 6876.627563490588, 6954.756583519553, 6386.808395748135, 6559.836004099936, 6596.208454985433, 6612.404883560503, 6665.666716664245, 6465.321141280097, 6568.343165683394, 6594.670266486753, 6645.568038077509, 6661.4004739573675, 6322.557420980487, 6387.869943727447, 6430.3891130342545, 6534.4772418205475, 6546.967265163834, 6468.838279043061, 6510.641914694737, 6564.704588293634, 6574.53978221539, 6606.240282367589, 6257.68711564429, 6270.2475702915945, 6324.715387807468, 6342.143810585512, 6454.548181627241], "value": 5294.223888075567, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [983.3559018842658, 998.5656239535803, 1003.9849402258967, 1004.0461561516561, 1008.5763979128765, 20133.798662013374, 20350.389488315337, 20780.168793248253, 20820.16719331229, 20831.791682083174, 19377.90311048443, 19829.900850495764, 19843.801561984375, 19924.0, 19924.800751992476, 1020.4693559349134, 1027.275770581738, 1046.3669479964626, 1047.2355180718043, 1047.3611097230682, 1067.5302866738648, 1078.6009176604666, 1079.4926384599225, 1080.378782200238, 1080.95676172953, 1120.1263014848432, 1120.675004248767, 1125.9268147570422, 1129.5989923577135, 1132.4054871192607, 1110.4225802582653, 1118.4966764955761, 1118.8825173356843, 1119.7256672115343, 1119.9776004479866, 819.7745619954501, 821.708293555791, 822.5393779483509, 825.158338494738, 826.099551488874, 18973.43079707611, 19080.14139363732, 19136.712949305773, 19312.0, 19327.130279137473, 23126.53746925052, 23218.3034508965, 23825.404364890845, 23834.0, 23889.28332150038, 18429.723554146698, 18451.169697363515, 18466.815331846643, 18502.629947400976, 18505.167267472996, 3862.942055869164, 3959.5842436544035, 3976.1451287973223, 3979.303621866162, 3999.960000399988, 158869.0, 158914.0, 161230.0, 161960.0, 162698.3730162695, 17798.46604601864, 17983.820161798216, 18113.0, 18179.181936812874, 18224.908875455538, 34028.0, 34651.65348346535, 34756.47865282023, 34962.82518587442, 34979.12552186216, 9299.67451139207, 9522.571484283224, 9533.285003624756, 9587.568559414844, 9620.422774633544, 4550.089982003613, 4586.564276393738, 4615.538446155358, 4615.792289346988, 4617.699849509771, 5618.129189975561, 5721.685307308055, 5721.971390143106, 5730.971345143247, 5733.684647344436, 957.7366224288377, 999.6551189839494, 1002.0080120680474, 1009.0313299232672, 1012.0, 670.4937771982122, 692.5740669488329, 694.3299715774302, 701.5194591704699, 705.4180301251488, 12813.743725125445, 12992.740145197044, 13481.932590336986, 14302.713945721236, 14448.711025779425, 692.9272426395257, 698.0750505580127, 698.6960672107649, 705.5131958948309, 716.9928300716927, 5857.853553661193, 5883.676397798076, 5903.940960590425, 5929.733162007634, 5956.7693953187745, 150400.0, 151203.0, 152081.0, 153015.0, 153136.0, 131009.0, 133162.0, 133970.3301483506, 134399.0, 138118.0, 114750.0, 117764.41117794356, 118375.40812295883, 118600.0, 120350.3982480082, 11053.83419248728, 11250.943745281222, 11361.37512436824, 11361.886381136082, 11423.600173994202, 54067.45932540624, 55306.170407444726, 55638.16542751781, 56213.15680264717, 56219.43780562142, 67511.0, 68654.65672671604, 69195.30804691889, 70312.64843675954, 70965.29034709794, 15960.680786384439, 16045.438409655606, 16113.0, 16195.190240488164, 16318.918405408373, 15873.206339682738, 15997.280122394288, 16010.439634612732, 16038.599035024217, 16101.114438705983, 16380.262888170299, 16423.096729679983, 16550.751738724168, 16589.419370321983, 16602.169891505135, 14205.715885682435, 14470.710585788436, 14521.201333926736, 14612.050216735877, 14631.780523292373, 15162.3176957035, 15504.457343992906, 15507.534773956799, 15583.610409739847, 15622.609434764221, 11915.880871063042, 12065.457054432396, 12073.154879158375, 12094.0, 12132.696682583006, 11700.648980530597, 11748.647540573797, 11953.760924781629, 12115.575954841539, 12183.878161218274], "value": 9588.652712722222, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1368.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 105.0, 105.0, 105.0, 108.0, 106.0, 105.0, 105.0, 105.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 111.0, 116.0, 116.0, 115.0, 112.0, 117.0, 112.0, 117.0], "value": 114.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 164.0, 162.0, 161.0, 165.0, 167.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 74.0, 72.0, 72.0, 73.0, 73.0, 74.0, 73.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 78.0, 78.0, 77.0, 78.0, 78.0, 77.0, 78.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 117.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 110.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 149.0, 150.0, 150.0, 149.0, 151.0, 149.0, 149.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 93.0, 94.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 44.0, 47.0, 46.0, 44.0, 44.0, 44.0, 44.0, 46.0], "value": 44.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 39.0, 39.0, 39.0, 42.0, 40.0, 39.0, 40.0, 38.0], "value": 39.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 74.0, 71.0, 71.0, 71.0, 70.0, 75.0, 73.0, 70.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 104.0, 108.0, 107.0, 108.0, 112.0, 107.0, 108.0, 104.0, 107.0], "value": 106.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 153.0, 152.0, 151.0, 158.0, 165.0, 151.0, 153.0, 150.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 67.0, 60.0, 60.0, 59.0, 61.0, 61.0, 61.0, 58.0], "value": 61.2, "unit": "score"}]}]} 04:08:53 INFO - Return code: 0 04:08:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:08:53 INFO - # TBPL SUCCESS # 04:08:53 INFO - Running post-action listener: _package_coverage_data 04:08:53 INFO - Running post-action listener: _resource_record_post_action 04:08:53 INFO - [mozharness: 2017-09-18 11:08:53.539365Z] Finished run-tests step (success) 04:08:53 INFO - Running post-run listener: _resource_record_post_run 04:08:53 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321896448; Read time: 12; Write time: 232336 04:08:53 INFO - TinderboxPrint: CPU usage
13.1% 04:08:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:08:53 INFO - TinderboxPrint: I/O write bytes / time
321,896,448 / 232,336 04:08:53 INFO - TinderboxPrint: CPU idle
8,219.4 (86.9%) 04:08:53 INFO - TinderboxPrint: CPU user
1,187.1 (12.6%) 04:08:53 INFO - TinderboxPrint: Swap in / out
0 / 0 04:08:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9400320; Read time: 0; Write time: 1296 04:08:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:08:53 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311881728; Read time: 12; Write time: 231040 04:08:54 INFO - Running post-run listener: _upload_blobber_files 04:08:54 INFO - Blob upload gear active. 04:08:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:08:54 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 04:08:54 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'] 04:08:54 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 04:08:54 INFO - (blobuploader) - INFO - Open directory for files ... 04:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:55 INFO - (blobuploader) - INFO - Done attempting. 04:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:08:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:56 INFO - (blobuploader) - INFO - Done attempting. 04:08:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:08:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:09:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:03 INFO - (blobuploader) - INFO - Done attempting. 04:09:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:09:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:09:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:04 INFO - (blobuploader) - INFO - Done attempting. 04:09:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:09:04 INFO - Return code: 0 04:09:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:09:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:09:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dd9a80635e6e2bb959e0b02f7ec532d36129470eaccd56b4b35b8366ea2388fda765599a87e683950b11e57c3ad76588cd498a9bb87e33b67234981670edd27", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cbfcf46dd8d89ab3a5ab2db2058003315e251437f0f944ab6e9401af4ca1f4efb835aa5a054179139aad504f5fe3cdd9d3b81c30e2933a8739226c8389944a2", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c21bbf57ffdfc07509d5dc6fb73c2a3f3f74dda673ddb4425c0d909ea32f89abd3c43aa83e6243b27aff2ce01444c57942759c03efdc028c3f94e61c4e41d59", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/933a66547ec0a31ca44c56c9af54403fdd9b20568c423103125742498681a4dd1e781e5e5cf142b1a26e66023c35e22df12b15a1b20bdca2de40e7a81b15d911"} 04:09:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:09:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:09:04 INFO - Contents: 04:09:04 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dd9a80635e6e2bb959e0b02f7ec532d36129470eaccd56b4b35b8366ea2388fda765599a87e683950b11e57c3ad76588cd498a9bb87e33b67234981670edd27", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cbfcf46dd8d89ab3a5ab2db2058003315e251437f0f944ab6e9401af4ca1f4efb835aa5a054179139aad504f5fe3cdd9d3b81c30e2933a8739226c8389944a2", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c21bbf57ffdfc07509d5dc6fb73c2a3f3f74dda673ddb4425c0d909ea32f89abd3c43aa83e6243b27aff2ce01444c57942759c03efdc028c3f94e61c4e41d59", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/933a66547ec0a31ca44c56c9af54403fdd9b20568c423103125742498681a4dd1e781e5e5cf142b1a26e66023c35e22df12b15a1b20bdca2de40e7a81b15d911"} 04:09:04 INFO - Running post-run listener: copy_logs_to_upload_dir 04:09:04 INFO - Copying logs to upload dir... 04:09:04 INFO - mkdir: /builds/slave/test/build/upload/logs 04:09:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.208384 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-18 04:09:04.899329) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 04:09:04.908484) ========= 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=fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888 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/8dd9a80635e6e2bb959e0b02f7ec532d36129470eaccd56b4b35b8366ea2388fda765599a87e683950b11e57c3ad76588cd498a9bb87e33b67234981670edd27", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cbfcf46dd8d89ab3a5ab2db2058003315e251437f0f944ab6e9401af4ca1f4efb835aa5a054179139aad504f5fe3cdd9d3b81c30e2933a8739226c8389944a2", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c21bbf57ffdfc07509d5dc6fb73c2a3f3f74dda673ddb4425c0d909ea32f89abd3c43aa83e6243b27aff2ce01444c57942759c03efdc028c3f94e61c4e41d59", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/933a66547ec0a31ca44c56c9af54403fdd9b20568c423103125742498681a4dd1e781e5e5cf142b1a26e66023c35e22df12b15a1b20bdca2de40e7a81b15d911"} build_url:https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011774 build_url: 'https://queue.taskcluster.net/v1/task/cW-otTD3QsK5dWc76_Bxuw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dd9a80635e6e2bb959e0b02f7ec532d36129470eaccd56b4b35b8366ea2388fda765599a87e683950b11e57c3ad76588cd498a9bb87e33b67234981670edd27", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cbfcf46dd8d89ab3a5ab2db2058003315e251437f0f944ab6e9401af4ca1f4efb835aa5a054179139aad504f5fe3cdd9d3b81c30e2933a8739226c8389944a2", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c21bbf57ffdfc07509d5dc6fb73c2a3f3f74dda673ddb4425c0d909ea32f89abd3c43aa83e6243b27aff2ce01444c57942759c03efdc028c3f94e61c4e41d59", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/933a66547ec0a31ca44c56c9af54403fdd9b20568c423103125742498681a4dd1e781e5e5cf142b1a26e66023c35e22df12b15a1b20bdca2de40e7a81b15d911"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 04:09:04.941279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 04:09:04.941608) ========= 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=fcadb68e09dcf59683000ff6000001dc-1505731549.708976-1891472888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 04:09:05.021834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 04:09:05.024153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 04:09:05.024441) ========= ========= Total master_lag: 0.21 =========