builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1506450686.94 results: success (0) revision: b30ae5a455367f336ded1052081e4c54a139fa81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:26.940453) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:26.941048) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:26.941368) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:26.959366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:26.959728) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 11:31:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 219M=0s 2017-09-26 11:31:27 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134909 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:27.111952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:27.112314) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016818 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:27.162977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-09-26 11:31:27.163362) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b30ae5a455367f336ded1052081e4c54a139fa81 --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 b30ae5a455367f336ded1052081e4c54a139fa81 --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=88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 11:31:27,217 truncating revision to first 12 chars 2017-09-26 11:31:27,217 Setting DEBUG logging. 2017-09-26 11:31:27,217 attempt 1/10 2017-09-26 11:31:27,217 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b30ae5a45536?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 11:31:28,184 unpacking tar archive at: mozilla-central-b30ae5a45536/testing/mozharness/ program finished with exit code 0 elapsedTime=1.850262 ========= master_lag: 0.56 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-09-26 11:31:29.575420) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:29.575744) ========= script_repo_revision: b30ae5a455367f336ded1052081e4c54a139fa81 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:29.576119) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:29.576377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:29.595611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-26 11:31:29.595937) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:31:29 INFO - MultiFileLogger online at 20170926 11:31:29 in /builds/slave/test 11:31:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:31:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:31:29 INFO - {'append_to_log': False, 11:31:29 INFO - 'base_work_dir': '/builds/slave/test', 11:31:29 INFO - 'blob_upload_branch': 'Firefox', 11:31:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:31:29 INFO - 'branch': 'Firefox', 11:31:29 INFO - 'buildbot_json_path': 'buildprops.json', 11:31:29 INFO - 'code_coverage': False, 11:31:29 INFO - 'config_files': ('talos/linux_config.py',), 11:31:29 INFO - 'default_actions': ('clobber', 11:31:29 INFO - 'read-buildbot-config', 11:31:29 INFO - 'download-and-extract', 11:31:29 INFO - 'populate-webroot', 11:31:29 INFO - 'create-virtualenv', 11:31:29 INFO - 'install', 11:31:29 INFO - 'setup-mitmproxy', 11:31:29 INFO - 'run-tests'), 11:31:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:31:29 INFO - 'disable_ccov_upload': False, 11:31:29 INFO - 'disable_stylo': False, 11:31:29 INFO - 'download_minidump_stackwalk': True, 11:31:29 INFO - 'download_symbols': 'ondemand', 11:31:29 INFO - 'enable_stylo': False, 11:31:29 INFO - 'enable_webrender': False, 11:31:29 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:31:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:31:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:31:29 INFO - 'gecko_profile': False, 11:31:29 INFO - 'gecko_profile_interval': 0, 11:31:29 INFO - 'installer_path': 'installer.exe', 11:31:29 INFO - 'log_level': 'info', 11:31:29 INFO - 'log_name': 'talos', 11:31:29 INFO - 'log_to_console': True, 11:31:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:31:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:31:29 INFO - 'opt_config_files': (), 11:31:29 INFO - 'pip_index': False, 11:31:29 INFO - 'suite': 'dromaeojs-e10s', 11:31:29 INFO - 'system_bits': '32', 11:31:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:31:29 INFO - 'title': 'talos-linux64-ix-044', 11:31:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:31:29 INFO - 'use_talos_json': True, 11:31:29 INFO - 'verify': 'False', 11:31:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:31:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:31:29 INFO - 'work_dir': 'build'} 11:31:29 INFO - [mozharness: 2017-09-26 18:31:29.785211Z] Running clobber step. 11:31:29 INFO - Running pre-action listener: _resource_record_pre_action 11:31:29 INFO - Running main action method: clobber 11:31:29 INFO - rmtree: /builds/slave/test/build 11:31:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:31:31 INFO - Running post-action listener: _resource_record_post_action 11:31:31 INFO - [mozharness: 2017-09-26 18:31:31.297771Z] Finished clobber step (success) 11:31:31 INFO - [mozharness: 2017-09-26 18:31:31.297868Z] Running read-buildbot-config step. 11:31:31 INFO - Running pre-action listener: _resource_record_pre_action 11:31:31 INFO - Running main action method: read_buildbot_config 11:31:31 INFO - Using buildbot properties: 11:31:31 INFO - { 11:31:31 INFO - "project": "", 11:31:31 INFO - "product": "firefox", 11:31:31 INFO - "who": "ffxbld@noreply.mozilla.org", 11:31:31 INFO - "installer_path": "public/build/target.tar.bz2", 11:31:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:31:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:31:31 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:31:31 INFO - "stage_platform": "linux64-qr", 11:31:31 INFO - "basedir": "/builds/slave/test", 11:31:31 INFO - "buildnumber": 84, 11:31:31 INFO - "platform": "ubuntu64_hw_qr", 11:31:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:31:31 INFO - "slavebuilddir": "test", 11:31:31 INFO - "taskId": "HBAGo6cjS-OWl9baI37tlA", 11:31:31 INFO - "branch": "mozilla-central", 11:31:31 INFO - "script_repo_revision": "production", 11:31:31 INFO - "revision": "b30ae5a455367f336ded1052081e4c54a139fa81", 11:31:31 INFO - "slavename": "talos-linux64-ix-044", 11:31:31 INFO - "repo_path": "mozilla-central" 11:31:31 INFO - } 11:31:31 INFO - Finding installer, test and symbols from parent task. 11:31:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBAGo6cjS-OWl9baI37tlA'}, attempt #1 11:31:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBAGo6cjS-OWl9baI37tlA'}, attempt #1 11:31:32 INFO - Task dependencies: OiaXjfiURii_c_az-GohGA 11:31:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA'}, attempt #1 11:31:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 11:31:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.test_packages.json 11:31:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.crashreporter-symbols.zip 11:31:32 INFO - Running post-action listener: _resource_record_post_action 11:31:32 INFO - [mozharness: 2017-09-26 18:31:32.627728Z] Finished read-buildbot-config step (success) 11:31:32 INFO - [mozharness: 2017-09-26 18:31:32.627946Z] Running download-and-extract step. 11:31:32 INFO - Running pre-action listener: _resource_record_pre_action 11:31:32 INFO - Running main action method: download_and_extract 11:31:32 INFO - mkdir: /builds/slave/test/build/tests 11:31:32 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')]} 11:31:32 INFO - trying https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.test_packages.json 11:31:32 INFO - Downloading https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:31:33 INFO - Downloaded 989 bytes. 11:31:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:31:33 INFO - Using the following test package requirements: 11:31:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:31:33 INFO - u'common': [u'target.common.tests.zip'], 11:31:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:31:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:31:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:31:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:31:33 INFO - u'mozbase': [u'target.common.tests.zip'], 11:31:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:31:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:31:33 INFO - u'web-platform': [u'target.common.tests.zip', 11:31:33 INFO - u'target.web-platform.tests.tar.gz'], 11:31:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:31:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:31:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.common.tests.zip 11:31:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:31:33 INFO - Fetch https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.common.tests.zip into memory 11:31:34 INFO - Content-Length response header: 54943939 11:31:34 INFO - Bytes received: 54943939 11:31:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.talos.tests.zip 11:31:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:31:45 INFO - Fetch https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.talos.tests.zip into memory 11:31:46 INFO - Content-Length response header: 14513823 11:31:46 INFO - Bytes received: 14513823 11:31:46 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')]} 11:31:46 INFO - trying https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 11:31:46 INFO - Downloading https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:31:47 INFO - Downloaded 61654855 bytes. 11:31:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 11:31:47 INFO - mkdir: /builds/slave/test/properties 11:31:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:31:47 INFO - Writing to file /builds/slave/test/properties/build_url 11:31:47 INFO - Contents: 11:31:47 INFO - build_url:https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 11:31:47 INFO - Running post-action listener: _resource_record_post_action 11:31:47 INFO - Running post-action listener: find_tests_for_verification 11:31:47 INFO - Running post-action listener: set_extra_try_arguments 11:31:47 INFO - [mozharness: 2017-09-26 18:31:47.794572Z] Finished download-and-extract step (success) 11:31:47 INFO - [mozharness: 2017-09-26 18:31:47.794674Z] Running populate-webroot step. 11:31:47 INFO - Running pre-action listener: _resource_record_pre_action 11:31:47 INFO - Running main action method: populate_webroot 11:31:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:31:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:47 INFO - 'tests': ['tresize', 11:31:47 INFO - 'tcanvasmark']}, 11:31:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:31:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:47 INFO - 'tests': ['dromaeo_css', 11:31:47 INFO - 'kraken']}, 11:31:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:31:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:47 INFO - 'talos_options': ['--disable-stylo'], 11:31:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:31:47 INFO - 'tests': ['damp', 'tps']}, 11:31:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:47 INFO - 'talos_options': ['--disable-stylo'], 11:31:47 INFO - 'tests': ['damp', 'tps']}, 11:31:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:31:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:47 INFO - 'tests': ['dromaeo_dom']}, 11:31:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:31:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:47 INFO - 'tests': ['basic_compositor_video', 11:31:47 INFO - 'glvideo']}, 11:31:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:31:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:31:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:47 INFO - 'talos_options': ['--disable-stylo'], 11:31:47 INFO - 'tests': ['ts_paint_webext', 11:31:47 INFO - 'tp5o_webext']}, 11:31:47 INFO - 'other-e10s': {'tests': ['a11yr', 11:31:47 INFO - 'ts_paint', 11:31:47 INFO - 'tpaint', 11:31:47 INFO - 'sessionrestore', 11:31:47 INFO - 'sessionrestore_many_windows', 11:31:47 INFO - 'sessionrestore_no_auto_restore', 11:31:47 INFO - 'tabpaint']}, 11:31:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:47 INFO - 'tests': ['a11yr', 11:31:47 INFO - 'ts_paint', 11:31:47 INFO - 'tpaint', 11:31:47 INFO - 'sessionrestore', 11:31:47 INFO - 'sessionrestore_many_windows', 11:31:47 INFO - 'sessionrestore_no_auto_restore', 11:31:47 INFO - 'tabpaint']}, 11:31:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:31:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:31:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:47 INFO - 'tests': ['perf_reftest_singletons']}, 11:31:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:47 INFO - 'tests': ['perf_reftest']}, 11:31:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:31:47 INFO - 'tsvgr_opacity', 11:31:47 INFO - 'tart', 11:31:47 INFO - 'tscrollx', 11:31:47 INFO - 'tsvg_static']}, 11:31:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:47 INFO - 'tests': ['tsvgx', 11:31:47 INFO - 'tsvgr_opacity', 11:31:47 INFO - 'tart', 11:31:47 INFO - 'tscrollx', 11:31:47 INFO - 'tsvg_static']}, 11:31:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:31:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:47 INFO - 'talos_options': ['--disable-stylo'], 11:31:47 INFO - 'tests': ['tp5o']}, 11:31:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:31:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:31:47 INFO - 'talos_options': ['--mitmproxy', 11:31:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:31:47 INFO - '--firstNonBlankPaint'], 11:31:47 INFO - 'tests': ['tp6_google', 11:31:47 INFO - 'tp6_youtube', 11:31:47 INFO - 'tp6_amazon', 11:31:47 INFO - 'tp6_facebook']}, 11:31:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:31:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:31:47 INFO - 'talos_options': ['--disable-stylo', 11:31:47 INFO - '--mitmproxy', 11:31:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:31:47 INFO - '--firstNonBlankPaint'], 11:31:47 INFO - 'tests': ['tp6_google', 11:31:47 INFO - 'tp6_youtube', 11:31:47 INFO - 'tp6_amazon', 11:31:47 INFO - 'tp6_facebook']}, 11:31:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:31:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:31:47 INFO - 'talos_options': ['--stylo-threads=1', 11:31:47 INFO - '--mitmproxy', 11:31:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:31:47 INFO - '--firstNonBlankPaint'], 11:31:47 INFO - 'tests': ['tp6_google', 11:31:47 INFO - 'tp6_youtube', 11:31:47 INFO - 'tp6_amazon', 11:31:47 INFO - 'tp6_facebook']}, 11:31:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:31:47 INFO - 'talos_options': ['--xperf_path', 11:31:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:47 INFO - 'tests': ['tp5n']}, 11:31:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:47 INFO - 'talos_options': ['--disable-stylo', 11:31:47 INFO - '--xperf_path', 11:31:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:47 INFO - 'tests': ['tp5n']}}} 11:31:47 INFO - Running post-action listener: _resource_record_post_action 11:31:47 INFO - [mozharness: 2017-09-26 18:31:47.818686Z] Finished populate-webroot step (success) 11:31:47 INFO - [mozharness: 2017-09-26 18:31:47.818775Z] Running create-virtualenv step. 11:31:47 INFO - Running pre-action listener: _resource_record_pre_action 11:31:47 INFO - Running main action method: create_virtualenv 11:31:47 INFO - Creating virtualenv /builds/slave/test/build/venv 11:31:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:31:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:31:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:31:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:31:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:31:48 INFO - Installing distribute.............................................................................................................................................................................................done. 11:31:48 INFO - Installing pip...............done. 11:31:48 INFO - Return code: 0 11:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:31:48 INFO - Reading from file tmpfile_stdout 11:31:48 INFO - Output received: 11:31: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) 11:31:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:31: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')]} 11:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31: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')]} 11:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31: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 0x212d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2498df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249c440>, '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 0x249d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2497320>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', '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 11:31: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 11:31: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 11:31:48 INFO - Using env: {'DISPLAY': ':0', 11:31:48 INFO - 'HOME': '/home/cltbld', 11:31:48 INFO - 'LANG': 'en_US.UTF-8', 11:31:48 INFO - 'LANGUAGE': 'en_US:en', 11:31:48 INFO - 'LOGNAME': 'cltbld', 11:31:48 INFO - 'MAIL': '/var/mail/cltbld', 11:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:48 INFO - 'MOZ_NO_REMOTE': '1', 11:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:48 INFO - 'NO_EM_RESTART': '1', 11:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:48 INFO - 'PWD': '/builds/slave/test', 11:31:48 INFO - 'SHELL': '/bin/bash', 11:31:48 INFO - 'SHLVL': '1', 11:31:48 INFO - 'TERM': 'linux', 11:31:48 INFO - 'TMOUT': '86400', 11:31:48 INFO - 'USER': 'cltbld', 11:31:48 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:48 INFO - '_': '/tools/buildbot/bin/python'} 11:31:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:31:50 INFO - Downloading/unpacking pip>=1.5 11:31:50 INFO - Running setup.py egg_info for package pip 11:31:50 INFO - warning: no files found matching 'pip/cacert.pem' 11:31:50 INFO - warning: no files found matching '*.html' under directory 'docs' 11:31:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:31:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:31:50 INFO - Installing collected packages: pip 11:31:50 INFO - Found existing installation: pip 1.1 11:31:50 INFO - Uninstalling pip: 11:31:50 INFO - Successfully uninstalled pip 11:31:50 INFO - Running setup.py install for pip 11:31:50 INFO - warning: no files found matching 'pip/cacert.pem' 11:31:50 INFO - warning: no files found matching '*.html' under directory 'docs' 11:31:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:31:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:31:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Successfully installed pip 11:31:50 INFO - Cleaning up... 11:31:50 INFO - Return code: 0 11:31:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:31: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')]} 11:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31: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')]} 11:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31: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 0x212d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2498df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249c440>, '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 0x249d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2497320>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', '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 11:31: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 11:31: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 11:31:50 INFO - Using env: {'DISPLAY': ':0', 11:31:50 INFO - 'HOME': '/home/cltbld', 11:31:50 INFO - 'LANG': 'en_US.UTF-8', 11:31:50 INFO - 'LANGUAGE': 'en_US:en', 11:31:50 INFO - 'LOGNAME': 'cltbld', 11:31:50 INFO - 'MAIL': '/var/mail/cltbld', 11:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:50 INFO - 'MOZ_NO_REMOTE': '1', 11:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:50 INFO - 'NO_EM_RESTART': '1', 11:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:50 INFO - 'PWD': '/builds/slave/test', 11:31:50 INFO - 'SHELL': '/bin/bash', 11:31:50 INFO - 'SHLVL': '1', 11:31:50 INFO - 'TERM': 'linux', 11:31:50 INFO - 'TMOUT': '86400', 11:31:50 INFO - 'USER': 'cltbld', 11:31:50 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:50 INFO - '_': '/tools/buildbot/bin/python'} 11:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:50 INFO - Downloading/unpacking psutil>=3.1.1 11:31: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 11:31: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 11:31: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 11:31: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 11:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:31:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:51 INFO - Installing collected packages: psutil 11:31:51 INFO - Running setup.py install for psutil 11:31:51 INFO - building 'psutil._psutil_linux' extension 11:31: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 11:31: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 11:31:51 INFO - building 'psutil._psutil_posix' extension 11:31: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 11:31: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 11:31:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:52 INFO - Successfully installed psutil 11:31:52 INFO - Cleaning up... 11:31:52 INFO - Return code: 0 11:31:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:31: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')]} 11:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31: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')]} 11:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31: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 0x212d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2498df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249c440>, '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 0x249d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2497320>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', '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 11:31: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 11:31: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 11:31:52 INFO - Using env: {'DISPLAY': ':0', 11:31:52 INFO - 'HOME': '/home/cltbld', 11:31:52 INFO - 'LANG': 'en_US.UTF-8', 11:31:52 INFO - 'LANGUAGE': 'en_US:en', 11:31:52 INFO - 'LOGNAME': 'cltbld', 11:31:52 INFO - 'MAIL': '/var/mail/cltbld', 11:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:52 INFO - 'MOZ_NO_REMOTE': '1', 11:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:52 INFO - 'NO_EM_RESTART': '1', 11:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:52 INFO - 'PWD': '/builds/slave/test', 11:31:52 INFO - 'SHELL': '/bin/bash', 11:31:52 INFO - 'SHLVL': '1', 11:31:52 INFO - 'TERM': 'linux', 11:31:52 INFO - 'TMOUT': '86400', 11:31:52 INFO - 'USER': 'cltbld', 11:31:52 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:52 INFO - '_': '/tools/buildbot/bin/python'} 11:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:31: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 11:31: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 11:31: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 11:31: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 11:31:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:31:53 INFO - Installing collected packages: mozsystemmonitor 11:31:53 INFO - Running setup.py install for mozsystemmonitor 11:31:53 INFO - Successfully installed mozsystemmonitor 11:31:53 INFO - Cleaning up... 11:31:54 INFO - Return code: 0 11:31:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:31: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')]} 11:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31: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')]} 11:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31: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 0x212d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2498df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249c440>, '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 0x249d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2497320>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', '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 11:31: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 11:31: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 11:31:54 INFO - Using env: {'DISPLAY': ':0', 11:31:54 INFO - 'HOME': '/home/cltbld', 11:31:54 INFO - 'LANG': 'en_US.UTF-8', 11:31:54 INFO - 'LANGUAGE': 'en_US:en', 11:31:54 INFO - 'LOGNAME': 'cltbld', 11:31:54 INFO - 'MAIL': '/var/mail/cltbld', 11:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:54 INFO - 'MOZ_NO_REMOTE': '1', 11:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:54 INFO - 'NO_EM_RESTART': '1', 11:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:54 INFO - 'PWD': '/builds/slave/test', 11:31:54 INFO - 'SHELL': '/bin/bash', 11:31:54 INFO - 'SHLVL': '1', 11:31:54 INFO - 'TERM': 'linux', 11:31:54 INFO - 'TMOUT': '86400', 11:31:54 INFO - 'USER': 'cltbld', 11:31:54 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:54 INFO - '_': '/tools/buildbot/bin/python'} 11:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:54 INFO - Downloading/unpacking jsonschema==2.5.1 11:31:54 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 11:31:54 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 11:31:54 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 11:31:54 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 11:31:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:31:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:31: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 11:31: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 11:31: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 11:31: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 11:31:55 INFO - Downloading functools32-3.2.3-2.tar.gz 11:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:31:55 INFO - warning: no files found matching '*.txt' 11:31:55 INFO - no previously-included directories found matching 'build' 11:31:55 INFO - no previously-included directories found matching 'dist' 11:31:55 INFO - no previously-included directories found matching '.git*' 11:31:55 INFO - Installing collected packages: jsonschema, functools32 11:31:56 INFO - Running setup.py install for functools32 11:31:56 INFO - warning: no files found matching '*.txt' 11:31:56 INFO - no previously-included directories found matching 'build' 11:31:56 INFO - no previously-included directories found matching 'dist' 11:31:56 INFO - no previously-included directories found matching '.git*' 11:31:56 INFO - Successfully installed jsonschema functools32 11:31:56 INFO - Cleaning up... 11:31:56 INFO - Return code: 0 11:31:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:56 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 0x212d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2498df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249c440>, '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 0x249d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2497320>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', '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 11:31:56 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 11:31:56 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 11:31:56 INFO - Using env: {'DISPLAY': ':0', 11:31:56 INFO - 'HOME': '/home/cltbld', 11:31:56 INFO - 'LANG': 'en_US.UTF-8', 11:31:56 INFO - 'LANGUAGE': 'en_US:en', 11:31:56 INFO - 'LOGNAME': 'cltbld', 11:31:56 INFO - 'MAIL': '/var/mail/cltbld', 11:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:56 INFO - 'MOZ_NO_REMOTE': '1', 11:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:56 INFO - 'NO_EM_RESTART': '1', 11:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:56 INFO - 'PWD': '/builds/slave/test', 11:31:56 INFO - 'SHELL': '/bin/bash', 11:31:56 INFO - 'SHLVL': '1', 11:31:56 INFO - 'TERM': 'linux', 11:31:56 INFO - 'TMOUT': '86400', 11:31:56 INFO - 'USER': 'cltbld', 11:31:56 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:56 INFO - '_': '/tools/buildbot/bin/python'} 11:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:31:56 INFO - Cleaning up... 11:31:56 INFO - Return code: 0 11:31:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:56 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 0x212d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2498df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249c440>, '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 0x249d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2497320>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', '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 11:31:56 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 11:31:56 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 11:31:56 INFO - Using env: {'DISPLAY': ':0', 11:31:56 INFO - 'HOME': '/home/cltbld', 11:31:56 INFO - 'LANG': 'en_US.UTF-8', 11:31:56 INFO - 'LANGUAGE': 'en_US:en', 11:31:56 INFO - 'LOGNAME': 'cltbld', 11:31:56 INFO - 'MAIL': '/var/mail/cltbld', 11:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:56 INFO - 'MOZ_NO_REMOTE': '1', 11:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:56 INFO - 'NO_EM_RESTART': '1', 11:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:56 INFO - 'PWD': '/builds/slave/test', 11:31:56 INFO - 'SHELL': '/bin/bash', 11:31:56 INFO - 'SHLVL': '1', 11:31:56 INFO - 'TERM': 'linux', 11:31:56 INFO - 'TMOUT': '86400', 11:31:56 INFO - 'USER': 'cltbld', 11:31:56 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:56 INFO - '_': '/tools/buildbot/bin/python'} 11:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:31: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 11:31: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 11:31: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 11:31: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 11:31:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:31:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:31: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 11:31: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 11:31: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 11:31: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 11:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:31:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:31: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 11:31: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 11:31: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 11:31: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 11:31:58 INFO - Downloading docopt-0.6.1.tar.gz 11:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:31:58 INFO - Installing collected packages: blobuploader, requests, docopt 11:31:58 INFO - Running setup.py install for blobuploader 11:31:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:31:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:31:58 INFO - Running setup.py install for requests 11:31:59 INFO - Running setup.py install for docopt 11:31:59 INFO - Successfully installed blobuploader requests docopt 11:31:59 INFO - Cleaning up... 11:31:59 INFO - Return code: 0 11:31:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:59 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')]} 11:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:59 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')]} 11:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:59 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 0x212d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2498df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249c440>, '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 0x249d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2497320>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', '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 11:31:59 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 11:31:59 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 11:31:59 INFO - Using env: {'DISPLAY': ':0', 11:31:59 INFO - 'HOME': '/home/cltbld', 11:31:59 INFO - 'LANG': 'en_US.UTF-8', 11:31:59 INFO - 'LANGUAGE': 'en_US:en', 11:31:59 INFO - 'LOGNAME': 'cltbld', 11:31:59 INFO - 'MAIL': '/var/mail/cltbld', 11:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:59 INFO - 'MOZ_NO_REMOTE': '1', 11:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:59 INFO - 'NO_EM_RESTART': '1', 11:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:59 INFO - 'PWD': '/builds/slave/test', 11:31:59 INFO - 'SHELL': '/bin/bash', 11:31:59 INFO - 'SHLVL': '1', 11:31:59 INFO - 'TERM': 'linux', 11:31:59 INFO - 'TMOUT': '86400', 11:31:59 INFO - 'USER': 'cltbld', 11:31:59 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:59 INFO - '_': '/tools/buildbot/bin/python'} 11:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:59 INFO - Running setup.py (path:/tmp/pip-I61ON1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:59 INFO - Running setup.py (path:/tmp/pip-RyBdp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:59 INFO - Running setup.py (path:/tmp/pip-TNkiiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:59 INFO - Running setup.py (path:/tmp/pip-03U4W9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:59 INFO - Running setup.py (path:/tmp/pip-PA53CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:59 INFO - Running setup.py (path:/tmp/pip-9SjyY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:59 INFO - Running setup.py (path:/tmp/pip-FpchfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:59 INFO - Running setup.py (path:/tmp/pip-y9fI2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:00 INFO - Running setup.py (path:/tmp/pip-YKincz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:00 INFO - Running setup.py (path:/tmp/pip-ncizMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:00 INFO - Running setup.py (path:/tmp/pip-q_fHic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:00 INFO - Running setup.py (path:/tmp/pip-peG3tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:00 INFO - Running setup.py (path:/tmp/pip-PJJQZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:00 INFO - Running setup.py (path:/tmp/pip-F3uELy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:00 INFO - Running setup.py (path:/tmp/pip-jsqo8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:00 INFO - Running setup.py (path:/tmp/pip-2khuSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:00 INFO - Running setup.py (path:/tmp/pip-0yLjZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:00 INFO - Running setup.py install for manifestparser 11:32:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:32:00 INFO - Running setup.py install for mozcrash 11:32:00 INFO - Running setup.py install for mozdebug 11:32:00 INFO - Running setup.py install for mozdevice 11:32:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for mozfile 11:32:01 INFO - Running setup.py install for mozhttpd 11:32:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for mozinfo 11:32:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for mozInstall 11:32:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for mozleak 11:32:01 INFO - Running setup.py install for mozlog 11:32:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for moznetwork 11:32:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for mozprocess 11:32:01 INFO - Running setup.py install for mozprofile 11:32:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for mozrunner 11:32:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:32:02 INFO - Running setup.py install for mozscreenshot 11:32:02 INFO - Running setup.py install for moztest 11:32:02 INFO - Running setup.py install for mozversion 11:32:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:32:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:02 INFO - Cleaning up... 11:32:02 INFO - Return code: 0 11:32:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:02 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 0x212d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2498df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249c440>, '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 0x249d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2497320>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', '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 11:32:02 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 11:32:02 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 11:32:02 INFO - Using env: {'DISPLAY': ':0', 11:32:02 INFO - 'HOME': '/home/cltbld', 11:32:02 INFO - 'LANG': 'en_US.UTF-8', 11:32:02 INFO - 'LANGUAGE': 'en_US:en', 11:32:02 INFO - 'LOGNAME': 'cltbld', 11:32:02 INFO - 'MAIL': '/var/mail/cltbld', 11:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:02 INFO - 'MOZ_NO_REMOTE': '1', 11:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:02 INFO - 'NO_EM_RESTART': '1', 11:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:02 INFO - 'PWD': '/builds/slave/test', 11:32:02 INFO - 'SHELL': '/bin/bash', 11:32:02 INFO - 'SHLVL': '1', 11:32:02 INFO - 'TERM': 'linux', 11:32:02 INFO - 'TMOUT': '86400', 11:32:02 INFO - 'USER': 'cltbld', 11:32:02 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:02 INFO - '_': '/tools/buildbot/bin/python'} 11:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:02 INFO - Running setup.py (path:/tmp/pip-a5X4qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:02 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)) 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:02 INFO - Running setup.py (path:/tmp/pip-YqcASI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:02 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)) 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:02 INFO - Running setup.py (path:/tmp/pip-fdD6M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:02 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)) 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:02 INFO - Running setup.py (path:/tmp/pip-Mx0_5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:02 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)) 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:02 INFO - Running setup.py (path:/tmp/pip-umezKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:03 INFO - Running setup.py (path:/tmp/pip-ukMm44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:03 INFO - Running setup.py (path:/tmp/pip-nWhZFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:03 INFO - Running setup.py (path:/tmp/pip-T0jSL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:03 INFO - Running setup.py (path:/tmp/pip-kjfpDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:03 INFO - Running setup.py (path:/tmp/pip-LWlPZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:03 INFO - Running setup.py (path:/tmp/pip-Peo1zX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:03 INFO - Running setup.py (path:/tmp/pip-lRV50a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:03 INFO - Running setup.py (path:/tmp/pip-kq8Y81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:03 INFO - Running setup.py (path:/tmp/pip-PVRKYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:03 INFO - Running setup.py (path:/tmp/pip-sDqQM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:03 INFO - Running setup.py (path:/tmp/pip-LQwIjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:03 INFO - Running setup.py (path:/tmp/pip-SAbSaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:03 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)) 11:32:03 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)) 11:32:03 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)) 11:32:03 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)) 11:32:03 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)) 11:32:03 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)) 11:32:03 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)) 11:32:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:03 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 11:32:03 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 11:32:03 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 11:32:03 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 11:32:04 INFO - Downloading blessings-1.6.tar.gz 11:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:05 INFO - Installing collected packages: blessings 11:32:05 INFO - Running setup.py install for blessings 11:32:05 INFO - Successfully installed blessings 11:32:05 INFO - Cleaning up... 11:32:05 INFO - Return code: 0 11:32:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:32:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:05 INFO - Reading from file tmpfile_stdout 11:32:05 INFO - Current package versions: 11:32:05 INFO - argparse == 1.2.1 11:32:05 INFO - blessings == 1.6 11:32:05 INFO - blobuploader == 1.2.4 11:32:05 INFO - docopt == 0.6.1 11:32:05 INFO - functools32 == 3.2.3-2 11:32:05 INFO - jsonschema == 2.5.1 11:32:05 INFO - manifestparser == 1.1 11:32:05 INFO - mozInstall == 1.13 11:32:05 INFO - mozcrash == 1.0 11:32:05 INFO - mozdebug == 0.1 11:32:05 INFO - mozdevice == 0.51 11:32:05 INFO - mozfile == 1.2 11:32:05 INFO - mozhttpd == 0.7 11:32:05 INFO - mozinfo == 0.10 11:32:05 INFO - mozleak == 0.1 11:32:05 INFO - mozlog == 3.5 11:32:05 INFO - moznetwork == 0.27 11:32:05 INFO - mozprocess == 0.25 11:32:05 INFO - mozprofile == 0.28 11:32:05 INFO - mozrunner == 6.13 11:32:05 INFO - mozscreenshot == 0.1 11:32:05 INFO - mozsystemmonitor == 0.3 11:32:05 INFO - moztest == 0.8 11:32:05 INFO - mozversion == 1.4 11:32:05 INFO - psutil == 3.1.1 11:32:05 INFO - requests == 1.2.3 11:32:05 INFO - wsgiref == 0.1.2 11:32:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:05 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')]} 11:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:05 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')]} 11:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:05 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 0x212d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2498df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249c440>, '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 0x249d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2497320>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', '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 11:32:05 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 11:32:05 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 11:32:05 INFO - Using env: {'DISPLAY': ':0', 11:32:05 INFO - 'HOME': '/home/cltbld', 11:32:05 INFO - 'LANG': 'en_US.UTF-8', 11:32:05 INFO - 'LANGUAGE': 'en_US:en', 11:32:05 INFO - 'LOGNAME': 'cltbld', 11:32:05 INFO - 'MAIL': '/var/mail/cltbld', 11:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:05 INFO - 'MOZ_NO_REMOTE': '1', 11:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:05 INFO - 'NO_EM_RESTART': '1', 11:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:05 INFO - 'PWD': '/builds/slave/test', 11:32:05 INFO - 'SHELL': '/bin/bash', 11:32:05 INFO - 'SHLVL': '1', 11:32:05 INFO - 'TERM': 'linux', 11:32:05 INFO - 'TMOUT': '86400', 11:32:05 INFO - 'USER': 'cltbld', 11:32:05 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:05 INFO - '_': '/tools/buildbot/bin/python'} 11:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:05 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)) 11:32:05 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)) 11:32:05 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)) 11:32:05 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)) 11:32:05 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)) 11:32:05 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)) 11:32:05 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)) 11:32:05 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)) 11:32:05 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)) 11:32:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:32: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 11:32: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 11:32: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 11:32: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 11:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:32:06 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)) 11:32:06 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)) 11:32:06 INFO - Installing collected packages: simplejson 11:32:06 INFO - Running setup.py install for simplejson 11:32:06 INFO - building 'simplejson._speedups' extension 11:32:06 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 11:32:07 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 11:32:07 INFO - Successfully installed simplejson 11:32:07 INFO - Cleaning up... 11:32:07 INFO - Return code: 0 11:32:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32: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')]} 11:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2498df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249c440>, '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 0x249d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2497320>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', '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 11:32:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:32:07 INFO - Using env: {'DISPLAY': ':0', 11:32:07 INFO - 'HOME': '/home/cltbld', 11:32:07 INFO - 'LANG': 'en_US.UTF-8', 11:32:07 INFO - 'LANGUAGE': 'en_US:en', 11:32:07 INFO - 'LOGNAME': 'cltbld', 11:32:07 INFO - 'MAIL': '/var/mail/cltbld', 11:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:07 INFO - 'MOZ_NO_REMOTE': '1', 11:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:07 INFO - 'NO_EM_RESTART': '1', 11:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:07 INFO - 'PWD': '/builds/slave/test', 11:32:07 INFO - 'SHELL': '/bin/bash', 11:32:07 INFO - 'SHLVL': '1', 11:32:07 INFO - 'TERM': 'linux', 11:32:07 INFO - 'TMOUT': '86400', 11:32:07 INFO - 'USER': 'cltbld', 11:32:07 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:07 INFO - '_': '/tools/buildbot/bin/python'} 11:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:32:08 INFO - Cleaning up... 11:32:08 INFO - Return code: 0 11:32:08 INFO - Running post-action listener: _resource_record_post_action 11:32:08 INFO - Running post-action listener: _start_resource_monitoring 11:32:08 INFO - Starting resource monitoring. 11:32:08 INFO - [mozharness: 2017-09-26 18:32:08.168541Z] Finished create-virtualenv step (success) 11:32:08 INFO - [mozharness: 2017-09-26 18:32:08.169059Z] Running install step. 11:32:08 INFO - Running pre-action listener: _resource_record_pre_action 11:32:08 INFO - Running main action method: install 11:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:08 INFO - Reading from file tmpfile_stdout 11:32:08 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:32:08 INFO - Reading from file tmpfile_stdout 11:32:08 INFO - Output received: 11:32:08 INFO - Usage: mozinstall [options] installer 11:32:08 INFO - Options: 11:32:08 INFO - -h, --help show this help message and exit 11:32:08 INFO - -d DEST, --destination=DEST 11:32:08 INFO - Directory to install application into. [default: 11:32:08 INFO - "/builds/slave/test"] 11:32:08 INFO - --app=APP Application being installed. [default: firefox] 11:32:08 INFO - mkdir: /builds/slave/test/build/application 11:32:08 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'] 11:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:32:26 INFO - Reading from file tmpfile_stdout 11:32:26 INFO - Output received: 11:32:26 INFO - /builds/slave/test/build/application/firefox/firefox 11:32:26 INFO - Running post-action listener: _resource_record_post_action 11:32:26 INFO - [mozharness: 2017-09-26 18:32:26.327087Z] Finished install step (success) 11:32:26 INFO - [mozharness: 2017-09-26 18:32:26.327384Z] Running setup-mitmproxy step. 11:32:26 INFO - Running pre-action listener: _resource_record_pre_action 11:32:26 INFO - Running main action method: setup_mitmproxy 11:32:26 INFO - Skipping: mitmproxy is not required 11:32:26 INFO - Running post-action listener: _resource_record_post_action 11:32:26 INFO - [mozharness: 2017-09-26 18:32:26.328519Z] Finished setup-mitmproxy step (success) 11:32:26 INFO - [mozharness: 2017-09-26 18:32:26.328740Z] Running run-tests step. 11:32:26 INFO - Running pre-action listener: _resource_record_pre_action 11:32:26 INFO - Running pre-action listener: _set_gcov_prefix 11:32:26 INFO - Running main action method: run_tests 11:32:26 WARNING - Try message not found. 11:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:32:26 INFO - Python 2.7.3 11:32:26 INFO - Return code: 0 11:32:26 INFO - grabbing minidump binary from tooltool 11:32:26 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')]} 11:32:26 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 0x249c440>, '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 0x249d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2497320>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:32:26 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 11:32:26 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 11:32:26 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 11:32:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:32:26 INFO - Return code: 0 11:32:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:32:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:32:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:32:26 INFO - ENV: RUST_BACKTRACE is now full 11:32:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:32:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:32:26 INFO - Using env: {'DISPLAY': ':0', 11:32:26 INFO - 'HOME': '/home/cltbld', 11:32:26 INFO - 'LANG': 'en_US.UTF-8', 11:32:26 INFO - 'LANGUAGE': 'en_US:en', 11:32:26 INFO - 'LOGNAME': 'cltbld', 11:32:26 INFO - 'MAIL': '/var/mail/cltbld', 11:32:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:26 INFO - 'MOZ_ACCELERATED': '1', 11:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:26 INFO - 'MOZ_NO_REMOTE': '1', 11:32:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:26 INFO - 'MOZ_WEBRENDER': '1', 11:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:26 INFO - 'NO_EM_RESTART': '1', 11:32:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:26 INFO - 'PWD': '/builds/slave/test', 11:32:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:26 INFO - 'RUST_BACKTRACE': 'full', 11:32:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:26 INFO - 'SHELL': '/bin/bash', 11:32:26 INFO - 'SHLVL': '1', 11:32:26 INFO - 'TERM': 'linux', 11:32:26 INFO - 'TMOUT': '86400', 11:32:26 INFO - 'USER': 'cltbld', 11:32:26 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:26 INFO - '_': '/tools/buildbot/bin/python'} 11:32:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:32:26 INFO - mozversion application_buildid: 20170926173447 11:32:26 INFO - mozversion application_changeset: b30ae5a455367f336ded1052081e4c54a139fa81 11:32:26 INFO - mozversion application_display_name: Nightly 11:32:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:32:26 INFO - mozversion application_name: Firefox 11:32:26 INFO - mozversion application_remotingname: firefox 11:32:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:32:26 INFO - mozversion application_vendor: Mozilla 11:32:26 INFO - mozversion application_version: 58.0a1 11:32:26 INFO - mozversion platform_buildid: 20170926173447 11:32:26 INFO - mozversion platform_changeset: b30ae5a455367f336ded1052081e4c54a139fa81 11:32:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:32:26 INFO - mozversion platform_version: 58.0a1 11:32:26 INFO - using testdate: 1506450746 11:32:26 INFO - actual date: 1506450746 11:32:26 INFO - starting webserver on 'localhost:60140' 11:32:26 INFO - SUITE-START | Running 2 tests 11:32:26 INFO - TEST-START | dromaeo_css 11:32:26 INFO - Initialising browser for dromaeo_css test... 11:32:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60140/getInfo.html -profile /tmp/tmpGPBzes/profile 11:32:26 INFO - TEST-INFO | started process 13621 (/builds/slave/test/build/application/firefox/firefox http://localhost:60140/getInfo.html) 11:32:32 INFO - TEST-INFO | 13621: exit 0 11:32:32 INFO - Browser initialized. 11:32:32 INFO - Running cycle 1/1 for dromaeo_css test... 11:32:32 INFO - Using env: {'DISPLAY': ':0', 11:32:32 INFO - 'HOME': '/home/cltbld', 11:32:32 INFO - 'JSGC_DISABLE_POISONING': '1', 11:32:32 INFO - 'LANG': 'en_US.UTF-8', 11:32:32 INFO - 'LANGUAGE': 'en_US:en', 11:32:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:32:32 INFO - 'LOGNAME': 'cltbld', 11:32:32 INFO - 'MAIL': '/var/mail/cltbld', 11:32:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:32 INFO - 'MOZ_ACCELERATED': '1', 11:32:32 INFO - 'MOZ_CRASHREPORTER': '1', 11:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:32:32 INFO - 'MOZ_NO_REMOTE': '1', 11:32:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:32 INFO - 'MOZ_WEBRENDER': '1', 11:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:32 INFO - 'NO_EM_RESTART': '1', 11:32:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:32 INFO - 'PWD': '/builds/slave/test', 11:32:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:32 INFO - 'RUST_BACKTRACE': 'full', 11:32:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:32 INFO - 'SHELL': '/bin/bash', 11:32:32 INFO - 'SHLVL': '1', 11:32:32 INFO - 'TERM': 'linux', 11:32:32 INFO - 'TMOUT': '86400', 11:32:32 INFO - 'USER': 'cltbld', 11:32:32 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:32 INFO - '_': '/tools/buildbot/bin/python'} 11:32:32 INFO - TEST-INFO | started process 13868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGPBzes/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:33 INFO - PID 13868 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:32:33 INFO - PID 13868 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:32:33 INFO - PID 13868 | 11:32:33 INFO - PID 13868 | (/builds/slave/test/build/application/firefox/firefox:13927): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:32:33 INFO - PID 13868 | 11:32:44 INFO - PID 13868 | RSS: Main: 191389696 11:32:44 INFO - PID 13868 | 11:35:40 INFO - PID 13868 | Cycle 1(1): loaded http://localhost:60140/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60140/tests/dromaeo/cssquery-ext.html) 11:35:42 INFO - PID 13868 | RSS: Main: 192950272 11:35:42 INFO - PID 13868 | 11:38:44 INFO - PID 13868 | Cycle 1(1): loaded http://localhost:60140/tests/dromaeo/cssquery-ext.html (next: http://localhost:60140/tests/dromaeo/cssquery-jquery.html) 11:38:45 INFO - PID 13868 | RSS: Main: 191913984 11:38:45 INFO - PID 13868 | 11:41:47 INFO - PID 13868 | Cycle 1(1): loaded http://localhost:60140/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60140/tests/dromaeo/cssquery-mootools.html) 11:41:47 INFO - PID 13868 | RSS: Main: 193597440 11:41:47 INFO - PID 13868 | 11:44:49 INFO - PID 13868 | Cycle 1(1): loaded http://localhost:60140/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60140/tests/dromaeo/cssquery-prototype.html) 11:44:50 INFO - PID 13868 | RSS: Main: 189149184 11:44:50 INFO - PID 13868 | 11:47:54 INFO - PID 13868 | Cycle 1(1): loaded http://localhost:60140/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60140/tests/dromaeo/cssquery-yui.html) 11:47:54 INFO - PID 13868 | RSS: Main: 192913408 11:47:54 INFO - PID 13868 | 11:50:56 INFO - PID 13868 | Cycle 1(1): loaded http://localhost:60140/tests/dromaeo/cssquery-yui.html (next: http://localhost:60140/tests/dromaeo/cssquery-dojo.html) 11:50:57 INFO - PID 13868 | RSS: Main: 192622592 11:50:57 INFO - PID 13868 | 11:50:57 INFO - PID 13868 | __start_tp_report 11:50:57 INFO - PID 13868 | _x_x_mozilla_page_load 11:50:57 INFO - PID 13868 | _x_x_mozilla_page_load_details 11:50:57 INFO - PID 13868 | |i|pagename|runs| 11:50:57 INFO - PID 13868 | |0;dojo.html;3111.1599868035632;3111.5799367085438;3120.516319970405;3174.444472217361;3186.060112266881;6095.299040610331;6213.937860621392;6244.188255526781;6299.65351905645;6327.968360158193;6166.198394208758;6172.22847144107;6195.7521699131985;6209.658468784215;6245.063240513925;5711.885762284752;5713.4572215639555;5768.192453056576;5768.3654797972185;5844.824655260328;5772.393898640646;5838.095095260242;5857;5895.469407753301;5924.88150236995;54.70420954532059;5655.293088363955;5765.625234359774;5852.356240813507;5865.266841644794;5640.746166422521;5642.125470552071;5726.627769194989;5806.216160818278;5806.245188125559;5710.200571919934;5721.71391430431;5759.251297331362;5775.422457754233;5820.039693450575;6093.847653808646;6192.628442293477;6237.469815065725;6258.780942666985;6288.465480434169;6630.602163870135;6645.568038077509;6685.331466853324;6742.494312926501;6763.0193621924545;6673.599584024974;6700.128983232197;6738.427233685143;6752.088468056799;6767.864642707118;6016.639001659871;6216.347283535209;6221.96889015552;6275.121482992385;6300.968495157541;6803.557768745065;6927.757528486479;6932.445404367639;6958.965205173941;6961.129858767654;6552.705128269239;6560.967195163994;6600.933990660128;6638.701258443381;6643.40209381158;6465;6680.198376194888;6695.832604184934;6705.195376554844;6744.696488657924;6519.837004074841;6557.803265901935;6665.700043498055;6670.566413183127;6684.766033188912;6687.364700353459;6692.96653516739;6715.56348837324;6725.125733654593;6757.324267573302;5201.45384734605;5261.868453288622;5262.868428289246;5266.868328291824;5273.1035723927025;4515.706479078849;4547.977260113678;4559.224931761609;4581.5647513486165;4582;5554.527865131428;5637.210790489335;5669.489745922887;5713.143028545752;5755.769769209185;6738.831529211711;6749.392554670103;6765.830854228585;6770.018347339706;6785.796426107225;5709.571782116358;5723.5707321950185;5726.599138060295;5772;5796.942030579725;5722.599418040697;5745.253117094751;5746.655200687972;5817.7091145442555;5818.95258853402;6542.901856472156;6555;6560.147180866456;6560.671966401661;6573.408393244536;6547.705353259114;6560.606363618198;6565.310642382481;6589.406953374028;6638.568493048033;6316.715747791269;6382.840428989312;6508.056331831953;6514.185726784152;6522.28254891971;6516.087747715418;6647.368499992493;6668.799936001928;6668.899966500603;6698.162729658793;6481.967590162019;6712.798616041527;6721.663916804238;6802.251752307143;6805.829854253683;6340.619562826245;6409.391107844747;6453.290138084901;6457.321981191907;6467.094606754964;6399.328070552525;6402.743890244525;6432.6462044588;6457.063725759833;6464.838379040561;6484.319146489739;6494.318096599789;6512.511561632802;6532.183477065367;6541.378569035934;6587.505937054644;6589.27517973013;6671.499637527108;6673.132492775908;6677.933220667731;6323.905141422791;6332.651704156131;6355.682215889095;6372.681365931778;6389.93610063912 11:50:57 INFO - PID 13868 | |1;ext.html;871.9433236839606;897.3808072430021;902.5306840442973;905.0858632780889;907.4283201582998;39116.41325380118;42730.35904461431;42847.57152428475;42904.570954290444;42994.140117197676;39439.40840887389;39463.210735785266;39515;39621.40567891484;39666.20667586654;7108.857822843527;7212;7240.0587923569865;7254.9637251813665;7265.673044712974;7103.8224044398785;7192.892106618378;7246.637668116599;7260.382867456273;7292.088488938883;7305.634718264092;7328.596927169004;7333.156686980986;7334.853302933965;7339.229380915007;7261.346478816906;7859.449838511335;7973.242541958504;8020.839583208362;8021.2379823916635;7845.646945887392;7932.920670793276;7954.244346787046;7983.600819958979;7996.800079997988;37160.81419592885;37556;37714.24571508582;39176.41235381472;39284;3436.6563343665684;3481.1993241554333;3482.2513159670793;3485.0764547394706;3490.5636795400574;32365.190870228198;32408;32530.512042319384;32589.348213035606;32598;4981.651284410093;5012.27322038306;5046.495350464961;5050.065737838475;5050.419201791804;183984;185877;186961;187174.99999999863;187230;43241.56758432438;43711.562884371386;48587;48615;48872.75563622159;51545.48454515407;52941.2058819118;52987.470125298256;53222.73388633032;53713.1943020855;15159.545213643609;15197.240137993056;15232;15274;15362.923185384001;12322.260664360167;12355.196912200678;12358.62924112278;12369.134160608852;12389.93805030969;14407.42370305176;14471.493497727739;14507.637309067357;14514.475980022156;14644.633884152981;5679.204911312419;5808.941910580925;5881.264841894763;5885.5585831062845;5954.255718035246;1004.8743907011624;1010.4038617215878;1019.4393083803878;1028.953697083618;1038.2472707287156;23304.883475582512;23385;23660.053597856237;23691.763082368954;23903;1113.6714669172613;1122.141561705296;1122.528538014036;1124.612008856943;1135.4039129456935;12161;12350;12405.13164078524;12450.937745311216;12553.435095420546;226014;228372;228990;230270;230494;53971;54439.72780136074;54664;54725;54954;1417.6526750945877;1447.0594113825887;1449.9565013049626;1457.2932127917952;1458.6936743283818;22860.799488071352;22882;22936.655950160428;23343.53312933766;23472;37668.62331376651;38008;38307.425388618634;38316.42525362066;38395.42406863955;197838;198281;198768;199332;199768;31572.526412104296;35456.645433546364;35745.1063723409;36072.639273606925;36101.638983609824;44626.77686611546;44740;44779.776101119285;45180;45994.31008534808;32094.35811283808;32226.35547289088;32267.51598725974;32302.515462268555;32450;31701.841490792398;31762.52356214705;31803;31881.521777172897;32193;36446.453303201;36586.63413365939;36710.63289367179;36786.26427471489;36833.26333473369;31435.84282078575;31587.526187107673;31625.36749264956;31734.841325793222;31997.36005279928;23135.190268340528;23419.882900585388;23470;23555;23586.646200307354 11:50:57 INFO - PID 13868 | |2;jquery.html;579.744912238615;584.5557376393942;590.2326974932587;614.612793939818;628.5662892604104;21994.34016979489;22580.8870955645;22713.432164195903;22753.886230568867;22761.203357882478;23829.76170238297;24129.879350603267;25244;25327.240182794547;25653.87173064132;6450.96774516128;6598.802035938929;6688.3646053624825;6694.497912656546;6697.665116744143;6486.124373209604;6517.315681853408;6599.307072757363;6665.266820649749;6689.732410703566;6723.966380168117;6735.8652826943435;6737.865242695168;6746;6748.325167483237;6722.394984451374;6729.158855143107;6740.93259067408;6742.629155396476;6753.459723222155;6048.637081775108;6211.503079753609;6239.937600624026;6240.750369985195;6252.937470625281;29537.556936645968;29868.55197172044;29876;29913;29943.550846737315;2007.1770574064562;2042.9897850510802;2045.0490521907236;2047.9555426732325;2058.2384517728538;18413.171407286703;18976.62046759071;19114.23543058276;19118.330858420028;19521.316753913547;2386.618141097416;2411.1440438644204;2432.914847980312;2442.7435119312395;2451.5832308507597;116488.41755791167;134583.32708336395;140211;147089.99999999892;147834;20077;20734.896325518577;21738.565358660337;22146.778532214794;22427.43931401728;41010.79494602508;41111.7944410276;41239.381409278285;41412;41612.1677566453;11349.773004540028;11529.884701152881;11556.88443115575;11654.475548600334;11665.183437159318;9496.525173741424;9556.904430955741;9617.086376794194;9754.658586949423;9819.803603927881;11060.446977651085;11254.94372528132;11290.0967922566;11379.862013798554;11425.428728563538;3759.3045286622064;4325.9134817303475;4390.143921935192;4457.24226881431;4488.910221795546;937.4422218779815;946.8769060022153;955.6894009446958;959.4339339789558;988.8912219655832;19270.80729192718;19463.80536194648;19945.301914432926;20158.69761953572;20170.798292017185;1013.852991316255;1018.9439580823126;1030.5620111452602;1031.0617338222332;1037.5019990404649;10900.672979810619;10956.726081848017;11073.944630276797;11116.61091861781;11264.986151246427;430347;442062;444772;445384;464478;105848;109234.45382773035;109566;109690.45154774174;112252.43873780742;1042.358949246208;1164.190887333312;1167.2646232873406;1171.4552732979205;1175.1010476985114;17708.291668333124;17742.822571774115;18069.638607228044;18116;18167.90916045464;55977.44022559722;57436;57887.131693023795;58236.70881645565;58551.70724146352;70085;70177.29822701708;70727.64636176787;71479.64260178666;71783.64108179425;19429;19866.60266794627;19967.700484493034;19994.800051999293;20229.49426264355;22521.324360269216;22707.772922270568;22728.54152128389;22741.20405785856;23130.421739456648;17819.287228510715;18096.547586310448;18303.176357063698;18426.72359914629;18657;16422.096784676956;16506;16611.50165495037;16881.240344184785;16986.405475808286;18079.005654689117;18101.366452174112;18415.17131729102;18707.158177882302;18755.531111722317;19321.613567728287;19475.220991160193;19695.409137725892;19780.208791648172;19913;18000.819991799915;18163.63772717025;18321.541961451072;18324.175412106753;18501.44495665132 11:50:57 INFO - PID 13868 | |3;mootools.html;1321.643156347786;1366.3509832829402;1372.1492674541785;1376.972460550789;1382.2397681275302;15120.546383608482;15802.604934876634;15890.920545397286;15911.60220994473;15911.920440397811;15338.769918451233;15461.226938653079;15488.070715757034;15507.922460387683;15509.146996915166;2741.5065288248056;2833.688294287627;2836.4610723962483;2840.3609187932652;2843.6161118249083;2597.7141315049075;2618.698849632288;2642.9339266518396;2646.179684297874;2741.3968926836164;2835.9858200709073;2842.403095349979;2850.1164638961886;2859.3280579063903;2872.8707208175683;2706.7563919247264;2727.8499682517454;2730.5631099024063;2742.2184677366854;2742.369255071345;2578.2523068310165;2596.8961241550314;2603.3231359846577;2616.7644911957823;2628.290361602376;15006.24968751569;15119.848801511955;15292.311845966959;15308.464203752927;15319.617009574738;8038.075621303508;8314.542700151489;8316.750497485085;8317.750467485985;8330.125336839666;5099.33708617881;5300.390455097675;5368.865778355534;5434.728263586805;5451.918221226685;1954.3257576136211;1985.6723640599284;2004;2006.277740013594;2061.814436700704;27378.726212737816;27440.725592744016;27687.584686229722;27718.3070423239;27734.445311093667;6964.129483814523;7008.22909479967;7054.118235220598;7124;7211;17590.296388144587;17609.647807043788;17640.823591764176;17643.647127057386;17776.466705998842;7829.217078292125;8076.434649574591;8124.268815806606;8308.916910830936;8563.486190828571;7494.362979146725;7565.848683026308;7568.243175682498;7573.848523029508;7611.238876112345;5304.9734751326;5337;5389.487998640201;5408.648437851527;5490.505854473036;1440.4094321328205;1472.786445965329;1550.71311807316;1550.8061492313461;1598.8081430228215;882.5940067568862;908.8046070094962;912.3066469483108;930.5161316115582;950.2872845365976;8556.529390883437;8580.95709521461;8593.828123437495;8846.646134154691;8870.51212183336;963.4026903319987;1003.3077176748167;1005.3163848582888;1015.9332700664273;1026.4457193115784;5487.3263654585735;5538.972305138448;5563.860903477445;5570.442955704478;5633.774649014075;21262.362129136152;21662.566748665253;22217.333479995625;22242.88878555597;22561.210357637403;21602.351929442142;21747.45631359197;22276.77723222747;22316.88841555782;22378.55242895133;11459.541618335339;11668.88331116695;11769.117316201147;11773.352465614302;11827.231229970024;8292.460990035628;8541.14588541141;8580.528070956158;8668.133186681282;8685.435446695945;17998.550036248675;18463.53841153982;18733.81266187375;18888.772229805018;19363.709544356563;18862.71705924385;19577.8042219576;19611;19713.1129099188;20164.193432262546;11433.970942615204;11530.654080377602;11541.769164616828;11605.071594272269;11611.941940290244;14093.718125637635;14097.295135243401;14224.928875355557;14350.712985740018;14352.856471435569;11429.885701142883;11601.883981160418;11880.108991825475;11903.702407439538;11916.225445346025;11288.380343268425;11337.26307789991;11428;11563.826542602035;11581.884181158417;10152.441615711206;10318.793624127626;10388.636397726043;10401.84397234027;10442.373457592568;7339.70641174347;7375.409967202718;7414.295641914009;7419.220981796833;7462.291082347168;7182.3535881770895;7363.484556081023;7383.446241531799;7393.371563417169;7480.551166929784 11:50:57 INFO - PID 13868 | |4;prototype.html;502.1438447447103;516.1818517649525;541.539691262427;542.3356388424181;543.1987817968494;6142.20151380321;6180.474659653929;6243.313235544092;6259.6870156492105;6332.208473940757;6141.60079594826;6194.318624951263;6214.378562143795;6227.28386235583;6233.189685340911;5103.617228707843;5137.126688462951;5182.922256166161;5198.9480105198845;5206.609504287175;4817.759112044401;5184.53339199472;5201.479852014787;5234.136367499358;5236.31927849379;4945.4065512138595;4968.875778105558;4979.875503112415;4983.800647974077;4995.300657907896;4917.262410638397;4929.605631549467;4931.26031095335;4999.575036121916;5014.699118052892;4396.340548917656;4459.331100334944;4466.726982809883;4486.685931984763;4507.256302710081;5981.371955944606;6018.886505996405;6063.423974722438;6071.787487437919;6113.266408031021;5655.123455864347;5705.001624715658;5713.571482138815;5755.971220143914;5787.160861675034;6518.576292541017;6533.72592344493;6569;6582.835429114262;6593.868122637568;4696.530346965276;4796;4845.304143549764;4869.123557759602;4939.55544001038;6662.300458451889;6668.666566671695;6698.4641228701585;6771.51026774104;6849.4177994871;4944.456109827916;4982.2775697524385;5027.120253955543;5028.4663177731145;5055.595552355802;5089.134847076006;5111.718855462911;5114;5117;5133.486651334837;5436;5608.989572455714;5690.430956904359;5699.686517241592;5731.570132240098;6531.5427920046095;6538.1500404947055;6620.371064748938;6631.336866313427;6636.668166591651;1745.7468667043208;1765.2056574541507;1771.68109740248;1776.786785585738;1781.6792977264217;1216.7566486702694;1239.1449899569268;1250.3123282194938;1262.3057318474803;1272.7009152849073;5495.890082198333;5505.256790333334;5539.224508568804;5566.693831839288;5579;6592.670366481657;6621.635810030494;6636.469082473391;6683.722417652706;6709.664516774239;5502.697351645698;5523.254360661259;5527.364353099365;5569.972150139304;5585;3448.37920183806;3557.7687450316166;3562.71498280137;3572.1603374262277;3580.803055831954;6417.550771446047;6425.839354016187;6463;6470.805875823733;6477.664003038439;6663.800085997428;6753.358430949052;6784.0841486399695;6798.93201067983;6803.795886123424;6012.248468941382;6235.657038862906;6276.184096067482;6415.615063096229;6441.32366101562;6532.5753826001155;6598.208215014229;6601.405873471411;6625.4037136657935;6694.564853284521;6248.843778905563;6622.37087476689;6667.133272674715;6667.8666426670225;6687.933120668731;6141.6007959482495;6315.158178819458;6337.524685648503;6364.713587888648;6446.419822216023;4973.104841128632;4974.925376119433;4991.600671946163;5000.924986125284;5004.499550044967;6638.20341559016;6705.597664140168;6710.798676039727;6726.7981960541265;6748.493862960199;6409.871802563829;6430.324815894451;6446.967765161145;6478.805635830932;6517.283098859217;6354.237491500865;6451.387118223761;6483.870322593616;6500.577462464925;6515.543911926309;6274.717637706405;6319.842003949938;6333.018382150774;6341.682915854281;6394.5523813334485;6381.501041765637;6385.616862988236;6425.7750978717395;6484.157059582224;6558.376954189344;6257.5932564383165;6285.517220697708;6294.779682711083;6309.589876658002;6349.14286571307 11:50:57 INFO - PID 13868 | |5;yui.html;924.4730503612943;933.2021121940741;938.6714649872541;944.4946953379939;952.9475878826667;20269.290574829884;21506.56986860262;21514.677279840795;21524.89237553812;21544.56910861782;19362.12870420831;19593;21429.892850535725;22327.33018009458;22423.103075876985;916.7295647783919;970.1511177719495;982.6413359123904;983.1201075037836;983.233078199006;974.512743628186;1004.9849252261222;1005.7485628592851;1007.30999265503;1009.7324209084599;1042.2183362478142;1045.8797238317616;1045.9581616735322;1047.586203449637;1049.1397054415384;1033.3231733214757;1042.5985995391752;1049.5486940615533;1051.1433181956681;1052.9052385285322;765.4527013185543;765.4947734495262;771.4522688890838;771.8842173673994;774.1291047571482;17351.91324043384;17820.287188512444;17823.376181833573;18035;18107.54731131719;21895.233666821583;22038.44903877416;22318.21886233974;22453;22489.887550562144;17414.825851741574;17455.825441745546;17544.210510527057;17590.736138957927;17595.824041759548;3711.740178187528;3713.3687273163628;3720.9953312605717;3722.571904230994;3727.0682329417646;139232.30383848117;139882.1041263561;140758;141874.99999999898;142867;16258.105804180883;16534.338626455046;16740.58148546296;16786.74819877703;16862.40981565664;31806.36387272288;32065.51901721476;32207.51688724671;32441.837790811365;32563.18592035218;7822.491538050009;8072.596370181467;8320.251177394064;8591.828163436696;8639.049704532496;4212.473440819897;4285.292926667065;4286.164197981426;4287.142571485715;4292.5707429257445;5283.788648454096;5361.27622770921;5363.919541206885;5442.210879422461;5509.118541033496;1073.6993641780314;1088.6570730219955;1090.6564432203832;1098.2641630107687;1102.52040362441;612.6722203621131;631.324482803396;637.6174295422709;641.5060403489381;643.8969764837697;11524.884751152382;11695.982410553599;11791.764164716658;11909.404529773477;11998.880011199777;685.9039734437183;701.8140192848899;705.5801797930224;710.1442761472414;730.2952650692001;5766.481016708432;5787.826365209051;5841.508981557323;5887.264091988502;5996.340402555716;116947.41526292314;119778.40110799564;120276;122060;124225;100581;102765.48617256866;103953.48023259835;105191.4740426293;105605.47197263964;86040;87806;88352.5582372084;91045;91203.54398227966;10512.335853561359;10544.736381590521;10705.143588513056;10743.355398676105;10847.13222942147;42509;43011.13977720366;43222;43846.56153438425;44266;56211.15683264836;56375.43624563702;57198.42801572097;57991.71004144952;58336;15283.388664453742;15393.30730117125;15450;15533.611659708598;15601.921990389976;16904.66190676204;16963.7455438171;17226;17299.481015569552;17903.641927161643;14897.702045959237;14914.477993270184;15018.774718379014;15041.924790375979;15191.544253672408;15081.849181508484;15369.538913832603;15412.768808467657;15493.612659683598;15538.922305388402;14587.270636468347;14608.269586520419;14637.194954277616;14686.926565367105;14720.631984200481;10621.362718236931;10628.574857005633;10725.30285531438;10778.514966826355;10880.401577912975;12272.325022123869;12287.75424491523;12364.072694547765;12495.125341226027;12538.686532836387 11:50:57 INFO - PID 13868 | __end_tp_report 11:50:57 INFO - PID 13868 | __start_cc_report 11:50:57 INFO - PID 13868 | _x_x_mozilla_cycle_collect,301 11:50:57 INFO - PID 13868 | __end_cc_report 11:50:57 INFO - PID 13868 | __startTimestamp1506451857172__endTimestamp 11:50:57 INFO - PID 13868 | 11:50:57 INFO - PID 13868 | ------- Summary: start ------- 11:50:57 INFO - PID 13868 | Number of tests: 6 11:50:57 INFO - PID 13868 | 11:50:57 INFO - PID 13868 | [#0] dojo.html Cycles:165 Average:6112.59 Median:6389.94 stddev:877.78 (13.7%) stddev-sans-first:848.31 11:50:57 INFO - PID 13868 | Values: 3111.2 3111.6 3120.5 3174.4 3186.1 6095.3 6213.9 6244.2 6299.7 6328.0 6166.2 6172.2 6195.8 6209.7 6245.1 5711.9 5713.5 5768.2 5768.4 5844.8 5772.4 5838.1 5857.0 5895.5 5924.9 54.7 5655.3 5765.6 5852.4 5865.3 5640.7 5642.1 5726.6 5806.2 5806.2 5710.2 5721.7 5759.3 5775.4 5820.0 6093.8 6192.6 6237.5 6258.8 6288.5 6630.6 6645.6 6685.3 6742.5 6763.0 6673.6 6700.1 6738.4 6752.1 6767.9 6016.6 6216.3 6222.0 6275.1 6301.0 6803.6 6927.8 6932.4 6959.0 6961.1 6552.7 6561.0 6600.9 6638.7 6643.4 6465.0 6680.2 6695.8 6705.2 6744.7 6519.8 6557.8 6665.7 6670.6 6684.8 6687.4 6693.0 6715.6 6725.1 6757.3 5201.5 5261.9 5262.9 5266.9 5273.1 4515.7 4548.0 4559.2 4581.6 4582.0 5554.5 5637.2 5669.5 5713.1 5755.8 6738.8 6749.4 6765.8 6770.0 6785.8 5709.6 5723.6 5726.6 5772.0 5796.9 5722.6 5745.3 5746.7 5817.7 5819.0 6542.9 6555.0 6560.1 6560.7 6573.4 6547.7 6560.6 6565.3 6589.4 6638.6 6316.7 6382.8 6508.1 6514.2 6522.3 6516.1 6647.4 6668.8 6668.9 6698.2 6482.0 6712.8 6721.7 6802.3 6805.8 6340.6 6409.4 6453.3 6457.3 6467.1 6399.3 6402.7 6432.6 6457.1 6464.8 6484.3 6494.3 6512.5 6532.2 6541.4 6587.5 6589.3 6671.5 6673.1 6677.9 6323.9 6332.7 6355.7 6372.7 6389.9 11:50:57 INFO - PID 13868 | 11:50:57 INFO - PID 13868 | [#1] ext.html Cycles:180 Average:37553.01 Median:19473.60 stddev:53240.71 (273.4%) stddev-sans-first:53318.81 11:50:57 INFO - PID 13868 | Values: 871.9 897.4 902.5 905.1 907.4 39116.4 42730.4 42847.6 42904.6 42994.1 39439.4 39463.2 39515.0 39621.4 39666.2 7108.9 7212.0 7240.1 7255.0 7265.7 7103.8 7192.9 7246.6 7260.4 7292.1 7305.6 7328.6 7333.2 7334.9 7339.2 7261.3 7859.4 7973.2 8020.8 8021.2 7845.6 7932.9 7954.2 7983.6 7996.8 37160.8 37556.0 37714.2 39176.4 39284.0 3436.7 3481.2 3482.3 3485.1 3490.6 32365.2 32408.0 32530.5 32589.3 32598.0 4981.7 5012.3 5046.5 5050.1 5050.4 183984.0 185877.0 186961.0 187175.0 187230.0 43241.6 43711.6 48587.0 48615.0 48872.8 51545.5 52941.2 52987.5 53222.7 53713.2 15159.5 15197.2 15232.0 15274.0 15362.9 12322.3 12355.2 12358.6 12369.1 12389.9 14407.4 14471.5 14507.6 14514.5 14644.6 5679.2 5808.9 5881.3 5885.6 5954.3 1004.9 1010.4 1019.4 1029.0 1038.2 23304.9 23385.0 23660.1 23691.8 23903.0 1113.7 1122.1 1122.5 1124.6 1135.4 12161.0 12350.0 12405.1 12450.9 12553.4 226014.0 228372.0 228990.0 230270.0 230494.0 53971.0 54439.7 54664.0 54725.0 54954.0 1417.7 1447.1 1450.0 1457.3 1458.7 22860.8 22882.0 22936.7 23343.5 23472.0 37668.6 38008.0 38307.4 38316.4 38395.4 197838.0 198281.0 198768.0 199332.0 199768.0 31572.5 35456.6 35745.1 36072.6 36101.6 44626.8 44740.0 44779.8 45180.0 45994.3 32094.4 32226.4 32267.5 32302.5 32450.0 31701.8 31762.5 31803.0 31881.5 32193.0 36446.5 36586.6 36710.6 36786.3 36833.3 31435.8 31587.5 31625.4 31734.8 31997.4 23135.2 23419.9 23470.0 23555.0 23586.6 11:50:57 INFO - PID 13868 | 11:50:57 INFO - PID 13868 | [#2] jquery.html Cycles:180 Average:34444.08 Median:22474.38 stddev:75418.25 (335.6%) stddev-sans-first:75586.96 11:50:57 INFO - PID 13868 | Values: 579.7 584.6 590.2 614.6 628.6 21994.3 22580.9 22713.4 22753.9 22761.2 23829.8 24129.9 25244.0 25327.2 25653.9 6451.0 6598.8 6688.4 6694.5 6697.7 6486.1 6517.3 6599.3 6665.3 6689.7 6724.0 6735.9 6737.9 6746.0 6748.3 6722.4 6729.2 6740.9 6742.6 6753.5 6048.6 6211.5 6239.9 6240.8 6252.9 29537.6 29868.6 29876.0 29913.0 29943.6 2007.2 2043.0 2045.0 2048.0 2058.2 18413.2 18976.6 19114.2 19118.3 19521.3 2386.6 2411.1 2432.9 2442.7 2451.6 116488.4 134583.3 140211.0 147090.0 147834.0 20077.0 20734.9 21738.6 22146.8 22427.4 41010.8 41111.8 41239.4 41412.0 41612.2 11349.8 11529.9 11556.9 11654.5 11665.2 9496.5 9556.9 9617.1 9754.7 9819.8 11060.4 11254.9 11290.1 11379.9 11425.4 3759.3 4325.9 4390.1 4457.2 4488.9 937.4 946.9 955.7 959.4 988.9 19270.8 19463.8 19945.3 20158.7 20170.8 1013.9 1018.9 1030.6 1031.1 1037.5 10900.7 10956.7 11073.9 11116.6 11265.0 430347.0 442062.0 444772.0 445384.0 464478.0 105848.0 109234.5 109566.0 109690.5 112252.4 1042.4 1164.2 1167.3 1171.5 1175.1 17708.3 17742.8 18069.6 18116.0 18167.9 55977.4 57436.0 57887.1 58236.7 58551.7 70085.0 70177.3 70727.6 71479.6 71783.6 19429.0 19866.6 19967.7 19994.8 20229.5 22521.3 22707.8 22728.5 22741.2 23130.4 17819.3 18096.5 18303.2 18426.7 18657.0 16422.1 16506.0 16611.5 16881.2 16986.4 18079.0 18101.4 18415.2 18707.2 18755.5 19321.6 19475.2 19695.4 19780.2 19913.0 18000.8 18163.6 18321.5 18324.2 18501.4 11:50:57 INFO - PID 13868 | 11:50:57 INFO - PID 13868 | [#3] mootools.html Cycles:180 Average:9577.54 Median:2597.31 stddev:6843.80 (263.5%) stddev-sans-first:6834.88 11:50:57 INFO - PID 13868 | Values: 1321.6 1366.4 1372.1 1377.0 1382.2 15120.5 15802.6 15890.9 15911.6 15911.9 15338.8 15461.2 15488.1 15507.9 15509.1 2741.5 2833.7 2836.5 2840.4 2843.6 2597.7 2618.7 2642.9 2646.2 2741.4 2836.0 2842.4 2850.1 2859.3 2872.9 2706.8 2727.8 2730.6 2742.2 2742.4 2578.3 2596.9 2603.3 2616.8 2628.3 15006.2 15119.8 15292.3 15308.5 15319.6 8038.1 8314.5 8316.8 8317.8 8330.1 5099.3 5300.4 5368.9 5434.7 5451.9 1954.3 1985.7 2004.0 2006.3 2061.8 27378.7 27440.7 27687.6 27718.3 27734.4 6964.1 7008.2 7054.1 7124.0 7211.0 17590.3 17609.6 17640.8 17643.6 17776.5 7829.2 8076.4 8124.3 8308.9 8563.5 7494.4 7565.8 7568.2 7573.8 7611.2 5305.0 5337.0 5389.5 5408.6 5490.5 1440.4 1472.8 1550.7 1550.8 1598.8 882.6 908.8 912.3 930.5 950.3 8556.5 8581.0 8593.8 8846.6 8870.5 963.4 1003.3 1005.3 1015.9 1026.4 5487.3 5539.0 5563.9 5570.4 5633.8 21262.4 21662.6 22217.3 22242.9 22561.2 21602.4 21747.5 22276.8 22316.9 22378.6 11459.5 11668.9 11769.1 11773.4 11827.2 8292.5 8541.1 8580.5 8668.1 8685.4 17998.6 18463.5 18733.8 18888.8 19363.7 18862.7 19577.8 19611.0 19713.1 20164.2 11434.0 11530.7 11541.8 11605.1 11611.9 14093.7 14097.3 14224.9 14350.7 14352.9 11429.9 11601.9 11880.1 11903.7 11916.2 11288.4 11337.3 11428.0 11563.8 11581.9 10152.4 10318.8 10388.6 10401.8 10442.4 7339.7 7375.4 7414.3 7419.2 7462.3 7182.4 7363.5 7383.4 7393.4 7480.6 11:50:57 INFO - PID 13868 | 11:50:57 INFO - PID 13868 | [#4] prototype.html Cycles:180 Average:5468.79 Median:6127.43 stddev:1512.42 (24.7%) stddev-sans-first:1470.00 11:50:57 INFO - PID 13868 | Values: 502.1 516.2 541.5 542.3 543.2 6142.2 6180.5 6243.3 6259.7 6332.2 6141.6 6194.3 6214.4 6227.3 6233.2 5103.6 5137.1 5182.9 5198.9 5206.6 4817.8 5184.5 5201.5 5234.1 5236.3 4945.4 4968.9 4979.9 4983.8 4995.3 4917.3 4929.6 4931.3 4999.6 5014.7 4396.3 4459.3 4466.7 4486.7 4507.3 5981.4 6018.9 6063.4 6071.8 6113.3 5655.1 5705.0 5713.6 5756.0 5787.2 6518.6 6533.7 6569.0 6582.8 6593.9 4696.5 4796.0 4845.3 4869.1 4939.6 6662.3 6668.7 6698.5 6771.5 6849.4 4944.5 4982.3 5027.1 5028.5 5055.6 5089.1 5111.7 5114.0 5117.0 5133.5 5436.0 5609.0 5690.4 5699.7 5731.6 6531.5 6538.2 6620.4 6631.3 6636.7 1745.7 1765.2 1771.7 1776.8 1781.7 1216.8 1239.1 1250.3 1262.3 1272.7 5495.9 5505.3 5539.2 5566.7 5579.0 6592.7 6621.6 6636.5 6683.7 6709.7 5502.7 5523.3 5527.4 5570.0 5585.0 3448.4 3557.8 3562.7 3572.2 3580.8 6417.6 6425.8 6463.0 6470.8 6477.7 6663.8 6753.4 6784.1 6798.9 6803.8 6012.2 6235.7 6276.2 6415.6 6441.3 6532.6 6598.2 6601.4 6625.4 6694.6 6248.8 6622.4 6667.1 6667.9 6687.9 6141.6 6315.2 6337.5 6364.7 6446.4 4973.1 4974.9 4991.6 5000.9 5004.5 6638.2 6705.6 6710.8 6726.8 6748.5 6409.9 6430.3 6447.0 6478.8 6517.3 6354.2 6451.4 6483.9 6500.6 6515.5 6274.7 6319.8 6333.0 6341.7 6394.6 6381.5 6385.6 6425.8 6484.2 6558.4 6257.6 6285.5 6294.8 6309.6 6349.1 11:50:57 INFO - PID 13868 | 11:50:57 INFO - PID 13868 | [#5] yui.html Cycles:180 Average:23957.65 Median:17863.51 stddev:34577.21 (193.6%) stddev-sans-first:34630.95 11:50:57 INFO - PID 13868 | Values: 924.5 933.2 938.7 944.5 952.9 20269.3 21506.6 21514.7 21524.9 21544.6 19362.1 19593.0 21429.9 22327.3 22423.1 916.7 970.2 982.6 983.1 983.2 974.5 1005.0 1005.7 1007.3 1009.7 1042.2 1045.9 1046.0 1047.6 1049.1 1033.3 1042.6 1049.5 1051.1 1052.9 765.5 765.5 771.5 771.9 774.1 17351.9 17820.3 17823.4 18035.0 18107.5 21895.2 22038.4 22318.2 22453.0 22489.9 17414.8 17455.8 17544.2 17590.7 17595.8 3711.7 3713.4 3721.0 3722.6 3727.1 139232.3 139882.1 140758.0 141875.0 142867.0 16258.1 16534.3 16740.6 16786.7 16862.4 31806.4 32065.5 32207.5 32441.8 32563.2 7822.5 8072.6 8320.3 8591.8 8639.0 4212.5 4285.3 4286.2 4287.1 4292.6 5283.8 5361.3 5363.9 5442.2 5509.1 1073.7 1088.7 1090.7 1098.3 1102.5 612.7 631.3 637.6 641.5 643.9 11524.9 11696.0 11791.8 11909.4 11998.9 685.9 701.8 705.6 710.1 730.3 5766.5 5787.8 5841.5 5887.3 5996.3 116947.4 119778.4 120276.0 122060.0 124225.0 100581.0 102765.5 103953.5 105191.5 105605.5 86040.0 87806.0 88352.6 91045.0 91203.5 10512.3 10544.7 10705.1 10743.4 10847.1 42509.0 43011.1 43222.0 43846.6 44266.0 56211.2 56375.4 57198.4 57991.7 58336.0 15283.4 15393.3 15450.0 15533.6 15601.9 16904.7 16963.7 17226.0 17299.5 17903.6 14897.7 14914.5 15018.8 15041.9 15191.5 15081.8 15369.5 15412.8 15493.6 15538.9 14587.3 14608.3 14637.2 14686.9 14720.6 10621.4 10628.6 10725.3 10778.5 10880.4 12272.3 12287.8 12364.1 12495.1 12538.7 11:50:57 INFO - PID 13868 | -------- Summary: end -------- 11:50:57 INFO - PID 13868 | 11:50:57 INFO - TEST-INFO | 13868: exit 0 11:50:57 INFO - TEST-OK | dromaeo_css | took 1111244ms 11:50:57 INFO - TEST-START | kraken 11:50:57 INFO - Initialising browser for kraken test... 11:50:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60140/getInfo.html -profile /tmp/tmpgnFOZg/profile 11:50:57 INFO - TEST-INFO | started process 14252 (/builds/slave/test/build/application/firefox/firefox http://localhost:60140/getInfo.html) 11:51:03 INFO - TEST-INFO | 14252: exit 0 11:51:03 INFO - Browser initialized. 11:51:03 INFO - Running cycle 1/1 for kraken test... 11:51:03 INFO - Using env: {'DISPLAY': ':0', 11:51:03 INFO - 'HOME': '/home/cltbld', 11:51:03 INFO - 'JSGC_DISABLE_POISONING': '1', 11:51:03 INFO - 'LANG': 'en_US.UTF-8', 11:51:03 INFO - 'LANGUAGE': 'en_US:en', 11:51:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:51:03 INFO - 'LOGNAME': 'cltbld', 11:51:03 INFO - 'MAIL': '/var/mail/cltbld', 11:51:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:51:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:51:03 INFO - 'MOZ_ACCELERATED': '1', 11:51:03 INFO - 'MOZ_CRASHREPORTER': '1', 11:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:51:03 INFO - 'MOZ_NO_REMOTE': '1', 11:51:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:51:03 INFO - 'MOZ_WEBRENDER': '1', 11:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:03 INFO - 'NO_EM_RESTART': '1', 11:51:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:03 INFO - 'PWD': '/builds/slave/test', 11:51:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:51:03 INFO - 'RUST_BACKTRACE': 'full', 11:51:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:51:03 INFO - 'SHELL': '/bin/bash', 11:51:03 INFO - 'SHLVL': '1', 11:51:03 INFO - 'TERM': 'linux', 11:51:03 INFO - 'TMOUT': '86400', 11:51:03 INFO - 'USER': 'cltbld', 11:51:03 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922', 11:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:03 INFO - '_': '/tools/buildbot/bin/python'} 11:51:03 INFO - TEST-INFO | started process 14491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgnFOZg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:04 INFO - PID 14491 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:51:04 INFO - PID 14491 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:51:04 INFO - PID 14491 | 11:51:04 INFO - PID 14491 | (/builds/slave/test/build/application/firefox/firefox:14551): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:51:04 INFO - PID 14491 | 11:51:14 INFO - PID 14491 | RSS: Main: 193187840 11:51:14 INFO - PID 14491 | 11:51:17 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60140/tests/kraken/driver.html?testName=audio-beat-detection) 11:51:18 INFO - PID 14491 | RSS: Main: 191148032 11:51:18 INFO - PID 14491 | 11:51:21 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60140/tests/kraken/driver.html?testName=audio-dft) 11:51:21 INFO - PID 14491 | RSS: Main: 192880640 11:51:21 INFO - PID 14491 | 11:51:24 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60140/tests/kraken/driver.html?testName=audio-fft) 11:51:25 INFO - PID 14491 | RSS: Main: 188903424 11:51:25 INFO - PID 14491 | 11:51:27 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60140/tests/kraken/driver.html?testName=audio-oscillator) 11:51:28 INFO - PID 14491 | RSS: Main: 189497344 11:51:28 INFO - PID 14491 | 11:51:30 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60140/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:51:31 INFO - PID 14491 | RSS: Main: 189460480 11:51:31 INFO - PID 14491 | 11:51:34 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60140/tests/kraken/driver.html?testName=imaging-darkroom) 11:51:34 INFO - PID 14491 | RSS: Main: 191791104 11:51:34 INFO - PID 14491 | 11:51:38 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60140/tests/kraken/driver.html?testName=imaging-desaturate) 11:51:39 INFO - PID 14491 | RSS: Main: 191074304 11:51:39 INFO - PID 14491 | 11:51:42 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60140/tests/kraken/driver.html?testName=json-parse-financial) 11:51:42 INFO - PID 14491 | RSS: Main: 192151552 11:51:42 INFO - PID 14491 | 11:51:44 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60140/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:51:45 INFO - PID 14491 | RSS: Main: 190697472 11:51:45 INFO - PID 14491 | 11:51:46 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60140/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:51:47 INFO - PID 14491 | RSS: Main: 190918656 11:51:47 INFO - PID 14491 | 11:51:49 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60140/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:51:50 INFO - PID 14491 | RSS: Main: 188440576 11:51:50 INFO - PID 14491 | 11:51:52 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:51:53 INFO - PID 14491 | RSS: Main: 189259776 11:51:53 INFO - PID 14491 | 11:51:56 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:51:57 INFO - PID 14491 | RSS: Main: 188411904 11:51:57 INFO - PID 14491 | 11:51:58 INFO - PID 14491 | Cycle 1(1): loaded http://localhost:60140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60140/tests/kraken/driver.html?testName=ai-astar) 11:51:59 INFO - PID 14491 | RSS: Main: 191709184 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | __start_tp_report 11:51:59 INFO - PID 14491 | _x_x_mozilla_page_load 11:51:59 INFO - PID 14491 | _x_x_mozilla_page_load_details 11:51:59 INFO - PID 14491 | |i|pagename|runs| 11:51:59 INFO - PID 14491 | |0;ai-astar;111;112;109;117;107;106;106;112;107;107 11:51:59 INFO - PID 14491 | |1;audio-beat-detection;126;121;115;118;119;147;120;125;121;120 11:51:59 INFO - PID 14491 | |2;audio-dft;166;163;164;169;164;166;172;166;164;164 11:51:59 INFO - PID 14491 | |3;audio-fft;94;85;75;82;78;74;83;75;82;77 11:51:59 INFO - PID 14491 | |4;audio-oscillator;80;82;84;82;88;89;84;88;80;79 11:51:59 INFO - PID 14491 | |5;imaging-gaussian-blur;118;115;121;114;115;110;119;114;121;116 11:51:59 INFO - PID 14491 | |6;imaging-darkroom;147;149;150;148;148;155;148;148;155;148 11:51:59 INFO - PID 14491 | |7;imaging-desaturate;101;100;94;100;95;95;100;94;96;96 11:51:59 INFO - PID 14491 | |8;json-parse-financial;53;55;54;64;54;52;53;54;60;53 11:51:59 INFO - PID 14491 | |9;json-stringify-tinderbox;42;49;42;38;42;44;42;38;47;44 11:51:59 INFO - PID 14491 | |10;stanford-crypto-aes;83;74;80;85;74;75;78;76;80;72 11:51:59 INFO - PID 14491 | |11;stanford-crypto-ccm;119;118;114;123;120;114;130;112;119;110 11:51:59 INFO - PID 14491 | |12;stanford-crypto-pbkdf2;170;174;181;169;169;175;171;170;172;174 11:51:59 INFO - PID 14491 | |13;stanford-crypto-sha256-iterative;71;73;65;64;66;75;65;67;65;68 11:51:59 INFO - PID 14491 | __end_tp_report 11:51:59 INFO - PID 14491 | __start_cc_report 11:51:59 INFO - PID 14491 | _x_x_mozilla_cycle_collect,745 11:51:59 INFO - PID 14491 | __end_cc_report 11:51:59 INFO - PID 14491 | __startTimestamp1506451919216__endTimestamp 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | ------- Summary: start ------- 11:51:59 INFO - PID 14491 | Number of tests: 14 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:3.57 (3.2%) stddev-sans-first:3.73 11:51:59 INFO - PID 14491 | Values: 111.0 112.0 109.0 117.0 107.0 106.0 106.0 112.0 107.0 107.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#1] audio-beat-detection Cycles:10 Average:123.20 Median:121.00 stddev:8.94 (7.4%) stddev-sans-first:9.43 11:51:59 INFO - PID 14491 | Values: 126.0 121.0 115.0 118.0 119.0 147.0 120.0 125.0 121.0 120.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#2] audio-dft Cycles:10 Average:165.80 Median:166.00 stddev:2.78 (1.7%) stddev-sans-first:2.95 11:51:59 INFO - PID 14491 | Values: 166.0 163.0 164.0 169.0 164.0 166.0 172.0 166.0 164.0 164.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#3] audio-fft Cycles:10 Average:80.50 Median:82.00 stddev:6.10 (7.4%) stddev-sans-first:4.06 11:51:59 INFO - PID 14491 | Values: 94.0 85.0 75.0 82.0 78.0 74.0 83.0 75.0 82.0 77.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#4] audio-oscillator Cycles:10 Average:83.60 Median:84.00 stddev:3.66 (4.4%) stddev-sans-first:3.64 11:51:59 INFO - PID 14491 | Values: 80.0 82.0 84.0 82.0 88.0 89.0 84.0 88.0 80.0 79.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:117.00 stddev:3.47 (3.0%) stddev-sans-first:3.62 11:51:59 INFO - PID 14491 | Values: 118.0 115.0 121.0 114.0 115.0 110.0 119.0 114.0 121.0 116.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:148.50 stddev:2.95 (2.0%) stddev-sans-first:2.98 11:51:59 INFO - PID 14491 | Values: 147.0 149.0 150.0 148.0 148.0 155.0 148.0 148.0 155.0 148.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:94.50 stddev:2.81 (3.0%) stddev-sans-first:2.60 11:51:59 INFO - PID 14491 | Values: 101.0 100.0 94.0 100.0 95.0 95.0 100.0 94.0 96.0 96.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.00 stddev:3.79 (7.0%) stddev-sans-first:3.94 11:51:59 INFO - PID 14491 | Values: 53.0 55.0 54.0 64.0 54.0 52.0 53.0 54.0 60.0 53.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#9] json-stringify-tinderbox Cycles:10 Average:42.80 Median:43.00 stddev:3.46 (8.0%) stddev-sans-first:3.66 11:51:59 INFO - PID 14491 | Values: 42.0 49.0 42.0 38.0 42.0 44.0 42.0 38.0 47.0 44.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:79.00 stddev:4.24 (5.4%) stddev-sans-first:4.04 11:51:59 INFO - PID 14491 | Values: 83.0 74.0 80.0 85.0 74.0 75.0 78.0 76.0 80.0 72.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:119.00 stddev:5.84 (4.9%) stddev-sans-first:6.18 11:51:59 INFO - PID 14491 | Values: 119.0 118.0 114.0 123.0 120.0 114.0 130.0 112.0 119.0 110.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.00 stddev:3.69 (2.1%) stddev-sans-first:3.80 11:51:59 INFO - PID 14491 | Values: 170.0 174.0 181.0 169.0 169.0 175.0 171.0 170.0 172.0 174.0 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:3.81 (5.6%) stddev-sans-first:3.88 11:51:59 INFO - PID 14491 | Values: 71.0 73.0 65.0 64.0 66.0 75.0 65.0 67.0 65.0 68.0 11:51:59 INFO - PID 14491 | -------- Summary: end -------- 11:51:59 INFO - PID 14491 | 11:51:59 INFO - PID 14491 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:52:00 INFO - TEST-INFO | 14491: exit 0 11:52:00 INFO - TEST-OK | kraken | took 62179ms 11:52:00 INFO - SUITE-END | took 1173s 11:52:00 INFO - Completed test suite (00:19:33) 11:52:00 INFO - javascript benchmark 11:52:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8600.669177426691, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.1599868035632, 3111.5799367085438, 3120.516319970405, 3174.444472217361, 3186.060112266881, 6095.299040610331, 6213.937860621392, 6244.188255526781, 6299.65351905645, 6327.968360158193, 6166.198394208758, 6172.22847144107, 6195.7521699131985, 6209.658468784215, 6245.063240513925, 5711.885762284752, 5713.4572215639555, 5768.192453056576, 5768.3654797972185, 5844.824655260328, 5772.393898640646, 5838.095095260242, 5857.0, 5895.469407753301, 5924.88150236995, 54.70420954532059, 5655.293088363955, 5765.625234359774, 5852.356240813507, 5865.266841644794, 5640.746166422521, 5642.125470552071, 5726.627769194989, 5806.216160818278, 5806.245188125559, 5710.200571919934, 5721.71391430431, 5759.251297331362, 5775.422457754233, 5820.039693450575, 6093.847653808646, 6192.628442293477, 6237.469815065725, 6258.780942666985, 6288.465480434169, 6630.602163870135, 6645.568038077509, 6685.331466853324, 6742.494312926501, 6763.0193621924545, 6673.599584024974, 6700.128983232197, 6738.427233685143, 6752.088468056799, 6767.864642707118, 6016.639001659871, 6216.347283535209, 6221.96889015552, 6275.121482992385, 6300.968495157541, 6803.557768745065, 6927.757528486479, 6932.445404367639, 6958.965205173941, 6961.129858767654, 6552.705128269239, 6560.967195163994, 6600.933990660128, 6638.701258443381, 6643.40209381158, 6465.0, 6680.198376194888, 6695.832604184934, 6705.195376554844, 6744.696488657924, 6519.837004074841, 6557.803265901935, 6665.700043498055, 6670.566413183127, 6684.766033188912, 6687.364700353459, 6692.96653516739, 6715.56348837324, 6725.125733654593, 6757.324267573302, 5201.45384734605, 5261.868453288622, 5262.868428289246, 5266.868328291824, 5273.1035723927025, 4515.706479078849, 4547.977260113678, 4559.224931761609, 4581.5647513486165, 4582.0, 5554.527865131428, 5637.210790489335, 5669.489745922887, 5713.143028545752, 5755.769769209185, 6738.831529211711, 6749.392554670103, 6765.830854228585, 6770.018347339706, 6785.796426107225, 5709.571782116358, 5723.5707321950185, 5726.599138060295, 5772.0, 5796.942030579725, 5722.599418040697, 5745.253117094751, 5746.655200687972, 5817.7091145442555, 5818.95258853402, 6542.901856472156, 6555.0, 6560.147180866456, 6560.671966401661, 6573.408393244536, 6547.705353259114, 6560.606363618198, 6565.310642382481, 6589.406953374028, 6638.568493048033, 6316.715747791269, 6382.840428989312, 6508.056331831953, 6514.185726784152, 6522.28254891971, 6516.087747715418, 6647.368499992493, 6668.799936001928, 6668.899966500603, 6698.162729658793, 6481.967590162019, 6712.798616041527, 6721.663916804238, 6802.251752307143, 6805.829854253683, 6340.619562826245, 6409.391107844747, 6453.290138084901, 6457.321981191907, 6467.094606754964, 6399.328070552525, 6402.743890244525, 6432.6462044588, 6457.063725759833, 6464.838379040561, 6484.319146489739, 6494.318096599789, 6512.511561632802, 6532.183477065367, 6541.378569035934, 6587.505937054644, 6589.27517973013, 6671.499637527108, 6673.132492775908, 6677.933220667731, 6323.905141422791, 6332.651704156131, 6355.682215889095, 6372.681365931778, 6389.93610063912], "value": 6050.243648015249, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [871.9433236839606, 897.3808072430021, 902.5306840442973, 905.0858632780889, 907.4283201582998, 39116.41325380118, 42730.35904461431, 42847.57152428475, 42904.570954290444, 42994.140117197676, 39439.40840887389, 39463.210735785266, 39515.0, 39621.40567891484, 39666.20667586654, 7108.857822843527, 7212.0, 7240.0587923569865, 7254.9637251813665, 7265.673044712974, 7103.8224044398785, 7192.892106618378, 7246.637668116599, 7260.382867456273, 7292.088488938883, 7305.634718264092, 7328.596927169004, 7333.156686980986, 7334.853302933965, 7339.229380915007, 7261.346478816906, 7859.449838511335, 7973.242541958504, 8020.839583208362, 8021.2379823916635, 7845.646945887392, 7932.920670793276, 7954.244346787046, 7983.600819958979, 7996.800079997988, 37160.81419592885, 37556.0, 37714.24571508582, 39176.41235381472, 39284.0, 3436.6563343665684, 3481.1993241554333, 3482.2513159670793, 3485.0764547394706, 3490.5636795400574, 32365.190870228198, 32408.0, 32530.512042319384, 32589.348213035606, 32598.0, 4981.651284410093, 5012.27322038306, 5046.495350464961, 5050.065737838475, 5050.419201791804, 183984.0, 185877.0, 186961.0, 187174.99999999863, 187230.0, 43241.56758432438, 43711.562884371386, 48587.0, 48615.0, 48872.75563622159, 51545.48454515407, 52941.2058819118, 52987.470125298256, 53222.73388633032, 53713.1943020855, 15159.545213643609, 15197.240137993056, 15232.0, 15274.0, 15362.923185384001, 12322.260664360167, 12355.196912200678, 12358.62924112278, 12369.134160608852, 12389.93805030969, 14407.42370305176, 14471.493497727739, 14507.637309067357, 14514.475980022156, 14644.633884152981, 5679.204911312419, 5808.941910580925, 5881.264841894763, 5885.5585831062845, 5954.255718035246, 1004.8743907011624, 1010.4038617215878, 1019.4393083803878, 1028.953697083618, 1038.2472707287156, 23304.883475582512, 23385.0, 23660.053597856237, 23691.763082368954, 23903.0, 1113.6714669172613, 1122.141561705296, 1122.528538014036, 1124.612008856943, 1135.4039129456935, 12161.0, 12350.0, 12405.13164078524, 12450.937745311216, 12553.435095420546, 226014.0, 228372.0, 228990.0, 230270.0, 230494.0, 53971.0, 54439.72780136074, 54664.0, 54725.0, 54954.0, 1417.6526750945877, 1447.0594113825887, 1449.9565013049626, 1457.2932127917952, 1458.6936743283818, 22860.799488071352, 22882.0, 22936.655950160428, 23343.53312933766, 23472.0, 37668.62331376651, 38008.0, 38307.425388618634, 38316.42525362066, 38395.42406863955, 197838.0, 198281.0, 198768.0, 199332.0, 199768.0, 31572.526412104296, 35456.645433546364, 35745.1063723409, 36072.639273606925, 36101.638983609824, 44626.77686611546, 44740.0, 44779.776101119285, 45180.0, 45994.31008534808, 32094.35811283808, 32226.35547289088, 32267.51598725974, 32302.515462268555, 32450.0, 31701.841490792398, 31762.52356214705, 31803.0, 31881.521777172897, 32193.0, 36446.453303201, 36586.63413365939, 36710.63289367179, 36786.26427471489, 36833.26333473369, 31435.84282078575, 31587.526187107673, 31625.36749264956, 31734.841325793222, 31997.36005279928, 23135.190268340528, 23419.882900585388, 23470.0, 23555.0, 23586.646200307354], "value": 17137.51410266313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.744912238615, 584.5557376393942, 590.2326974932587, 614.612793939818, 628.5662892604104, 21994.34016979489, 22580.8870955645, 22713.432164195903, 22753.886230568867, 22761.203357882478, 23829.76170238297, 24129.879350603267, 25244.0, 25327.240182794547, 25653.87173064132, 6450.96774516128, 6598.802035938929, 6688.3646053624825, 6694.497912656546, 6697.665116744143, 6486.124373209604, 6517.315681853408, 6599.307072757363, 6665.266820649749, 6689.732410703566, 6723.966380168117, 6735.8652826943435, 6737.865242695168, 6746.0, 6748.325167483237, 6722.394984451374, 6729.158855143107, 6740.93259067408, 6742.629155396476, 6753.459723222155, 6048.637081775108, 6211.503079753609, 6239.937600624026, 6240.750369985195, 6252.937470625281, 29537.556936645968, 29868.55197172044, 29876.0, 29913.0, 29943.550846737315, 2007.1770574064562, 2042.9897850510802, 2045.0490521907236, 2047.9555426732325, 2058.2384517728538, 18413.171407286703, 18976.62046759071, 19114.23543058276, 19118.330858420028, 19521.316753913547, 2386.618141097416, 2411.1440438644204, 2432.914847980312, 2442.7435119312395, 2451.5832308507597, 116488.41755791167, 134583.32708336395, 140211.0, 147089.99999999892, 147834.0, 20077.0, 20734.896325518577, 21738.565358660337, 22146.778532214794, 22427.43931401728, 41010.79494602508, 41111.7944410276, 41239.381409278285, 41412.0, 41612.1677566453, 11349.773004540028, 11529.884701152881, 11556.88443115575, 11654.475548600334, 11665.183437159318, 9496.525173741424, 9556.904430955741, 9617.086376794194, 9754.658586949423, 9819.803603927881, 11060.446977651085, 11254.94372528132, 11290.0967922566, 11379.862013798554, 11425.428728563538, 3759.3045286622064, 4325.9134817303475, 4390.143921935192, 4457.24226881431, 4488.910221795546, 937.4422218779815, 946.8769060022153, 955.6894009446958, 959.4339339789558, 988.8912219655832, 19270.80729192718, 19463.80536194648, 19945.301914432926, 20158.69761953572, 20170.798292017185, 1013.852991316255, 1018.9439580823126, 1030.5620111452602, 1031.0617338222332, 1037.5019990404649, 10900.672979810619, 10956.726081848017, 11073.944630276797, 11116.61091861781, 11264.986151246427, 430347.0, 442062.0, 444772.0, 445384.0, 464478.0, 105848.0, 109234.45382773035, 109566.0, 109690.45154774174, 112252.43873780742, 1042.358949246208, 1164.190887333312, 1167.2646232873406, 1171.4552732979205, 1175.1010476985114, 17708.291668333124, 17742.822571774115, 18069.638607228044, 18116.0, 18167.90916045464, 55977.44022559722, 57436.0, 57887.131693023795, 58236.70881645565, 58551.70724146352, 70085.0, 70177.29822701708, 70727.64636176787, 71479.64260178666, 71783.64108179425, 19429.0, 19866.60266794627, 19967.700484493034, 19994.800051999293, 20229.49426264355, 22521.324360269216, 22707.772922270568, 22728.54152128389, 22741.20405785856, 23130.421739456648, 17819.287228510715, 18096.547586310448, 18303.176357063698, 18426.72359914629, 18657.0, 16422.096784676956, 16506.0, 16611.50165495037, 16881.240344184785, 16986.405475808286, 18079.005654689117, 18101.366452174112, 18415.17131729102, 18707.158177882302, 18755.531111722317, 19321.613567728287, 19475.220991160193, 19695.409137725892, 19780.208791648172, 19913.0, 18000.819991799915, 18163.63772717025, 18321.541961451072, 18324.175412106753, 18501.44495665132], "value": 12739.647520960752, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.643156347786, 1366.3509832829402, 1372.1492674541785, 1376.972460550789, 1382.2397681275302, 15120.546383608482, 15802.604934876634, 15890.920545397286, 15911.60220994473, 15911.920440397811, 15338.769918451233, 15461.226938653079, 15488.070715757034, 15507.922460387683, 15509.146996915166, 2741.5065288248056, 2833.688294287627, 2836.4610723962483, 2840.3609187932652, 2843.6161118249083, 2597.7141315049075, 2618.698849632288, 2642.9339266518396, 2646.179684297874, 2741.3968926836164, 2835.9858200709073, 2842.403095349979, 2850.1164638961886, 2859.3280579063903, 2872.8707208175683, 2706.7563919247264, 2727.8499682517454, 2730.5631099024063, 2742.2184677366854, 2742.369255071345, 2578.2523068310165, 2596.8961241550314, 2603.3231359846577, 2616.7644911957823, 2628.290361602376, 15006.24968751569, 15119.848801511955, 15292.311845966959, 15308.464203752927, 15319.617009574738, 8038.075621303508, 8314.542700151489, 8316.750497485085, 8317.750467485985, 8330.125336839666, 5099.33708617881, 5300.390455097675, 5368.865778355534, 5434.728263586805, 5451.918221226685, 1954.3257576136211, 1985.6723640599284, 2004.0, 2006.277740013594, 2061.814436700704, 27378.726212737816, 27440.725592744016, 27687.584686229722, 27718.3070423239, 27734.445311093667, 6964.129483814523, 7008.22909479967, 7054.118235220598, 7124.0, 7211.0, 17590.296388144587, 17609.647807043788, 17640.823591764176, 17643.647127057386, 17776.466705998842, 7829.217078292125, 8076.434649574591, 8124.268815806606, 8308.916910830936, 8563.486190828571, 7494.362979146725, 7565.848683026308, 7568.243175682498, 7573.848523029508, 7611.238876112345, 5304.9734751326, 5337.0, 5389.487998640201, 5408.648437851527, 5490.505854473036, 1440.4094321328205, 1472.786445965329, 1550.71311807316, 1550.8061492313461, 1598.8081430228215, 882.5940067568862, 908.8046070094962, 912.3066469483108, 930.5161316115582, 950.2872845365976, 8556.529390883437, 8580.95709521461, 8593.828123437495, 8846.646134154691, 8870.51212183336, 963.4026903319987, 1003.3077176748167, 1005.3163848582888, 1015.9332700664273, 1026.4457193115784, 5487.3263654585735, 5538.972305138448, 5563.860903477445, 5570.442955704478, 5633.774649014075, 21262.362129136152, 21662.566748665253, 22217.333479995625, 22242.88878555597, 22561.210357637403, 21602.351929442142, 21747.45631359197, 22276.77723222747, 22316.88841555782, 22378.55242895133, 11459.541618335339, 11668.88331116695, 11769.117316201147, 11773.352465614302, 11827.231229970024, 8292.460990035628, 8541.14588541141, 8580.528070956158, 8668.133186681282, 8685.435446695945, 17998.550036248675, 18463.53841153982, 18733.81266187375, 18888.772229805018, 19363.709544356563, 18862.71705924385, 19577.8042219576, 19611.0, 19713.1129099188, 20164.193432262546, 11433.970942615204, 11530.654080377602, 11541.769164616828, 11605.071594272269, 11611.941940290244, 14093.718125637635, 14097.295135243401, 14224.928875355557, 14350.712985740018, 14352.856471435569, 11429.885701142883, 11601.883981160418, 11880.108991825475, 11903.702407439538, 11916.225445346025, 11288.380343268425, 11337.26307789991, 11428.0, 11563.826542602035, 11581.884181158417, 10152.441615711206, 10318.793624127626, 10388.636397726043, 10401.84397234027, 10442.373457592568, 7339.70641174347, 7375.409967202718, 7414.295641914009, 7419.220981796833, 7462.291082347168, 7182.3535881770895, 7363.484556081023, 7383.446241531799, 7393.371563417169, 7480.551166929784], "value": 6841.031329671291, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.1438447447103, 516.1818517649525, 541.539691262427, 542.3356388424181, 543.1987817968494, 6142.20151380321, 6180.474659653929, 6243.313235544092, 6259.6870156492105, 6332.208473940757, 6141.60079594826, 6194.318624951263, 6214.378562143795, 6227.28386235583, 6233.189685340911, 5103.617228707843, 5137.126688462951, 5182.922256166161, 5198.9480105198845, 5206.609504287175, 4817.759112044401, 5184.53339199472, 5201.479852014787, 5234.136367499358, 5236.31927849379, 4945.4065512138595, 4968.875778105558, 4979.875503112415, 4983.800647974077, 4995.300657907896, 4917.262410638397, 4929.605631549467, 4931.26031095335, 4999.575036121916, 5014.699118052892, 4396.340548917656, 4459.331100334944, 4466.726982809883, 4486.685931984763, 4507.256302710081, 5981.371955944606, 6018.886505996405, 6063.423974722438, 6071.787487437919, 6113.266408031021, 5655.123455864347, 5705.001624715658, 5713.571482138815, 5755.971220143914, 5787.160861675034, 6518.576292541017, 6533.72592344493, 6569.0, 6582.835429114262, 6593.868122637568, 4696.530346965276, 4796.0, 4845.304143549764, 4869.123557759602, 4939.55544001038, 6662.300458451889, 6668.666566671695, 6698.4641228701585, 6771.51026774104, 6849.4177994871, 4944.456109827916, 4982.2775697524385, 5027.120253955543, 5028.4663177731145, 5055.595552355802, 5089.134847076006, 5111.718855462911, 5114.0, 5117.0, 5133.486651334837, 5436.0, 5608.989572455714, 5690.430956904359, 5699.686517241592, 5731.570132240098, 6531.5427920046095, 6538.1500404947055, 6620.371064748938, 6631.336866313427, 6636.668166591651, 1745.7468667043208, 1765.2056574541507, 1771.68109740248, 1776.786785585738, 1781.6792977264217, 1216.7566486702694, 1239.1449899569268, 1250.3123282194938, 1262.3057318474803, 1272.7009152849073, 5495.890082198333, 5505.256790333334, 5539.224508568804, 5566.693831839288, 5579.0, 6592.670366481657, 6621.635810030494, 6636.469082473391, 6683.722417652706, 6709.664516774239, 5502.697351645698, 5523.254360661259, 5527.364353099365, 5569.972150139304, 5585.0, 3448.37920183806, 3557.7687450316166, 3562.71498280137, 3572.1603374262277, 3580.803055831954, 6417.550771446047, 6425.839354016187, 6463.0, 6470.805875823733, 6477.664003038439, 6663.800085997428, 6753.358430949052, 6784.0841486399695, 6798.93201067983, 6803.795886123424, 6012.248468941382, 6235.657038862906, 6276.184096067482, 6415.615063096229, 6441.32366101562, 6532.5753826001155, 6598.208215014229, 6601.405873471411, 6625.4037136657935, 6694.564853284521, 6248.843778905563, 6622.37087476689, 6667.133272674715, 6667.8666426670225, 6687.933120668731, 6141.6007959482495, 6315.158178819458, 6337.524685648503, 6364.713587888648, 6446.419822216023, 4973.104841128632, 4974.925376119433, 4991.600671946163, 5000.924986125284, 5004.499550044967, 6638.20341559016, 6705.597664140168, 6710.798676039727, 6726.7981960541265, 6748.493862960199, 6409.871802563829, 6430.324815894451, 6446.967765161145, 6478.805635830932, 6517.283098859217, 6354.237491500865, 6451.387118223761, 6483.870322593616, 6500.577462464925, 6515.543911926309, 6274.717637706405, 6319.842003949938, 6333.018382150774, 6341.682915854281, 6394.5523813334485, 6381.501041765637, 6385.616862988236, 6425.7750978717395, 6484.157059582224, 6558.376954189344, 6257.5932564383165, 6285.517220697708, 6294.779682711083, 6309.589876658002, 6349.14286571307], "value": 5030.409880693299, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [924.4730503612943, 933.2021121940741, 938.6714649872541, 944.4946953379939, 952.9475878826667, 20269.290574829884, 21506.56986860262, 21514.677279840795, 21524.89237553812, 21544.56910861782, 19362.12870420831, 19593.0, 21429.892850535725, 22327.33018009458, 22423.103075876985, 916.7295647783919, 970.1511177719495, 982.6413359123904, 983.1201075037836, 983.233078199006, 974.512743628186, 1004.9849252261222, 1005.7485628592851, 1007.30999265503, 1009.7324209084599, 1042.2183362478142, 1045.8797238317616, 1045.9581616735322, 1047.586203449637, 1049.1397054415384, 1033.3231733214757, 1042.5985995391752, 1049.5486940615533, 1051.1433181956681, 1052.9052385285322, 765.4527013185543, 765.4947734495262, 771.4522688890838, 771.8842173673994, 774.1291047571482, 17351.91324043384, 17820.287188512444, 17823.376181833573, 18035.0, 18107.54731131719, 21895.233666821583, 22038.44903877416, 22318.21886233974, 22453.0, 22489.887550562144, 17414.825851741574, 17455.825441745546, 17544.210510527057, 17590.736138957927, 17595.824041759548, 3711.740178187528, 3713.3687273163628, 3720.9953312605717, 3722.571904230994, 3727.0682329417646, 139232.30383848117, 139882.1041263561, 140758.0, 141874.99999999898, 142867.0, 16258.105804180883, 16534.338626455046, 16740.58148546296, 16786.74819877703, 16862.40981565664, 31806.36387272288, 32065.51901721476, 32207.51688724671, 32441.837790811365, 32563.18592035218, 7822.491538050009, 8072.596370181467, 8320.251177394064, 8591.828163436696, 8639.049704532496, 4212.473440819897, 4285.292926667065, 4286.164197981426, 4287.142571485715, 4292.5707429257445, 5283.788648454096, 5361.27622770921, 5363.919541206885, 5442.210879422461, 5509.118541033496, 1073.6993641780314, 1088.6570730219955, 1090.6564432203832, 1098.2641630107687, 1102.52040362441, 612.6722203621131, 631.324482803396, 637.6174295422709, 641.5060403489381, 643.8969764837697, 11524.884751152382, 11695.982410553599, 11791.764164716658, 11909.404529773477, 11998.880011199777, 685.9039734437183, 701.8140192848899, 705.5801797930224, 710.1442761472414, 730.2952650692001, 5766.481016708432, 5787.826365209051, 5841.508981557323, 5887.264091988502, 5996.340402555716, 116947.41526292314, 119778.40110799564, 120276.0, 122060.0, 124225.0, 100581.0, 102765.48617256866, 103953.48023259835, 105191.4740426293, 105605.47197263964, 86040.0, 87806.0, 88352.5582372084, 91045.0, 91203.54398227966, 10512.335853561359, 10544.736381590521, 10705.143588513056, 10743.355398676105, 10847.13222942147, 42509.0, 43011.13977720366, 43222.0, 43846.56153438425, 44266.0, 56211.15683264836, 56375.43624563702, 57198.42801572097, 57991.71004144952, 58336.0, 15283.388664453742, 15393.30730117125, 15450.0, 15533.611659708598, 15601.921990389976, 16904.66190676204, 16963.7455438171, 17226.0, 17299.481015569552, 17903.641927161643, 14897.702045959237, 14914.477993270184, 15018.774718379014, 15041.924790375979, 15191.544253672408, 15081.849181508484, 15369.538913832603, 15412.768808467657, 15493.612659683598, 15538.922305388402, 14587.270636468347, 14608.269586520419, 14637.194954277616, 14686.926565367105, 14720.631984200481, 10621.362718236931, 10628.574857005633, 10725.30285531438, 10778.514966826355, 10880.401577912975, 12272.325022123869, 12287.75424491523, 12364.072694547765, 12495.125341226027, 12538.686532836387], "value": 8903.557633436103, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 109.0, 117.0, 107.0, 106.0, 106.0, 112.0, 107.0, 107.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 121.0, 115.0, 118.0, 119.0, 147.0, 120.0, 125.0, 121.0, 120.0], "value": 123.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 164.0, 169.0, 164.0, 166.0, 172.0, 166.0, 164.0, 164.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 85.0, 75.0, 82.0, 78.0, 74.0, 83.0, 75.0, 82.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 84.0, 82.0, 88.0, 89.0, 84.0, 88.0, 80.0, 79.0], "value": 83.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 121.0, 114.0, 115.0, 110.0, 119.0, 114.0, 121.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 150.0, 148.0, 148.0, 155.0, 148.0, 148.0, 155.0, 148.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 100.0, 94.0, 100.0, 95.0, 95.0, 100.0, 94.0, 96.0, 96.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 64.0, 54.0, 52.0, 53.0, 54.0, 60.0, 53.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 49.0, 42.0, 38.0, 42.0, 44.0, 42.0, 38.0, 47.0, 44.0], "value": 42.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 74.0, 80.0, 85.0, 74.0, 75.0, 78.0, 76.0, 80.0, 72.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 114.0, 123.0, 120.0, 114.0, 130.0, 112.0, 119.0, 110.0], "value": 117.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 181.0, 169.0, 169.0, 175.0, 171.0, 170.0, 172.0, 174.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 65.0, 64.0, 66.0, 75.0, 65.0, 67.0, 65.0, 68.0], "value": 67.9, "unit": "score"}]}]} 11:52:00 INFO - Return code: 0 11:52:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:52:00 INFO - # TBPL SUCCESS # 11:52:00 INFO - Running post-action listener: _package_coverage_data 11:52:00 INFO - Running post-action listener: _resource_record_post_action 11:52:00 INFO - [mozharness: 2017-09-26 18:52:00.524362Z] Finished run-tests step (success) 11:52:00 INFO - Running post-run listener: _resource_record_post_run 11:52:00 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 337899520; Read time: 12; Write time: 235460 11:52:00 INFO - TinderboxPrint: CPU usage
13.3% 11:52:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:52:00 INFO - TinderboxPrint: I/O write bytes / time
337,899,520 / 235,460 11:52:00 INFO - TinderboxPrint: CPU idle
8,237.6 (86.7%) 11:52:00 INFO - TinderboxPrint: CPU user
1,199.7 (12.6%) 11:52:00 INFO - TinderboxPrint: Swap in / out
0 / 0 11:52:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12824576; Read time: 0; Write time: 2072 11:52:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:52:00 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 324050944; Read time: 0; Write time: 233372 11:52:01 INFO - Running post-run listener: _upload_blobber_files 11:52:01 INFO - Blob upload gear active. 11:52:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:52:01 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 11:52:01 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'] 11:52:01 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 11:52:01 INFO - (blobuploader) - INFO - Open directory for files ... 11:52:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:52:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:52:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:02 INFO - (blobuploader) - INFO - Done attempting. 11:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:52:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:09 INFO - (blobuploader) - INFO - Done attempting. 11:52:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:52:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:52:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:10 INFO - (blobuploader) - INFO - Done attempting. 11:52:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:52:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:52:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:11 INFO - (blobuploader) - INFO - Done attempting. 11:52:11 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:11 INFO - Return code: 0 11:52:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adeb7095ab9081f2173dbe314b327b731d00748fcbcbc33aeae3abb429410301c21762e3d6b588b6c80f02fcc3e436987869e1b14e4fedb6073f0b9395f70fd9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38b62ee5e6d06fcdef7e384367e21b53f7bad2e670b7dbf74e206a2c3c51e2edbb6fbf46b3e4aec6f364ac0e52c81551d9bb5b516a55451032a2c5d6ed5b190b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3c5c90a6837754e66e4434167656b65e3e739147b18758ce7ef5a9c687559b468dc32398838d7aa4f74b4f0ed513b7b36bf2a3a6c4b900be94a7b5a4999ceda", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5237a030b52d8c69d217f59ee0da8c61be2e6049c05986dd0ad5ec99aa6753544bb4ec6b2c2fe1f4d6d3d50d09e47c62659e489cd24741ba9697a35f16d0f007"} 11:52:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:11 INFO - Contents: 11:52:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adeb7095ab9081f2173dbe314b327b731d00748fcbcbc33aeae3abb429410301c21762e3d6b588b6c80f02fcc3e436987869e1b14e4fedb6073f0b9395f70fd9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38b62ee5e6d06fcdef7e384367e21b53f7bad2e670b7dbf74e206a2c3c51e2edbb6fbf46b3e4aec6f364ac0e52c81551d9bb5b516a55451032a2c5d6ed5b190b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3c5c90a6837754e66e4434167656b65e3e739147b18758ce7ef5a9c687559b468dc32398838d7aa4f74b4f0ed513b7b36bf2a3a6c4b900be94a7b5a4999ceda", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5237a030b52d8c69d217f59ee0da8c61be2e6049c05986dd0ad5ec99aa6753544bb4ec6b2c2fe1f4d6d3d50d09e47c62659e489cd24741ba9697a35f16d0f007"} 11:52:11 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:11 INFO - Copying logs to upload dir... 11:52:11 INFO - mkdir: /builds/slave/test/build/upload/logs 11:52:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.010219 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-26 11:52:11.638932) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 11:52:11.642063) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adeb7095ab9081f2173dbe314b327b731d00748fcbcbc33aeae3abb429410301c21762e3d6b588b6c80f02fcc3e436987869e1b14e4fedb6073f0b9395f70fd9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38b62ee5e6d06fcdef7e384367e21b53f7bad2e670b7dbf74e206a2c3c51e2edbb6fbf46b3e4aec6f364ac0e52c81551d9bb5b516a55451032a2c5d6ed5b190b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3c5c90a6837754e66e4434167656b65e3e739147b18758ce7ef5a9c687559b468dc32398838d7aa4f74b4f0ed513b7b36bf2a3a6c4b900be94a7b5a4999ceda", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5237a030b52d8c69d217f59ee0da8c61be2e6049c05986dd0ad5ec99aa6753544bb4ec6b2c2fe1f4d6d3d50d09e47c62659e489cd24741ba9697a35f16d0f007"} build_url:https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.012084 build_url: 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adeb7095ab9081f2173dbe314b327b731d00748fcbcbc33aeae3abb429410301c21762e3d6b588b6c80f02fcc3e436987869e1b14e4fedb6073f0b9395f70fd9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38b62ee5e6d06fcdef7e384367e21b53f7bad2e670b7dbf74e206a2c3c51e2edbb6fbf46b3e4aec6f364ac0e52c81551d9bb5b516a55451032a2c5d6ed5b190b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3c5c90a6837754e66e4434167656b65e3e739147b18758ce7ef5a9c687559b468dc32398838d7aa4f74b4f0ed513b7b36bf2a3a6c4b900be94a7b5a4999ceda", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5237a030b52d8c69d217f59ee0da8c61be2e6049c05986dd0ad5ec99aa6753544bb4ec6b2c2fe1f4d6d3d50d09e47c62659e489cd24741ba9697a35f16d0f007"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 11:52:11.671947) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:52:11.672365) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1506450686.57195-174062922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:52:11.756050) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 11:52:11.756425) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 11:52:11.756883) ========= ========= Total master_lag: 0.74 =========