builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1506469945.76 results: success (0) revision: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:25.762790) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:25.763286) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:25.763570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:25.921736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:25.921998) ========= 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=9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 16:52:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 106M=0s 2017-09-26 16:52:26 (106 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157067 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.145062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.145354) ========= 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=9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021325 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.212623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.212966) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b7d8ae4a03c62e549b9d82595b1d1964f0af70cd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev b7d8ae4a03c62e549b9d82595b1d1964f0af70cd --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 16:52:26,307 truncating revision to first 12 chars 2017-09-26 16:52:26,307 Setting DEBUG logging. 2017-09-26 16:52:26,307 attempt 1/10 2017-09-26 16:52:26,307 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b7d8ae4a03c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 16:52:26,670 unpacking tar archive at: mozilla-central-b7d8ae4a03c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674953 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.956779) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.957071) ========= script_repo_revision: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.957430) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.957699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.983865) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-09-26 16:52:26.984158) ========= /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=9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:52:27 INFO - MultiFileLogger online at 20170926 16:52:27 in /builds/slave/test 16:52:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:52:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:52:27 INFO - {'append_to_log': False, 16:52:27 INFO - 'base_work_dir': '/builds/slave/test', 16:52:27 INFO - 'blob_upload_branch': 'Firefox', 16:52:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:52:27 INFO - 'branch': 'Firefox', 16:52:27 INFO - 'buildbot_json_path': 'buildprops.json', 16:52:27 INFO - 'code_coverage': False, 16:52:27 INFO - 'config_files': ('talos/linux_config.py',), 16:52:27 INFO - 'default_actions': ('clobber', 16:52:27 INFO - 'read-buildbot-config', 16:52:27 INFO - 'download-and-extract', 16:52:27 INFO - 'populate-webroot', 16:52:27 INFO - 'create-virtualenv', 16:52:27 INFO - 'install', 16:52:27 INFO - 'setup-mitmproxy', 16:52:27 INFO - 'run-tests'), 16:52:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:52:27 INFO - 'disable_ccov_upload': False, 16:52:27 INFO - 'disable_stylo': False, 16:52:27 INFO - 'download_minidump_stackwalk': True, 16:52:27 INFO - 'download_symbols': 'ondemand', 16:52:27 INFO - 'enable_stylo': False, 16:52:27 INFO - 'enable_webrender': False, 16:52:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:52:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:52:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:52:27 INFO - 'gecko_profile': False, 16:52:27 INFO - 'gecko_profile_interval': 0, 16:52:27 INFO - 'installer_path': 'installer.exe', 16:52:27 INFO - 'log_level': 'info', 16:52:27 INFO - 'log_name': 'talos', 16:52:27 INFO - 'log_to_console': True, 16:52:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:52:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:52:27 INFO - 'opt_config_files': (), 16:52:27 INFO - 'pip_index': False, 16:52:27 INFO - 'suite': 'dromaeojs-e10s', 16:52:27 INFO - 'system_bits': '32', 16:52:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:52:27 INFO - 'title': 'talos-linux64-ix-088', 16:52:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:52:27 INFO - 'use_talos_json': True, 16:52:27 INFO - 'verify': 'False', 16:52:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:52:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:52:27 INFO - 'work_dir': 'build'} 16:52:27 INFO - [mozharness: 2017-09-26 23:52:27.181361Z] Running clobber step. 16:52:27 INFO - Running pre-action listener: _resource_record_pre_action 16:52:27 INFO - Running main action method: clobber 16:52:27 INFO - rmtree: /builds/slave/test/build 16:52:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:52:28 INFO - Running post-action listener: _resource_record_post_action 16:52:28 INFO - [mozharness: 2017-09-26 23:52:28.178152Z] Finished clobber step (success) 16:52:28 INFO - [mozharness: 2017-09-26 23:52:28.178250Z] Running read-buildbot-config step. 16:52:28 INFO - Running pre-action listener: _resource_record_pre_action 16:52:28 INFO - Running main action method: read_buildbot_config 16:52:28 INFO - Using buildbot properties: 16:52:28 INFO - { 16:52:28 INFO - "project": "", 16:52:28 INFO - "product": "firefox", 16:52:28 INFO - "who": "kwierso@gmail.com", 16:52:28 INFO - "installer_path": "public/build/target.tar.bz2", 16:52:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 16:52:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:52:28 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 16:52:28 INFO - "stage_platform": "linux64-qr", 16:52:28 INFO - "basedir": "/builds/slave/test", 16:52:28 INFO - "buildnumber": 100, 16:52:28 INFO - "platform": "ubuntu64_hw_qr", 16:52:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:52:28 INFO - "slavebuilddir": "test", 16:52:28 INFO - "taskId": "JK2iZWc7TWuu29G_lM7tcA", 16:52:28 INFO - "branch": "mozilla-central", 16:52:28 INFO - "script_repo_revision": "production", 16:52:28 INFO - "revision": "b7d8ae4a03c62e549b9d82595b1d1964f0af70cd", 16:52:28 INFO - "slavename": "talos-linux64-ix-088", 16:52:28 INFO - "repo_path": "mozilla-central" 16:52:28 INFO - } 16:52:28 INFO - Finding installer, test and symbols from parent task. 16:52:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JK2iZWc7TWuu29G_lM7tcA'}, attempt #1 16:52:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JK2iZWc7TWuu29G_lM7tcA'}, attempt #1 16:52:29 INFO - Task dependencies: HLKvdi3eRuyWAkkyUmZMZA 16:52:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA'}, attempt #1 16:52:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2 16:52:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.test_packages.json 16:52:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.crashreporter-symbols.zip 16:52:29 INFO - Running post-action listener: _resource_record_post_action 16:52:29 INFO - [mozharness: 2017-09-26 23:52:29.574486Z] Finished read-buildbot-config step (success) 16:52:29 INFO - [mozharness: 2017-09-26 23:52:29.574704Z] Running download-and-extract step. 16:52:29 INFO - Running pre-action listener: _resource_record_pre_action 16:52:29 INFO - Running main action method: download_and_extract 16:52:29 INFO - mkdir: /builds/slave/test/build/tests 16:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:29 INFO - trying https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.test_packages.json 16:52:29 INFO - Downloading https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:52:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:52:30 INFO - Downloaded 989 bytes. 16:52:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:52:30 INFO - Using the following test package requirements: 16:52:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:52:30 INFO - u'common': [u'target.common.tests.zip'], 16:52:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:52:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:52:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:52:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:52:30 INFO - u'mozbase': [u'target.common.tests.zip'], 16:52:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:52:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:52:30 INFO - u'web-platform': [u'target.common.tests.zip', 16:52:30 INFO - u'target.web-platform.tests.tar.gz'], 16:52:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:52:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:52:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.common.tests.zip 16:52:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:52:30 INFO - Fetch https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.common.tests.zip into memory 16:52:34 INFO - Content-Length response header: 54945817 16:52:34 INFO - Bytes received: 54945817 16:52:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.talos.tests.zip 16:52:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:52:45 INFO - Fetch https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.talos.tests.zip into memory 16:52:46 INFO - Content-Length response header: 14513823 16:52:46 INFO - Bytes received: 14513823 16:52: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')]} 16:52:46 INFO - trying https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2 16:52:46 INFO - Downloading https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:52:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:52:51 INFO - Downloaded 61702688 bytes. 16:52:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2 16:52:51 INFO - mkdir: /builds/slave/test/properties 16:52:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:52:51 INFO - Writing to file /builds/slave/test/properties/build_url 16:52:51 INFO - Contents: 16:52:51 INFO - build_url:https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2 16:52:51 INFO - Running post-action listener: _resource_record_post_action 16:52:51 INFO - Running post-action listener: find_tests_for_verification 16:52:51 INFO - Running post-action listener: set_extra_try_arguments 16:52:51 INFO - [mozharness: 2017-09-26 23:52:51.373774Z] Finished download-and-extract step (success) 16:52:51 INFO - [mozharness: 2017-09-26 23:52:51.374004Z] Running populate-webroot step. 16:52:51 INFO - Running pre-action listener: _resource_record_pre_action 16:52:51 INFO - Running main action method: populate_webroot 16:52:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:52:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['tresize', 16:52:51 INFO - 'tcanvasmark']}, 16:52:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:52:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['dromaeo_css', 16:52:51 INFO - 'kraken']}, 16:52:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'tests': ['damp', 'tps']}, 16:52:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['damp', 'tps']}, 16:52:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:52:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['dromaeo_dom']}, 16:52:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:52:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['basic_compositor_video', 16:52:51 INFO - 'glvideo']}, 16:52:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:52:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['ts_paint_webext', 16:52:51 INFO - 'tp5o_webext']}, 16:52:51 INFO - 'other-e10s': {'tests': ['a11yr', 16:52:51 INFO - 'ts_paint', 16:52:51 INFO - 'tpaint', 16:52:51 INFO - 'sessionrestore', 16:52:51 INFO - 'sessionrestore_many_windows', 16:52:51 INFO - 'sessionrestore_no_auto_restore', 16:52:51 INFO - 'tabpaint']}, 16:52:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['a11yr', 16:52:51 INFO - 'ts_paint', 16:52:51 INFO - 'tpaint', 16:52:51 INFO - 'sessionrestore', 16:52:51 INFO - 'sessionrestore_many_windows', 16:52:51 INFO - 'sessionrestore_no_auto_restore', 16:52:51 INFO - 'tabpaint']}, 16:52:51 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:52:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:52:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['perf_reftest_singletons']}, 16:52:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['perf_reftest']}, 16:52:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:52:51 INFO - 'tsvgr_opacity', 16:52:51 INFO - 'tart', 16:52:51 INFO - 'tscrollx', 16:52:51 INFO - 'tsvg_static']}, 16:52:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['tsvgx', 16:52:51 INFO - 'tsvgr_opacity', 16:52:51 INFO - 'tart', 16:52:51 INFO - 'tscrollx', 16:52:51 INFO - 'tsvg_static']}, 16:52:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:52:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['tp5o']}, 16:52:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:52:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:52:51 INFO - 'talos_options': ['--mitmproxy', 16:52:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:52:51 INFO - '--firstNonBlankPaint'], 16:52:51 INFO - 'tests': ['tp6_google', 16:52:51 INFO - 'tp6_youtube', 16:52:51 INFO - 'tp6_amazon', 16:52:51 INFO - 'tp6_facebook']}, 16:52:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:52:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:52:51 INFO - 'talos_options': ['--disable-stylo', 16:52:51 INFO - '--mitmproxy', 16:52:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:52:51 INFO - '--firstNonBlankPaint'], 16:52:51 INFO - 'tests': ['tp6_google', 16:52:51 INFO - 'tp6_youtube', 16:52:51 INFO - 'tp6_amazon', 16:52:51 INFO - 'tp6_facebook']}, 16:52:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:52:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:52:51 INFO - 'talos_options': ['--stylo-threads=1', 16:52:51 INFO - '--mitmproxy', 16:52:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:52:51 INFO - '--firstNonBlankPaint'], 16:52:51 INFO - 'tests': ['tp6_google', 16:52:51 INFO - 'tp6_youtube', 16:52:51 INFO - 'tp6_amazon', 16:52:51 INFO - 'tp6_facebook']}, 16:52:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'talos_options': ['--xperf_path', 16:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:51 INFO - 'tests': ['tp5n']}, 16:52:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'talos_options': ['--disable-stylo', 16:52:51 INFO - '--xperf_path', 16:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:51 INFO - 'tests': ['tp5n']}}} 16:52:51 INFO - Running post-action listener: _resource_record_post_action 16:52:51 INFO - [mozharness: 2017-09-26 23:52:51.390814Z] Finished populate-webroot step (success) 16:52:51 INFO - [mozharness: 2017-09-26 23:52:51.390903Z] Running create-virtualenv step. 16:52:51 INFO - Running pre-action listener: _resource_record_pre_action 16:52:51 INFO - Running main action method: create_virtualenv 16:52:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:52:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:52:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:52:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:52:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:52:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:52:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:52:52 INFO - Installing pip...............done. 16:52:52 INFO - Return code: 0 16:52:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:52:52 INFO - Reading from file tmpfile_stdout 16:52:52 INFO - Output received: 16:52:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:52:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:52: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')]} 16:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52: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')]} 16:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b949c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b91d60>, '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 0x2b92a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', '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 16:52: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', 'pip>=1.5'] in /builds/slave/test/build 16:52: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 pip>=1.5 16:52:52 INFO - Using env: {'DISPLAY': ':0', 16:52:52 INFO - 'HOME': '/home/cltbld', 16:52:52 INFO - 'LANG': 'en_US.UTF-8', 16:52:52 INFO - 'LANGUAGE': 'en_US:en', 16:52:52 INFO - 'LOGNAME': 'cltbld', 16:52:52 INFO - 'MAIL': '/var/mail/cltbld', 16:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:52 INFO - 'MOZ_NO_REMOTE': '1', 16:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:52 INFO - 'NO_EM_RESTART': '1', 16:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:52 INFO - 'PWD': '/builds/slave/test', 16:52:52 INFO - 'SHELL': '/bin/bash', 16:52:52 INFO - 'SHLVL': '1', 16:52:52 INFO - 'TERM': 'linux', 16:52:52 INFO - 'TMOUT': '86400', 16:52:52 INFO - 'USER': 'cltbld', 16:52:52 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 16:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:52 INFO - '_': '/tools/buildbot/bin/python'} 16:52:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:52:54 INFO - Downloading/unpacking pip>=1.5 16:52:54 INFO - Running setup.py egg_info for package pip 16:52:54 INFO - warning: no files found matching 'pip/cacert.pem' 16:52:54 INFO - warning: no files found matching '*.html' under directory 'docs' 16:52:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:52:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:52:54 INFO - Installing collected packages: pip 16:52:54 INFO - Found existing installation: pip 1.1 16:52:54 INFO - Uninstalling pip: 16:52:54 INFO - Successfully uninstalled pip 16:52:54 INFO - Running setup.py install for pip 16:52:54 INFO - warning: no files found matching 'pip/cacert.pem' 16:52:54 INFO - warning: no files found matching '*.html' under directory 'docs' 16:52:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:52:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:52:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:52:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:52:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:52:54 INFO - Successfully installed pip 16:52:54 INFO - Cleaning up... 16:52:54 INFO - Return code: 0 16:52:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:52: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')]} 16:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52: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')]} 16:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52: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', '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 0x28271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b949c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b91d60>, '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 0x2b92a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', '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 16:52: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:52: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 psutil>=3.1.1 16:52:54 INFO - Using env: {'DISPLAY': ':0', 16:52:54 INFO - 'HOME': '/home/cltbld', 16:52:54 INFO - 'LANG': 'en_US.UTF-8', 16:52:54 INFO - 'LANGUAGE': 'en_US:en', 16:52:54 INFO - 'LOGNAME': 'cltbld', 16:52:54 INFO - 'MAIL': '/var/mail/cltbld', 16:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:54 INFO - 'MOZ_NO_REMOTE': '1', 16:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:54 INFO - 'NO_EM_RESTART': '1', 16:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:54 INFO - 'PWD': '/builds/slave/test', 16:52:54 INFO - 'SHELL': '/bin/bash', 16:52:54 INFO - 'SHLVL': '1', 16:52:54 INFO - 'TERM': 'linux', 16:52:54 INFO - 'TMOUT': '86400', 16:52:54 INFO - 'USER': 'cltbld', 16:52:54 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 16:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:54 INFO - '_': '/tools/buildbot/bin/python'} 16:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:54 INFO - Downloading/unpacking psutil>=3.1.1 16:52: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 16:52: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 16:52: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 16:52: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 16:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:52:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:56 INFO - Installing collected packages: psutil 16:52:56 INFO - Running setup.py install for psutil 16:52:56 INFO - building 'psutil._psutil_linux' extension 16:52:56 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 16:52:56 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 16:52:56 INFO - building 'psutil._psutil_posix' extension 16:52:56 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 16:52:56 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 16:52:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:56 INFO - Successfully installed psutil 16:52:56 INFO - Cleaning up... 16:52:57 INFO - Return code: 0 16:52:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b949c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b91d60>, '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 0x2b92a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', '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 16:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:52:57 INFO - Using env: {'DISPLAY': ':0', 16:52:57 INFO - 'HOME': '/home/cltbld', 16:52:57 INFO - 'LANG': 'en_US.UTF-8', 16:52:57 INFO - 'LANGUAGE': 'en_US:en', 16:52:57 INFO - 'LOGNAME': 'cltbld', 16:52:57 INFO - 'MAIL': '/var/mail/cltbld', 16:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:57 INFO - 'MOZ_NO_REMOTE': '1', 16:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:57 INFO - 'NO_EM_RESTART': '1', 16:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:57 INFO - 'PWD': '/builds/slave/test', 16:52:57 INFO - 'SHELL': '/bin/bash', 16:52:57 INFO - 'SHLVL': '1', 16:52:57 INFO - 'TERM': 'linux', 16:52:57 INFO - 'TMOUT': '86400', 16:52:57 INFO - 'USER': 'cltbld', 16:52:57 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 16:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:57 INFO - '_': '/tools/buildbot/bin/python'} 16:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:52:58 INFO - Installing collected packages: mozsystemmonitor 16:52:58 INFO - Running setup.py install for mozsystemmonitor 16:52:58 INFO - Successfully installed mozsystemmonitor 16:52:58 INFO - Cleaning up... 16:52:59 INFO - Return code: 0 16:52:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:52: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')]} 16:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52: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')]} 16:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:59 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 0x28271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b949c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b91d60>, '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 0x2b92a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', '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 16:52:59 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 16:52:59 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 16:52:59 INFO - Using env: {'DISPLAY': ':0', 16:52:59 INFO - 'HOME': '/home/cltbld', 16:52:59 INFO - 'LANG': 'en_US.UTF-8', 16:52:59 INFO - 'LANGUAGE': 'en_US:en', 16:52:59 INFO - 'LOGNAME': 'cltbld', 16:52:59 INFO - 'MAIL': '/var/mail/cltbld', 16:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:59 INFO - 'MOZ_NO_REMOTE': '1', 16:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:59 INFO - 'NO_EM_RESTART': '1', 16:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:59 INFO - 'PWD': '/builds/slave/test', 16:52:59 INFO - 'SHELL': '/bin/bash', 16:52:59 INFO - 'SHLVL': '1', 16:52:59 INFO - 'TERM': 'linux', 16:52:59 INFO - 'TMOUT': '86400', 16:52:59 INFO - 'USER': 'cltbld', 16:52:59 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 16:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:59 INFO - '_': '/tools/buildbot/bin/python'} 16:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:59 INFO - Downloading/unpacking jsonschema==2.5.1 16:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:53:00 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 16:53:00 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 16:53:00 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 16:53:00 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 16:53:00 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:00 INFO - warning: no files found matching '*.txt' 16:53:00 INFO - no previously-included directories found matching 'build' 16:53:00 INFO - no previously-included directories found matching 'dist' 16:53:00 INFO - no previously-included directories found matching '.git*' 16:53:00 INFO - Installing collected packages: jsonschema, functools32 16:53:00 INFO - Running setup.py install for functools32 16:53:00 INFO - warning: no files found matching '*.txt' 16:53:00 INFO - no previously-included directories found matching 'build' 16:53:00 INFO - no previously-included directories found matching 'dist' 16:53:00 INFO - no previously-included directories found matching '.git*' 16:53:00 INFO - Successfully installed jsonschema functools32 16:53:00 INFO - Cleaning up... 16:53:00 INFO - Return code: 0 16:53:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:00 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 0x28271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b949c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b91d60>, '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 0x2b92a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', '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 16:53:00 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 16:53:00 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 16:53:00 INFO - Using env: {'DISPLAY': ':0', 16:53:00 INFO - 'HOME': '/home/cltbld', 16:53:00 INFO - 'LANG': 'en_US.UTF-8', 16:53:00 INFO - 'LANGUAGE': 'en_US:en', 16:53:00 INFO - 'LOGNAME': 'cltbld', 16:53:00 INFO - 'MAIL': '/var/mail/cltbld', 16:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:00 INFO - 'MOZ_NO_REMOTE': '1', 16:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:00 INFO - 'NO_EM_RESTART': '1', 16:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:00 INFO - 'PWD': '/builds/slave/test', 16:53:00 INFO - 'SHELL': '/bin/bash', 16:53:00 INFO - 'SHLVL': '1', 16:53:00 INFO - 'TERM': 'linux', 16:53:00 INFO - 'TMOUT': '86400', 16:53:00 INFO - 'USER': 'cltbld', 16:53:00 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 16:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:00 INFO - '_': '/tools/buildbot/bin/python'} 16:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:53:01 INFO - Cleaning up... 16:53:01 INFO - Return code: 0 16:53:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:01 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 0x28271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b949c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b91d60>, '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 0x2b92a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', '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 16:53:01 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 16:53:01 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 16:53:01 INFO - Using env: {'DISPLAY': ':0', 16:53:01 INFO - 'HOME': '/home/cltbld', 16:53:01 INFO - 'LANG': 'en_US.UTF-8', 16:53:01 INFO - 'LANGUAGE': 'en_US:en', 16:53:01 INFO - 'LOGNAME': 'cltbld', 16:53:01 INFO - 'MAIL': '/var/mail/cltbld', 16:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:01 INFO - 'MOZ_NO_REMOTE': '1', 16:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:01 INFO - 'NO_EM_RESTART': '1', 16:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:01 INFO - 'PWD': '/builds/slave/test', 16:53:01 INFO - 'SHELL': '/bin/bash', 16:53:01 INFO - 'SHLVL': '1', 16:53:01 INFO - 'TERM': 'linux', 16:53:01 INFO - 'TMOUT': '86400', 16:53:01 INFO - 'USER': 'cltbld', 16:53:01 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 16:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:01 INFO - '_': '/tools/buildbot/bin/python'} 16:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:01 INFO - Downloading/unpacking blobuploader==1.2.4 16:53:01 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 16:53:01 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 16:53:01 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 16:53:01 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 16:53:02 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:53:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:02 INFO - Downloading docopt-0.6.1.tar.gz 16:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:02 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:02 INFO - Running setup.py install for blobuploader 16:53:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:53:03 INFO - Running setup.py install for requests 16:53:03 INFO - Running setup.py install for docopt 16:53:03 INFO - Successfully installed blobuploader requests docopt 16:53:03 INFO - Cleaning up... 16:53:03 INFO - Return code: 0 16:53:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:03 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 0x28271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b949c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b91d60>, '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 0x2b92a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', '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 16:53:03 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 16:53:03 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 16:53:03 INFO - Using env: {'DISPLAY': ':0', 16:53:03 INFO - 'HOME': '/home/cltbld', 16:53:03 INFO - 'LANG': 'en_US.UTF-8', 16:53:03 INFO - 'LANGUAGE': 'en_US:en', 16:53:03 INFO - 'LOGNAME': 'cltbld', 16:53:03 INFO - 'MAIL': '/var/mail/cltbld', 16:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:03 INFO - 'MOZ_NO_REMOTE': '1', 16:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:03 INFO - 'NO_EM_RESTART': '1', 16:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:03 INFO - 'PWD': '/builds/slave/test', 16:53:03 INFO - 'SHELL': '/bin/bash', 16:53:03 INFO - 'SHLVL': '1', 16:53:03 INFO - 'TERM': 'linux', 16:53:03 INFO - 'TMOUT': '86400', 16:53:03 INFO - 'USER': 'cltbld', 16:53:03 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 16:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:03 INFO - '_': '/tools/buildbot/bin/python'} 16:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:03 INFO - Running setup.py (path:/tmp/pip-Yf6bvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:03 INFO - Running setup.py (path:/tmp/pip-aCtJ5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:03 INFO - Running setup.py (path:/tmp/pip-o5TQ3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:03 INFO - Running setup.py (path:/tmp/pip-FX1xoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:03 INFO - Running setup.py (path:/tmp/pip-4Iam8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:04 INFO - Running setup.py (path:/tmp/pip-Msnaoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:04 INFO - Running setup.py (path:/tmp/pip-ch9nUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:04 INFO - Running setup.py (path:/tmp/pip-RXqXuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:04 INFO - Running setup.py (path:/tmp/pip-605j3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:04 INFO - Running setup.py (path:/tmp/pip-pu8NrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:04 INFO - Running setup.py (path:/tmp/pip-d0gcsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:04 INFO - Running setup.py (path:/tmp/pip-blvAQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:04 INFO - Running setup.py (path:/tmp/pip-Ebzo9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:04 INFO - Running setup.py (path:/tmp/pip-7LEgG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:04 INFO - Running setup.py (path:/tmp/pip-51ILPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:04 INFO - Running setup.py (path:/tmp/pip-LNyIVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:04 INFO - Running setup.py (path:/tmp/pip-uPGcYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:04 INFO - Running setup.py install for manifestparser 16:53:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozcrash 16:53:05 INFO - Running setup.py install for mozdebug 16:53:05 INFO - Running setup.py install for mozdevice 16:53:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozfile 16:53:05 INFO - Running setup.py install for mozhttpd 16:53:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozinfo 16:53:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozInstall 16:53:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozleak 16:53:05 INFO - Running setup.py install for mozlog 16:53:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for moznetwork 16:53:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Running setup.py install for mozprocess 16:53:06 INFO - Running setup.py install for mozprofile 16:53:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Running setup.py install for mozrunner 16:53:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Running setup.py install for mozscreenshot 16:53:06 INFO - Running setup.py install for moztest 16:53:06 INFO - Running setup.py install for mozversion 16:53:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:53:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:06 INFO - Cleaning up... 16:53:06 INFO - Return code: 0 16:53:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:06 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 0x28271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b949c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b91d60>, '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 0x2b92a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', '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 16:53:06 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 16:53:06 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 16:53:06 INFO - Using env: {'DISPLAY': ':0', 16:53:06 INFO - 'HOME': '/home/cltbld', 16:53:06 INFO - 'LANG': 'en_US.UTF-8', 16:53:06 INFO - 'LANGUAGE': 'en_US:en', 16:53:06 INFO - 'LOGNAME': 'cltbld', 16:53:06 INFO - 'MAIL': '/var/mail/cltbld', 16:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:06 INFO - 'MOZ_NO_REMOTE': '1', 16:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:06 INFO - 'NO_EM_RESTART': '1', 16:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:06 INFO - 'PWD': '/builds/slave/test', 16:53:06 INFO - 'SHELL': '/bin/bash', 16:53:06 INFO - 'SHLVL': '1', 16:53:06 INFO - 'TERM': 'linux', 16:53:06 INFO - 'TMOUT': '86400', 16:53:06 INFO - 'USER': 'cltbld', 16:53:06 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 16:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:06 INFO - '_': '/tools/buildbot/bin/python'} 16:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:06 INFO - Running setup.py (path:/tmp/pip-lxasdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:06 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)) 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:06 INFO - Running setup.py (path:/tmp/pip-ARPqzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:07 INFO - Running setup.py (path:/tmp/pip-FSSvzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:07 INFO - Running setup.py (path:/tmp/pip-eInoPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:07 INFO - Running setup.py (path:/tmp/pip-hCFgsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:07 INFO - Running setup.py (path:/tmp/pip-S36XYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:07 INFO - Running setup.py (path:/tmp/pip-z5lvuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:07 INFO - Running setup.py (path:/tmp/pip-RzLE4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:07 INFO - Running setup.py (path:/tmp/pip-Uy1A78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:07 INFO - Running setup.py (path:/tmp/pip-ohxlGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:07 INFO - Running setup.py (path:/tmp/pip-4skaZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:07 INFO - Running setup.py (path:/tmp/pip-1da1JD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:07 INFO - Running setup.py (path:/tmp/pip-w70oYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:07 INFO - Running setup.py (path:/tmp/pip-h9jovX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:07 INFO - Running setup.py (path:/tmp/pip-x2Pzwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:07 INFO - Running setup.py (path:/tmp/pip-26JQpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:08 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)) 16:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:08 INFO - Running setup.py (path:/tmp/pip-_kzU1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:08 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 16:53:08 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 16:53:08 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 16:53:08 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 16:53:09 INFO - Downloading blessings-1.6.tar.gz 16:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:09 INFO - Installing collected packages: blessings 16:53:09 INFO - Running setup.py install for blessings 16:53:09 INFO - Successfully installed blessings 16:53:09 INFO - Cleaning up... 16:53:09 INFO - Return code: 0 16:53:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:53:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:09 INFO - Reading from file tmpfile_stdout 16:53:09 INFO - Current package versions: 16:53:09 INFO - argparse == 1.2.1 16:53:09 INFO - blessings == 1.6 16:53:09 INFO - blobuploader == 1.2.4 16:53:09 INFO - docopt == 0.6.1 16:53:09 INFO - functools32 == 3.2.3-2 16:53:09 INFO - jsonschema == 2.5.1 16:53:09 INFO - manifestparser == 1.1 16:53:09 INFO - mozInstall == 1.13 16:53:09 INFO - mozcrash == 1.0 16:53:09 INFO - mozdebug == 0.1 16:53:09 INFO - mozdevice == 0.51 16:53:09 INFO - mozfile == 1.2 16:53:09 INFO - mozhttpd == 0.7 16:53:09 INFO - mozinfo == 0.10 16:53:09 INFO - mozleak == 0.1 16:53:09 INFO - mozlog == 3.5 16:53:09 INFO - moznetwork == 0.27 16:53:09 INFO - mozprocess == 0.25 16:53:09 INFO - mozprofile == 0.28 16:53:09 INFO - mozrunner == 6.13 16:53:09 INFO - mozscreenshot == 0.1 16:53:09 INFO - mozsystemmonitor == 0.3 16:53:09 INFO - moztest == 0.8 16:53:09 INFO - mozversion == 1.4 16:53:09 INFO - psutil == 3.1.1 16:53:09 INFO - requests == 1.2.3 16:53:09 INFO - wsgiref == 0.1.2 16:53:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:09 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 0x28271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b949c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b91d60>, '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 0x2b92a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', '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 16:53:09 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 16:53:09 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 16:53:09 INFO - Using env: {'DISPLAY': ':0', 16:53:09 INFO - 'HOME': '/home/cltbld', 16:53:09 INFO - 'LANG': 'en_US.UTF-8', 16:53:09 INFO - 'LANGUAGE': 'en_US:en', 16:53:09 INFO - 'LOGNAME': 'cltbld', 16:53:09 INFO - 'MAIL': '/var/mail/cltbld', 16:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:09 INFO - 'MOZ_NO_REMOTE': '1', 16:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:09 INFO - 'NO_EM_RESTART': '1', 16:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:09 INFO - 'PWD': '/builds/slave/test', 16:53:09 INFO - 'SHELL': '/bin/bash', 16:53:09 INFO - 'SHLVL': '1', 16:53:09 INFO - 'TERM': 'linux', 16:53:09 INFO - 'TMOUT': '86400', 16:53:09 INFO - 'USER': 'cltbld', 16:53:09 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 16:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:09 INFO - '_': '/tools/buildbot/bin/python'} 16:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:53:09 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 16:53:09 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 16:53:09 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 16:53:09 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 16:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:53:11 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)) 16:53:11 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)) 16:53:11 INFO - Installing collected packages: simplejson 16:53:11 INFO - Running setup.py install for simplejson 16:53:11 INFO - building 'simplejson._speedups' extension 16:53:11 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 16:53:11 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 16:53:12 INFO - Successfully installed simplejson 16:53:12 INFO - Cleaning up... 16:53:12 INFO - Return code: 0 16:53:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:53:12 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')]} 16:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:12 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')]} 16:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:12 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 0x28271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b949c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b91d60>, '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 0x2b92a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92ef0>, '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': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', '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 16:53:12 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 16:53:12 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 16:53:12 INFO - Using env: {'DISPLAY': ':0', 16:53:12 INFO - 'HOME': '/home/cltbld', 16:53:12 INFO - 'LANG': 'en_US.UTF-8', 16:53:12 INFO - 'LANGUAGE': 'en_US:en', 16:53:12 INFO - 'LOGNAME': 'cltbld', 16:53:12 INFO - 'MAIL': '/var/mail/cltbld', 16:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:12 INFO - 'MOZ_NO_REMOTE': '1', 16:53:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:12 INFO - 'NO_EM_RESTART': '1', 16:53:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:12 INFO - 'PWD': '/builds/slave/test', 16:53:12 INFO - 'SHELL': '/bin/bash', 16:53:12 INFO - 'SHLVL': '1', 16:53:12 INFO - 'TERM': 'linux', 16:53:12 INFO - 'TMOUT': '86400', 16:53:12 INFO - 'USER': 'cltbld', 16:53:12 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 16:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:12 INFO - '_': '/tools/buildbot/bin/python'} 16:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:53:12 INFO - Cleaning up... 16:53:12 INFO - Return code: 0 16:53:12 INFO - Running post-action listener: _resource_record_post_action 16:53:12 INFO - Running post-action listener: _start_resource_monitoring 16:53:12 INFO - Starting resource monitoring. 16:53:12 INFO - [mozharness: 2017-09-26 23:53:12.380073Z] Finished create-virtualenv step (success) 16:53:12 INFO - [mozharness: 2017-09-26 23:53:12.380617Z] Running install step. 16:53:12 INFO - Running pre-action listener: _resource_record_pre_action 16:53:12 INFO - Running main action method: install 16:53:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:12 INFO - Reading from file tmpfile_stdout 16:53:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:53:12 INFO - Reading from file tmpfile_stdout 16:53:12 INFO - Output received: 16:53:12 INFO - Usage: mozinstall [options] installer 16:53:12 INFO - Options: 16:53:12 INFO - -h, --help show this help message and exit 16:53:12 INFO - -d DEST, --destination=DEST 16:53:12 INFO - Directory to install application into. [default: 16:53:12 INFO - "/builds/slave/test"] 16:53:12 INFO - --app=APP Application being installed. [default: firefox] 16:53:12 INFO - mkdir: /builds/slave/test/build/application 16:53:12 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'] 16:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:53:30 INFO - Reading from file tmpfile_stdout 16:53:30 INFO - Output received: 16:53:30 INFO - /builds/slave/test/build/application/firefox/firefox 16:53:30 INFO - Running post-action listener: _resource_record_post_action 16:53:30 INFO - [mozharness: 2017-09-26 23:53:30.602766Z] Finished install step (success) 16:53:30 INFO - [mozharness: 2017-09-26 23:53:30.603016Z] Running setup-mitmproxy step. 16:53:30 INFO - Running pre-action listener: _resource_record_pre_action 16:53:30 INFO - Running main action method: setup_mitmproxy 16:53:30 INFO - Skipping: mitmproxy is not required 16:53:30 INFO - Running post-action listener: _resource_record_post_action 16:53:30 INFO - [mozharness: 2017-09-26 23:53:30.604208Z] Finished setup-mitmproxy step (success) 16:53:30 INFO - [mozharness: 2017-09-26 23:53:30.604438Z] Running run-tests step. 16:53:30 INFO - Running pre-action listener: _resource_record_pre_action 16:53:30 INFO - Running pre-action listener: _set_gcov_prefix 16:53:30 INFO - Running main action method: run_tests 16:53:30 WARNING - Try message not found. 16:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:53:30 INFO - Python 2.7.3 16:53:30 INFO - Return code: 0 16:53:30 INFO - grabbing minidump binary from tooltool 16:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:30 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 0x2b91d60>, '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 0x2b92a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:53:30 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 16:53:30 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 16:53:30 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 16:53:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:53:30 INFO - Return code: 0 16:53:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:53:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:53:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:53:30 INFO - ENV: RUST_BACKTRACE is now full 16:53:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:53:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:53:30 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/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 16:53:30 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/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 16:53:30 INFO - Using env: {'DISPLAY': ':0', 16:53:30 INFO - 'HOME': '/home/cltbld', 16:53:30 INFO - 'LANG': 'en_US.UTF-8', 16:53:30 INFO - 'LANGUAGE': 'en_US:en', 16:53:30 INFO - 'LOGNAME': 'cltbld', 16:53:30 INFO - 'MAIL': '/var/mail/cltbld', 16:53:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:30 INFO - 'MOZ_ACCELERATED': '1', 16:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:30 INFO - 'MOZ_NO_REMOTE': '1', 16:53:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:30 INFO - 'MOZ_WEBRENDER': '1', 16:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:30 INFO - 'NO_EM_RESTART': '1', 16:53:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:30 INFO - 'PWD': '/builds/slave/test', 16:53:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:30 INFO - 'RUST_BACKTRACE': 'full', 16:53:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:53:30 INFO - 'SHELL': '/bin/bash', 16:53:30 INFO - 'SHLVL': '1', 16:53:30 INFO - 'TERM': 'linux', 16:53:30 INFO - 'TMOUT': '86400', 16:53:30 INFO - 'USER': 'cltbld', 16:53:30 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 16:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:30 INFO - '_': '/tools/buildbot/bin/python'} 16:53:30 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/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 16:53:30 INFO - mozversion application_buildid: 20170926225505 16:53:30 INFO - mozversion application_changeset: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd 16:53:30 INFO - mozversion application_display_name: Nightly 16:53:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:53:30 INFO - mozversion application_name: Firefox 16:53:30 INFO - mozversion application_remotingname: firefox 16:53:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:53:30 INFO - mozversion application_vendor: Mozilla 16:53:30 INFO - mozversion application_version: 58.0a1 16:53:30 INFO - mozversion platform_buildid: 20170926225505 16:53:30 INFO - mozversion platform_changeset: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd 16:53:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:53:30 INFO - mozversion platform_version: 58.0a1 16:53:30 INFO - using testdate: 1506470010 16:53:30 INFO - actual date: 1506470010 16:53:30 INFO - starting webserver on 'localhost:58616' 16:53:30 INFO - SUITE-START | Running 2 tests 16:53:30 INFO - TEST-START | dromaeo_css 16:53:30 INFO - Initialising browser for dromaeo_css test... 16:53:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58616/getInfo.html -profile /tmp/tmprTWsNH/profile 16:53:30 INFO - TEST-INFO | started process 22828 (/builds/slave/test/build/application/firefox/firefox http://localhost:58616/getInfo.html) 16:53:37 INFO - TEST-INFO | 22828: exit 0 16:53:37 INFO - Browser initialized. 16:53:37 INFO - Running cycle 1/1 for dromaeo_css test... 16:53:37 INFO - Using env: {'DISPLAY': ':0', 16:53:37 INFO - 'HOME': '/home/cltbld', 16:53:37 INFO - 'JSGC_DISABLE_POISONING': '1', 16:53:37 INFO - 'LANG': 'en_US.UTF-8', 16:53:37 INFO - 'LANGUAGE': 'en_US:en', 16:53:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:53:37 INFO - 'LOGNAME': 'cltbld', 16:53:37 INFO - 'MAIL': '/var/mail/cltbld', 16:53:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:37 INFO - 'MOZ_ACCELERATED': '1', 16:53:37 INFO - 'MOZ_CRASHREPORTER': '1', 16:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:53:37 INFO - 'MOZ_NO_REMOTE': '1', 16:53:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:37 INFO - 'MOZ_WEBRENDER': '1', 16:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:37 INFO - 'NO_EM_RESTART': '1', 16:53:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:37 INFO - 'PWD': '/builds/slave/test', 16:53:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:37 INFO - 'RUST_BACKTRACE': 'full', 16:53:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:53:37 INFO - 'SHELL': '/bin/bash', 16:53:37 INFO - 'SHLVL': '1', 16:53:37 INFO - 'TERM': 'linux', 16:53:37 INFO - 'TMOUT': '86400', 16:53:37 INFO - 'USER': 'cltbld', 16:53:37 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 16:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:37 INFO - '_': '/tools/buildbot/bin/python'} 16:53:37 INFO - TEST-INFO | started process 23076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprTWsNH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:38 INFO - PID 23076 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:53:38 INFO - PID 23076 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:53:38 INFO - PID 23076 | 16:53:38 INFO - PID 23076 | (/builds/slave/test/build/application/firefox/firefox:23136): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:53:38 INFO - PID 23076 | 16:53:49 INFO - PID 23076 | RSS: Main: 189403136 16:53:49 INFO - PID 23076 | 16:56:46 INFO - PID 23076 | Cycle 1(1): loaded http://localhost:58616/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58616/tests/dromaeo/cssquery-ext.html) 16:56:48 INFO - PID 23076 | RSS: Main: 200146944 16:56:48 INFO - PID 23076 | 16:59:50 INFO - PID 23076 | Cycle 1(1): loaded http://localhost:58616/tests/dromaeo/cssquery-ext.html (next: http://localhost:58616/tests/dromaeo/cssquery-jquery.html) 16:59:51 INFO - PID 23076 | RSS: Main: 195670016 16:59:51 INFO - PID 23076 | 17:02:53 INFO - PID 23076 | Cycle 1(1): loaded http://localhost:58616/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58616/tests/dromaeo/cssquery-mootools.html) 17:02:53 INFO - PID 23076 | RSS: Main: 197378048 17:02:53 INFO - PID 23076 | 17:05:55 INFO - PID 23076 | Cycle 1(1): loaded http://localhost:58616/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58616/tests/dromaeo/cssquery-prototype.html) 17:05:56 INFO - PID 23076 | RSS: Main: 196108288 17:05:56 INFO - PID 23076 | 17:09:00 INFO - PID 23076 | Cycle 1(1): loaded http://localhost:58616/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58616/tests/dromaeo/cssquery-yui.html) 17:09:00 INFO - PID 23076 | RSS: Main: 194105344 17:09:00 INFO - PID 23076 | 17:12:02 INFO - PID 23076 | Cycle 1(1): loaded http://localhost:58616/tests/dromaeo/cssquery-yui.html (next: http://localhost:58616/tests/dromaeo/cssquery-dojo.html) 17:12:03 INFO - PID 23076 | RSS: Main: 199847936 17:12:03 INFO - PID 23076 | 17:12:03 INFO - PID 23076 | __start_tp_report 17:12:03 INFO - PID 23076 | _x_x_mozilla_page_load 17:12:03 INFO - PID 23076 | _x_x_mozilla_page_load_details 17:12:03 INFO - PID 23076 | |i|pagename|runs| 17:12:03 INFO - PID 23076 | |0;dojo.html;3104.7516198704097;3126.2653276480037;3143.559901613774;3148.7166155046043;3156.132063682487;6371.203599550056;6396.488280937526;6401.039844023393;6428.51786116042;6450.483961283092;6214.098955651428;6312.084747711579;6338.936610633892;6369.490440764739;6373.840653983652;5717.514011309034;5842.853928651775;5869.706514674271;5875.059990401536;5908;5886.058230683092;5959.344472108065;5963.61236519627;5979.671118088503;5993.520518358521;5721.885562288751;5738.397468265814;5767.682777447239;5788.247527821377;5923.052311630118;5803.92234411227;5853.414658534155;5889.4405031522365;5905.6751878646655;5909.940900590982;5623.26897503326;5823.912641310341;5877.970610146922;5884.911726324109;5902.61632993854;6208.161898143783;6257.812265632038;6270.592411493239;6292.339304373067;6338.080978258173;6824;6871.690773915186;6895.931040689579;6897.379235868746;6917.654117294115;6806.863862722767;6837.042814006043;6855.5886646801355;6866.450683945322;6946.548474349152;6198.256209254918;6237.095621134956;6259.71831267594;6304.810855674337;6326;6964.721411143498;6990.650467476606;7002.614856182959;7010.75462358815;7027.086478757728;6564.081028655992;6599.47204223661;6682.264950855402;6691.799246022627;6702.530822842355;6766.28953959837;6813.693383797741;6827.1807383113355;6889.069975553236;6898.448124150156;6760.357766012221;6794;6807.0810440589885;6850.349216824394;6888.655567221619;6592.0111983202905;6711.932880671228;6763.289854565298;6770.4922130839395;6779.830504237335;5206.349206349207;5236.450172731808;5243.632945693765;5294.7617357219015;5308.46915308466;4648.674592778473;4700.976495117503;4705.811767529261;4757.690750101232;4778.116048530964;5770.451807078405;5826.126081087871;5871.207387002785;5904.409559044061;5909.970450147722;6579.374959378852;6797.762078327334;6823.38589526945;6897.48268879836;6911.6544172791155;5775.566832487496;5802.854928626818;5803.88392232153;5807.041838096667;5827.533797296291;5693.28833895763;5762.654240745569;5779.826605201851;5799.043157878903;5839.678817664984;6470.611763294218;6550.0829883816305;6604.1084453599115;6613.900791488131;6624.238212605612;6826.078479405217;6854.177498700188;6890.2420733719255;6890.896636550356;6922.411595014279;6351.2696039956;6508.316626754123;6533.085368048382;6580.078788969452;6615.536912416084;6612.272650008592;6636.402723754885;6672.499562532927;6673.666316684049;6695.464362850863;6852;6951.895721564281;6969.651517424007;6974.68613912365;6975.860482790417;6494.935050649433;6506.512011599054;6536.738530458729;6578.375054369827;6588.176477940257;6486.4486518646445;6505.642189679424;6582.703778330082;6608.867822643617;6628.90056649141;6432.388923052303;6451.741930322734;6466.870662586628;6505.902411463737;6509.088727578048;6507.251666058464;6600.372964568358;6605.504587156079;6614.900776488453;6680.799576012728;6464.870702586016;6488.416042556192;6509.1863517060365;6514.57655252407;6534.934650653433 17:12:03 INFO - PID 23076 | |1;ext.html;859.6045818923295;884.3190743127795;889.9644014239435;891.9554022298884;892.9776755581107;38872.41691374632;42830.357544636856;42916.356254656166;43021.35467967979;43062.78468607653;39377.40933885987;39409.80295098528;39431.211375772466;39469.40795888064;39742;7157.749478768244;7218.819529511778;7283.635818209094;7285.781426557185;7290.927090729105;7640.426967977396;7737.071551413838;7779.805504862367;7796.298333150015;7807.063152421717;7676.117246516638;7802;7804.258595433453;7848.68605255789;7865.252800983897;7665.655045522964;7820.76537703867;7837.804054898616;8066.838663226761;8123.47197432165;7855.371570274421;7956.562389068599;7965.920340796633;7982.720604778805;7983.401244906597;37077.81461092677;37329.62670373289;37335.81332093322;37524.812375937945;37702.43446348307;3454.481827725836;3491.022513696169;3500.2124521982605;3518.278752855684;3533.328667553182;31002;31008.844955775076;31065.378692426024;31229.53155702666;31385.686143138504;5051.696898186121;5140.254663073871;5188.11801993662;5210.062188806013;5217.3217481727515;184766;184995;185215.07392463085;185464;185902;42471;48819.511804882204;48937.26594101091;49035;49089.754551227015;45194.32208516875;50827;50909.236361454605;51374.43127843593;51580.74209628928;14487.78268325976;14617.707645847024;14624.415023399157;14640.853591464162;14650.63373415673;11765.294082354914;11807.940960295144;11831.88168118325;11875.346855923008;11933.701657458632;13507.324633768469;13619.659508512168;13657.385417656229;13663.658408539668;13848.238346890816;5491.341039075257;5494.835154945278;5728.856778580569;5751.597388182787;5800.709964501758;984.1782111936614;1005.2309982863115;1011.9291649584459;1023.22746326523;1029.4749677664445;22863.657045144337;22919.427014324774;23050.769492305197;23073;23156.53686926252;1094.715374002765;1109.0554577596495;1111.5942680921405;1115.7991561519004;1122.399516258814;12038.277703337828;12091.334976576196;12201.38993050344;12244.204126731735;12284;217014;217773;218561;218632;219058;52022;52057.21914171291;52352.47647523476;52761.47238527642;52771.736141319816;1403.4456389726001;1439.107753193048;1446.6238777917818;1451.3759083593945;1461.101422625078;22026.44933876666;22482;22620.66069008999;22632.547349053257;22819.885900570393;36485.63514364822;36526.26947460983;36594.08514787152;36609.63390366062;36770.63229367672;181967;182361.08819455816;184355;184508;185640;32423;34200.14499637529;34318.14204644904;34713.65286347205;34757.47863781995;43355.566444335156;44549.55450445584;44885.32672009857;45126.32310515411;45341;32043.198920026254;32504.02487925366;32533.34933301368;32662.673373265963;32913.67086329202;32226.838865806458;32404.675953240167;32727.345453091282;32869.67130328666;32901.17747056343;36204.81897590495;36230.818845905604;36606.63393366032;36953.076173094814;37181.25637487181;31602.841985789924;31856.8407157972;32056;32271;32314.35371292608;23415.531689366457;23667.28998130059;23731;23876.880615596812;24372.63441048421 17:12:03 INFO - PID 23076 | |2;jquery.html;589.1427972300304;595.306467964821;598.7156100852096;600.5915977135548;612.5558969746933;22001.66997495039;22749.203777867777;22751.544969100607;22779.430514237152;22794.88602556989;19792.165310355846;20671.586568268627;20703.896480517575;21035.263765768203;21085.789142108613;6414.807555773323;6546.1490006299355;6562.343765623447;6562.3765742254645;6585.769498067569;6419.261784894727;6527.640979746112;6535.673216339188;6541.084248205255;6564.80305590833;6111.449969502743;6376.202974628171;6431.742730290806;6478.416942475176;6507.2191337039385;6341.397567231105;6396.136521569599;6401.103845461639;6406.871862562769;6411.455026322768;5922.170896074553;5960.0761881908375;5971.462568368825;5980.461758441761;6008.48927841134;26869.193924182306;28274.575881361798;28329.71670283312;28429.289267768265;28435.431291374265;1929.951751206217;1989.8706584072133;1992;1993.8404927605757;2006.9297574584818;18610.90694546532;19237.23051077955;19265.614687706166;19469.415917522496;19599.510012249666;2406.9638955415508;2466.1491785334033;2467.037855236459;2469.5678256305073;2478.3804048987754;120079;123214;137521.56196095078;146137;146788.2660586701;14504.854951450561;14692.926535367254;14848.703025939421;14956.700865982619;15067.719243864176;23009.42476438069;23017.539649207258;23018.65472017921;23052.53894922092;23147.305580832603;9650.565724542412;9795.853062204073;9800.754981125387;9802.852957205647;9889.307748457539;8730.17063378978;8851.60167792451;8889.244414224864;8946.552672366355;8979.236764875059;9107.726768196964;9109.635614575476;9114.772130696785;9152.95423522878;9361.110694484014;2641.590553464216;2702.851343176105;2716.511028014976;2770.1551026936977;2776.88892444304;946.7491114854569;958.5063692198523;962.323109686921;966.5408930757974;975.2393133355994;18256.81743182551;18792.154353054146;18963.810361896205;19143.61712765737;19542.413727588195;997.2371136080903;1016.2479764974014;1022.2792930983638;1041.3803786747026;1042.3849928542197;10725.89274107249;10771.730706732395;10840.132789376989;10890.29213101146;11063.22557420989;446232;448551;460500.2914464255;466440;469724;113093.86906130998;113745;116686.41656791662;116806;116890.9999999983;1110.1729211737306;1142.2232881640564;1210.6126039667397;1238.3993763024926;1238.58507400022;19893.204271829545;20452.284170053976;20689.482762931046;20852.270170543958;20925.476863078544;59508.107378390225;60919.390806091375;61644;61896.69051654713;62654.37345626485;78369.60815196116;78638.60680696789;79011.60494197492;79779.60110199412;80570.19429805627;14151.363188656742;14290.928545357623;14417.495387661802;14447.277636118362;14526;21542.246021389175;21574.244901428374;21607.783922160575;21813.890930545247;22006.779932201112;17459.56351091233;17583;17621.823781762017;17857;17861.73207401864;15326.157061361731;15333.463328783439;15656;16057;16067;17940.923544587367;18061.367852125113;18200.635987279915;18258.452246432098;18277.451676449728;14328.785068224193;14386.424543018162;14484.565463036126;14487.348069337117;14540.563783086101;16842.242099105813;17886.28454861791;17926;18071.548211294823;18096.185671644544 17:12:03 INFO - PID 23076 | |3;mootools.html;1342.8648448966144;1389.763740164172;1406.5217825939178;1410.597979575821;1411.8916650429414;15377.154256515902;15867.285972131252;15907.602309942256;15940.760888586667;15943.282552285145;15489.457868974589;15533.301001454933;15626.843731562682;15681.137537435436;15739.449119280827;2755.3938133610573;2776.6390369251967;2799.258196577898;2803.1310293808883;2808.382155925693;2648.748368904951;2698.1231099892516;2705.485957668037;2707.9729202708018;2716.307341627882;2622.17401518522;2744.945101097977;2749.463854548364;2757.062598716436;2758.213909035925;2749.42262124954;2761.8619069046467;2775.4726601945767;2781.5549512078073;2793.1760130761472;2670.4258584404447;2692.1923422973227;2698.5547384681504;2702;2707.878145483458;14373.425062997467;14616.415343386252;14623.853761462356;14752.55742327732;14816.925915370353;7699.807504812368;7860.606969651494;7937.523748575104;7977.082635496934;7980.082290536605;5226.163813789775;5300.496452836975;5328.413874473805;5405;5425.159100339453;2004.8295894848955;2006.147387360366;2019.232691577206;2061.917523299066;2079.5425006498544;26930.192094237205;27198.864005680043;27230.319242019108;27252.72747272522;27323.726762732516;6727.192736871509;6833.111695479655;6877.037214789933;6999.370056694922;7001;16886.493405197863;16975.405860794814;17034.31862725502;17075.316987320617;17138.485845424657;7628.961855190689;7702.037245344332;7760.185180556074;7776.144624091346;7784.026996625422;6878;6942.687579058854;7054.188768291609;7087.610181439967;7090.042844215965;5102.540771330598;5263.605229607795;5270.78916843322;5287.814926477555;5336.599755018389;1296.7989961555975;1328.734253149374;1576.968460630804;1578.084710867694;1583.7070142023763;726.9345758881726;880.6389380354024;895.2971917045088;901.4591245252927;914.6478605736706;8408.159184081544;8576.185262400062;8582.914170858212;8613.181747733955;8678.6962456315;939.9530023498935;952.5570609666538;975.6829030565095;982.921366290695;991.1129539062499;5081.720505372166;5220.686758794484;5228;5235.214717792285;5312.76092575835;20906.37280881576;22033.669494957587;22056.117755289928;22100.668489972664;22292.55414891693;20182.89908550448;20866.47833804167;21423.143074277166;21607;21873.562528749335;10803.13574914005;10844.295120817122;10857.185711071701;10861.728456788802;10901.563937442572;8167.632456539352;8268.793280168044;8325.500469971821;8436.114208008315;8460.703875364332;18509.444716658523;18534.25862965466;18604.81395186085;18887.433376998713;19144.521386965436;18573.16420761096;18966.810331896504;19176.712349314494;19431;19466.707999380305;10781.24531282834;10982.341059536453;11030.889691102986;11049.116070714163;11053.618297712786;12996.415161317953;13064.608061758163;13189.802152967904;13199.20804751718;13340.19958802475;10531.526081326205;10748.731281718019;11187.944060279646;11361.431928403712;11442.37066961325;10877.292975956538;10918.344899306067;11153.330800152016;11227.49476273586;11278.210525263154;9462.290328225548;9755.170810481188;9852;9852.901470985198;9857.605695772088;6769.661516924036;6796.082528858541;6855.657217139223;6890.483213758888;6900.965495172492;6843.281455447305;7009.369156775914;7022.297770222936;7208.639568021473;7301 17:12:03 INFO - PID 23076 | |4;prototype.html;517.2474050256876;525.2174260352075;542.7123624479027;543.5977376741212;550.8898220355927;6236.812895613133;6272.717727702253;6293.685315734212;6332.778352757655;6417.197850268716;6197.41124593164;6219.471344935675;6234.539830394129;6272.121902933582;6284.5600807943465;5185.533302002809;5249;5260;5282.603804714642;5300.973495132519;5195.974020129894;5262.973790070706;5293.285406470135;5312.495312945283;5370.758315875775;5182.196759502264;5200.6619569727845;5203.739813009334;5234.188700751371;5244.318238628973;5122.308488354099;5149.613778966593;5180.663256888291;5190.247414124969;5198.68807871527;4733.810647574093;4809.0862736080035;4817.445993710733;4826.251930950708;4844.176489996709;6148.44663980244;6174.5060395168275;6183.598066125687;6189.690515474208;6201.627902325829;5954.315253745832;5980.611260268069;5990.880182396328;6028.035514317732;6028.216331876872;6589.242237142742;6597.175353080865;6666.733330666768;6702.497312701566;6709.9329006709795;5010.674306170087;5176.83521207729;5183.5853131749745;5211.140161873286;5220.4779522047875;6714.026466162428;6825.48808839339;6889.345512176335;6912.308769123098;6980.092587963633;5425.186222066722;5437.238786569884;5448.809291674773;5484.945150548523;5521.365043020024;5455.5908306876345;5481.64289355581;5511.917321240185;5517.475839795213;5609.382967873531;5969.537463321514;5971.2233811277965;5982.850428739316;6006.219191505076;6039.516838652898;6676.666166691646;6687.531872768956;6695.631740254333;6713.63075030878;6717.596944183365;1931.1502938706924;1933.6132773445368;1938.108470103768;1945.6108778244409;1953.8241558259824;1347.5379213553404;1399.866108452157;1428.1431141315127;1438.4461982136952;1443.6751730860472;5647.209390685307;5682.431756824367;5692.6299790513485;5716.399778023331;5718.628289161191;6602.438792702578;6624.436922861514;6636.236832764197;6716.529842911047;6717.966410167918;5685.545156387479;5694.487496125285;5760.884782304414;5766.365699773021;5824.912626310609;3586.8565257389932;3587;3595.6404359563835;3599.1541987632886;3629.709623230135;6413;6456.160699109086;6495.1556297681;6520.869582608321;6524.445422139172;6743.258241593421;6763.5941843489545;6842.392037871096;6918.965405173042;6933.3066693331275;6534.117894084237;6558.80323590293;6568.310327415648;6569.507286953498;6599.406053455212;6695.096162018065;6752.210664173899;6779.661016949231;6806.897896531457;6855.143107111611;6651.201855777338;6762.188537375547;6782.5913156448705;6791.286914873867;6798.150231221098;6496.610203387623;6524.086627872007;6547.9672601636685;6551.770688025897;6578.210614726264;5480.862978425571;5494.752736126964;5518.227448157341;5548.250986116984;5576.888462230814;6420.967895160495;6581.80254592363;6657.2677005528385;6780.932190678227;6826.726930922906;6354.745810167541;6479.727737492724;6567.605943643397;6588.5058620604605;6604.669766511559;6519.946216941648;6555.311692272243;6576.177977752781;6587.868242635216;6627.834304142242;6365.809025729235;6368.554201205871;6373.617582944853;6406.775762848278;6486.610803351814;6496.577722448026;6511.316311787384;6562.606243625207;6664.900556324742;6668.166479190101;6321.273053598711;6348.873022539616;6436.8390790230615;6469.7412103515335;6470.450011749054 17:12:03 INFO - PID 23076 | |5;yui.html;888.3825741109923;896.188949001154;904.1862323908477;904.5884122724161;915.9267258619309;17122.315107395705;17862;17948.371806986757;18014.369497067604;18038.098095095258;17329.133543322845;17552.297908083663;17583.208755605996;17753.46739597811;17789.82210177898;937.995310023449;952.9237660987104;953.5041778275292;959.4387283439196;960.5581432541039;961.1013702188441;962.6678795815433;967.2842096848352;969.021288498618;971.3103696375582;985.6895078050427;1012.6152062216347;1015.7105225010873;1020.7244044108087;1020.8009438159562;984.3355734878963;1006.6376104602338;1008.7074748322977;1010.2524132142162;1011.544804837826;738.1105767550089;742.3838214282133;745.3440971944708;749.8950146979428;750.4334227658138;16617.83382166175;17697.823021769746;18424.078796060276;18442.170102345426;18455.538611534685;21546.56906861854;22054.558908821735;22168.445788855246;22524.774752252597;22557.097716091335;17592.472225833244;17620.03089830059;17702.468925932244;17770.555736106573;17982.37061702847;3708.517892673935;3739.6821270192067;3740.0836794985403;3740.17716102457;3745.887623371303;111230;121216;135157;136264.31867840697;136744;17264.913675431795;17674.381396651057;17838.286468541373;17840.91079544594;17849.910750446164;31956.84021579924;32076.358472830412;32433.837830810695;32475.837620811744;32615.836920815244;9095;9279.396839205565;9294.117058879396;9300.302477314228;9387.436753794795;4213;4246.299360605465;4280.764557949343;4283.314669652903;4288.2281189385585;5411.242426060355;5485.067538518461;5508.421615730291;5518.44815518453;5521.199426083195;1101.735583459964;1143.89704926557;1151.5048529132553;1155.763068570941;1158.5365853658604;617.2469587103816;647.6955830759536;657.9440747536418;661.9503537234631;665.3313420012953;12181.842724941116;12325.198862073936;12545;12702.301373424365;12734.172278801849;682.1064405628642;683.3064439593817;687.1925487552106;687.6836655138692;696.502001069238;5844.532437404998;5907.172995780594;5922.318933322636;5961.135635332939;6063.514918806485;119026;120889.39555302168;122451.38774306071;123233.38383308025;124311;108663;110010.44994775135;111897.44051279692;112120;112631.43684281527;91487.54256228676;92004;93270.53364733132;95903.52048239854;96537;10931.904117321084;10969.561217551209;11028.172887033665;11123.110151187724;11205.991460768244;41779.37330939977;42518;42957.57042429536;43225;43790.34314485222;55119;56496.15255771085;57070.143947839984;57204.42795571991;57353;14001.0199286049;14210.147391156564;14237.786433203717;14238.928805355907;14381;16163.67672646517;16305.184740763152;16338.591535211715;16365.181740912669;16590.170491475135;14412.495562655256;14591.489297874523;14787.186704731343;14804.925975370053;14870.256487175815;15172.620684482976;15199.544013679608;15226.77159842581;15292;15379.307931143348;15555.45555905538;15586.220688965734;15874.52376428709;15878.60303492422;15936.28286727077;10999.175061870232;11103.961210960286;11107.111431085656;11355.54577816878;11507.309561426342;11694.29834209916;11874.584389546324;12016.098792590765;12110.394480276127;12123.45444454984 17:12:03 INFO - PID 23076 | __end_tp_report 17:12:03 INFO - PID 23076 | __start_cc_report 17:12:03 INFO - PID 23076 | _x_x_mozilla_cycle_collect,282 17:12:03 INFO - PID 23076 | __end_cc_report 17:12:03 INFO - PID 23076 | __startTimestamp1506471123131__endTimestamp 17:12:03 INFO - PID 23076 | 17:12:03 INFO - PID 23076 | ------- Summary: start ------- 17:12:03 INFO - PID 23076 | Number of tests: 6 17:12:03 INFO - PID 23076 | 17:12:03 INFO - PID 23076 | [#0] dojo.html Cycles:165 Average:6240.14 Median:6488.42 stddev:758.17 (11.7%) stddev-sans-first:719.50 17:12:03 INFO - PID 23076 | Values: 3104.8 3126.3 3143.6 3148.7 3156.1 6371.2 6396.5 6401.0 6428.5 6450.5 6214.1 6312.1 6338.9 6369.5 6373.8 5717.5 5842.9 5869.7 5875.1 5908.0 5886.1 5959.3 5963.6 5979.7 5993.5 5721.9 5738.4 5767.7 5788.2 5923.1 5803.9 5853.4 5889.4 5905.7 5909.9 5623.3 5823.9 5878.0 5884.9 5902.6 6208.2 6257.8 6270.6 6292.3 6338.1 6824.0 6871.7 6895.9 6897.4 6917.7 6806.9 6837.0 6855.6 6866.5 6946.5 6198.3 6237.1 6259.7 6304.8 6326.0 6964.7 6990.7 7002.6 7010.8 7027.1 6564.1 6599.5 6682.3 6691.8 6702.5 6766.3 6813.7 6827.2 6889.1 6898.4 6760.4 6794.0 6807.1 6850.3 6888.7 6592.0 6711.9 6763.3 6770.5 6779.8 5206.3 5236.5 5243.6 5294.8 5308.5 4648.7 4701.0 4705.8 4757.7 4778.1 5770.5 5826.1 5871.2 5904.4 5910.0 6579.4 6797.8 6823.4 6897.5 6911.7 5775.6 5802.9 5803.9 5807.0 5827.5 5693.3 5762.7 5779.8 5799.0 5839.7 6470.6 6550.1 6604.1 6613.9 6624.2 6826.1 6854.2 6890.2 6890.9 6922.4 6351.3 6508.3 6533.1 6580.1 6615.5 6612.3 6636.4 6672.5 6673.7 6695.5 6852.0 6951.9 6969.7 6974.7 6975.9 6494.9 6506.5 6536.7 6578.4 6588.2 6486.4 6505.6 6582.7 6608.9 6628.9 6432.4 6451.7 6466.9 6505.9 6509.1 6507.3 6600.4 6605.5 6614.9 6680.8 6464.9 6488.4 6509.2 6514.6 6534.9 17:12:03 INFO - PID 23076 | 17:12:03 INFO - PID 23076 | [#1] ext.html Cycles:180 Average:36544.90 Median:3495.62 stddev:50836.51 (1454.3%) stddev-sans-first:50908.50 17:12:03 INFO - PID 23076 | Values: 859.6 884.3 890.0 892.0 893.0 38872.4 42830.4 42916.4 43021.4 43062.8 39377.4 39409.8 39431.2 39469.4 39742.0 7157.7 7218.8 7283.6 7285.8 7290.9 7640.4 7737.1 7779.8 7796.3 7807.1 7676.1 7802.0 7804.3 7848.7 7865.3 7665.7 7820.8 7837.8 8066.8 8123.5 7855.4 7956.6 7965.9 7982.7 7983.4 37077.8 37329.6 37335.8 37524.8 37702.4 3454.5 3491.0 3500.2 3518.3 3533.3 31002.0 31008.8 31065.4 31229.5 31385.7 5051.7 5140.3 5188.1 5210.1 5217.3 184766.0 184995.0 185215.1 185464.0 185902.0 42471.0 48819.5 48937.3 49035.0 49089.8 45194.3 50827.0 50909.2 51374.4 51580.7 14487.8 14617.7 14624.4 14640.9 14650.6 11765.3 11807.9 11831.9 11875.3 11933.7 13507.3 13619.7 13657.4 13663.7 13848.2 5491.3 5494.8 5728.9 5751.6 5800.7 984.2 1005.2 1011.9 1023.2 1029.5 22863.7 22919.4 23050.8 23073.0 23156.5 1094.7 1109.1 1111.6 1115.8 1122.4 12038.3 12091.3 12201.4 12244.2 12284.0 217014.0 217773.0 218561.0 218632.0 219058.0 52022.0 52057.2 52352.5 52761.5 52771.7 1403.4 1439.1 1446.6 1451.4 1461.1 22026.4 22482.0 22620.7 22632.5 22819.9 36485.6 36526.3 36594.1 36609.6 36770.6 181967.0 182361.1 184355.0 184508.0 185640.0 32423.0 34200.1 34318.1 34713.7 34757.5 43355.6 44549.6 44885.3 45126.3 45341.0 32043.2 32504.0 32533.3 32662.7 32913.7 32226.8 32404.7 32727.3 32869.7 32901.2 36204.8 36230.8 36606.6 36953.1 37181.3 31602.8 31856.8 32056.0 32271.0 32314.4 23415.5 23667.3 23731.0 23876.9 24372.6 17:12:03 INFO - PID 23076 | 17:12:03 INFO - PID 23076 | [#2] jquery.html Cycles:180 Average:33840.10 Median:22750.37 stddev:77832.41 (342.1%) stddev-sans-first:78010.71 17:12:03 INFO - PID 23076 | Values: 589.1 595.3 598.7 600.6 612.6 22001.7 22749.2 22751.5 22779.4 22794.9 19792.2 20671.6 20703.9 21035.3 21085.8 6414.8 6546.1 6562.3 6562.4 6585.8 6419.3 6527.6 6535.7 6541.1 6564.8 6111.4 6376.2 6431.7 6478.4 6507.2 6341.4 6396.1 6401.1 6406.9 6411.5 5922.2 5960.1 5971.5 5980.5 6008.5 26869.2 28274.6 28329.7 28429.3 28435.4 1930.0 1989.9 1992.0 1993.8 2006.9 18610.9 19237.2 19265.6 19469.4 19599.5 2407.0 2466.1 2467.0 2469.6 2478.4 120079.0 123214.0 137521.6 146137.0 146788.3 14504.9 14692.9 14848.7 14956.7 15067.7 23009.4 23017.5 23018.7 23052.5 23147.3 9650.6 9795.9 9800.8 9802.9 9889.3 8730.2 8851.6 8889.2 8946.6 8979.2 9107.7 9109.6 9114.8 9153.0 9361.1 2641.6 2702.9 2716.5 2770.2 2776.9 946.7 958.5 962.3 966.5 975.2 18256.8 18792.2 18963.8 19143.6 19542.4 997.2 1016.2 1022.3 1041.4 1042.4 10725.9 10771.7 10840.1 10890.3 11063.2 446232.0 448551.0 460500.3 466440.0 469724.0 113093.9 113745.0 116686.4 116806.0 116891.0 1110.2 1142.2 1210.6 1238.4 1238.6 19893.2 20452.3 20689.5 20852.3 20925.5 59508.1 60919.4 61644.0 61896.7 62654.4 78369.6 78638.6 79011.6 79779.6 80570.2 14151.4 14290.9 14417.5 14447.3 14526.0 21542.2 21574.2 21607.8 21813.9 22006.8 17459.6 17583.0 17621.8 17857.0 17861.7 15326.2 15333.5 15656.0 16057.0 16067.0 17940.9 18061.4 18200.6 18258.5 18277.5 14328.8 14386.4 14484.6 14487.3 14540.6 16842.2 17886.3 17926.0 18071.5 18096.2 17:12:03 INFO - PID 23076 | 17:12:03 INFO - PID 23076 | [#3] mootools.html Cycles:180 Average:9295.63 Median:2712.14 stddev:6711.51 (247.5%) stddev-sans-first:6703.74 17:12:03 INFO - PID 23076 | Values: 1342.9 1389.8 1406.5 1410.6 1411.9 15377.2 15867.3 15907.6 15940.8 15943.3 15489.5 15533.3 15626.8 15681.1 15739.4 2755.4 2776.6 2799.3 2803.1 2808.4 2648.7 2698.1 2705.5 2708.0 2716.3 2622.2 2744.9 2749.5 2757.1 2758.2 2749.4 2761.9 2775.5 2781.6 2793.2 2670.4 2692.2 2698.6 2702.0 2707.9 14373.4 14616.4 14623.9 14752.6 14816.9 7699.8 7860.6 7937.5 7977.1 7980.1 5226.2 5300.5 5328.4 5405.0 5425.2 2004.8 2006.1 2019.2 2061.9 2079.5 26930.2 27198.9 27230.3 27252.7 27323.7 6727.2 6833.1 6877.0 6999.4 7001.0 16886.5 16975.4 17034.3 17075.3 17138.5 7629.0 7702.0 7760.2 7776.1 7784.0 6878.0 6942.7 7054.2 7087.6 7090.0 5102.5 5263.6 5270.8 5287.8 5336.6 1296.8 1328.7 1577.0 1578.1 1583.7 726.9 880.6 895.3 901.5 914.6 8408.2 8576.2 8582.9 8613.2 8678.7 940.0 952.6 975.7 982.9 991.1 5081.7 5220.7 5228.0 5235.2 5312.8 20906.4 22033.7 22056.1 22100.7 22292.6 20182.9 20866.5 21423.1 21607.0 21873.6 10803.1 10844.3 10857.2 10861.7 10901.6 8167.6 8268.8 8325.5 8436.1 8460.7 18509.4 18534.3 18604.8 18887.4 19144.5 18573.2 18966.8 19176.7 19431.0 19466.7 10781.2 10982.3 11030.9 11049.1 11053.6 12996.4 13064.6 13189.8 13199.2 13340.2 10531.5 10748.7 11187.9 11361.4 11442.4 10877.3 10918.3 11153.3 11227.5 11278.2 9462.3 9755.2 9852.0 9852.9 9857.6 6769.7 6796.1 6855.7 6890.5 6901.0 6843.3 7009.4 7022.3 7208.6 7301.0 17:12:03 INFO - PID 23076 | 17:12:03 INFO - PID 23076 | [#4] prototype.html Cycles:180 Average:5639.31 Median:6210.55 stddev:1501.24 (24.2%) stddev-sans-first:1455.39 17:12:03 INFO - PID 23076 | Values: 517.2 525.2 542.7 543.6 550.9 6236.8 6272.7 6293.7 6332.8 6417.2 6197.4 6219.5 6234.5 6272.1 6284.6 5185.5 5249.0 5260.0 5282.6 5301.0 5196.0 5263.0 5293.3 5312.5 5370.8 5182.2 5200.7 5203.7 5234.2 5244.3 5122.3 5149.6 5180.7 5190.2 5198.7 4733.8 4809.1 4817.4 4826.3 4844.2 6148.4 6174.5 6183.6 6189.7 6201.6 5954.3 5980.6 5990.9 6028.0 6028.2 6589.2 6597.2 6666.7 6702.5 6709.9 5010.7 5176.8 5183.6 5211.1 5220.5 6714.0 6825.5 6889.3 6912.3 6980.1 5425.2 5437.2 5448.8 5484.9 5521.4 5455.6 5481.6 5511.9 5517.5 5609.4 5969.5 5971.2 5982.9 6006.2 6039.5 6676.7 6687.5 6695.6 6713.6 6717.6 1931.2 1933.6 1938.1 1945.6 1953.8 1347.5 1399.9 1428.1 1438.4 1443.7 5647.2 5682.4 5692.6 5716.4 5718.6 6602.4 6624.4 6636.2 6716.5 6718.0 5685.5 5694.5 5760.9 5766.4 5824.9 3586.9 3587.0 3595.6 3599.2 3629.7 6413.0 6456.2 6495.2 6520.9 6524.4 6743.3 6763.6 6842.4 6919.0 6933.3 6534.1 6558.8 6568.3 6569.5 6599.4 6695.1 6752.2 6779.7 6806.9 6855.1 6651.2 6762.2 6782.6 6791.3 6798.2 6496.6 6524.1 6548.0 6551.8 6578.2 5480.9 5494.8 5518.2 5548.3 5576.9 6421.0 6581.8 6657.3 6780.9 6826.7 6354.7 6479.7 6567.6 6588.5 6604.7 6519.9 6555.3 6576.2 6587.9 6627.8 6365.8 6368.6 6373.6 6406.8 6486.6 6496.6 6511.3 6562.6 6664.9 6668.2 6321.3 6348.9 6436.8 6469.7 6470.5 17:12:03 INFO - PID 23076 | 17:12:03 INFO - PID 23076 | [#5] yui.html Cycles:180 Average:23819.82 Median:17905.19 stddev:34328.59 (191.7%) stddev-sans-first:34381.70 17:12:03 INFO - PID 23076 | Values: 888.4 896.2 904.2 904.6 915.9 17122.3 17862.0 17948.4 18014.4 18038.1 17329.1 17552.3 17583.2 17753.5 17789.8 938.0 952.9 953.5 959.4 960.6 961.1 962.7 967.3 969.0 971.3 985.7 1012.6 1015.7 1020.7 1020.8 984.3 1006.6 1008.7 1010.3 1011.5 738.1 742.4 745.3 749.9 750.4 16617.8 17697.8 18424.1 18442.2 18455.5 21546.6 22054.6 22168.4 22524.8 22557.1 17592.5 17620.0 17702.5 17770.6 17982.4 3708.5 3739.7 3740.1 3740.2 3745.9 111230.0 121216.0 135157.0 136264.3 136744.0 17264.9 17674.4 17838.3 17840.9 17849.9 31956.8 32076.4 32433.8 32475.8 32615.8 9095.0 9279.4 9294.1 9300.3 9387.4 4213.0 4246.3 4280.8 4283.3 4288.2 5411.2 5485.1 5508.4 5518.4 5521.2 1101.7 1143.9 1151.5 1155.8 1158.5 617.2 647.7 657.9 662.0 665.3 12181.8 12325.2 12545.0 12702.3 12734.2 682.1 683.3 687.2 687.7 696.5 5844.5 5907.2 5922.3 5961.1 6063.5 119026.0 120889.4 122451.4 123233.4 124311.0 108663.0 110010.4 111897.4 112120.0 112631.4 91487.5 92004.0 93270.5 95903.5 96537.0 10931.9 10969.6 11028.2 11123.1 11206.0 41779.4 42518.0 42957.6 43225.0 43790.3 55119.0 56496.2 57070.1 57204.4 57353.0 14001.0 14210.1 14237.8 14238.9 14381.0 16163.7 16305.2 16338.6 16365.2 16590.2 14412.5 14591.5 14787.2 14804.9 14870.3 15172.6 15199.5 15226.8 15292.0 15379.3 15555.5 15586.2 15874.5 15878.6 15936.3 10999.2 11104.0 11107.1 11355.5 11507.3 11694.3 11874.6 12016.1 12110.4 12123.5 17:12:03 INFO - PID 23076 | -------- Summary: end -------- 17:12:03 INFO - PID 23076 | 17:12:04 INFO - TEST-INFO | 23076: exit 0 17:12:04 INFO - TEST-OK | dromaeo_css | took 1113048ms 17:12:04 INFO - TEST-START | kraken 17:12:04 INFO - Initialising browser for kraken test... 17:12:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58616/getInfo.html -profile /tmp/tmpLZym8S/profile 17:12:04 INFO - TEST-INFO | started process 23453 (/builds/slave/test/build/application/firefox/firefox http://localhost:58616/getInfo.html) 17:12:09 INFO - TEST-INFO | 23453: exit 0 17:12:09 INFO - Browser initialized. 17:12:09 INFO - Running cycle 1/1 for kraken test... 17:12:09 INFO - Using env: {'DISPLAY': ':0', 17:12:09 INFO - 'HOME': '/home/cltbld', 17:12:09 INFO - 'JSGC_DISABLE_POISONING': '1', 17:12:09 INFO - 'LANG': 'en_US.UTF-8', 17:12:09 INFO - 'LANGUAGE': 'en_US:en', 17:12:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:12:09 INFO - 'LOGNAME': 'cltbld', 17:12:09 INFO - 'MAIL': '/var/mail/cltbld', 17:12:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:12:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:12:09 INFO - 'MOZ_ACCELERATED': '1', 17:12:09 INFO - 'MOZ_CRASHREPORTER': '1', 17:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:12:09 INFO - 'MOZ_NO_REMOTE': '1', 17:12:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:12:09 INFO - 'MOZ_WEBRENDER': '1', 17:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:09 INFO - 'NO_EM_RESTART': '1', 17:12:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:09 INFO - 'PWD': '/builds/slave/test', 17:12:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:12:09 INFO - 'RUST_BACKTRACE': 'full', 17:12:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:12:09 INFO - 'SHELL': '/bin/bash', 17:12:09 INFO - 'SHLVL': '1', 17:12:09 INFO - 'TERM': 'linux', 17:12:09 INFO - 'TMOUT': '86400', 17:12:09 INFO - 'USER': 'cltbld', 17:12:09 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734', 17:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:09 INFO - '_': '/tools/buildbot/bin/python'} 17:12:09 INFO - TEST-INFO | started process 23701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLZym8S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:10 INFO - PID 23701 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:12:10 INFO - PID 23701 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:12:10 INFO - PID 23701 | 17:12:10 INFO - PID 23701 | (/builds/slave/test/build/application/firefox/firefox:23762): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:12:10 INFO - PID 23701 | 17:12:21 INFO - PID 23701 | RSS: Main: 193798144 17:12:21 INFO - PID 23701 | 17:12:23 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58616/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:24 INFO - PID 23701 | RSS: Main: 194502656 17:12:24 INFO - PID 23701 | 17:12:27 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58616/tests/kraken/driver.html?testName=audio-dft) 17:12:28 INFO - PID 23701 | RSS: Main: 194736128 17:12:28 INFO - PID 23701 | 17:12:31 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58616/tests/kraken/driver.html?testName=audio-fft) 17:12:31 INFO - PID 23701 | RSS: Main: 192327680 17:12:31 INFO - PID 23701 | 17:12:33 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58616/tests/kraken/driver.html?testName=audio-oscillator) 17:12:34 INFO - PID 23701 | RSS: Main: 193093632 17:12:34 INFO - PID 23701 | 17:12:36 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58616/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:12:37 INFO - PID 23701 | RSS: Main: 193515520 17:12:37 INFO - PID 23701 | 17:12:40 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58616/tests/kraken/driver.html?testName=imaging-darkroom) 17:12:41 INFO - PID 23701 | RSS: Main: 195563520 17:12:41 INFO - PID 23701 | 17:12:44 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58616/tests/kraken/driver.html?testName=imaging-desaturate) 17:12:45 INFO - PID 23701 | RSS: Main: 194805760 17:12:45 INFO - PID 23701 | 17:12:48 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58616/tests/kraken/driver.html?testName=json-parse-financial) 17:12:49 INFO - PID 23701 | RSS: Main: 194535424 17:12:49 INFO - PID 23701 | 17:12:50 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58616/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:12:51 INFO - PID 23701 | RSS: Main: 195592192 17:12:51 INFO - PID 23701 | 17:12:52 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:12:53 INFO - PID 23701 | RSS: Main: 192802816 17:12:53 INFO - PID 23701 | 17:12:55 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:12:56 INFO - PID 23701 | RSS: Main: 192180224 17:12:56 INFO - PID 23701 | 17:12:59 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:12:59 INFO - PID 23701 | RSS: Main: 192733184 17:12:59 INFO - PID 23701 | 17:13:02 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:03 INFO - PID 23701 | RSS: Main: 192716800 17:13:03 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58616/tests/kraken/driver.html?testName=ai-astar) 17:13:05 INFO - PID 23701 | RSS: Main: 194699264 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | __start_tp_report 17:13:05 INFO - PID 23701 | _x_x_mozilla_page_load 17:13:05 INFO - PID 23701 | _x_x_mozilla_page_load_details 17:13:05 INFO - PID 23701 | |i|pagename|runs| 17:13:05 INFO - PID 23701 | |0;ai-astar;113;107;114;107;117;108;113;113;107;113 17:13:05 INFO - PID 23701 | |1;audio-beat-detection;129;122;115;115;120;116;122;118;141;121 17:13:05 INFO - PID 23701 | |2;audio-dft;169;171;164;161;164;169;172;164;164;166 17:13:05 INFO - PID 23701 | |3;audio-fft;76;78;80;85;73;78;74;84;77;75 17:13:05 INFO - PID 23701 | |4;audio-oscillator;85;88;79;77;81;84;78;88;87;80 17:13:05 INFO - PID 23701 | |5;imaging-gaussian-blur;117;123;116;115;119;115;117;119;116;121 17:13:05 INFO - PID 23701 | |6;imaging-darkroom;149;148;151;148;158;149;148;150;150;150 17:13:05 INFO - PID 23701 | |7;imaging-desaturate;102;103;94;95;93;94;96;102;98;97 17:13:05 INFO - PID 23701 | |8;json-parse-financial;56;57;54;54;53;55;57;61;53;61 17:13:05 INFO - PID 23701 | |9;json-stringify-tinderbox;39;46;44;39;38;38;43;43;39;45 17:13:05 INFO - PID 23701 | |10;stanford-crypto-aes;89;75;86;74;80;72;87;75;81;76 17:13:05 INFO - PID 23701 | |11;stanford-crypto-ccm;114;119;116;111;122;113;116;124;115;120 17:13:05 INFO - PID 23701 | |12;stanford-crypto-pbkdf2;174;166;170;169;169;176;171;175;165;168 17:13:05 INFO - PID 23701 | |13;stanford-crypto-sha256-iterative;69;72;66;65;63;68;66;64;67;65 17:13:05 INFO - PID 23701 | __end_tp_report 17:13:05 INFO - PID 23701 | __start_cc_report 17:13:05 INFO - PID 23701 | _x_x_mozilla_cycle_collect,734 17:13:05 INFO - PID 23701 | __end_cc_report 17:13:05 INFO - PID 23701 | __startTimestamp1506471185367__endTimestamp 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | ------- Summary: start ------- 17:13:05 INFO - PID 23701 | Number of tests: 14 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:3.61 (3.2%) stddev-sans-first:3.77 17:13:05 INFO - PID 23701 | Values: 113.0 107.0 114.0 107.0 117.0 108.0 113.0 113.0 107.0 113.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#1] audio-beat-detection Cycles:10 Average:121.90 Median:121.50 stddev:7.92 (6.5%) stddev-sans-first:7.98 17:13:05 INFO - PID 23701 | Values: 129.0 122.0 115.0 115.0 120.0 116.0 122.0 118.0 141.0 121.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#2] audio-dft Cycles:10 Average:166.40 Median:167.50 stddev:3.63 (2.2%) stddev-sans-first:3.72 17:13:05 INFO - PID 23701 | Values: 169.0 171.0 164.0 161.0 164.0 169.0 172.0 164.0 164.0 166.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#3] audio-fft Cycles:10 Average:78.00 Median:78.00 stddev:4.00 (5.1%) stddev-sans-first:4.18 17:13:05 INFO - PID 23701 | Values: 76.0 78.0 80.0 85.0 73.0 78.0 74.0 84.0 77.0 75.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:84.50 stddev:4.22 (5.0%) stddev-sans-first:4.39 17:13:05 INFO - PID 23701 | Values: 85.0 88.0 79.0 77.0 81.0 84.0 78.0 88.0 87.0 80.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:2.66 (2.3%) stddev-sans-first:2.80 17:13:05 INFO - PID 23701 | Values: 117.0 123.0 116.0 115.0 119.0 115.0 117.0 119.0 116.0 121.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:2.96 (2.0%) stddev-sans-first:3.11 17:13:05 INFO - PID 23701 | Values: 149.0 148.0 151.0 148.0 158.0 149.0 148.0 150.0 150.0 150.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#7] imaging-desaturate Cycles:10 Average:97.40 Median:94.50 stddev:3.72 (3.9%) stddev-sans-first:3.55 17:13:05 INFO - PID 23701 | Values: 102.0 103.0 94.0 95.0 93.0 94.0 96.0 102.0 98.0 97.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:2.96 (5.2%) stddev-sans-first:3.14 17:13:05 INFO - PID 23701 | Values: 56.0 57.0 54.0 54.0 53.0 55.0 57.0 61.0 53.0 61.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#9] json-stringify-tinderbox Cycles:10 Average:41.40 Median:43.00 stddev:3.10 (7.2%) stddev-sans-first:3.16 17:13:05 INFO - PID 23701 | Values: 39.0 46.0 44.0 39.0 38.0 38.0 43.0 43.0 39.0 45.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:80.50 stddev:6.06 (7.5%) stddev-sans-first:5.36 17:13:05 INFO - PID 23701 | Values: 89.0 75.0 86.0 74.0 80.0 72.0 87.0 75.0 81.0 76.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:117.50 stddev:4.14 (3.5%) stddev-sans-first:4.24 17:13:05 INFO - PID 23701 | Values: 114.0 119.0 116.0 111.0 122.0 113.0 116.0 124.0 115.0 120.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:170.50 stddev:3.71 (2.2%) stddev-sans-first:3.69 17:13:05 INFO - PID 23701 | Values: 174.0 166.0 170.0 169.0 169.0 176.0 171.0 175.0 165.0 168.0 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:2.64 (4.0%) stddev-sans-first:2.64 17:13:05 INFO - PID 23701 | Values: 69.0 72.0 66.0 65.0 63.0 68.0 66.0 64.0 67.0 65.0 17:13:05 INFO - PID 23701 | -------- Summary: end -------- 17:13:05 INFO - PID 23701 | 17:13:05 INFO - PID 23701 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:13:06 INFO - TEST-INFO | 23701: exit 0 17:13:06 INFO - TEST-OK | kraken | took 62286ms 17:13:06 INFO - SUITE-END | took 1175s 17:13:06 INFO - Completed test suite (00:19:35) 17:13:06 INFO - javascript benchmark 17:13:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8506.12819646084, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.7516198704097, 3126.2653276480037, 3143.559901613774, 3148.7166155046043, 3156.132063682487, 6371.203599550056, 6396.488280937526, 6401.039844023393, 6428.51786116042, 6450.483961283092, 6214.098955651428, 6312.084747711579, 6338.936610633892, 6369.490440764739, 6373.840653983652, 5717.514011309034, 5842.853928651775, 5869.706514674271, 5875.059990401536, 5908.0, 5886.058230683092, 5959.344472108065, 5963.61236519627, 5979.671118088503, 5993.520518358521, 5721.885562288751, 5738.397468265814, 5767.682777447239, 5788.247527821377, 5923.052311630118, 5803.92234411227, 5853.414658534155, 5889.4405031522365, 5905.6751878646655, 5909.940900590982, 5623.26897503326, 5823.912641310341, 5877.970610146922, 5884.911726324109, 5902.61632993854, 6208.161898143783, 6257.812265632038, 6270.592411493239, 6292.339304373067, 6338.080978258173, 6824.0, 6871.690773915186, 6895.931040689579, 6897.379235868746, 6917.654117294115, 6806.863862722767, 6837.042814006043, 6855.5886646801355, 6866.450683945322, 6946.548474349152, 6198.256209254918, 6237.095621134956, 6259.71831267594, 6304.810855674337, 6326.0, 6964.721411143498, 6990.650467476606, 7002.614856182959, 7010.75462358815, 7027.086478757728, 6564.081028655992, 6599.47204223661, 6682.264950855402, 6691.799246022627, 6702.530822842355, 6766.28953959837, 6813.693383797741, 6827.1807383113355, 6889.069975553236, 6898.448124150156, 6760.357766012221, 6794.0, 6807.0810440589885, 6850.349216824394, 6888.655567221619, 6592.0111983202905, 6711.932880671228, 6763.289854565298, 6770.4922130839395, 6779.830504237335, 5206.349206349207, 5236.450172731808, 5243.632945693765, 5294.7617357219015, 5308.46915308466, 4648.674592778473, 4700.976495117503, 4705.811767529261, 4757.690750101232, 4778.116048530964, 5770.451807078405, 5826.126081087871, 5871.207387002785, 5904.409559044061, 5909.970450147722, 6579.374959378852, 6797.762078327334, 6823.38589526945, 6897.48268879836, 6911.6544172791155, 5775.566832487496, 5802.854928626818, 5803.88392232153, 5807.041838096667, 5827.533797296291, 5693.28833895763, 5762.654240745569, 5779.826605201851, 5799.043157878903, 5839.678817664984, 6470.611763294218, 6550.0829883816305, 6604.1084453599115, 6613.900791488131, 6624.238212605612, 6826.078479405217, 6854.177498700188, 6890.2420733719255, 6890.896636550356, 6922.411595014279, 6351.2696039956, 6508.316626754123, 6533.085368048382, 6580.078788969452, 6615.536912416084, 6612.272650008592, 6636.402723754885, 6672.499562532927, 6673.666316684049, 6695.464362850863, 6852.0, 6951.895721564281, 6969.651517424007, 6974.68613912365, 6975.860482790417, 6494.935050649433, 6506.512011599054, 6536.738530458729, 6578.375054369827, 6588.176477940257, 6486.4486518646445, 6505.642189679424, 6582.703778330082, 6608.867822643617, 6628.90056649141, 6432.388923052303, 6451.741930322734, 6466.870662586628, 6505.902411463737, 6509.088727578048, 6507.251666058464, 6600.372964568358, 6605.504587156079, 6614.900776488453, 6680.799576012728, 6464.870702586016, 6488.416042556192, 6509.1863517060365, 6514.57655252407, 6534.934650653433], "value": 6181.316448847021, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.6045818923295, 884.3190743127795, 889.9644014239435, 891.9554022298884, 892.9776755581107, 38872.41691374632, 42830.357544636856, 42916.356254656166, 43021.35467967979, 43062.78468607653, 39377.40933885987, 39409.80295098528, 39431.211375772466, 39469.40795888064, 39742.0, 7157.749478768244, 7218.819529511778, 7283.635818209094, 7285.781426557185, 7290.927090729105, 7640.426967977396, 7737.071551413838, 7779.805504862367, 7796.298333150015, 7807.063152421717, 7676.117246516638, 7802.0, 7804.258595433453, 7848.68605255789, 7865.252800983897, 7665.655045522964, 7820.76537703867, 7837.804054898616, 8066.838663226761, 8123.47197432165, 7855.371570274421, 7956.562389068599, 7965.920340796633, 7982.720604778805, 7983.401244906597, 37077.81461092677, 37329.62670373289, 37335.81332093322, 37524.812375937945, 37702.43446348307, 3454.481827725836, 3491.022513696169, 3500.2124521982605, 3518.278752855684, 3533.328667553182, 31002.0, 31008.844955775076, 31065.378692426024, 31229.53155702666, 31385.686143138504, 5051.696898186121, 5140.254663073871, 5188.11801993662, 5210.062188806013, 5217.3217481727515, 184766.0, 184995.0, 185215.07392463085, 185464.0, 185902.0, 42471.0, 48819.511804882204, 48937.26594101091, 49035.0, 49089.754551227015, 45194.32208516875, 50827.0, 50909.236361454605, 51374.43127843593, 51580.74209628928, 14487.78268325976, 14617.707645847024, 14624.415023399157, 14640.853591464162, 14650.63373415673, 11765.294082354914, 11807.940960295144, 11831.88168118325, 11875.346855923008, 11933.701657458632, 13507.324633768469, 13619.659508512168, 13657.385417656229, 13663.658408539668, 13848.238346890816, 5491.341039075257, 5494.835154945278, 5728.856778580569, 5751.597388182787, 5800.709964501758, 984.1782111936614, 1005.2309982863115, 1011.9291649584459, 1023.22746326523, 1029.4749677664445, 22863.657045144337, 22919.427014324774, 23050.769492305197, 23073.0, 23156.53686926252, 1094.715374002765, 1109.0554577596495, 1111.5942680921405, 1115.7991561519004, 1122.399516258814, 12038.277703337828, 12091.334976576196, 12201.38993050344, 12244.204126731735, 12284.0, 217014.0, 217773.0, 218561.0, 218632.0, 219058.0, 52022.0, 52057.21914171291, 52352.47647523476, 52761.47238527642, 52771.736141319816, 1403.4456389726001, 1439.107753193048, 1446.6238777917818, 1451.3759083593945, 1461.101422625078, 22026.44933876666, 22482.0, 22620.66069008999, 22632.547349053257, 22819.885900570393, 36485.63514364822, 36526.26947460983, 36594.08514787152, 36609.63390366062, 36770.63229367672, 181967.0, 182361.08819455816, 184355.0, 184508.0, 185640.0, 32423.0, 34200.14499637529, 34318.14204644904, 34713.65286347205, 34757.47863781995, 43355.566444335156, 44549.55450445584, 44885.32672009857, 45126.32310515411, 45341.0, 32043.198920026254, 32504.02487925366, 32533.34933301368, 32662.673373265963, 32913.67086329202, 32226.838865806458, 32404.675953240167, 32727.345453091282, 32869.67130328666, 32901.17747056343, 36204.81897590495, 36230.818845905604, 36606.63393366032, 36953.076173094814, 37181.25637487181, 31602.841985789924, 31856.8407157972, 32056.0, 32271.0, 32314.35371292608, 23415.531689366457, 23667.28998130059, 23731.0, 23876.880615596812, 24372.63441048421], "value": 16950.95338454356, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.1427972300304, 595.306467964821, 598.7156100852096, 600.5915977135548, 612.5558969746933, 22001.66997495039, 22749.203777867777, 22751.544969100607, 22779.430514237152, 22794.88602556989, 19792.165310355846, 20671.586568268627, 20703.896480517575, 21035.263765768203, 21085.789142108613, 6414.807555773323, 6546.1490006299355, 6562.343765623447, 6562.3765742254645, 6585.769498067569, 6419.261784894727, 6527.640979746112, 6535.673216339188, 6541.084248205255, 6564.80305590833, 6111.449969502743, 6376.202974628171, 6431.742730290806, 6478.416942475176, 6507.2191337039385, 6341.397567231105, 6396.136521569599, 6401.103845461639, 6406.871862562769, 6411.455026322768, 5922.170896074553, 5960.0761881908375, 5971.462568368825, 5980.461758441761, 6008.48927841134, 26869.193924182306, 28274.575881361798, 28329.71670283312, 28429.289267768265, 28435.431291374265, 1929.951751206217, 1989.8706584072133, 1992.0, 1993.8404927605757, 2006.9297574584818, 18610.90694546532, 19237.23051077955, 19265.614687706166, 19469.415917522496, 19599.510012249666, 2406.9638955415508, 2466.1491785334033, 2467.037855236459, 2469.5678256305073, 2478.3804048987754, 120079.0, 123214.0, 137521.56196095078, 146137.0, 146788.2660586701, 14504.854951450561, 14692.926535367254, 14848.703025939421, 14956.700865982619, 15067.719243864176, 23009.42476438069, 23017.539649207258, 23018.65472017921, 23052.53894922092, 23147.305580832603, 9650.565724542412, 9795.853062204073, 9800.754981125387, 9802.852957205647, 9889.307748457539, 8730.17063378978, 8851.60167792451, 8889.244414224864, 8946.552672366355, 8979.236764875059, 9107.726768196964, 9109.635614575476, 9114.772130696785, 9152.95423522878, 9361.110694484014, 2641.590553464216, 2702.851343176105, 2716.511028014976, 2770.1551026936977, 2776.88892444304, 946.7491114854569, 958.5063692198523, 962.323109686921, 966.5408930757974, 975.2393133355994, 18256.81743182551, 18792.154353054146, 18963.810361896205, 19143.61712765737, 19542.413727588195, 997.2371136080903, 1016.2479764974014, 1022.2792930983638, 1041.3803786747026, 1042.3849928542197, 10725.89274107249, 10771.730706732395, 10840.132789376989, 10890.29213101146, 11063.22557420989, 446232.0, 448551.0, 460500.2914464255, 466440.0, 469724.0, 113093.86906130998, 113745.0, 116686.41656791662, 116806.0, 116890.9999999983, 1110.1729211737306, 1142.2232881640564, 1210.6126039667397, 1238.3993763024926, 1238.58507400022, 19893.204271829545, 20452.284170053976, 20689.482762931046, 20852.270170543958, 20925.476863078544, 59508.107378390225, 60919.390806091375, 61644.0, 61896.69051654713, 62654.37345626485, 78369.60815196116, 78638.60680696789, 79011.60494197492, 79779.60110199412, 80570.19429805627, 14151.363188656742, 14290.928545357623, 14417.495387661802, 14447.277636118362, 14526.0, 21542.246021389175, 21574.244901428374, 21607.783922160575, 21813.890930545247, 22006.779932201112, 17459.56351091233, 17583.0, 17621.823781762017, 17857.0, 17861.73207401864, 15326.157061361731, 15333.463328783439, 15656.0, 16057.0, 16067.0, 17940.923544587367, 18061.367852125113, 18200.635987279915, 18258.452246432098, 18277.451676449728, 14328.785068224193, 14386.424543018162, 14484.565463036126, 14487.348069337117, 14540.563783086101, 16842.242099105813, 17886.28454861791, 17926.0, 18071.548211294823, 18096.185671644544], "value": 11804.514592650703, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.8648448966144, 1389.763740164172, 1406.5217825939178, 1410.597979575821, 1411.8916650429414, 15377.154256515902, 15867.285972131252, 15907.602309942256, 15940.760888586667, 15943.282552285145, 15489.457868974589, 15533.301001454933, 15626.843731562682, 15681.137537435436, 15739.449119280827, 2755.3938133610573, 2776.6390369251967, 2799.258196577898, 2803.1310293808883, 2808.382155925693, 2648.748368904951, 2698.1231099892516, 2705.485957668037, 2707.9729202708018, 2716.307341627882, 2622.17401518522, 2744.945101097977, 2749.463854548364, 2757.062598716436, 2758.213909035925, 2749.42262124954, 2761.8619069046467, 2775.4726601945767, 2781.5549512078073, 2793.1760130761472, 2670.4258584404447, 2692.1923422973227, 2698.5547384681504, 2702.0, 2707.878145483458, 14373.425062997467, 14616.415343386252, 14623.853761462356, 14752.55742327732, 14816.925915370353, 7699.807504812368, 7860.606969651494, 7937.523748575104, 7977.082635496934, 7980.082290536605, 5226.163813789775, 5300.496452836975, 5328.413874473805, 5405.0, 5425.159100339453, 2004.8295894848955, 2006.147387360366, 2019.232691577206, 2061.917523299066, 2079.5425006498544, 26930.192094237205, 27198.864005680043, 27230.319242019108, 27252.72747272522, 27323.726762732516, 6727.192736871509, 6833.111695479655, 6877.037214789933, 6999.370056694922, 7001.0, 16886.493405197863, 16975.405860794814, 17034.31862725502, 17075.316987320617, 17138.485845424657, 7628.961855190689, 7702.037245344332, 7760.185180556074, 7776.144624091346, 7784.026996625422, 6878.0, 6942.687579058854, 7054.188768291609, 7087.610181439967, 7090.042844215965, 5102.540771330598, 5263.605229607795, 5270.78916843322, 5287.814926477555, 5336.599755018389, 1296.7989961555975, 1328.734253149374, 1576.968460630804, 1578.084710867694, 1583.7070142023763, 726.9345758881726, 880.6389380354024, 895.2971917045088, 901.4591245252927, 914.6478605736706, 8408.159184081544, 8576.185262400062, 8582.914170858212, 8613.181747733955, 8678.6962456315, 939.9530023498935, 952.5570609666538, 975.6829030565095, 982.921366290695, 991.1129539062499, 5081.720505372166, 5220.686758794484, 5228.0, 5235.214717792285, 5312.76092575835, 20906.37280881576, 22033.669494957587, 22056.117755289928, 22100.668489972664, 22292.55414891693, 20182.89908550448, 20866.47833804167, 21423.143074277166, 21607.0, 21873.562528749335, 10803.13574914005, 10844.295120817122, 10857.185711071701, 10861.728456788802, 10901.563937442572, 8167.632456539352, 8268.793280168044, 8325.500469971821, 8436.114208008315, 8460.703875364332, 18509.444716658523, 18534.25862965466, 18604.81395186085, 18887.433376998713, 19144.521386965436, 18573.16420761096, 18966.810331896504, 19176.712349314494, 19431.0, 19466.707999380305, 10781.24531282834, 10982.341059536453, 11030.889691102986, 11049.116070714163, 11053.618297712786, 12996.415161317953, 13064.608061758163, 13189.802152967904, 13199.20804751718, 13340.19958802475, 10531.526081326205, 10748.731281718019, 11187.944060279646, 11361.431928403712, 11442.37066961325, 10877.292975956538, 10918.344899306067, 11153.330800152016, 11227.49476273586, 11278.210525263154, 9462.290328225548, 9755.170810481188, 9852.0, 9852.901470985198, 9857.605695772088, 6769.661516924036, 6796.082528858541, 6855.657217139223, 6890.483213758888, 6900.965495172492, 6843.281455447305, 7009.369156775914, 7022.297770222936, 7208.639568021473, 7301.0], "value": 6648.7721365101825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.2474050256876, 525.2174260352075, 542.7123624479027, 543.5977376741212, 550.8898220355927, 6236.812895613133, 6272.717727702253, 6293.685315734212, 6332.778352757655, 6417.197850268716, 6197.41124593164, 6219.471344935675, 6234.539830394129, 6272.121902933582, 6284.5600807943465, 5185.533302002809, 5249.0, 5260.0, 5282.603804714642, 5300.973495132519, 5195.974020129894, 5262.973790070706, 5293.285406470135, 5312.495312945283, 5370.758315875775, 5182.196759502264, 5200.6619569727845, 5203.739813009334, 5234.188700751371, 5244.318238628973, 5122.308488354099, 5149.613778966593, 5180.663256888291, 5190.247414124969, 5198.68807871527, 4733.810647574093, 4809.0862736080035, 4817.445993710733, 4826.251930950708, 4844.176489996709, 6148.44663980244, 6174.5060395168275, 6183.598066125687, 6189.690515474208, 6201.627902325829, 5954.315253745832, 5980.611260268069, 5990.880182396328, 6028.035514317732, 6028.216331876872, 6589.242237142742, 6597.175353080865, 6666.733330666768, 6702.497312701566, 6709.9329006709795, 5010.674306170087, 5176.83521207729, 5183.5853131749745, 5211.140161873286, 5220.4779522047875, 6714.026466162428, 6825.48808839339, 6889.345512176335, 6912.308769123098, 6980.092587963633, 5425.186222066722, 5437.238786569884, 5448.809291674773, 5484.945150548523, 5521.365043020024, 5455.5908306876345, 5481.64289355581, 5511.917321240185, 5517.475839795213, 5609.382967873531, 5969.537463321514, 5971.2233811277965, 5982.850428739316, 6006.219191505076, 6039.516838652898, 6676.666166691646, 6687.531872768956, 6695.631740254333, 6713.63075030878, 6717.596944183365, 1931.1502938706924, 1933.6132773445368, 1938.108470103768, 1945.6108778244409, 1953.8241558259824, 1347.5379213553404, 1399.866108452157, 1428.1431141315127, 1438.4461982136952, 1443.6751730860472, 5647.209390685307, 5682.431756824367, 5692.6299790513485, 5716.399778023331, 5718.628289161191, 6602.438792702578, 6624.436922861514, 6636.236832764197, 6716.529842911047, 6717.966410167918, 5685.545156387479, 5694.487496125285, 5760.884782304414, 5766.365699773021, 5824.912626310609, 3586.8565257389932, 3587.0, 3595.6404359563835, 3599.1541987632886, 3629.709623230135, 6413.0, 6456.160699109086, 6495.1556297681, 6520.869582608321, 6524.445422139172, 6743.258241593421, 6763.5941843489545, 6842.392037871096, 6918.965405173042, 6933.3066693331275, 6534.117894084237, 6558.80323590293, 6568.310327415648, 6569.507286953498, 6599.406053455212, 6695.096162018065, 6752.210664173899, 6779.661016949231, 6806.897896531457, 6855.143107111611, 6651.201855777338, 6762.188537375547, 6782.5913156448705, 6791.286914873867, 6798.150231221098, 6496.610203387623, 6524.086627872007, 6547.9672601636685, 6551.770688025897, 6578.210614726264, 5480.862978425571, 5494.752736126964, 5518.227448157341, 5548.250986116984, 5576.888462230814, 6420.967895160495, 6581.80254592363, 6657.2677005528385, 6780.932190678227, 6826.726930922906, 6354.745810167541, 6479.727737492724, 6567.605943643397, 6588.5058620604605, 6604.669766511559, 6519.946216941648, 6555.311692272243, 6576.177977752781, 6587.868242635216, 6627.834304142242, 6365.809025729235, 6368.554201205871, 6373.617582944853, 6406.775762848278, 6486.610803351814, 6496.577722448026, 6511.316311787384, 6562.606243625207, 6664.900556324742, 6668.166479190101, 6321.273053598711, 6348.873022539616, 6436.8390790230615, 6469.7412103515335, 6470.450011749054], "value": 5209.998271791605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.3825741109923, 896.188949001154, 904.1862323908477, 904.5884122724161, 915.9267258619309, 17122.315107395705, 17862.0, 17948.371806986757, 18014.369497067604, 18038.098095095258, 17329.133543322845, 17552.297908083663, 17583.208755605996, 17753.46739597811, 17789.82210177898, 937.995310023449, 952.9237660987104, 953.5041778275292, 959.4387283439196, 960.5581432541039, 961.1013702188441, 962.6678795815433, 967.2842096848352, 969.021288498618, 971.3103696375582, 985.6895078050427, 1012.6152062216347, 1015.7105225010873, 1020.7244044108087, 1020.8009438159562, 984.3355734878963, 1006.6376104602338, 1008.7074748322977, 1010.2524132142162, 1011.544804837826, 738.1105767550089, 742.3838214282133, 745.3440971944708, 749.8950146979428, 750.4334227658138, 16617.83382166175, 17697.823021769746, 18424.078796060276, 18442.170102345426, 18455.538611534685, 21546.56906861854, 22054.558908821735, 22168.445788855246, 22524.774752252597, 22557.097716091335, 17592.472225833244, 17620.03089830059, 17702.468925932244, 17770.555736106573, 17982.37061702847, 3708.517892673935, 3739.6821270192067, 3740.0836794985403, 3740.17716102457, 3745.887623371303, 111230.0, 121216.0, 135157.0, 136264.31867840697, 136744.0, 17264.913675431795, 17674.381396651057, 17838.286468541373, 17840.91079544594, 17849.910750446164, 31956.84021579924, 32076.358472830412, 32433.837830810695, 32475.837620811744, 32615.836920815244, 9095.0, 9279.396839205565, 9294.117058879396, 9300.302477314228, 9387.436753794795, 4213.0, 4246.299360605465, 4280.764557949343, 4283.314669652903, 4288.2281189385585, 5411.242426060355, 5485.067538518461, 5508.421615730291, 5518.44815518453, 5521.199426083195, 1101.735583459964, 1143.89704926557, 1151.5048529132553, 1155.763068570941, 1158.5365853658604, 617.2469587103816, 647.6955830759536, 657.9440747536418, 661.9503537234631, 665.3313420012953, 12181.842724941116, 12325.198862073936, 12545.0, 12702.301373424365, 12734.172278801849, 682.1064405628642, 683.3064439593817, 687.1925487552106, 687.6836655138692, 696.502001069238, 5844.532437404998, 5907.172995780594, 5922.318933322636, 5961.135635332939, 6063.514918806485, 119026.0, 120889.39555302168, 122451.38774306071, 123233.38383308025, 124311.0, 108663.0, 110010.44994775135, 111897.44051279692, 112120.0, 112631.43684281527, 91487.54256228676, 92004.0, 93270.53364733132, 95903.52048239854, 96537.0, 10931.904117321084, 10969.561217551209, 11028.172887033665, 11123.110151187724, 11205.991460768244, 41779.37330939977, 42518.0, 42957.57042429536, 43225.0, 43790.34314485222, 55119.0, 56496.15255771085, 57070.143947839984, 57204.42795571991, 57353.0, 14001.0199286049, 14210.147391156564, 14237.786433203717, 14238.928805355907, 14381.0, 16163.67672646517, 16305.184740763152, 16338.591535211715, 16365.181740912669, 16590.170491475135, 14412.495562655256, 14591.489297874523, 14787.186704731343, 14804.925975370053, 14870.256487175815, 15172.620684482976, 15199.544013679608, 15226.77159842581, 15292.0, 15379.307931143348, 15555.45555905538, 15586.220688965734, 15874.52376428709, 15878.60303492422, 15936.28286727077, 10999.175061870232, 11103.961210960286, 11107.111431085656, 11355.54577816878, 11507.309561426342, 11694.29834209916, 11874.584389546324, 12016.098792590765, 12110.394480276127, 12123.45444454984], "value": 8840.262156477967, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1456.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 114.0, 107.0, 117.0, 108.0, 113.0, 113.0, 107.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 122.0, 115.0, 115.0, 120.0, 116.0, 122.0, 118.0, 141.0, 121.0], "value": 121.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 164.0, 161.0, 164.0, 169.0, 172.0, 164.0, 164.0, 166.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 80.0, 85.0, 73.0, 78.0, 74.0, 84.0, 77.0, 75.0], "value": 78.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 79.0, 77.0, 81.0, 84.0, 78.0, 88.0, 87.0, 80.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 123.0, 116.0, 115.0, 119.0, 115.0, 117.0, 119.0, 116.0, 121.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 151.0, 148.0, 158.0, 149.0, 148.0, 150.0, 150.0, 150.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 103.0, 94.0, 95.0, 93.0, 94.0, 96.0, 102.0, 98.0, 97.0], "value": 97.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 54.0, 54.0, 53.0, 55.0, 57.0, 61.0, 53.0, 61.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 46.0, 44.0, 39.0, 38.0, 38.0, 43.0, 43.0, 39.0, 45.0], "value": 41.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 75.0, 86.0, 74.0, 80.0, 72.0, 87.0, 75.0, 81.0, 76.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 116.0, 111.0, 122.0, 113.0, 116.0, 124.0, 115.0, 120.0], "value": 117.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 166.0, 170.0, 169.0, 169.0, 176.0, 171.0, 175.0, 165.0, 168.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 66.0, 65.0, 63.0, 68.0, 66.0, 64.0, 67.0, 65.0], "value": 66.5, "unit": "score"}]}]} 17:13:06 INFO - Return code: 0 17:13:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:13:06 INFO - # TBPL SUCCESS # 17:13:06 INFO - Running post-action listener: _package_coverage_data 17:13:06 INFO - Running post-action listener: _resource_record_post_action 17:13:06 INFO - [mozharness: 2017-09-27 00:13:06.646653Z] Finished run-tests step (success) 17:13:06 INFO - Running post-run listener: _resource_record_post_run 17:13:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 3080192; Write bytes: 346619904; Read time: 928; Write time: 204200 17:13:06 INFO - TinderboxPrint: CPU usage
13.3% 17:13:06 INFO - TinderboxPrint: I/O read bytes / time
3,080,192 / 928 17:13:06 INFO - TinderboxPrint: I/O write bytes / time
346,619,904 / 204,200 17:13:06 INFO - TinderboxPrint: CPU idle
8,251.9 (86.7%) 17:13:06 INFO - TinderboxPrint: CPU user
1,202.8 (12.6%) 17:13:06 INFO - TinderboxPrint: Swap in / out
0 / 0 17:13:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13045760; Read time: 0; Write time: 1684 17:13:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:13:06 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 3076096; Write bytes: 333574144; Read time: 912; Write time: 202516 17:13:07 INFO - Running post-run listener: _upload_blobber_files 17:13:07 INFO - Blob upload gear active. 17:13:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:13:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:13:07 INFO - (blobuploader) - INFO - Open directory for files ... 17:13:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:13:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:13:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:08 INFO - (blobuploader) - INFO - Done attempting. 17:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:13:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:20 INFO - (blobuploader) - INFO - Done attempting. 17:13:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:13:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:13:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:21 INFO - (blobuploader) - INFO - Done attempting. 17:13:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:13:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:13:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:22 INFO - (blobuploader) - INFO - Done attempting. 17:13:22 INFO - (blobuploader) - INFO - Iteration through files over. 17:13:22 INFO - Return code: 0 17:13:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:13:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:13:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54bdcced2e9b09555cf365254c9822779682e24030eede76bb78730058f183a509bdf035b02401e39aa88ac45b03f3b39c733c754f1ec6219b2aef99986d9761", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c44c994f208b0ba2057a3c83b1229f50b905daa8f41647c26a11e82f2fdb3b3bd308144f2ebd7d0311341224c209c08c363a4d1bf2532190cb4ab59ffeadbd9e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/064c5a22c374e74435e9ae2db321222e38b48af8ce90492ca89181cbcaea9be6e90877280a45e5dbc44b7316877b39446cde1abee3a036e5e6ab25c879863347", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f7c5123ab1181d094bdea500d9eb09c516b9dba92ad43b52e43bf4269fabe40cec41522b9cdfddd84715720c48899ba4dc8e4ba26b8083485f65cbdaf683d31"} 17:13:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:13:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:13:22 INFO - Contents: 17:13:22 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54bdcced2e9b09555cf365254c9822779682e24030eede76bb78730058f183a509bdf035b02401e39aa88ac45b03f3b39c733c754f1ec6219b2aef99986d9761", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c44c994f208b0ba2057a3c83b1229f50b905daa8f41647c26a11e82f2fdb3b3bd308144f2ebd7d0311341224c209c08c363a4d1bf2532190cb4ab59ffeadbd9e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/064c5a22c374e74435e9ae2db321222e38b48af8ce90492ca89181cbcaea9be6e90877280a45e5dbc44b7316877b39446cde1abee3a036e5e6ab25c879863347", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f7c5123ab1181d094bdea500d9eb09c516b9dba92ad43b52e43bf4269fabe40cec41522b9cdfddd84715720c48899ba4dc8e4ba26b8083485f65cbdaf683d31"} 17:13:22 INFO - Running post-run listener: copy_logs_to_upload_dir 17:13:22 INFO - Copying logs to upload dir... 17:13:22 INFO - mkdir: /builds/slave/test/build/upload/logs 17:13:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.803740 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-09-26 17:13:22.854593) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 17:13:22.863483) ========= 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=9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54bdcced2e9b09555cf365254c9822779682e24030eede76bb78730058f183a509bdf035b02401e39aa88ac45b03f3b39c733c754f1ec6219b2aef99986d9761", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c44c994f208b0ba2057a3c83b1229f50b905daa8f41647c26a11e82f2fdb3b3bd308144f2ebd7d0311341224c209c08c363a4d1bf2532190cb4ab59ffeadbd9e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/064c5a22c374e74435e9ae2db321222e38b48af8ce90492ca89181cbcaea9be6e90877280a45e5dbc44b7316877b39446cde1abee3a036e5e6ab25c879863347", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f7c5123ab1181d094bdea500d9eb09c516b9dba92ad43b52e43bf4269fabe40cec41522b9cdfddd84715720c48899ba4dc8e4ba26b8083485f65cbdaf683d31"} build_url:https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011411 build_url: 'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54bdcced2e9b09555cf365254c9822779682e24030eede76bb78730058f183a509bdf035b02401e39aa88ac45b03f3b39c733c754f1ec6219b2aef99986d9761", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c44c994f208b0ba2057a3c83b1229f50b905daa8f41647c26a11e82f2fdb3b3bd308144f2ebd7d0311341224c209c08c363a4d1bf2532190cb4ab59ffeadbd9e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/064c5a22c374e74435e9ae2db321222e38b48af8ce90492ca89181cbcaea9be6e90877280a45e5dbc44b7316877b39446cde1abee3a036e5e6ab25c879863347", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f7c5123ab1181d094bdea500d9eb09c516b9dba92ad43b52e43bf4269fabe40cec41522b9cdfddd84715720c48899ba4dc8e4ba26b8083485f65cbdaf683d31"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 17:13:22.894669) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:13:22.894993) ========= 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=9f7544b6a75ada7b6b576032000001a7-1506469290.259306-1399361734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:13:22.952066) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 17:13:22.952414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 17:13:22.952812) ========= ========= Total master_lag: 0.32 =========