builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-040 starttime: 1506471744.94 results: success (0) revision: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:24.943451) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:24.950465) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:24.950802) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:24.997405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:24.997792) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 17:22:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.7M=0s 2017-09-26 17:22:25 (33.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126040 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:25.144910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:25.145221) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019990 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:25.203874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:25.207208) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b7d8ae4a03c62e549b9d82595b1d1964f0af70cd --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 b7d8ae4a03c62e549b9d82595b1d1964f0af70cd --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=9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 17:22:25,283 truncating revision to first 12 chars 2017-09-26 17:22:25,284 Setting DEBUG logging. 2017-09-26 17:22:25,284 attempt 1/10 2017-09-26 17:22:25,284 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b7d8ae4a03c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 17:22:25,880 unpacking tar archive at: mozilla-central-b7d8ae4a03c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.883246 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:26.153050) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:26.153493) ========= script_repo_revision: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:26.153875) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:26.154203) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 17:22:26.354533) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-26 17:22:26.354852) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:22:26 INFO - MultiFileLogger online at 20170926 17:22:26 in /builds/slave/test 17:22:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:22:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:22:26 INFO - {'append_to_log': False, 17:22:26 INFO - 'base_work_dir': '/builds/slave/test', 17:22:26 INFO - 'blob_upload_branch': 'Firefox', 17:22:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:22:26 INFO - 'branch': 'Firefox', 17:22:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:22:26 INFO - 'code_coverage': False, 17:22:26 INFO - 'config_files': ('talos/linux_config.py',), 17:22:26 INFO - 'default_actions': ('clobber', 17:22:26 INFO - 'read-buildbot-config', 17:22:26 INFO - 'download-and-extract', 17:22:26 INFO - 'populate-webroot', 17:22:26 INFO - 'create-virtualenv', 17:22:26 INFO - 'install', 17:22:26 INFO - 'setup-mitmproxy', 17:22:26 INFO - 'run-tests'), 17:22:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:22:26 INFO - 'disable_ccov_upload': False, 17:22:26 INFO - 'disable_stylo': False, 17:22:26 INFO - 'download_minidump_stackwalk': True, 17:22:26 INFO - 'download_symbols': 'ondemand', 17:22:26 INFO - 'enable_stylo': False, 17:22:26 INFO - 'enable_webrender': False, 17:22:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:22:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:22:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:22:26 INFO - 'gecko_profile': False, 17:22:26 INFO - 'gecko_profile_interval': 0, 17:22:26 INFO - 'installer_path': 'installer.exe', 17:22:26 INFO - 'log_level': 'info', 17:22:26 INFO - 'log_name': 'talos', 17:22:26 INFO - 'log_to_console': True, 17:22:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:22:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:22:26 INFO - 'opt_config_files': (), 17:22:26 INFO - 'pip_index': False, 17:22:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:22:26 INFO - 'system_bits': '32', 17:22:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:22:26 INFO - 'title': 'talos-linux64-ix-040', 17:22:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:22:26 INFO - 'use_talos_json': True, 17:22:26 INFO - 'verify': 'False', 17:22:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:22:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:22:26 INFO - 'work_dir': 'build'} 17:22:26 INFO - [mozharness: 2017-09-27 00:22:26.585618Z] Running clobber step. 17:22:26 INFO - Running pre-action listener: _resource_record_pre_action 17:22:26 INFO - Running main action method: clobber 17:22:26 INFO - rmtree: /builds/slave/test/build 17:22:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:22:27 INFO - Running post-action listener: _resource_record_post_action 17:22:27 INFO - [mozharness: 2017-09-27 00:22:27.571921Z] Finished clobber step (success) 17:22:27 INFO - [mozharness: 2017-09-27 00:22:27.572020Z] Running read-buildbot-config step. 17:22:27 INFO - Running pre-action listener: _resource_record_pre_action 17:22:27 INFO - Running main action method: read_buildbot_config 17:22:27 INFO - Using buildbot properties: 17:22:27 INFO - { 17:22:27 INFO - "project": "", 17:22:27 INFO - "product": "firefox", 17:22:27 INFO - "who": "kwierso@gmail.com", 17:22:27 INFO - "installer_path": "public/build/target.tar.bz2", 17:22:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:22:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:22:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 17:22:27 INFO - "stage_platform": "linux64-pgo", 17:22:27 INFO - "basedir": "/builds/slave/test", 17:22:27 INFO - "buildnumber": 63, 17:22:27 INFO - "platform": "ubuntu64_hw", 17:22:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:22:27 INFO - "slavebuilddir": "test", 17:22:27 INFO - "taskId": "TIaGFq9LS6iSSVxZZDCwlg", 17:22:27 INFO - "branch": "mozilla-central", 17:22:27 INFO - "script_repo_revision": "production", 17:22:27 INFO - "revision": "b7d8ae4a03c62e549b9d82595b1d1964f0af70cd", 17:22:27 INFO - "slavename": "talos-linux64-ix-040", 17:22:27 INFO - "repo_path": "mozilla-central" 17:22:27 INFO - } 17:22:27 INFO - Finding installer, test and symbols from parent task. 17:22:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TIaGFq9LS6iSSVxZZDCwlg'}, attempt #1 17:22:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TIaGFq9LS6iSSVxZZDCwlg'}, attempt #1 17:22:28 INFO - Task dependencies: A6SBlonfSxyxXhl1ngSEGA 17:22:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA'}, attempt #1 17:22:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2 17:22:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.test_packages.json 17:22:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.crashreporter-symbols.zip 17:22:29 INFO - Running post-action listener: _resource_record_post_action 17:22:29 INFO - [mozharness: 2017-09-27 00:22:29.018256Z] Finished read-buildbot-config step (success) 17:22:29 INFO - [mozharness: 2017-09-27 00:22:29.018471Z] Running download-and-extract step. 17:22:29 INFO - Running pre-action listener: _resource_record_pre_action 17:22:29 INFO - Running main action method: download_and_extract 17:22:29 INFO - mkdir: /builds/slave/test/build/tests 17:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:29 INFO - trying https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.test_packages.json 17:22:29 INFO - Downloading https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:22:29 INFO - Downloaded 989 bytes. 17:22:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:22:29 INFO - Using the following test package requirements: 17:22:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:22:29 INFO - u'common': [u'target.common.tests.zip'], 17:22:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:22:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:22:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:22:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:22:29 INFO - u'mozbase': [u'target.common.tests.zip'], 17:22:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:22:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:22:29 INFO - u'web-platform': [u'target.common.tests.zip', 17:22:29 INFO - u'target.web-platform.tests.tar.gz'], 17:22:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:22:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:22:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.common.tests.zip 17:22:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:22:29 INFO - Fetch https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.common.tests.zip into memory 17:22:32 INFO - Content-Length response header: 55349519 17:22:32 INFO - Bytes received: 55349519 17:22:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.talos.tests.zip 17:22:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:22:43 INFO - Fetch https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.talos.tests.zip into memory 17:22:44 INFO - Content-Length response header: 14513823 17:22:44 INFO - Bytes received: 14513823 17:22:44 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')]} 17:22:44 INFO - trying https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2 17:22:44 INFO - Downloading https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:22:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:22:47 INFO - Downloaded 62414004 bytes. 17:22:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2 17:22:47 INFO - mkdir: /builds/slave/test/properties 17:22:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:22:47 INFO - Writing to file /builds/slave/test/properties/build_url 17:22:47 INFO - Contents: 17:22:47 INFO - build_url:https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2 17:22:47 INFO - Running post-action listener: _resource_record_post_action 17:22:47 INFO - Running post-action listener: find_tests_for_verification 17:22:47 INFO - Running post-action listener: set_extra_try_arguments 17:22:47 INFO - [mozharness: 2017-09-27 00:22:47.915839Z] Finished download-and-extract step (success) 17:22:47 INFO - [mozharness: 2017-09-27 00:22:47.915937Z] Running populate-webroot step. 17:22:47 INFO - Running pre-action listener: _resource_record_pre_action 17:22:47 INFO - Running main action method: populate_webroot 17:22:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:22:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:47 INFO - 'tests': ['tresize', 17:22:47 INFO - 'tcanvasmark']}, 17:22:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:22:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:47 INFO - 'tests': ['dromaeo_css', 17:22:47 INFO - 'kraken']}, 17:22:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:47 INFO - 'talos_options': ['--disable-stylo'], 17:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:22:47 INFO - 'tests': ['damp', 'tps']}, 17:22:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:47 INFO - 'talos_options': ['--disable-stylo'], 17:22:47 INFO - 'tests': ['damp', 'tps']}, 17:22:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:22:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:47 INFO - 'tests': ['dromaeo_dom']}, 17:22:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:22:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:47 INFO - 'tests': ['basic_compositor_video', 17:22:47 INFO - 'glvideo']}, 17:22:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:22:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:22:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:47 INFO - 'talos_options': ['--disable-stylo'], 17:22:47 INFO - 'tests': ['ts_paint_webext', 17:22:47 INFO - 'tp5o_webext']}, 17:22:47 INFO - 'other-e10s': {'tests': ['a11yr', 17:22:47 INFO - 'ts_paint', 17:22:47 INFO - 'tpaint', 17:22:47 INFO - 'sessionrestore', 17:22:47 INFO - 'sessionrestore_many_windows', 17:22:47 INFO - 'sessionrestore_no_auto_restore', 17:22:47 INFO - 'tabpaint']}, 17:22:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:47 INFO - 'tests': ['a11yr', 17:22:47 INFO - 'ts_paint', 17:22:47 INFO - 'tpaint', 17:22:47 INFO - 'sessionrestore', 17:22:47 INFO - 'sessionrestore_many_windows', 17:22:47 INFO - 'sessionrestore_no_auto_restore', 17:22:47 INFO - 'tabpaint']}, 17:22:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:22:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:22:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:47 INFO - 'tests': ['perf_reftest_singletons']}, 17:22:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:47 INFO - 'tests': ['perf_reftest']}, 17:22:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:22:47 INFO - 'tsvgr_opacity', 17:22:47 INFO - 'tart', 17:22:47 INFO - 'tscrollx', 17:22:47 INFO - 'tsvg_static']}, 17:22:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:47 INFO - 'tests': ['tsvgx', 17:22:47 INFO - 'tsvgr_opacity', 17:22:47 INFO - 'tart', 17:22:47 INFO - 'tscrollx', 17:22:47 INFO - 'tsvg_static']}, 17:22:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:22:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:47 INFO - 'talos_options': ['--disable-stylo'], 17:22:47 INFO - 'tests': ['tp5o']}, 17:22:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:22:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:22:47 INFO - 'talos_options': ['--mitmproxy', 17:22:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:22:47 INFO - '--firstNonBlankPaint'], 17:22:47 INFO - 'tests': ['tp6_google', 17:22:47 INFO - 'tp6_youtube', 17:22:47 INFO - 'tp6_amazon', 17:22:47 INFO - 'tp6_facebook']}, 17:22:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:22:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:22:47 INFO - 'talos_options': ['--disable-stylo', 17:22:47 INFO - '--mitmproxy', 17:22:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:22:47 INFO - '--firstNonBlankPaint'], 17:22:47 INFO - 'tests': ['tp6_google', 17:22:47 INFO - 'tp6_youtube', 17:22:47 INFO - 'tp6_amazon', 17:22:47 INFO - 'tp6_facebook']}, 17:22:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:22:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:22:47 INFO - 'talos_options': ['--stylo-threads=1', 17:22:47 INFO - '--mitmproxy', 17:22:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:22:47 INFO - '--firstNonBlankPaint'], 17:22:47 INFO - 'tests': ['tp6_google', 17:22:47 INFO - 'tp6_youtube', 17:22:47 INFO - 'tp6_amazon', 17:22:47 INFO - 'tp6_facebook']}, 17:22:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:22:47 INFO - 'talos_options': ['--xperf_path', 17:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:47 INFO - 'tests': ['tp5n']}, 17:22:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:47 INFO - 'talos_options': ['--disable-stylo', 17:22:47 INFO - '--xperf_path', 17:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:47 INFO - 'tests': ['tp5n']}}} 17:22:47 INFO - Running post-action listener: _resource_record_post_action 17:22:47 INFO - [mozharness: 2017-09-27 00:22:47.934319Z] Finished populate-webroot step (success) 17:22:47 INFO - [mozharness: 2017-09-27 00:22:47.934425Z] Running create-virtualenv step. 17:22:47 INFO - Running pre-action listener: _resource_record_pre_action 17:22:47 INFO - Running main action method: create_virtualenv 17:22:47 INFO - Creating virtualenv /builds/slave/test/build/venv 17:22:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:22:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:22:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:22:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:22:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:22:48 INFO - Installing distribute.............................................................................................................................................................................................done. 17:22:48 INFO - Installing pip...............done. 17:22:48 INFO - Return code: 0 17:22:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:22:48 INFO - Reading from file tmpfile_stdout 17:22:48 INFO - Output received: 17:22:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:22:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22: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')]} 17:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24139c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410d60>, '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 0x2411a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411ef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', '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 17:22: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', 'pip>=1.5'] in /builds/slave/test/build 17:22: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 pip>=1.5 17:22:48 INFO - Using env: {'DISPLAY': ':0', 17:22:48 INFO - 'HOME': '/home/cltbld', 17:22:48 INFO - 'LANG': 'en_US.UTF-8', 17:22:48 INFO - 'LANGUAGE': 'en_US:en', 17:22:48 INFO - 'LOGNAME': 'cltbld', 17:22:48 INFO - 'MAIL': '/var/mail/cltbld', 17:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:48 INFO - 'MOZ_NO_REMOTE': '1', 17:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:48 INFO - 'NO_EM_RESTART': '1', 17:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:48 INFO - 'PWD': '/builds/slave/test', 17:22:48 INFO - 'SHELL': '/bin/bash', 17:22:48 INFO - 'SHLVL': '1', 17:22:48 INFO - 'TERM': 'linux', 17:22:48 INFO - 'TMOUT': '86400', 17:22:48 INFO - 'USER': 'cltbld', 17:22:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:48 INFO - '_': '/tools/buildbot/bin/python'} 17:22:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:22:50 INFO - Downloading/unpacking pip>=1.5 17:22:50 INFO - Running setup.py egg_info for package pip 17:22:50 INFO - warning: no files found matching 'pip/cacert.pem' 17:22:50 INFO - warning: no files found matching '*.html' under directory 'docs' 17:22:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:22:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:22:50 INFO - Installing collected packages: pip 17:22:50 INFO - Found existing installation: pip 1.1 17:22:50 INFO - Uninstalling pip: 17:22:50 INFO - Successfully uninstalled pip 17:22:50 INFO - Running setup.py install for pip 17:22:50 INFO - warning: no files found matching 'pip/cacert.pem' 17:22:50 INFO - warning: no files found matching '*.html' under directory 'docs' 17:22:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:22:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:22:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:22:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:22:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:22:50 INFO - Successfully installed pip 17:22:50 INFO - Cleaning up... 17:22:50 INFO - Return code: 0 17:22:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22: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')]} 17:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22: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', '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 0x20a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24139c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410d60>, '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 0x2411a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411ef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', '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 17:22: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:22: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 psutil>=3.1.1 17:22:50 INFO - Using env: {'DISPLAY': ':0', 17:22:50 INFO - 'HOME': '/home/cltbld', 17:22:50 INFO - 'LANG': 'en_US.UTF-8', 17:22:50 INFO - 'LANGUAGE': 'en_US:en', 17:22:50 INFO - 'LOGNAME': 'cltbld', 17:22:50 INFO - 'MAIL': '/var/mail/cltbld', 17:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:50 INFO - 'MOZ_NO_REMOTE': '1', 17:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:50 INFO - 'NO_EM_RESTART': '1', 17:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:50 INFO - 'PWD': '/builds/slave/test', 17:22:50 INFO - 'SHELL': '/bin/bash', 17:22:50 INFO - 'SHLVL': '1', 17:22:50 INFO - 'TERM': 'linux', 17:22:50 INFO - 'TMOUT': '86400', 17:22:50 INFO - 'USER': 'cltbld', 17:22:50 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:50 INFO - '_': '/tools/buildbot/bin/python'} 17:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:50 INFO - Downloading/unpacking psutil>=3.1.1 17:22: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 17:22: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 17:22: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 17:22: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 17:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:22:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:51 INFO - Installing collected packages: psutil 17:22:51 INFO - Running setup.py install for psutil 17:22:51 INFO - building 'psutil._psutil_linux' extension 17:22:51 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 17:22:51 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 17:22:51 INFO - building 'psutil._psutil_posix' extension 17:22:51 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 17:22:51 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 17:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:52 INFO - Successfully installed psutil 17:22:52 INFO - Cleaning up... 17:22:52 INFO - Return code: 0 17:22:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22: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')]} 17:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24139c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410d60>, '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 0x2411a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411ef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', '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 17:22: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:22: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 mozsystemmonitor==0.3 17:22:52 INFO - Using env: {'DISPLAY': ':0', 17:22:52 INFO - 'HOME': '/home/cltbld', 17:22:52 INFO - 'LANG': 'en_US.UTF-8', 17:22:52 INFO - 'LANGUAGE': 'en_US:en', 17:22:52 INFO - 'LOGNAME': 'cltbld', 17:22:52 INFO - 'MAIL': '/var/mail/cltbld', 17:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:52 INFO - 'MOZ_NO_REMOTE': '1', 17:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:52 INFO - 'NO_EM_RESTART': '1', 17:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:52 INFO - 'PWD': '/builds/slave/test', 17:22:52 INFO - 'SHELL': '/bin/bash', 17:22:52 INFO - 'SHLVL': '1', 17:22:52 INFO - 'TERM': 'linux', 17:22:52 INFO - 'TMOUT': '86400', 17:22:52 INFO - 'USER': 'cltbld', 17:22:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:52 INFO - '_': '/tools/buildbot/bin/python'} 17:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:22:52 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 17:22:52 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 17:22:52 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 17:22:52 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 17:22:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:22:53 INFO - Installing collected packages: mozsystemmonitor 17:22:53 INFO - Running setup.py install for mozsystemmonitor 17:22:53 INFO - Successfully installed mozsystemmonitor 17:22:53 INFO - Cleaning up... 17:22:54 INFO - Return code: 0 17:22:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:54 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 0x20a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24139c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410d60>, '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 0x2411a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411ef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', '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 17:22:54 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 17:22:54 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 17:22:54 INFO - Using env: {'DISPLAY': ':0', 17:22:54 INFO - 'HOME': '/home/cltbld', 17:22:54 INFO - 'LANG': 'en_US.UTF-8', 17:22:54 INFO - 'LANGUAGE': 'en_US:en', 17:22:54 INFO - 'LOGNAME': 'cltbld', 17:22:54 INFO - 'MAIL': '/var/mail/cltbld', 17:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:54 INFO - 'MOZ_NO_REMOTE': '1', 17:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:54 INFO - 'NO_EM_RESTART': '1', 17:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:54 INFO - 'PWD': '/builds/slave/test', 17:22:54 INFO - 'SHELL': '/bin/bash', 17:22:54 INFO - 'SHLVL': '1', 17:22:54 INFO - 'TERM': 'linux', 17:22:54 INFO - 'TMOUT': '86400', 17:22:54 INFO - 'USER': 'cltbld', 17:22:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:54 INFO - '_': '/tools/buildbot/bin/python'} 17:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:55 INFO - Downloading/unpacking jsonschema==2.5.1 17:22: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 17:22: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 17:22: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 17:22: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 17:22:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:22:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:22:56 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 17:22:56 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 17:22:56 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 17:22:56 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 17:22:56 INFO - Downloading functools32-3.2.3-2.tar.gz 17:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:22:56 INFO - warning: no files found matching '*.txt' 17:22:56 INFO - no previously-included directories found matching 'build' 17:22:56 INFO - no previously-included directories found matching 'dist' 17:22:56 INFO - no previously-included directories found matching '.git*' 17:22:56 INFO - Installing collected packages: jsonschema, functools32 17:22:56 INFO - Running setup.py install for functools32 17:22:56 INFO - warning: no files found matching '*.txt' 17:22:56 INFO - no previously-included directories found matching 'build' 17:22:56 INFO - no previously-included directories found matching 'dist' 17:22:56 INFO - no previously-included directories found matching '.git*' 17:22:56 INFO - Successfully installed jsonschema functools32 17:22:56 INFO - Cleaning up... 17:22:57 INFO - Return code: 0 17:22:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:22:57 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')]} 17:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:57 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')]} 17:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:57 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 0x20a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24139c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410d60>, '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 0x2411a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411ef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', '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 17:22:57 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 17:22:57 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 17:22:57 INFO - Using env: {'DISPLAY': ':0', 17:22:57 INFO - 'HOME': '/home/cltbld', 17:22:57 INFO - 'LANG': 'en_US.UTF-8', 17:22:57 INFO - 'LANGUAGE': 'en_US:en', 17:22:57 INFO - 'LOGNAME': 'cltbld', 17:22:57 INFO - 'MAIL': '/var/mail/cltbld', 17:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:57 INFO - 'MOZ_NO_REMOTE': '1', 17:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:57 INFO - 'NO_EM_RESTART': '1', 17:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:57 INFO - 'PWD': '/builds/slave/test', 17:22:57 INFO - 'SHELL': '/bin/bash', 17:22:57 INFO - 'SHLVL': '1', 17:22:57 INFO - 'TERM': 'linux', 17:22:57 INFO - 'TMOUT': '86400', 17:22:57 INFO - 'USER': 'cltbld', 17:22:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:57 INFO - '_': '/tools/buildbot/bin/python'} 17:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:22:58 INFO - Cleaning up... 17:22:58 INFO - Return code: 0 17:22:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22: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')]} 17:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:58 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 0x20a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24139c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410d60>, '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 0x2411a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411ef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', '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 17:22:58 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 17:22:58 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 17:22:58 INFO - Using env: {'DISPLAY': ':0', 17:22:58 INFO - 'HOME': '/home/cltbld', 17:22:58 INFO - 'LANG': 'en_US.UTF-8', 17:22:58 INFO - 'LANGUAGE': 'en_US:en', 17:22:58 INFO - 'LOGNAME': 'cltbld', 17:22:58 INFO - 'MAIL': '/var/mail/cltbld', 17:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:58 INFO - 'MOZ_NO_REMOTE': '1', 17:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:58 INFO - 'NO_EM_RESTART': '1', 17:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:58 INFO - 'PWD': '/builds/slave/test', 17:22:58 INFO - 'SHELL': '/bin/bash', 17:22:58 INFO - 'SHLVL': '1', 17:22:58 INFO - 'TERM': 'linux', 17:22:58 INFO - 'TMOUT': '86400', 17:22:58 INFO - 'USER': 'cltbld', 17:22:58 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:58 INFO - '_': '/tools/buildbot/bin/python'} 17:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:58 INFO - Downloading/unpacking blobuploader==1.2.4 17:22:58 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 17:22:58 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 17:22:58 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 17:22:58 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 17:22:59 INFO - Downloading blobuploader-1.2.4.tar.gz 17:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:22:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:22:59 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 17:22:59 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 17:22:59 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 17:22:59 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 17:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:22:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:22:59 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 17:22:59 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 17:22:59 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 17:22:59 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 17:22:59 INFO - Downloading docopt-0.6.1.tar.gz 17:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:23:00 INFO - Installing collected packages: blobuploader, requests, docopt 17:23:00 INFO - Running setup.py install for blobuploader 17:23:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:23:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:23:00 INFO - Running setup.py install for requests 17:23:00 INFO - Running setup.py install for docopt 17:23:00 INFO - Successfully installed blobuploader requests docopt 17:23:00 INFO - Cleaning up... 17:23:00 INFO - Return code: 0 17:23:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:00 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 0x20a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24139c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410d60>, '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 0x2411a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411ef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', '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 17:23:00 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 17:23:00 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 17:23:00 INFO - Using env: {'DISPLAY': ':0', 17:23:00 INFO - 'HOME': '/home/cltbld', 17:23:00 INFO - 'LANG': 'en_US.UTF-8', 17:23:00 INFO - 'LANGUAGE': 'en_US:en', 17:23:00 INFO - 'LOGNAME': 'cltbld', 17:23:00 INFO - 'MAIL': '/var/mail/cltbld', 17:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:00 INFO - 'MOZ_NO_REMOTE': '1', 17:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:00 INFO - 'NO_EM_RESTART': '1', 17:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:00 INFO - 'PWD': '/builds/slave/test', 17:23:00 INFO - 'SHELL': '/bin/bash', 17:23:00 INFO - 'SHLVL': '1', 17:23:00 INFO - 'TERM': 'linux', 17:23:00 INFO - 'TMOUT': '86400', 17:23:00 INFO - 'USER': 'cltbld', 17:23:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:00 INFO - '_': '/tools/buildbot/bin/python'} 17:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:00 INFO - Running setup.py (path:/tmp/pip-0VaxfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:00 INFO - Running setup.py (path:/tmp/pip-IekqiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:00 INFO - Running setup.py (path:/tmp/pip-7mL35n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:01 INFO - Running setup.py (path:/tmp/pip-gRvTcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:01 INFO - Running setup.py (path:/tmp/pip-DsJ8UK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:01 INFO - Running setup.py (path:/tmp/pip-TfmVSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:01 INFO - Running setup.py (path:/tmp/pip-gGnMEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:01 INFO - Running setup.py (path:/tmp/pip-xUSwam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:01 INFO - Running setup.py (path:/tmp/pip-N7IRRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:01 INFO - Running setup.py (path:/tmp/pip-5Dg89L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:01 INFO - Running setup.py (path:/tmp/pip-FLKGZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:01 INFO - Running setup.py (path:/tmp/pip-rOu6y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:01 INFO - Running setup.py (path:/tmp/pip-ubLPsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:01 INFO - Running setup.py (path:/tmp/pip-yXhZtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:01 INFO - Running setup.py (path:/tmp/pip-aVHcYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:01 INFO - Running setup.py (path:/tmp/pip-1U2siO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:01 INFO - Running setup.py (path:/tmp/pip-deGRu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:23:02 INFO - Running setup.py install for manifestparser 17:23:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:23:02 INFO - Running setup.py install for mozcrash 17:23:02 INFO - Running setup.py install for mozdebug 17:23:02 INFO - Running setup.py install for mozdevice 17:23:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:23:02 INFO - Running setup.py install for mozfile 17:23:02 INFO - Running setup.py install for mozhttpd 17:23:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:23:02 INFO - Running setup.py install for mozinfo 17:23:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:23:02 INFO - Running setup.py install for mozInstall 17:23:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:23:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:23:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:23:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:23:02 INFO - Running setup.py install for mozleak 17:23:02 INFO - Running setup.py install for mozlog 17:23:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for moznetwork 17:23:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozprocess 17:23:03 INFO - Running setup.py install for mozprofile 17:23:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozrunner 17:23:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozscreenshot 17:23:03 INFO - Running setup.py install for moztest 17:23:03 INFO - Running setup.py install for mozversion 17:23:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:23:03 INFO - Cleaning up... 17:23:03 INFO - Return code: 0 17:23:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:03 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')]} 17:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:03 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')]} 17:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:03 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 0x20a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24139c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410d60>, '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 0x2411a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411ef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', '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 17:23:03 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 17:23:03 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 17:23:03 INFO - Using env: {'DISPLAY': ':0', 17:23:03 INFO - 'HOME': '/home/cltbld', 17:23:03 INFO - 'LANG': 'en_US.UTF-8', 17:23:03 INFO - 'LANGUAGE': 'en_US:en', 17:23:03 INFO - 'LOGNAME': 'cltbld', 17:23:03 INFO - 'MAIL': '/var/mail/cltbld', 17:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:03 INFO - 'MOZ_NO_REMOTE': '1', 17:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:03 INFO - 'NO_EM_RESTART': '1', 17:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:03 INFO - 'PWD': '/builds/slave/test', 17:23:03 INFO - 'SHELL': '/bin/bash', 17:23:03 INFO - 'SHLVL': '1', 17:23:03 INFO - 'TERM': 'linux', 17:23:03 INFO - 'TMOUT': '86400', 17:23:03 INFO - 'USER': 'cltbld', 17:23:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:03 INFO - '_': '/tools/buildbot/bin/python'} 17:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:04 INFO - Running setup.py (path:/tmp/pip-Fo6DX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:04 INFO - Running setup.py (path:/tmp/pip-ag4PpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:04 INFO - Running setup.py (path:/tmp/pip-DSG7ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:04 INFO - Running setup.py (path:/tmp/pip-KnHOWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:04 INFO - Running setup.py (path:/tmp/pip-1NMEsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:04 INFO - Running setup.py (path:/tmp/pip-jM_xnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:04 INFO - Running setup.py (path:/tmp/pip-_3zax5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:04 INFO - Running setup.py (path:/tmp/pip-uhFQrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:04 INFO - Running setup.py (path:/tmp/pip-WE2HwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:04 INFO - Running setup.py (path:/tmp/pip-Q0SS9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:04 INFO - Running setup.py (path:/tmp/pip-OKDuJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:04 INFO - Running setup.py (path:/tmp/pip-uBXUsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:04 INFO - Running setup.py (path:/tmp/pip-BEBjxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:04 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)) 17:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:04 INFO - Running setup.py (path:/tmp/pip-_HHV5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:05 INFO - Running setup.py (path:/tmp/pip-9RXHzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:05 INFO - Running setup.py (path:/tmp/pip-mH5Fz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23:05 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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:05 INFO - Running setup.py (path:/tmp/pip-EQSkZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23:05 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)) 17:23:05 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)) 17:23:05 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)) 17:23:05 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)) 17:23:05 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)) 17:23:05 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)) 17:23:05 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)) 17:23:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:23:05 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 17:23:05 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 17:23:05 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 17:23:05 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 17:23:06 INFO - Downloading blessings-1.6.tar.gz 17:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:23:06 INFO - Installing collected packages: blessings 17:23:06 INFO - Running setup.py install for blessings 17:23:06 INFO - Successfully installed blessings 17:23:06 INFO - Cleaning up... 17:23:06 INFO - Return code: 0 17:23:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:07 INFO - Reading from file tmpfile_stdout 17:23:07 INFO - Current package versions: 17:23:07 INFO - argparse == 1.2.1 17:23:07 INFO - blessings == 1.6 17:23:07 INFO - blobuploader == 1.2.4 17:23:07 INFO - docopt == 0.6.1 17:23:07 INFO - functools32 == 3.2.3-2 17:23:07 INFO - jsonschema == 2.5.1 17:23:07 INFO - manifestparser == 1.1 17:23:07 INFO - mozInstall == 1.13 17:23:07 INFO - mozcrash == 1.0 17:23:07 INFO - mozdebug == 0.1 17:23:07 INFO - mozdevice == 0.51 17:23:07 INFO - mozfile == 1.2 17:23:07 INFO - mozhttpd == 0.7 17:23:07 INFO - mozinfo == 0.10 17:23:07 INFO - mozleak == 0.1 17:23:07 INFO - mozlog == 3.5 17:23:07 INFO - moznetwork == 0.27 17:23:07 INFO - mozprocess == 0.25 17:23:07 INFO - mozprofile == 0.28 17:23:07 INFO - mozrunner == 6.13 17:23:07 INFO - mozscreenshot == 0.1 17:23:07 INFO - mozsystemmonitor == 0.3 17:23:07 INFO - moztest == 0.8 17:23:07 INFO - mozversion == 1.4 17:23:07 INFO - psutil == 3.1.1 17:23:07 INFO - requests == 1.2.3 17:23:07 INFO - wsgiref == 0.1.2 17:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:07 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 0x20a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24139c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410d60>, '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 0x2411a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411ef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', '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 17:23:07 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 17:23:07 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 17:23:07 INFO - Using env: {'DISPLAY': ':0', 17:23:07 INFO - 'HOME': '/home/cltbld', 17:23:07 INFO - 'LANG': 'en_US.UTF-8', 17:23:07 INFO - 'LANGUAGE': 'en_US:en', 17:23:07 INFO - 'LOGNAME': 'cltbld', 17:23:07 INFO - 'MAIL': '/var/mail/cltbld', 17:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:07 INFO - 'MOZ_NO_REMOTE': '1', 17:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:07 INFO - 'NO_EM_RESTART': '1', 17:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:07 INFO - 'PWD': '/builds/slave/test', 17:23:07 INFO - 'SHELL': '/bin/bash', 17:23:07 INFO - 'SHLVL': '1', 17:23:07 INFO - 'TERM': 'linux', 17:23:07 INFO - 'TMOUT': '86400', 17:23:07 INFO - 'USER': 'cltbld', 17:23:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:07 INFO - '_': '/tools/buildbot/bin/python'} 17:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:07 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)) 17:23:07 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)) 17:23:07 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)) 17:23:07 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)) 17:23:07 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)) 17:23:07 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)) 17:23:07 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)) 17:23:07 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)) 17:23:07 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)) 17:23:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:23:08 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)) 17:23:08 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)) 17:23:08 INFO - Installing collected packages: simplejson 17:23:08 INFO - Running setup.py install for simplejson 17:23:08 INFO - building 'simplejson._speedups' extension 17:23:08 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 17:23:09 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 17:23:09 INFO - Successfully installed simplejson 17:23:09 INFO - Cleaning up... 17:23:09 INFO - Return code: 0 17:23:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:09 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 0x20a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24139c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410d60>, '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 0x2411a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411ef0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', '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 17:23:09 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 17:23:09 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 17:23:09 INFO - Using env: {'DISPLAY': ':0', 17:23:09 INFO - 'HOME': '/home/cltbld', 17:23:09 INFO - 'LANG': 'en_US.UTF-8', 17:23:09 INFO - 'LANGUAGE': 'en_US:en', 17:23:09 INFO - 'LOGNAME': 'cltbld', 17:23:09 INFO - 'MAIL': '/var/mail/cltbld', 17:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:09 INFO - 'MOZ_NO_REMOTE': '1', 17:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:09 INFO - 'NO_EM_RESTART': '1', 17:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:09 INFO - 'PWD': '/builds/slave/test', 17:23:09 INFO - 'SHELL': '/bin/bash', 17:23:09 INFO - 'SHLVL': '1', 17:23:09 INFO - 'TERM': 'linux', 17:23:09 INFO - 'TMOUT': '86400', 17:23:09 INFO - 'USER': 'cltbld', 17:23:09 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:09 INFO - '_': '/tools/buildbot/bin/python'} 17:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:23:09 INFO - Cleaning up... 17:23:09 INFO - Return code: 0 17:23:09 INFO - Running post-action listener: _resource_record_post_action 17:23:09 INFO - Running post-action listener: _start_resource_monitoring 17:23:09 INFO - Starting resource monitoring. 17:23:09 INFO - [mozharness: 2017-09-27 00:23:09.756613Z] Finished create-virtualenv step (success) 17:23:09 INFO - [mozharness: 2017-09-27 00:23:09.757668Z] Running install step. 17:23:09 INFO - Running pre-action listener: _resource_record_pre_action 17:23:09 INFO - Running main action method: install 17:23:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:09 INFO - Reading from file tmpfile_stdout 17:23:09 INFO - Detecting whether we're running mozinstall >=1.0... 17:23:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:23:10 INFO - Reading from file tmpfile_stdout 17:23:10 INFO - Output received: 17:23:10 INFO - Usage: mozinstall [options] installer 17:23:10 INFO - Options: 17:23:10 INFO - -h, --help show this help message and exit 17:23:10 INFO - -d DEST, --destination=DEST 17:23:10 INFO - Directory to install application into. [default: 17:23:10 INFO - "/builds/slave/test"] 17:23:10 INFO - --app=APP Application being installed. [default: firefox] 17:23:10 INFO - mkdir: /builds/slave/test/build/application 17:23:10 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'] 17:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:23:28 INFO - Reading from file tmpfile_stdout 17:23:28 INFO - Output received: 17:23:28 INFO - /builds/slave/test/build/application/firefox/firefox 17:23:28 INFO - Running post-action listener: _resource_record_post_action 17:23:28 INFO - [mozharness: 2017-09-27 00:23:28.330555Z] Finished install step (success) 17:23:28 INFO - [mozharness: 2017-09-27 00:23:28.330807Z] Running setup-mitmproxy step. 17:23:28 INFO - Running pre-action listener: _resource_record_pre_action 17:23:28 INFO - Running main action method: setup_mitmproxy 17:23:28 INFO - Skipping: mitmproxy is not required 17:23:28 INFO - Running post-action listener: _resource_record_post_action 17:23:28 INFO - [mozharness: 2017-09-27 00:23:28.331940Z] Finished setup-mitmproxy step (success) 17:23:28 INFO - [mozharness: 2017-09-27 00:23:28.332160Z] Running run-tests step. 17:23:28 INFO - Running pre-action listener: _resource_record_pre_action 17:23:28 INFO - Running pre-action listener: _set_gcov_prefix 17:23:28 INFO - Running main action method: run_tests 17:23:28 WARNING - Try message not found. 17:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:23:28 INFO - Python 2.7.3 17:23:28 INFO - Return code: 0 17:23:28 INFO - grabbing minidump binary from tooltool 17:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:28 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 0x2410d60>, '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 0x2411a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2411ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:23:28 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 17:23:28 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 17:23:28 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 17:23:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:23:28 INFO - Return code: 0 17:23:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:23:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:23:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:23:28 INFO - ENV: RUST_BACKTRACE is now full 17:23:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:23:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 17:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 17:23:28 INFO - Using env: {'DISPLAY': ':0', 17:23:28 INFO - 'HOME': '/home/cltbld', 17:23:28 INFO - 'LANG': 'en_US.UTF-8', 17:23:28 INFO - 'LANGUAGE': 'en_US:en', 17:23:28 INFO - 'LOGNAME': 'cltbld', 17:23:28 INFO - 'MAIL': '/var/mail/cltbld', 17:23:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:28 INFO - 'MOZ_NO_REMOTE': '1', 17:23:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:28 INFO - 'NO_EM_RESTART': '1', 17:23:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:28 INFO - 'PWD': '/builds/slave/test', 17:23:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:28 INFO - 'RUST_BACKTRACE': 'full', 17:23:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:23:28 INFO - 'SHELL': '/bin/bash', 17:23:28 INFO - 'SHLVL': '1', 17:23:28 INFO - 'TERM': 'linux', 17:23:28 INFO - 'TMOUT': '86400', 17:23:28 INFO - 'USER': 'cltbld', 17:23:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:28 INFO - '_': '/tools/buildbot/bin/python'} 17:23:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 17:23:28 INFO - mozversion application_buildid: 20170926225505 17:23:28 INFO - mozversion application_changeset: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd 17:23:28 INFO - mozversion application_display_name: Nightly 17:23:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:23:28 INFO - mozversion application_name: Firefox 17:23:28 INFO - mozversion application_remotingname: firefox 17:23:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:23:28 INFO - mozversion application_vendor: Mozilla 17:23:28 INFO - mozversion application_version: 58.0a1 17:23:28 INFO - mozversion platform_buildid: 20170926225505 17:23:28 INFO - mozversion platform_changeset: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd 17:23:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:23:28 INFO - mozversion platform_version: 58.0a1 17:23:28 INFO - using testdate: 1506471808 17:23:28 INFO - actual date: 1506471808 17:23:28 INFO - starting webserver on 'localhost:56907' 17:23:28 INFO - SUITE-START | Running 2 tests 17:23:28 INFO - TEST-START | dromaeo_css 17:23:28 INFO - Initialising browser for dromaeo_css test... 17:23:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56907/getInfo.html -profile /tmp/tmpowQX0e/profile 17:23:28 INFO - TEST-INFO | started process 9463 (/builds/slave/test/build/application/firefox/firefox http://localhost:56907/getInfo.html) 17:23:34 INFO - TEST-INFO | 9463: exit 0 17:23:34 INFO - Browser initialized. 17:23:34 INFO - Running cycle 1/1 for dromaeo_css test... 17:23:34 INFO - Using env: {'DISPLAY': ':0', 17:23:34 INFO - 'HOME': '/home/cltbld', 17:23:34 INFO - 'JSGC_DISABLE_POISONING': '1', 17:23:34 INFO - 'LANG': 'en_US.UTF-8', 17:23:34 INFO - 'LANGUAGE': 'en_US:en', 17:23:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:23:34 INFO - 'LOGNAME': 'cltbld', 17:23:34 INFO - 'MAIL': '/var/mail/cltbld', 17:23:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:23:34 INFO - 'MOZ_CRASHREPORTER': '1', 17:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:23:34 INFO - 'MOZ_NO_REMOTE': '1', 17:23:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:34 INFO - 'NO_EM_RESTART': '1', 17:23:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:34 INFO - 'PWD': '/builds/slave/test', 17:23:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:34 INFO - 'RUST_BACKTRACE': 'full', 17:23:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:23:34 INFO - 'SHELL': '/bin/bash', 17:23:34 INFO - 'SHLVL': '1', 17:23:34 INFO - 'STYLO_FORCE_DISABLED': '1', 17:23:34 INFO - 'TERM': 'linux', 17:23:34 INFO - 'TMOUT': '86400', 17:23:34 INFO - 'USER': 'cltbld', 17:23:34 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:34 INFO - '_': '/tools/buildbot/bin/python'} 17:23:34 INFO - TEST-INFO | started process 9699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpowQX0e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:35 INFO - PID 9699 | 17:23:35 INFO - PID 9699 | (/builds/slave/test/build/application/firefox/firefox:9749): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:23:35 INFO - PID 9699 | 17:23:45 INFO - PID 9699 | RSS: Main: 144539648 17:23:45 INFO - PID 9699 | 17:26:43 INFO - PID 9699 | Cycle 1(1): loaded http://localhost:56907/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56907/tests/dromaeo/cssquery-ext.html) 17:26:44 INFO - PID 9699 | RSS: Main: 146182144 17:26:44 INFO - PID 9699 | 17:29:45 INFO - PID 9699 | Cycle 1(1): loaded http://localhost:56907/tests/dromaeo/cssquery-ext.html (next: http://localhost:56907/tests/dromaeo/cssquery-jquery.html) 17:29:46 INFO - PID 9699 | RSS: Main: 146100224 17:29:46 INFO - PID 9699 | 17:32:47 INFO - PID 9699 | Cycle 1(1): loaded http://localhost:56907/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56907/tests/dromaeo/cssquery-mootools.html) 17:32:48 INFO - PID 9699 | RSS: Main: 147832832 17:32:48 INFO - PID 9699 | 17:35:50 INFO - PID 9699 | Cycle 1(1): loaded http://localhost:56907/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56907/tests/dromaeo/cssquery-prototype.html) 17:35:50 INFO - PID 9699 | RSS: Main: 146345984 17:35:50 INFO - PID 9699 | 17:38:54 INFO - PID 9699 | Cycle 1(1): loaded http://localhost:56907/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56907/tests/dromaeo/cssquery-yui.html) 17:38:54 INFO - PID 9699 | RSS: Main: 148217856 17:38:54 INFO - PID 9699 | 17:41:56 INFO - PID 9699 | Cycle 1(1): loaded http://localhost:56907/tests/dromaeo/cssquery-yui.html (next: http://localhost:56907/tests/dromaeo/cssquery-dojo.html) 17:41:56 INFO - PID 9699 | RSS: Main: 150487040 17:41:56 INFO - PID 9699 | 17:41:56 INFO - PID 9699 | __start_tp_report 17:41:56 INFO - PID 9699 | _x_x_mozilla_page_load 17:41:56 INFO - PID 9699 | _x_x_mozilla_page_load_details 17:41:56 INFO - PID 9699 | |i|pagename|runs| 17:41:56 INFO - PID 9699 | |0;dojo.html;3900.648941595257;3916.8836881488783;3923.9215215695685;3945.191235796662;3957.228340473609;6324.367563243673;6373.171487706598;6441.838954026151;6441.8711625767455;6483.157189565356;6351.9682401587925;6427.710753016114;6431.7427302907945;6510.479161667067;6516.67416629169;5714.371419143891;5788;5807.680577568232;5808.564357673192;5826;112.42417285394089;5674.631148975324;5720.513756330696;5810.1865738796605;5826.737796799133;5660.405657405975;5744.253247077874;5746.597738158331;5783.045797443417;5810.477057064863;5721.056025755745;5725.82822515321;5793.594448388614;5822.039363505017;5822.301323841124;5724.627899186581;5724.8282551523525;5756.165356023395;5806.796762113306;5812.099124635688;6351.301356850743;6405.327440618715;6410.0705397717065;6495.512836537278;6529.31442198567;6852.862942741117;6921.342472465108;6933.479989000845;6939.340762627542;6939.861202775916;6992.6154061526595;6997.82505437363;7010.754623588201;7021.473389495757;7075.363217310415;6533.444657204096;6543.476521878286;6551.344865513458;6559.93440065598;6573.1783527059115;7112.537685050455;7135.607541585159;7136.892946605805;7208.783736487913;7232.674529646179;6744.055832183498;6767.2894346093935;6849.280825513349;6872.072270243553;6938.479614028968;6945.791626251221;7007.649617519103;7009.719611215494;7015.824604384829;7020.859582808417;6883.586984780929;6912.377885990285;6958.234594194634;6973.965130174317;6976.337247961435;6766.966165169143;6882.7591034313555;6890.552114112566;6891.896621550681;6898.862022759517;4998.400191976913;5011.899762004739;5018.397792264952;5040.949590504121;5065.366829146356;4582.289745089516;4590.311453282035;4602.033572949651;4619.86140415788;4652.302154676826;6314.747410103636;6354.872902542016;6428.5178611604315;6437.0988061671405;6443.323451037667;6839.384455399038;6862.3137686230975;6924.61914594692;6953.860922781516;6960.9303906961295;6341.492680585542;6344.904826427607;6369.904451433232;6380.202474690664;6395.616263024233;5487.6981766003255;5493.176023596492;5565.638233514889;5567.081431563827;5578.30271216098;7059.611721355374;7080.0795896534155;7154.964225178841;7164.820879478055;7167;6734.797956061326;6801.9319806801295;6852.931470685229;6854.34883686049;6886.208086069965;7169.820754481179;7201.603911784902;7242.6740796663225;7265.491415600857;7300.525465844703;6756.391924726799;6828.283030281749;6908.067410899464;6909.067275917687;6913.51605387618;6906.758263460755;6916.481263905127;6995.510314277952;7006.509544331848;7015.894761578478;6596.30738772422;6599.670016499252;6718.2609912908565;6760.1549806274215;6791.320867913169;6712.194536655633;6781.525293229624;6800.353966373186;6808.421284190899;6827.453803695792;6516.087747715229;6592.472602191909;6601.636909969806;6681.432078273401;6700;6730.663466826737;6764.492663050192;6806.285340039224;6828.487863410165;6875.278095799869;6421.903671444838;6521.608703477807;6601.405873471411;6610.206775187008;6634.767783127568 17:41:56 INFO - PID 9699 | |1;ext.html;914.3371055984408;967.7677357434214;988.7231575158953;995.4723996281973;1012.6101450941385;44286;45073;45170.548294517;45242;45250;42003.57996420035;42068.15863682725;42216;42315.15369692604;42378.364324535156;7464.365528930048;7584.43116766242;7596.354309883666;7609.162992070867;7614.961925190366;7455.0681164854395;7545.396368290551;7556.735514257002;7561.962190189069;7562.09254889414;8529.445586036887;8681.392302538825;8723.694670686527;8752.431091979033;8753.606087726068;8539.530325832076;8597.011343695462;8598.398112132154;8606.56967151643;8617.181367770052;8350.373721970816;8483.745487635319;8572.785680357978;8575.485470871768;8594.355423343211;41477;41918.1616367674;41942.58057419448;42048.26686265383;42065.579344206475;3713.702903767692;3774.169682669808;3777.074616718894;3780.8676696315497;3789.981050094732;33398.16504587381;33463.832680836684;33510.1622459438;33658.326833463194;33668.6633133668;5458.972705136449;5473.863153421156;5483.670979741229;5513.807016754435;5525.917111243334;211488;215231;216789;217219;219509;47406.52593474021;52445.7377713109;53270.46729532655;53293.736501079824;53423.19865202025;55649.721751390985;55702.16446753302;55788.72105639446;55825.72087139538;55891;14663.853361466248;14704.41182352694;14801.777973330409;14823.110613363233;14828.110313381232;11791.88208117925;11834.408279585987;11846.526138954345;11876.821847672292;11949.163558550992;14807.925960370128;14842;14845;14948.32732527039;14994.47519336818;5968.820935371946;6062.696865156725;6090.817275481742;6098.176746139215;6111.174991376108;1080.8000519903842;1095.802755504017;1102.3496137279044;1107.9612213572486;1109.4009235013164;25642.615360769603;25720.871395642902;25812.612810807852;25932.8703356482;25951.74048259493;1185.6917201527492;1196.132803717298;1202.5550546297925;1202.6752776750404;1223.082687984012;13588.048836581542;13613;13839.861601384058;13842.723145537033;13986.160830350009;270704;271419;271912;272102;273980;58144.418555814744;58628.4137158623;58656;58658;58708;1498.655309278872;1504.6689728259764;1537.0623919409152;1537.961550961235;1558.7350150474447;25618;25620;25687.229383118538;25984.480310393308;26044.34889127787;41793.58206417897;41847.37228941629;41992.16015679608;41995.58004419917;42132.368014479194;231648;233194;233926;235266;235420;36953.815230923676;38871.805640971616;39688.40467393049;39903.40144897771;40090.39864401978;49666.50333496619;49843.50156498388;49885.750571246914;50043;50555.494445055076;36497;36685.81657091698;37163;37190.8140459296;37446.625533744314;36353.454698180074;36521.269574608894;36543;36970.63029369672;37174.442383363734;42037;42869.356959646255;43254;43337.566624333354;43399;35421;35437.46843797294;35444.82277588596;35502.644973549934;35826.820865895505;27121.1863644091;27244.863775680995;27304.317392065357;27475.31311717223;27561.31096722598 17:41:56 INFO - PID 9699 | |2;jquery.html;591.8549955260962;596.9194158788567;602.8221674605991;628.7390732845869;630.2625927664633;23599.76400235997;24227.75772242277;24311.149109781138;24382.878085609547;24414;24290.878545607247;25742.485150296983;25846.612300815457;25875.353116172104;25901.87049064752;6329.620222786636;6460.644664543448;6486.059521369422;6491.058796474508;6497.740090396378;6371.362863713614;6500.772472963447;6628.966855165718;6647.567908085983;6655.334466553354;6622.238442579092;6622.470202383822;6626.237982631987;6637;6638.336166383371;6430.260520040185;6624.271330153703;6634.170728658918;6683;6690.19717633887;6246.875062498724;6254.155688981975;6255.155554000197;6257.499400047986;6269.529785266078;28756;29236.561451578244;29245.122646320644;29252;29280.121596352143;2093.9895300523553;2109.9894500527553;2120.5016821047043;2122.214780531198;2140.77521860204;20051.89714565698;20291.188352465884;20480.38558843237;20546.38360849162;20572.485687857774;2407.7712617301327;2418.6155950215993;2470.5305991861487;2501.3371456564023;2514.647949287083;137668.31165844208;142814;150907;155347;161131;15736.685266294839;16413.261403236884;16608.086555239577;16704.164791760362;17309.65380692404;26066.218013459627;26103.73896261051;26113.347166320615;26139.73860261411;26153.73846261513;10247.231457640706;10463.895361046445;10534.473276336152;10543.209259305582;10672.466376681135;9435.103665151937;9436.858447123299;9442.197413219816;9497.620095196253;9598;9423.19902808269;9596.08078384326;9617.615295388106;9720.805583888283;9942;2924.809887357315;2935.8678859451375;2986.6266716660416;2988.4023195361015;3046.01004673482;1004.5881188712593;1045.6078970386104;1068.3536460441476;1069.0752499088233;1081.3403823667556;20683;21287.36137915834;21525.892370538048;21622.35132946014;21653.67519487209;1069.6309773128414;1125.4372813593204;1130.197559732599;1131.9603813866474;1135.9432028398546;11616.244944078608;11839.881601183877;11865.584704535473;11906.702332441586;11940.641780746591;529959;554604;557575;561106;581251;126130;127978;128560;129711.35144324407;129737;1116.2186469471403;1174.0842143128373;1217.8355921950601;1223.8286639870425;1277.584784944878;22004.66992995074;22354.21760238384;22676.65985010259;22710.260292522787;22803.728974532136;61960.380396197266;65178.674106629165;66799;67119.99320010106;67557.3244267551;79025;79159.60420197863;79495;79619;80389.59805200937;15242.618934526725;15706.371745130067;15836.208189590245;15839.762403563725;15856.365745370056;24334.63498047495;24636;24806.131785387424;24920.750792491843;24955.251342459756;19235.03824808726;19511;19638.312659056865;19711.408657740292;19994.300199492947;17326.91336543309;17553.297868085134;17719.911400442914;18052.458426247234;18498.445046648623;19141.80858191456;20195.697064544336;20202.898985504977;20219.191232350542;20482.487937801674;15550.144742039296;15567.76648350253;15615.609609759847;15637.687246254784;15680.137592432526;16950.40673576419;17051.147442628066;17129.05790181552;18008.639827203122;19367.225310987404 17:41:56 INFO - PID 9699 | |3;mootools.html;1426.6718654709416;1466.1349803615865;1468.6328417895527;1497.618107382618;1498.7002599480106;16762.994220346787;17407;17444.127793610318;17461.388851390187;17480.737788933176;16862.83137168628;16879.662406751857;16932.492025239233;16994.405195818148;17045.659086818257;2844.360018995725;2853.044230182891;2881.394907069518;2886.7690584753273;2890.450814345278;2775.875085621142;2852.215640698804;2853.186841750102;2853.2153657744184;2853.843038632874;2706.2422521693957;2750.2161883863105;2752.2981639681852;2754.4628797384516;2755.61421401004;2608.3870290481723;2683.9194824155406;2684.691260505028;2685.11391240892;2685.825421347606;2616.973830261692;2647.2984659065364;2656.096927044795;2660.521106200883;2664.5869890167055;16386.83613163865;16500.42248521296;16507.33970641173;16529.33882644693;16561.08914009729;8245.546494942835;8496.532690702008;8521.14788521149;8532.402731808776;8544.78638034048;5478.863028424282;5669.688167150805;5828;5853.443922827367;5975.551833612496;2108.9156433742633;2144.1959265275523;2161.232762369352;2183.6833659119497;2194.2320187934256;27014.864925675443;27837.721622783716;29471.263218419495;30074.84962575195;30157.2858442739;7672.65473053714;7674.347680447113;7693.769186924401;7788.8052798679355;7876.645550950221;22040;22058;22216.777832221473;22291.219807306665;22405.66391504129;8439.789005274917;8531.74404767858;8540.060593334729;8548.145185481402;8559.572021398904;7426.183119856812;7582.848343033108;7603.505772124794;7635.160132385433;7667.156612772591;5748.655080695172;5950.553708471882;5971.134185543072;6002.759889604367;6054.091886217103;1878.4928069421453;1901.4010586665156;1932.2753967262277;1946.7371904792672;1969.320584398409;942.9104235097655;962.0235461007084;980.0346658541331;987.2694206287296;995.8008398320364;9351.205147562534;9442.95278523603;9636.46999415039;9655.275854310954;9719;816.7958010497375;817.1695402298926;817.3285630884855;824.0688022534498;836.2014276366056;5279.736013199325;5343.625946183807;5355.625106242604;5380.408155102936;5436.184572314105;22837.543249135255;23928.162514311916;24902.5019499609;25010;25244.74755252424;24059.879700601385;24167;24199.395015124763;24409;24507.142250021163;10947.233693641369;11250.831237531444;11569.595064172881;12053.819192712117;12243;9350.111739384747;9483.573239204114;9574.281928855504;9593.712188634352;9674.467904265333;21036.26373076935;21171.15315387367;21627.783722163207;21790.673139903232;22628.66057009113;22269.886505674975;22511.212107576157;22517.77482225157;22667.433314167276;22981.08075677021;12887.93556032214;13198;13241.602751917459;13279.468821247428;13280.070395072253;15150.31823567964;15380.69238615199;15415.306311216247;15459.458918937784;15489.457868974532;12116.697082572653;12246.081543884422;12276.877231227574;12426.5650702225;12691.555795547112;11488.368139752394;11750.58872939443;11778.17552771332;12009.219400738924;12271.263724176579;10758.784824303626;11011.174161937726;11077.723056923642;11169.497372618089;11224.7755044897;7757.185495522889;7968.920310796818;8032.919670803451;8052.637631306488;8087.47431416956;7682.462227644235;7836.333911617577;7858.135605083322;7937.40469464804;7981.321587665114 17:41:56 INFO - PID 9699 | |4;prototype.html;507.403800534372;541.8726599249176;566.6571724106915;567.7246535430316;574.9453801888819;6080.148779170914;6156.384361563847;6159.353267906872;6160.199174107371;6328;6219.253689557259;6232.220972378453;6284.811455656326;6306.265776911352;6326.873462530758;5144.562712169461;5152.896942061176;5164.6384753067305;5184;5208.453112423198;5010.073136469765;5162.303089082982;5167.715775632339;5184.351956005499;5194.8701282468055;5136;5161.27742116104;5172.327597412331;5191.948080519203;5209.921851172236;5180.2488639147305;5183.352080989876;5188.455212202702;5191.974040129813;5192.61055420845;4828.324034635154;4857;4860.222364421676;4880.243562247857;4892.63305252104;6158.67588468477;6229.719662615148;6233.3143354231;6243.625382477066;6259.624422534617;6112.419320164578;6125.908111378333;6166.969165154191;6211.223597050369;6230.283517395512;6530.477561795093;6575.901361479581;6641.767538136142;6645.169353830771;6648.301928297507;5429.864253393657;5466.863328416782;5501.889962200774;5514.6139770216105;5520.944790552083;7002.19474760404;7033.964830175919;7048.308405982527;7055.823604409879;7067.681954312068;5682.261306030272;5682.516986056149;5711.942880571141;5733.942660573341;5738.77044918207;5777;5827.329857066492;5836.249125262404;5855.502282305966;5873.882522349529;6053.545984051214;6126.23422072241;6139.833431647972;6192.225971753531;6201.96899015502;6566.179227596551;6609.173853268341;6701.497387695942;6716.126903502513;6732.730690772412;1840.7883093444425;1906.9523261918287;1937.6609093408597;1939.36001119633;1958.7159861819957;1453.3096779029877;1494.1782019889017;1500.3398504657916;1529.5640742388366;1557.7351850185269;6030.276366836008;6044.1840351552855;6054.546908741959;6062.211912451441;6148.661823599745;6365.936340636535;6529.738810447624;6582.473402127818;6717.328267173341;6758.256591774901;6174.876502470015;6175.752969881244;6243.219597550306;6250.718717657716;6255.74977000924;3443.328550932594;3469;3493.283876805249;3497.300539891981;3528.5060091587197;6850.417714494224;6926.896096558556;6934.653267336613;6935.202451718016;7011.544249623758;6779.661016949133;6860.622665753332;6892.724845903524;6917.377436030782;6961.860762784716;6934;6965.930340696629;7011.789646310619;7035.577865328097;7067.929320706727;6661.101586047953;6688.398044176048;6761.898571521333;6775.186977562724;6793.456523478011;6682.2649508555;6709.496787740842;6746.4265537429865;6748.2576916538155;6777.356151165632;7041.838096713985;7045.330693584101;7058.11773528309;7083.327083927019;7104.081897887645;5224;5235.476452354734;5239.502247286502;5255.684658920477;5269.973650131725;6463.903041454288;6653.168353955755;6703.66481675924;6735.966320168368;6824.93175068243;6134.895718770664;6374.872502550016;6496.480281577557;6525.934740652533;6542.640154791342;6403.551751377358;6430.646314452563;6486.870262594627;6520.706568204537;6561.507886908596;6285.560010799383;6286;6304.779332723333;6360.727854429225;6426.775062872777;6586.670666466754;6603.867922641616;6626.53614246998;6627;6673.265940746417;6386.882295598345;6442.677866106769;6462.5153113515735;6493.318201588765;6506.544541882023 17:41:56 INFO - PID 9699 | |5;yui.html;967.4872317671633;968.1528662420383;987.5852142100322;995.945223012734;999.0808456220277;18835.529111772197;19007.904960475196;19250.807491925094;19332;19353.806461935375;19106.331278405258;19374.128164232607;19494;19938.60122797547;19962.600747985067;1035.3632516002642;1052.6999805055561;1053.9683809485728;1054.3094273250995;1056.6988408303635;1064.0211005874576;1066.0245875024343;1067.2422579968193;1068.8931106889327;1070.8607880975462;1046.638909576195;1102.5865300512307;1107.3189988157264;1120.2046546951674;1120.3669926491507;1099.1426687183969;1099.5656715597333;1099.719571509268;1099.8350247462865;1102.536934487517;780.1652232111643;813.8046868751456;814.1614137438448;817.0603805623521;818.7339114787658;20422.08100635475;20534.794652053588;20556.486087847923;20563.280285189947;20602.484937876525;22421.103155873745;22791.08835646572;22893.084276628913;22990.770092299197;23000.539989200122;16580.253888575044;16768.496945091545;17525.912370438193;17635;17776.91111544447;3856.9421458678144;3858.247641709868;3899.824507897123;3918.4318273850417;3927.175293188434;130576;158441.2077939603;158761;160303.19848400683;161401;18165.273389064554;18214.90892545529;18442.63114737698;18629.534261643297;18696.626067478574;34238.48642270368;34841.47737783935;35004.64995350065;35163.64836351655;35804.28391432157;10020.69937901864;10049.497525123714;10091.697249082392;10104.29269951111;10157.644482443227;4519.728816271035;4543.273076307775;4603.49361570227;4620.422447194101;4626.583607475343;6063.5452341073715;6147.415995480422;6173.382661733791;6173.567850250529;6177.96911015451;1214.7509760499076;1227.3495047624774;1235.6540168752763;1237.418413345726;1241.0815996162955;715.8711431942196;729.0522320982807;733.0799846192994;744.6351287868905;754.1402800807084;13354.93322533381;13529.003212863532;13576.660583485493;13833.723325533432;13904.791428128587;701.6526819224516;708.2952462300044;709.6238993333542;722.3174100475001;725.4341613541341;6072.635641861502;6100.69496525172;6130.5402094842175;6140.907886381708;6174.043023331391;129205.35397322953;133109.33445332712;133364;136905;137634;127717.36141319234;129896;130896;131473.34263328812;131513.6971607893;107571;110809;114387;115746.37014519493;116776.41611791887;11729.120315976506;11733.647990560297;11780.352080635646;11886.881131188577;11898.524059037887;55898;56162;57278.14082788678;57389.713051434475;57632.71183644055;70504;72352.63823680847;72455.27544724486;73209.6339518299;73859;16971.83028169752;17424.82575174232;17444.73832892482;17647.117644117487;17688.91155544214;19712.704309435085;19885.701714474006;19914.302999394953;19919.454770756027;20161.193552257744;18474.815251847846;18558.628827423647;18582.81417185811;18662.253509859453;18763.71854422212;17442.47672569825;17447.127643618023;17684;17860.91069544644;17877;17492.47522574325;17503.912480437517;17510.387136450165;17593.648127037643;17842.107894604957;12868.935655321664;13282.867171328164;13561.796573051215;13585.796213056614;13590.32048397596;13592.524261650795;13596.79604805909;13601.727965440834;13631.318434078456;13714.93142534321 17:41:56 INFO - PID 9699 | __end_tp_report 17:41:56 INFO - PID 9699 | __start_cc_report 17:41:56 INFO - PID 9699 | _x_x_mozilla_cycle_collect,292 17:41:56 INFO - PID 9699 | __end_cc_report 17:41:56 INFO - PID 9699 | __startTimestamp1506472916351__endTimestamp 17:41:56 INFO - PID 9699 | 17:41:56 INFO - PID 9699 | ------- Summary: start ------- 17:41:56 INFO - PID 9699 | Number of tests: 6 17:41:56 INFO - PID 9699 | 17:41:56 INFO - PID 9699 | [#0] dojo.html Cycles:165 Average:6350.07 Median:6601.64 stddev:903.19 (13.7%) stddev-sans-first:885.29 17:41:56 INFO - PID 9699 | Values: 3900.6 3916.9 3923.9 3945.2 3957.2 6324.4 6373.2 6441.8 6441.9 6483.2 6352.0 6427.7 6431.7 6510.5 6516.7 5714.4 5788.0 5807.7 5808.6 5826.0 112.4 5674.6 5720.5 5810.2 5826.7 5660.4 5744.3 5746.6 5783.0 5810.5 5721.1 5725.8 5793.6 5822.0 5822.3 5724.6 5724.8 5756.2 5806.8 5812.1 6351.3 6405.3 6410.1 6495.5 6529.3 6852.9 6921.3 6933.5 6939.3 6939.9 6992.6 6997.8 7010.8 7021.5 7075.4 6533.4 6543.5 6551.3 6559.9 6573.2 7112.5 7135.6 7136.9 7208.8 7232.7 6744.1 6767.3 6849.3 6872.1 6938.5 6945.8 7007.6 7009.7 7015.8 7020.9 6883.6 6912.4 6958.2 6974.0 6976.3 6767.0 6882.8 6890.6 6891.9 6898.9 4998.4 5011.9 5018.4 5040.9 5065.4 4582.3 4590.3 4602.0 4619.9 4652.3 6314.7 6354.9 6428.5 6437.1 6443.3 6839.4 6862.3 6924.6 6953.9 6960.9 6341.5 6344.9 6369.9 6380.2 6395.6 5487.7 5493.2 5565.6 5567.1 5578.3 7059.6 7080.1 7155.0 7164.8 7167.0 6734.8 6801.9 6852.9 6854.3 6886.2 7169.8 7201.6 7242.7 7265.5 7300.5 6756.4 6828.3 6908.1 6909.1 6913.5 6906.8 6916.5 6995.5 7006.5 7015.9 6596.3 6599.7 6718.3 6760.2 6791.3 6712.2 6781.5 6800.4 6808.4 6827.5 6516.1 6592.5 6601.6 6681.4 6700.0 6730.7 6764.5 6806.3 6828.5 6875.3 6421.9 6521.6 6601.4 6610.2 6634.8 17:41:56 INFO - PID 9699 | 17:41:56 INFO - PID 9699 | [#1] ext.html Cycles:180 Average:42483.96 Median:3785.42 stddev:62809.60 (1659.2%) stddev-sans-first:62908.24 17:41:56 INFO - PID 9699 | Values: 914.3 967.8 988.7 995.5 1012.6 44286.0 45073.0 45170.5 45242.0 45250.0 42003.6 42068.2 42216.0 42315.2 42378.4 7464.4 7584.4 7596.4 7609.2 7615.0 7455.1 7545.4 7556.7 7562.0 7562.1 8529.4 8681.4 8723.7 8752.4 8753.6 8539.5 8597.0 8598.4 8606.6 8617.2 8350.4 8483.7 8572.8 8575.5 8594.4 41477.0 41918.2 41942.6 42048.3 42065.6 3713.7 3774.2 3777.1 3780.9 3790.0 33398.2 33463.8 33510.2 33658.3 33668.7 5459.0 5473.9 5483.7 5513.8 5525.9 211488.0 215231.0 216789.0 217219.0 219509.0 47406.5 52445.7 53270.5 53293.7 53423.2 55649.7 55702.2 55788.7 55825.7 55891.0 14663.9 14704.4 14801.8 14823.1 14828.1 11791.9 11834.4 11846.5 11876.8 11949.2 14807.9 14842.0 14845.0 14948.3 14994.5 5968.8 6062.7 6090.8 6098.2 6111.2 1080.8 1095.8 1102.3 1108.0 1109.4 25642.6 25720.9 25812.6 25932.9 25951.7 1185.7 1196.1 1202.6 1202.7 1223.1 13588.0 13613.0 13839.9 13842.7 13986.2 270704.0 271419.0 271912.0 272102.0 273980.0 58144.4 58628.4 58656.0 58658.0 58708.0 1498.7 1504.7 1537.1 1538.0 1558.7 25618.0 25620.0 25687.2 25984.5 26044.3 41793.6 41847.4 41992.2 41995.6 42132.4 231648.0 233194.0 233926.0 235266.0 235420.0 36953.8 38871.8 39688.4 39903.4 40090.4 49666.5 49843.5 49885.8 50043.0 50555.5 36497.0 36685.8 37163.0 37190.8 37446.6 36353.5 36521.3 36543.0 36970.6 37174.4 42037.0 42869.4 43254.0 43337.6 43399.0 35421.0 35437.5 35444.8 35502.6 35826.8 27121.2 27244.9 27304.3 27475.3 27561.3 17:41:56 INFO - PID 9699 | 17:41:56 INFO - PID 9699 | [#2] jquery.html Cycles:180 Average:38408.54 Median:13003.77 stddev:93727.44 (720.8%) stddev-sans-first:93947.36 17:41:56 INFO - PID 9699 | Values: 591.9 596.9 602.8 628.7 630.3 23599.8 24227.8 24311.1 24382.9 24414.0 24290.9 25742.5 25846.6 25875.4 25901.9 6329.6 6460.6 6486.1 6491.1 6497.7 6371.4 6500.8 6629.0 6647.6 6655.3 6622.2 6622.5 6626.2 6637.0 6638.3 6430.3 6624.3 6634.2 6683.0 6690.2 6246.9 6254.2 6255.2 6257.5 6269.5 28756.0 29236.6 29245.1 29252.0 29280.1 2094.0 2110.0 2120.5 2122.2 2140.8 20051.9 20291.2 20480.4 20546.4 20572.5 2407.8 2418.6 2470.5 2501.3 2514.6 137668.3 142814.0 150907.0 155347.0 161131.0 15736.7 16413.3 16608.1 16704.2 17309.7 26066.2 26103.7 26113.3 26139.7 26153.7 10247.2 10463.9 10534.5 10543.2 10672.5 9435.1 9436.9 9442.2 9497.6 9598.0 9423.2 9596.1 9617.6 9720.8 9942.0 2924.8 2935.9 2986.6 2988.4 3046.0 1004.6 1045.6 1068.4 1069.1 1081.3 20683.0 21287.4 21525.9 21622.4 21653.7 1069.6 1125.4 1130.2 1132.0 1135.9 11616.2 11839.9 11865.6 11906.7 11940.6 529959.0 554604.0 557575.0 561106.0 581251.0 126130.0 127978.0 128560.0 129711.4 129737.0 1116.2 1174.1 1217.8 1223.8 1277.6 22004.7 22354.2 22676.7 22710.3 22803.7 61960.4 65178.7 66799.0 67120.0 67557.3 79025.0 79159.6 79495.0 79619.0 80389.6 15242.6 15706.4 15836.2 15839.8 15856.4 24334.6 24636.0 24806.1 24920.8 24955.3 19235.0 19511.0 19638.3 19711.4 19994.3 17326.9 17553.3 17719.9 18052.5 18498.4 19141.8 20195.7 20202.9 20219.2 20482.5 15550.1 15567.8 15615.6 15637.7 15680.1 16950.4 17051.1 17129.1 18008.6 19367.2 17:41:56 INFO - PID 9699 | 17:41:56 INFO - PID 9699 | [#3] mootools.html Cycles:180 Average:10434.08 Median:2674.25 stddev:7680.18 (287.2%) stddev-sans-first:7671.91 17:41:56 INFO - PID 9699 | Values: 1426.7 1466.1 1468.6 1497.6 1498.7 16763.0 17407.0 17444.1 17461.4 17480.7 16862.8 16879.7 16932.5 16994.4 17045.7 2844.4 2853.0 2881.4 2886.8 2890.5 2775.9 2852.2 2853.2 2853.2 2853.8 2706.2 2750.2 2752.3 2754.5 2755.6 2608.4 2683.9 2684.7 2685.1 2685.8 2617.0 2647.3 2656.1 2660.5 2664.6 16386.8 16500.4 16507.3 16529.3 16561.1 8245.5 8496.5 8521.1 8532.4 8544.8 5478.9 5669.7 5828.0 5853.4 5975.6 2108.9 2144.2 2161.2 2183.7 2194.2 27014.9 27837.7 29471.3 30074.8 30157.3 7672.7 7674.3 7693.8 7788.8 7876.6 22040.0 22058.0 22216.8 22291.2 22405.7 8439.8 8531.7 8540.1 8548.1 8559.6 7426.2 7582.8 7603.5 7635.2 7667.2 5748.7 5950.6 5971.1 6002.8 6054.1 1878.5 1901.4 1932.3 1946.7 1969.3 942.9 962.0 980.0 987.3 995.8 9351.2 9443.0 9636.5 9655.3 9719.0 816.8 817.2 817.3 824.1 836.2 5279.7 5343.6 5355.6 5380.4 5436.2 22837.5 23928.2 24902.5 25010.0 25244.7 24059.9 24167.0 24199.4 24409.0 24507.1 10947.2 11250.8 11569.6 12053.8 12243.0 9350.1 9483.6 9574.3 9593.7 9674.5 21036.3 21171.2 21627.8 21790.7 22628.7 22269.9 22511.2 22517.8 22667.4 22981.1 12887.9 13198.0 13241.6 13279.5 13280.1 15150.3 15380.7 15415.3 15459.5 15489.5 12116.7 12246.1 12276.9 12426.6 12691.6 11488.4 11750.6 11778.2 12009.2 12271.3 10758.8 11011.2 11077.7 11169.5 11224.8 7757.2 7968.9 8032.9 8052.6 8087.5 7682.5 7836.3 7858.1 7937.4 7981.3 17:41:56 INFO - PID 9699 | 17:41:56 INFO - PID 9699 | [#4] prototype.html Cycles:180 Average:5716.62 Median:6232.77 stddev:1532.09 (24.6%) stddev-sans-first:1485.66 17:41:56 INFO - PID 9699 | Values: 507.4 541.9 566.7 567.7 574.9 6080.1 6156.4 6159.4 6160.2 6328.0 6219.3 6232.2 6284.8 6306.3 6326.9 5144.6 5152.9 5164.6 5184.0 5208.5 5010.1 5162.3 5167.7 5184.4 5194.9 5136.0 5161.3 5172.3 5191.9 5209.9 5180.2 5183.4 5188.5 5192.0 5192.6 4828.3 4857.0 4860.2 4880.2 4892.6 6158.7 6229.7 6233.3 6243.6 6259.6 6112.4 6125.9 6167.0 6211.2 6230.3 6530.5 6575.9 6641.8 6645.2 6648.3 5429.9 5466.9 5501.9 5514.6 5520.9 7002.2 7034.0 7048.3 7055.8 7067.7 5682.3 5682.5 5711.9 5733.9 5738.8 5777.0 5827.3 5836.2 5855.5 5873.9 6053.5 6126.2 6139.8 6192.2 6202.0 6566.2 6609.2 6701.5 6716.1 6732.7 1840.8 1907.0 1937.7 1939.4 1958.7 1453.3 1494.2 1500.3 1529.6 1557.7 6030.3 6044.2 6054.5 6062.2 6148.7 6365.9 6529.7 6582.5 6717.3 6758.3 6174.9 6175.8 6243.2 6250.7 6255.7 3443.3 3469.0 3493.3 3497.3 3528.5 6850.4 6926.9 6934.7 6935.2 7011.5 6779.7 6860.6 6892.7 6917.4 6961.9 6934.0 6965.9 7011.8 7035.6 7067.9 6661.1 6688.4 6761.9 6775.2 6793.5 6682.3 6709.5 6746.4 6748.3 6777.4 7041.8 7045.3 7058.1 7083.3 7104.1 5224.0 5235.5 5239.5 5255.7 5270.0 6463.9 6653.2 6703.7 6736.0 6824.9 6134.9 6374.9 6496.5 6525.9 6542.6 6403.6 6430.6 6486.9 6520.7 6561.5 6285.6 6286.0 6304.8 6360.7 6426.8 6586.7 6603.9 6626.5 6627.0 6673.3 6386.9 6442.7 6462.5 6493.3 6506.5 17:41:56 INFO - PID 9699 | 17:41:56 INFO - PID 9699 | [#5] yui.html Cycles:180 Average:27686.51 Median:18190.09 stddev:40459.08 (222.4%) stddev-sans-first:40522.84 17:41:56 INFO - PID 9699 | Values: 967.5 968.2 987.6 995.9 999.1 18835.5 19007.9 19250.8 19332.0 19353.8 19106.3 19374.1 19494.0 19938.6 19962.6 1035.4 1052.7 1054.0 1054.3 1056.7 1064.0 1066.0 1067.2 1068.9 1070.9 1046.6 1102.6 1107.3 1120.2 1120.4 1099.1 1099.6 1099.7 1099.8 1102.5 780.2 813.8 814.2 817.1 818.7 20422.1 20534.8 20556.5 20563.3 20602.5 22421.1 22791.1 22893.1 22990.8 23000.5 16580.3 16768.5 17525.9 17635.0 17776.9 3856.9 3858.2 3899.8 3918.4 3927.2 130576.0 158441.2 158761.0 160303.2 161401.0 18165.3 18214.9 18442.6 18629.5 18696.6 34238.5 34841.5 35004.6 35163.6 35804.3 10020.7 10049.5 10091.7 10104.3 10157.6 4519.7 4543.3 4603.5 4620.4 4626.6 6063.5 6147.4 6173.4 6173.6 6178.0 1214.8 1227.3 1235.7 1237.4 1241.1 715.9 729.1 733.1 744.6 754.1 13354.9 13529.0 13576.7 13833.7 13904.8 701.7 708.3 709.6 722.3 725.4 6072.6 6100.7 6130.5 6140.9 6174.0 129205.4 133109.3 133364.0 136905.0 137634.0 127717.4 129896.0 130896.0 131473.3 131513.7 107571.0 110809.0 114387.0 115746.4 116776.4 11729.1 11733.6 11780.4 11886.9 11898.5 55898.0 56162.0 57278.1 57389.7 57632.7 70504.0 72352.6 72455.3 73209.6 73859.0 16971.8 17424.8 17444.7 17647.1 17688.9 19712.7 19885.7 19914.3 19919.5 20161.2 18474.8 18558.6 18582.8 18662.3 18763.7 17442.5 17447.1 17684.0 17860.9 17877.0 17492.5 17503.9 17510.4 17593.6 17842.1 12868.9 13282.9 13561.8 13585.8 13590.3 13592.5 13596.8 13601.7 13631.3 13714.9 17:41:56 INFO - PID 9699 | -------- Summary: end -------- 17:41:56 INFO - PID 9699 | 17:41:57 INFO - TEST-INFO | 9699: exit 0 17:41:57 INFO - TEST-OK | dromaeo_css | took 1108391ms 17:41:57 INFO - TEST-START | kraken 17:41:57 INFO - Initialising browser for kraken test... 17:41:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56907/getInfo.html -profile /tmp/tmp0Nr8se/profile 17:41:57 INFO - TEST-INFO | started process 10063 (/builds/slave/test/build/application/firefox/firefox http://localhost:56907/getInfo.html) 17:42:02 INFO - TEST-INFO | 10063: exit 0 17:42:02 INFO - Browser initialized. 17:42:02 INFO - Running cycle 1/1 for kraken test... 17:42:02 INFO - Using env: {'DISPLAY': ':0', 17:42:02 INFO - 'HOME': '/home/cltbld', 17:42:02 INFO - 'JSGC_DISABLE_POISONING': '1', 17:42:02 INFO - 'LANG': 'en_US.UTF-8', 17:42:02 INFO - 'LANGUAGE': 'en_US:en', 17:42:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:42:02 INFO - 'LOGNAME': 'cltbld', 17:42:02 INFO - 'MAIL': '/var/mail/cltbld', 17:42:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:42:02 INFO - 'MOZ_CRASHREPORTER': '1', 17:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:42:02 INFO - 'MOZ_NO_REMOTE': '1', 17:42:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:02 INFO - 'NO_EM_RESTART': '1', 17:42:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:02 INFO - 'PWD': '/builds/slave/test', 17:42:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:02 INFO - 'RUST_BACKTRACE': 'full', 17:42:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:42:02 INFO - 'SHELL': '/bin/bash', 17:42:02 INFO - 'SHLVL': '1', 17:42:02 INFO - 'STYLO_FORCE_DISABLED': '1', 17:42:02 INFO - 'TERM': 'linux', 17:42:02 INFO - 'TMOUT': '86400', 17:42:02 INFO - 'USER': 'cltbld', 17:42:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530', 17:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:02 INFO - '_': '/tools/buildbot/bin/python'} 17:42:02 INFO - TEST-INFO | started process 10301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Nr8se/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:03 INFO - PID 10301 | 17:42:03 INFO - PID 10301 | (/builds/slave/test/build/application/firefox/firefox:10351): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:42:03 INFO - PID 10301 | 17:42:13 INFO - PID 10301 | RSS: Main: 144781312 17:42:13 INFO - PID 10301 | 17:42:16 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56907/tests/kraken/driver.html?testName=audio-beat-detection) 17:42:17 INFO - PID 10301 | RSS: Main: 151834624 17:42:17 INFO - PID 10301 | 17:42:19 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56907/tests/kraken/driver.html?testName=audio-dft) 17:42:20 INFO - PID 10301 | RSS: Main: 152420352 17:42:20 INFO - PID 10301 | 17:42:23 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56907/tests/kraken/driver.html?testName=audio-fft) 17:42:23 INFO - PID 10301 | RSS: Main: 148135936 17:42:23 INFO - PID 10301 | 17:42:25 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56907/tests/kraken/driver.html?testName=audio-oscillator) 17:42:26 INFO - PID 10301 | RSS: Main: 148467712 17:42:26 INFO - PID 10301 | 17:42:28 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56907/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:42:29 INFO - PID 10301 | RSS: Main: 149168128 17:42:29 INFO - PID 10301 | 17:42:32 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56907/tests/kraken/driver.html?testName=imaging-darkroom) 17:42:32 INFO - PID 10301 | RSS: Main: 148815872 17:42:32 INFO - PID 10301 | 17:42:36 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56907/tests/kraken/driver.html?testName=imaging-desaturate) 17:42:37 INFO - PID 10301 | RSS: Main: 149868544 17:42:37 INFO - PID 10301 | 17:42:39 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56907/tests/kraken/driver.html?testName=json-parse-financial) 17:42:40 INFO - PID 10301 | RSS: Main: 151588864 17:42:40 INFO - PID 10301 | 17:42:42 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56907/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:42:42 INFO - PID 10301 | RSS: Main: 151216128 17:42:42 INFO - PID 10301 | 17:42:44 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56907/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:42:44 INFO - PID 10301 | RSS: Main: 151244800 17:42:44 INFO - PID 10301 | 17:42:46 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56907/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:42:47 INFO - PID 10301 | RSS: Main: 148291584 17:42:47 INFO - PID 10301 | 17:42:49 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:42:50 INFO - PID 10301 | RSS: Main: 147980288 17:42:50 INFO - PID 10301 | 17:42:53 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:42:53 INFO - PID 10301 | RSS: Main: 148856832 17:42:53 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | Cycle 1(1): loaded http://localhost:56907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56907/tests/kraken/driver.html?testName=ai-astar) 17:42:55 INFO - PID 10301 | RSS: Main: 150335488 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | __start_tp_report 17:42:55 INFO - PID 10301 | _x_x_mozilla_page_load 17:42:55 INFO - PID 10301 | _x_x_mozilla_page_load_details 17:42:55 INFO - PID 10301 | |i|pagename|runs| 17:42:55 INFO - PID 10301 | |0;ai-astar;110;106;105;106;106;106;106;106;108;107 17:42:55 INFO - PID 10301 | |1;audio-beat-detection;112;112;114;112;114;117;114;116;114;114 17:42:55 INFO - PID 10301 | |2;audio-dft;164;162;166;164;164;176;163;163;166;166 17:42:55 INFO - PID 10301 | |3;audio-fft;75;79;74;77;73;73;73;72;74;75 17:42:55 INFO - PID 10301 | |4;audio-oscillator;78;78;79;79;80;80;78;79;78;78 17:42:55 INFO - PID 10301 | |5;imaging-gaussian-blur;113;113;110;116;117;114;113;113;114;114 17:42:55 INFO - PID 10301 | |6;imaging-darkroom;160;151;150;151;149;154;150;152;149;151 17:42:55 INFO - PID 10301 | |7;imaging-desaturate;94;95;95;95;94;95;99;94;97;95 17:42:55 INFO - PID 10301 | |8;json-parse-financial;43;52;44;44;45;44;50;53;44;44 17:42:55 INFO - PID 10301 | |9;json-stringify-tinderbox;36;36;36;36;35;36;37;36;36;38 17:42:55 INFO - PID 10301 | |10;stanford-crypto-aes;71;75;76;71;72;71;75;76;72;76 17:42:55 INFO - PID 10301 | |11;stanford-crypto-ccm;107;110;106;108;113;107;107;110;113;105 17:42:55 INFO - PID 10301 | |12;stanford-crypto-pbkdf2;157;155;160;157;153;157;155;162;161;158 17:42:55 INFO - PID 10301 | |13;stanford-crypto-sha256-iterative;66;63;62;61;61;60;64;60;61;62 17:42:55 INFO - PID 10301 | __end_tp_report 17:42:55 INFO - PID 10301 | __start_cc_report 17:42:55 INFO - PID 10301 | _x_x_mozilla_cycle_collect,685 17:42:55 INFO - PID 10301 | __end_cc_report 17:42:55 INFO - PID 10301 | __startTimestamp1506472975771__endTimestamp 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | ------- Summary: start ------- 17:42:55 INFO - PID 10301 | Number of tests: 14 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#0] ai-astar Cycles:10 Average:106.60 Median:106.00 stddev:1.43 (1.3%) stddev-sans-first:0.83 17:42:55 INFO - PID 10301 | Values: 110.0 106.0 105.0 106.0 106.0 106.0 106.0 106.0 108.0 107.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#1] audio-beat-detection Cycles:10 Average:113.90 Median:114.00 stddev:1.66 (1.5%) stddev-sans-first:1.62 17:42:55 INFO - PID 10301 | Values: 112.0 112.0 114.0 112.0 114.0 117.0 114.0 116.0 114.0 114.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:3.98 (2.4%) stddev-sans-first:4.19 17:42:55 INFO - PID 10301 | Values: 164.0 162.0 166.0 164.0 164.0 176.0 163.0 163.0 166.0 166.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#3] audio-fft Cycles:10 Average:74.50 Median:74.50 stddev:2.12 (2.8%) stddev-sans-first:2.24 17:42:55 INFO - PID 10301 | Values: 75.0 79.0 74.0 77.0 73.0 73.0 73.0 72.0 74.0 75.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:79.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 17:42:55 INFO - PID 10301 | Values: 78.0 78.0 79.0 79.0 80.0 80.0 78.0 79.0 78.0 78.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.89 (1.7%) stddev-sans-first:1.99 17:42:55 INFO - PID 10301 | Values: 113.0 113.0 110.0 116.0 117.0 114.0 113.0 113.0 114.0 114.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:151.00 stddev:3.27 (2.2%) stddev-sans-first:1.56 17:42:55 INFO - PID 10301 | Values: 160.0 151.0 150.0 151.0 149.0 154.0 150.0 152.0 149.0 151.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.57 (1.6%) stddev-sans-first:1.59 17:42:55 INFO - PID 10301 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 99.0 94.0 97.0 95.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#8] json-parse-financial Cycles:10 Average:46.30 Median:44.50 stddev:3.80 (8.5%) stddev-sans-first:3.84 17:42:55 INFO - PID 10301 | Values: 43.0 52.0 44.0 44.0 45.0 44.0 50.0 53.0 44.0 44.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#9] json-stringify-tinderbox Cycles:10 Average:36.20 Median:36.00 stddev:0.79 (2.2%) stddev-sans-first:0.83 17:42:55 INFO - PID 10301 | Values: 36.0 36.0 36.0 36.0 35.0 36.0 37.0 36.0 36.0 38.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#10] stanford-crypto-aes Cycles:10 Average:73.50 Median:75.00 stddev:2.27 (3.0%) stddev-sans-first:2.22 17:42:55 INFO - PID 10301 | Values: 71.0 75.0 76.0 71.0 72.0 71.0 75.0 76.0 72.0 76.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#11] stanford-crypto-ccm Cycles:10 Average:108.60 Median:109.00 stddev:2.80 (2.6%) stddev-sans-first:2.91 17:42:55 INFO - PID 10301 | Values: 107.0 110.0 106.0 108.0 113.0 107.0 107.0 110.0 113.0 105.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:157.50 stddev:2.84 (1.8%) stddev-sans-first:3.00 17:42:55 INFO - PID 10301 | Values: 157.0 155.0 160.0 157.0 153.0 157.0 155.0 162.0 161.0 158.0 17:42:55 INFO - PID 10301 | 17:42:55 INFO - PID 10301 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:1.89 (3.0%) stddev-sans-first:1.33 17:42:55 INFO - PID 10301 | Values: 66.0 63.0 62.0 61.0 61.0 60.0 64.0 60.0 61.0 62.0 17:42:55 INFO - PID 10301 | -------- Summary: end -------- 17:42:55 INFO - PID 10301 | 17:42:56 INFO - PID 10301 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:42:56 INFO - TEST-INFO | 10301: exit 0 17:42:56 INFO - TEST-OK | kraken | took 59250ms 17:42:56 INFO - SUITE-END | took 1167s 17:42:56 INFO - Completed test suite (00:19:27) 17:42:56 INFO - javascript benchmark 17:42:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9108.070086184132, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3900.648941595257, 3916.8836881488783, 3923.9215215695685, 3945.191235796662, 3957.228340473609, 6324.367563243673, 6373.171487706598, 6441.838954026151, 6441.8711625767455, 6483.157189565356, 6351.9682401587925, 6427.710753016114, 6431.7427302907945, 6510.479161667067, 6516.67416629169, 5714.371419143891, 5788.0, 5807.680577568232, 5808.564357673192, 5826.0, 112.42417285394089, 5674.631148975324, 5720.513756330696, 5810.1865738796605, 5826.737796799133, 5660.405657405975, 5744.253247077874, 5746.597738158331, 5783.045797443417, 5810.477057064863, 5721.056025755745, 5725.82822515321, 5793.594448388614, 5822.039363505017, 5822.301323841124, 5724.627899186581, 5724.8282551523525, 5756.165356023395, 5806.796762113306, 5812.099124635688, 6351.301356850743, 6405.327440618715, 6410.0705397717065, 6495.512836537278, 6529.31442198567, 6852.862942741117, 6921.342472465108, 6933.479989000845, 6939.340762627542, 6939.861202775916, 6992.6154061526595, 6997.82505437363, 7010.754623588201, 7021.473389495757, 7075.363217310415, 6533.444657204096, 6543.476521878286, 6551.344865513458, 6559.93440065598, 6573.1783527059115, 7112.537685050455, 7135.607541585159, 7136.892946605805, 7208.783736487913, 7232.674529646179, 6744.055832183498, 6767.2894346093935, 6849.280825513349, 6872.072270243553, 6938.479614028968, 6945.791626251221, 7007.649617519103, 7009.719611215494, 7015.824604384829, 7020.859582808417, 6883.586984780929, 6912.377885990285, 6958.234594194634, 6973.965130174317, 6976.337247961435, 6766.966165169143, 6882.7591034313555, 6890.552114112566, 6891.896621550681, 6898.862022759517, 4998.400191976913, 5011.899762004739, 5018.397792264952, 5040.949590504121, 5065.366829146356, 4582.289745089516, 4590.311453282035, 4602.033572949651, 4619.86140415788, 4652.302154676826, 6314.747410103636, 6354.872902542016, 6428.5178611604315, 6437.0988061671405, 6443.323451037667, 6839.384455399038, 6862.3137686230975, 6924.61914594692, 6953.860922781516, 6960.9303906961295, 6341.492680585542, 6344.904826427607, 6369.904451433232, 6380.202474690664, 6395.616263024233, 5487.6981766003255, 5493.176023596492, 5565.638233514889, 5567.081431563827, 5578.30271216098, 7059.611721355374, 7080.0795896534155, 7154.964225178841, 7164.820879478055, 7167.0, 6734.797956061326, 6801.9319806801295, 6852.931470685229, 6854.34883686049, 6886.208086069965, 7169.820754481179, 7201.603911784902, 7242.6740796663225, 7265.491415600857, 7300.525465844703, 6756.391924726799, 6828.283030281749, 6908.067410899464, 6909.067275917687, 6913.51605387618, 6906.758263460755, 6916.481263905127, 6995.510314277952, 7006.509544331848, 7015.894761578478, 6596.30738772422, 6599.670016499252, 6718.2609912908565, 6760.1549806274215, 6791.320867913169, 6712.194536655633, 6781.525293229624, 6800.353966373186, 6808.421284190899, 6827.453803695792, 6516.087747715229, 6592.472602191909, 6601.636909969806, 6681.432078273401, 6700.0, 6730.663466826737, 6764.492663050192, 6806.285340039224, 6828.487863410165, 6875.278095799869, 6421.903671444838, 6521.608703477807, 6601.405873471411, 6610.206775187008, 6634.767783127568], "value": 6290.408180259903, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [914.3371055984408, 967.7677357434214, 988.7231575158953, 995.4723996281973, 1012.6101450941385, 44286.0, 45073.0, 45170.548294517, 45242.0, 45250.0, 42003.57996420035, 42068.15863682725, 42216.0, 42315.15369692604, 42378.364324535156, 7464.365528930048, 7584.43116766242, 7596.354309883666, 7609.162992070867, 7614.961925190366, 7455.0681164854395, 7545.396368290551, 7556.735514257002, 7561.962190189069, 7562.09254889414, 8529.445586036887, 8681.392302538825, 8723.694670686527, 8752.431091979033, 8753.606087726068, 8539.530325832076, 8597.011343695462, 8598.398112132154, 8606.56967151643, 8617.181367770052, 8350.373721970816, 8483.745487635319, 8572.785680357978, 8575.485470871768, 8594.355423343211, 41477.0, 41918.1616367674, 41942.58057419448, 42048.26686265383, 42065.579344206475, 3713.702903767692, 3774.169682669808, 3777.074616718894, 3780.8676696315497, 3789.981050094732, 33398.16504587381, 33463.832680836684, 33510.1622459438, 33658.326833463194, 33668.6633133668, 5458.972705136449, 5473.863153421156, 5483.670979741229, 5513.807016754435, 5525.917111243334, 211488.0, 215231.0, 216789.0, 217219.0, 219509.0, 47406.52593474021, 52445.7377713109, 53270.46729532655, 53293.736501079824, 53423.19865202025, 55649.721751390985, 55702.16446753302, 55788.72105639446, 55825.72087139538, 55891.0, 14663.853361466248, 14704.41182352694, 14801.777973330409, 14823.110613363233, 14828.110313381232, 11791.88208117925, 11834.408279585987, 11846.526138954345, 11876.821847672292, 11949.163558550992, 14807.925960370128, 14842.0, 14845.0, 14948.32732527039, 14994.47519336818, 5968.820935371946, 6062.696865156725, 6090.817275481742, 6098.176746139215, 6111.174991376108, 1080.8000519903842, 1095.802755504017, 1102.3496137279044, 1107.9612213572486, 1109.4009235013164, 25642.615360769603, 25720.871395642902, 25812.612810807852, 25932.8703356482, 25951.74048259493, 1185.6917201527492, 1196.132803717298, 1202.5550546297925, 1202.6752776750404, 1223.082687984012, 13588.048836581542, 13613.0, 13839.861601384058, 13842.723145537033, 13986.160830350009, 270704.0, 271419.0, 271912.0, 272102.0, 273980.0, 58144.418555814744, 58628.4137158623, 58656.0, 58658.0, 58708.0, 1498.655309278872, 1504.6689728259764, 1537.0623919409152, 1537.961550961235, 1558.7350150474447, 25618.0, 25620.0, 25687.229383118538, 25984.480310393308, 26044.34889127787, 41793.58206417897, 41847.37228941629, 41992.16015679608, 41995.58004419917, 42132.368014479194, 231648.0, 233194.0, 233926.0, 235266.0, 235420.0, 36953.815230923676, 38871.805640971616, 39688.40467393049, 39903.40144897771, 40090.39864401978, 49666.50333496619, 49843.50156498388, 49885.750571246914, 50043.0, 50555.494445055076, 36497.0, 36685.81657091698, 37163.0, 37190.8140459296, 37446.625533744314, 36353.454698180074, 36521.269574608894, 36543.0, 36970.63029369672, 37174.442383363734, 42037.0, 42869.356959646255, 43254.0, 43337.566624333354, 43399.0, 35421.0, 35437.46843797294, 35444.82277588596, 35502.644973549934, 35826.820865895505, 27121.1863644091, 27244.863775680995, 27304.317392065357, 27475.31311717223, 27561.31096722598], "value": 18709.472472186586, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.8549955260962, 596.9194158788567, 602.8221674605991, 628.7390732845869, 630.2625927664633, 23599.76400235997, 24227.75772242277, 24311.149109781138, 24382.878085609547, 24414.0, 24290.878545607247, 25742.485150296983, 25846.612300815457, 25875.353116172104, 25901.87049064752, 6329.620222786636, 6460.644664543448, 6486.059521369422, 6491.058796474508, 6497.740090396378, 6371.362863713614, 6500.772472963447, 6628.966855165718, 6647.567908085983, 6655.334466553354, 6622.238442579092, 6622.470202383822, 6626.237982631987, 6637.0, 6638.336166383371, 6430.260520040185, 6624.271330153703, 6634.170728658918, 6683.0, 6690.19717633887, 6246.875062498724, 6254.155688981975, 6255.155554000197, 6257.499400047986, 6269.529785266078, 28756.0, 29236.561451578244, 29245.122646320644, 29252.0, 29280.121596352143, 2093.9895300523553, 2109.9894500527553, 2120.5016821047043, 2122.214780531198, 2140.77521860204, 20051.89714565698, 20291.188352465884, 20480.38558843237, 20546.38360849162, 20572.485687857774, 2407.7712617301327, 2418.6155950215993, 2470.5305991861487, 2501.3371456564023, 2514.647949287083, 137668.31165844208, 142814.0, 150907.0, 155347.0, 161131.0, 15736.685266294839, 16413.261403236884, 16608.086555239577, 16704.164791760362, 17309.65380692404, 26066.218013459627, 26103.73896261051, 26113.347166320615, 26139.73860261411, 26153.73846261513, 10247.231457640706, 10463.895361046445, 10534.473276336152, 10543.209259305582, 10672.466376681135, 9435.103665151937, 9436.858447123299, 9442.197413219816, 9497.620095196253, 9598.0, 9423.19902808269, 9596.08078384326, 9617.615295388106, 9720.805583888283, 9942.0, 2924.809887357315, 2935.8678859451375, 2986.6266716660416, 2988.4023195361015, 3046.01004673482, 1004.5881188712593, 1045.6078970386104, 1068.3536460441476, 1069.0752499088233, 1081.3403823667556, 20683.0, 21287.36137915834, 21525.892370538048, 21622.35132946014, 21653.67519487209, 1069.6309773128414, 1125.4372813593204, 1130.197559732599, 1131.9603813866474, 1135.9432028398546, 11616.244944078608, 11839.881601183877, 11865.584704535473, 11906.702332441586, 11940.641780746591, 529959.0, 554604.0, 557575.0, 561106.0, 581251.0, 126130.0, 127978.0, 128560.0, 129711.35144324407, 129737.0, 1116.2186469471403, 1174.0842143128373, 1217.8355921950601, 1223.8286639870425, 1277.584784944878, 22004.66992995074, 22354.21760238384, 22676.65985010259, 22710.260292522787, 22803.728974532136, 61960.380396197266, 65178.674106629165, 66799.0, 67119.99320010106, 67557.3244267551, 79025.0, 79159.60420197863, 79495.0, 79619.0, 80389.59805200937, 15242.618934526725, 15706.371745130067, 15836.208189590245, 15839.762403563725, 15856.365745370056, 24334.63498047495, 24636.0, 24806.131785387424, 24920.750792491843, 24955.251342459756, 19235.03824808726, 19511.0, 19638.312659056865, 19711.408657740292, 19994.300199492947, 17326.91336543309, 17553.297868085134, 17719.911400442914, 18052.458426247234, 18498.445046648623, 19141.80858191456, 20195.697064544336, 20202.898985504977, 20219.191232350542, 20482.487937801674, 15550.144742039296, 15567.76648350253, 15615.609609759847, 15637.687246254784, 15680.137592432526, 16950.40673576419, 17051.147442628066, 17129.05790181552, 18008.639827203122, 19367.225310987404], "value": 12716.068070905985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.6718654709416, 1466.1349803615865, 1468.6328417895527, 1497.618107382618, 1498.7002599480106, 16762.994220346787, 17407.0, 17444.127793610318, 17461.388851390187, 17480.737788933176, 16862.83137168628, 16879.662406751857, 16932.492025239233, 16994.405195818148, 17045.659086818257, 2844.360018995725, 2853.044230182891, 2881.394907069518, 2886.7690584753273, 2890.450814345278, 2775.875085621142, 2852.215640698804, 2853.186841750102, 2853.2153657744184, 2853.843038632874, 2706.2422521693957, 2750.2161883863105, 2752.2981639681852, 2754.4628797384516, 2755.61421401004, 2608.3870290481723, 2683.9194824155406, 2684.691260505028, 2685.11391240892, 2685.825421347606, 2616.973830261692, 2647.2984659065364, 2656.096927044795, 2660.521106200883, 2664.5869890167055, 16386.83613163865, 16500.42248521296, 16507.33970641173, 16529.33882644693, 16561.08914009729, 8245.546494942835, 8496.532690702008, 8521.14788521149, 8532.402731808776, 8544.78638034048, 5478.863028424282, 5669.688167150805, 5828.0, 5853.443922827367, 5975.551833612496, 2108.9156433742633, 2144.1959265275523, 2161.232762369352, 2183.6833659119497, 2194.2320187934256, 27014.864925675443, 27837.721622783716, 29471.263218419495, 30074.84962575195, 30157.2858442739, 7672.65473053714, 7674.347680447113, 7693.769186924401, 7788.8052798679355, 7876.645550950221, 22040.0, 22058.0, 22216.777832221473, 22291.219807306665, 22405.66391504129, 8439.789005274917, 8531.74404767858, 8540.060593334729, 8548.145185481402, 8559.572021398904, 7426.183119856812, 7582.848343033108, 7603.505772124794, 7635.160132385433, 7667.156612772591, 5748.655080695172, 5950.553708471882, 5971.134185543072, 6002.759889604367, 6054.091886217103, 1878.4928069421453, 1901.4010586665156, 1932.2753967262277, 1946.7371904792672, 1969.320584398409, 942.9104235097655, 962.0235461007084, 980.0346658541331, 987.2694206287296, 995.8008398320364, 9351.205147562534, 9442.95278523603, 9636.46999415039, 9655.275854310954, 9719.0, 816.7958010497375, 817.1695402298926, 817.3285630884855, 824.0688022534498, 836.2014276366056, 5279.736013199325, 5343.625946183807, 5355.625106242604, 5380.408155102936, 5436.184572314105, 22837.543249135255, 23928.162514311916, 24902.5019499609, 25010.0, 25244.74755252424, 24059.879700601385, 24167.0, 24199.395015124763, 24409.0, 24507.142250021163, 10947.233693641369, 11250.831237531444, 11569.595064172881, 12053.819192712117, 12243.0, 9350.111739384747, 9483.573239204114, 9574.281928855504, 9593.712188634352, 9674.467904265333, 21036.26373076935, 21171.15315387367, 21627.783722163207, 21790.673139903232, 22628.66057009113, 22269.886505674975, 22511.212107576157, 22517.77482225157, 22667.433314167276, 22981.08075677021, 12887.93556032214, 13198.0, 13241.602751917459, 13279.468821247428, 13280.070395072253, 15150.31823567964, 15380.69238615199, 15415.306311216247, 15459.458918937784, 15489.457868974532, 12116.697082572653, 12246.081543884422, 12276.877231227574, 12426.5650702225, 12691.555795547112, 11488.368139752394, 11750.58872939443, 11778.17552771332, 12009.219400738924, 12271.263724176579, 10758.784824303626, 11011.174161937726, 11077.723056923642, 11169.497372618089, 11224.7755044897, 7757.185495522889, 7968.920310796818, 8032.919670803451, 8052.637631306488, 8087.47431416956, 7682.462227644235, 7836.333911617577, 7858.135605083322, 7937.40469464804, 7981.321587665114], "value": 7296.80907751555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.403800534372, 541.8726599249176, 566.6571724106915, 567.7246535430316, 574.9453801888819, 6080.148779170914, 6156.384361563847, 6159.353267906872, 6160.199174107371, 6328.0, 6219.253689557259, 6232.220972378453, 6284.811455656326, 6306.265776911352, 6326.873462530758, 5144.562712169461, 5152.896942061176, 5164.6384753067305, 5184.0, 5208.453112423198, 5010.073136469765, 5162.303089082982, 5167.715775632339, 5184.351956005499, 5194.8701282468055, 5136.0, 5161.27742116104, 5172.327597412331, 5191.948080519203, 5209.921851172236, 5180.2488639147305, 5183.352080989876, 5188.455212202702, 5191.974040129813, 5192.61055420845, 4828.324034635154, 4857.0, 4860.222364421676, 4880.243562247857, 4892.63305252104, 6158.67588468477, 6229.719662615148, 6233.3143354231, 6243.625382477066, 6259.624422534617, 6112.419320164578, 6125.908111378333, 6166.969165154191, 6211.223597050369, 6230.283517395512, 6530.477561795093, 6575.901361479581, 6641.767538136142, 6645.169353830771, 6648.301928297507, 5429.864253393657, 5466.863328416782, 5501.889962200774, 5514.6139770216105, 5520.944790552083, 7002.19474760404, 7033.964830175919, 7048.308405982527, 7055.823604409879, 7067.681954312068, 5682.261306030272, 5682.516986056149, 5711.942880571141, 5733.942660573341, 5738.77044918207, 5777.0, 5827.329857066492, 5836.249125262404, 5855.502282305966, 5873.882522349529, 6053.545984051214, 6126.23422072241, 6139.833431647972, 6192.225971753531, 6201.96899015502, 6566.179227596551, 6609.173853268341, 6701.497387695942, 6716.126903502513, 6732.730690772412, 1840.7883093444425, 1906.9523261918287, 1937.6609093408597, 1939.36001119633, 1958.7159861819957, 1453.3096779029877, 1494.1782019889017, 1500.3398504657916, 1529.5640742388366, 1557.7351850185269, 6030.276366836008, 6044.1840351552855, 6054.546908741959, 6062.211912451441, 6148.661823599745, 6365.936340636535, 6529.738810447624, 6582.473402127818, 6717.328267173341, 6758.256591774901, 6174.876502470015, 6175.752969881244, 6243.219597550306, 6250.718717657716, 6255.74977000924, 3443.328550932594, 3469.0, 3493.283876805249, 3497.300539891981, 3528.5060091587197, 6850.417714494224, 6926.896096558556, 6934.653267336613, 6935.202451718016, 7011.544249623758, 6779.661016949133, 6860.622665753332, 6892.724845903524, 6917.377436030782, 6961.860762784716, 6934.0, 6965.930340696629, 7011.789646310619, 7035.577865328097, 7067.929320706727, 6661.101586047953, 6688.398044176048, 6761.898571521333, 6775.186977562724, 6793.456523478011, 6682.2649508555, 6709.496787740842, 6746.4265537429865, 6748.2576916538155, 6777.356151165632, 7041.838096713985, 7045.330693584101, 7058.11773528309, 7083.327083927019, 7104.081897887645, 5224.0, 5235.476452354734, 5239.502247286502, 5255.684658920477, 5269.973650131725, 6463.903041454288, 6653.168353955755, 6703.66481675924, 6735.966320168368, 6824.93175068243, 6134.895718770664, 6374.872502550016, 6496.480281577557, 6525.934740652533, 6542.640154791342, 6403.551751377358, 6430.646314452563, 6486.870262594627, 6520.706568204537, 6561.507886908596, 6285.560010799383, 6286.0, 6304.779332723333, 6360.727854429225, 6426.775062872777, 6586.670666466754, 6603.867922641616, 6626.53614246998, 6627.0, 6673.265940746417, 6386.882295598345, 6442.677866106769, 6462.5153113515735, 6493.318201588765, 6506.544541882023], "value": 5282.41767005212, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [967.4872317671633, 968.1528662420383, 987.5852142100322, 995.945223012734, 999.0808456220277, 18835.529111772197, 19007.904960475196, 19250.807491925094, 19332.0, 19353.806461935375, 19106.331278405258, 19374.128164232607, 19494.0, 19938.60122797547, 19962.600747985067, 1035.3632516002642, 1052.6999805055561, 1053.9683809485728, 1054.3094273250995, 1056.6988408303635, 1064.0211005874576, 1066.0245875024343, 1067.2422579968193, 1068.8931106889327, 1070.8607880975462, 1046.638909576195, 1102.5865300512307, 1107.3189988157264, 1120.2046546951674, 1120.3669926491507, 1099.1426687183969, 1099.5656715597333, 1099.719571509268, 1099.8350247462865, 1102.536934487517, 780.1652232111643, 813.8046868751456, 814.1614137438448, 817.0603805623521, 818.7339114787658, 20422.08100635475, 20534.794652053588, 20556.486087847923, 20563.280285189947, 20602.484937876525, 22421.103155873745, 22791.08835646572, 22893.084276628913, 22990.770092299197, 23000.539989200122, 16580.253888575044, 16768.496945091545, 17525.912370438193, 17635.0, 17776.91111544447, 3856.9421458678144, 3858.247641709868, 3899.824507897123, 3918.4318273850417, 3927.175293188434, 130576.0, 158441.2077939603, 158761.0, 160303.19848400683, 161401.0, 18165.273389064554, 18214.90892545529, 18442.63114737698, 18629.534261643297, 18696.626067478574, 34238.48642270368, 34841.47737783935, 35004.64995350065, 35163.64836351655, 35804.28391432157, 10020.69937901864, 10049.497525123714, 10091.697249082392, 10104.29269951111, 10157.644482443227, 4519.728816271035, 4543.273076307775, 4603.49361570227, 4620.422447194101, 4626.583607475343, 6063.5452341073715, 6147.415995480422, 6173.382661733791, 6173.567850250529, 6177.96911015451, 1214.7509760499076, 1227.3495047624774, 1235.6540168752763, 1237.418413345726, 1241.0815996162955, 715.8711431942196, 729.0522320982807, 733.0799846192994, 744.6351287868905, 754.1402800807084, 13354.93322533381, 13529.003212863532, 13576.660583485493, 13833.723325533432, 13904.791428128587, 701.6526819224516, 708.2952462300044, 709.6238993333542, 722.3174100475001, 725.4341613541341, 6072.635641861502, 6100.69496525172, 6130.5402094842175, 6140.907886381708, 6174.043023331391, 129205.35397322953, 133109.33445332712, 133364.0, 136905.0, 137634.0, 127717.36141319234, 129896.0, 130896.0, 131473.34263328812, 131513.6971607893, 107571.0, 110809.0, 114387.0, 115746.37014519493, 116776.41611791887, 11729.120315976506, 11733.647990560297, 11780.352080635646, 11886.881131188577, 11898.524059037887, 55898.0, 56162.0, 57278.14082788678, 57389.713051434475, 57632.71183644055, 70504.0, 72352.63823680847, 72455.27544724486, 73209.6339518299, 73859.0, 16971.83028169752, 17424.82575174232, 17444.73832892482, 17647.117644117487, 17688.91155544214, 19712.704309435085, 19885.701714474006, 19914.302999394953, 19919.454770756027, 20161.193552257744, 18474.815251847846, 18558.628827423647, 18582.81417185811, 18662.253509859453, 18763.71854422212, 17442.47672569825, 17447.127643618023, 17684.0, 17860.91069544644, 17877.0, 17492.47522574325, 17503.912480437517, 17510.387136450165, 17593.648127037643, 17842.107894604957, 12868.935655321664, 13282.867171328164, 13561.796573051215, 13585.796213056614, 13590.32048397596, 13592.524261650795, 13596.79604805909, 13601.727965440834, 13631.318434078456, 13714.93142534321], "value": 9896.31076696065, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1383.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 105.0, 106.0, 106.0, 106.0, 106.0, 106.0, 108.0, 107.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 114.0, 112.0, 114.0, 117.0, 114.0, 116.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 166.0, 164.0, 164.0, 176.0, 163.0, 163.0, 166.0, 166.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 74.0, 77.0, 73.0, 73.0, 73.0, 72.0, 74.0, 75.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 79.0, 80.0, 80.0, 78.0, 79.0, 78.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 110.0, 116.0, 117.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 151.0, 150.0, 151.0, 149.0, 154.0, 150.0, 152.0, 149.0, 151.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 99.0, 94.0, 97.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 52.0, 44.0, 44.0, 45.0, 44.0, 50.0, 53.0, 44.0, 44.0], "value": 46.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 36.0, 36.0, 35.0, 36.0, 37.0, 36.0, 36.0, 38.0], "value": 36.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 76.0, 71.0, 72.0, 71.0, 75.0, 76.0, 72.0, 76.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 106.0, 108.0, 113.0, 107.0, 107.0, 110.0, 113.0, 105.0], "value": 108.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 160.0, 157.0, 153.0, 157.0, 155.0, 162.0, 161.0, 158.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 62.0, 61.0, 61.0, 60.0, 64.0, 60.0, 61.0, 62.0], "value": 62.0, "unit": "score"}]}]} 17:42:56 INFO - Return code: 0 17:42:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:42:56 INFO - # TBPL SUCCESS # 17:42:56 INFO - Running post-action listener: _package_coverage_data 17:42:56 INFO - Running post-action listener: _resource_record_post_action 17:42:56 INFO - [mozharness: 2017-09-27 00:42:56.562650Z] Finished run-tests step (success) 17:42:56 INFO - Running post-run listener: _resource_record_post_run 17:42:56 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 12288; Write bytes: 329453568; Read time: 284; Write time: 268512 17:42:56 INFO - TinderboxPrint: CPU usage
13.1% 17:42:56 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 284 17:42:56 INFO - TinderboxPrint: I/O write bytes / time
329,453,568 / 268,512 17:42:56 INFO - TinderboxPrint: CPU idle
8,217.6 (86.9%) 17:42:56 INFO - TinderboxPrint: CPU user
1,187.9 (12.6%) 17:42:56 INFO - TinderboxPrint: Swap in / out
0 / 0 17:42:56 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 13717504; Read time: 0; Write time: 1844 17:42:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:42:56 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 12288; Write bytes: 315736064; Read time: 284; Write time: 266668 17:42:57 INFO - Running post-run listener: _upload_blobber_files 17:42:57 INFO - Blob upload gear active. 17:42:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:42:57 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 17:42:57 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'] 17:42:57 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 17:42:57 INFO - (blobuploader) - INFO - Open directory for files ... 17:42:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:42:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:42:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:58 INFO - (blobuploader) - INFO - Done attempting. 17:42:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:42:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:42:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:59 INFO - (blobuploader) - INFO - Done attempting. 17:42:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:42:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:43:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:07 INFO - (blobuploader) - INFO - Done attempting. 17:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:43:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:08 INFO - (blobuploader) - INFO - Done attempting. 17:43:08 INFO - (blobuploader) - INFO - Iteration through files over. 17:43:08 INFO - Return code: 0 17:43:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:43:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:43:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/087432c93a52003784efa65147c37977045e33030591d814ad52d2feaf29e44a4a2cb121a727bc25db31e4b280bae82cb6338bcae06cb37a6f9e67c15a1bd203", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/321a74862839c10599cc9138c910b16d1c906376073dd93c2f0e85bda476afae60bb3586eef6c2f3e98fa9cf9020603ec69e02eaef4407951d957498fbeee74d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c79329f0434c11ba63ba477d8a005f70ea418a6b12eed1570e59686d14ed8071754a1c76f96fdd44e88ff9820f634dd6634855061d1bbdd6f3acbc959be6211", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc14c93fdcd27582a1904166ff1339b644d283f9d6f604b7d6addd3d5cff57c7afad4563b291b75997d8801127b6ca12001042928bd6e4c2bee3b0ddfa52ea7"} 17:43:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:43:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:43:08 INFO - Contents: 17:43:08 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/087432c93a52003784efa65147c37977045e33030591d814ad52d2feaf29e44a4a2cb121a727bc25db31e4b280bae82cb6338bcae06cb37a6f9e67c15a1bd203", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/321a74862839c10599cc9138c910b16d1c906376073dd93c2f0e85bda476afae60bb3586eef6c2f3e98fa9cf9020603ec69e02eaef4407951d957498fbeee74d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c79329f0434c11ba63ba477d8a005f70ea418a6b12eed1570e59686d14ed8071754a1c76f96fdd44e88ff9820f634dd6634855061d1bbdd6f3acbc959be6211", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc14c93fdcd27582a1904166ff1339b644d283f9d6f604b7d6addd3d5cff57c7afad4563b291b75997d8801127b6ca12001042928bd6e4c2bee3b0ddfa52ea7"} 17:43:08 INFO - Running post-run listener: copy_logs_to_upload_dir 17:43:08 INFO - Copying logs to upload dir... 17:43:08 INFO - mkdir: /builds/slave/test/build/upload/logs 17:43:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.774200 ========= master_lag: -0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-26 17:43:07.966143) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 17:43:07.975537) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530 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/087432c93a52003784efa65147c37977045e33030591d814ad52d2feaf29e44a4a2cb121a727bc25db31e4b280bae82cb6338bcae06cb37a6f9e67c15a1bd203", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/321a74862839c10599cc9138c910b16d1c906376073dd93c2f0e85bda476afae60bb3586eef6c2f3e98fa9cf9020603ec69e02eaef4407951d957498fbeee74d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c79329f0434c11ba63ba477d8a005f70ea418a6b12eed1570e59686d14ed8071754a1c76f96fdd44e88ff9820f634dd6634855061d1bbdd6f3acbc959be6211", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc14c93fdcd27582a1904166ff1339b644d283f9d6f604b7d6addd3d5cff57c7afad4563b291b75997d8801127b6ca12001042928bd6e4c2bee3b0ddfa52ea7"} build_url:https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/A6SBlonfSxyxXhl1ngSEGA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/087432c93a52003784efa65147c37977045e33030591d814ad52d2feaf29e44a4a2cb121a727bc25db31e4b280bae82cb6338bcae06cb37a6f9e67c15a1bd203", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/321a74862839c10599cc9138c910b16d1c906376073dd93c2f0e85bda476afae60bb3586eef6c2f3e98fa9cf9020603ec69e02eaef4407951d957498fbeee74d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c79329f0434c11ba63ba477d8a005f70ea418a6b12eed1570e59686d14ed8071754a1c76f96fdd44e88ff9820f634dd6634855061d1bbdd6f3acbc959be6211", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc14c93fdcd27582a1904166ff1339b644d283f9d6f604b7d6addd3d5cff57c7afad4563b291b75997d8801127b6ca12001042928bd6e4c2bee3b0ddfa52ea7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 17:43:08.003370) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:43:08.003686) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506470602.846405-1184451530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:43:08.055901) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 17:43:08.056231) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 17:43:08.056593) ========= ========= Total master_lag: 0.02 =========