builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-076 starttime: 1505599868.39 results: success (0) revision: 44e56a4d482a0959e00afb371872035caf3cd56d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:08.387517) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:08.387922) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:08.388278) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:08.422875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:08.423233) ========= 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=9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 15:11:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-09-16 15:11:08 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093690 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:08.533080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:08.536409) ========= 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=9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019690 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:08.585851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:08.589196) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 44e56a4d482a0959e00afb371872035caf3cd56d --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 44e56a4d482a0959e00afb371872035caf3cd56d --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=9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 15:11:09,056 truncating revision to first 12 chars 2017-09-16 15:11:09,056 Setting DEBUG logging. 2017-09-16 15:11:09,056 attempt 1/10 2017-09-16 15:11:09,056 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/44e56a4d482a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 15:11:09,565 unpacking tar archive at: mozilla-central-44e56a4d482a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.783374 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:09.386022) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:09.389343) ========= script_repo_revision: 44e56a4d482a0959e00afb371872035caf3cd56d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:09.389703) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:09.389958) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 15:11:09.402545) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-16 15:11:09.402834) ========= /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=9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:11:10 INFO - MultiFileLogger online at 20170916 15:11:10 in /builds/slave/test 15:11:10 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 15:11:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:11:10 INFO - {'append_to_log': False, 15:11:10 INFO - 'base_work_dir': '/builds/slave/test', 15:11:10 INFO - 'blob_upload_branch': 'Firefox', 15:11:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:11:10 INFO - 'branch': 'Firefox', 15:11:10 INFO - 'buildbot_json_path': 'buildprops.json', 15:11:10 INFO - 'code_coverage': False, 15:11:10 INFO - 'config_files': ('talos/linux_config.py',), 15:11:10 INFO - 'default_actions': ('clobber', 15:11:10 INFO - 'read-buildbot-config', 15:11:10 INFO - 'download-and-extract', 15:11:10 INFO - 'populate-webroot', 15:11:10 INFO - 'create-virtualenv', 15:11:10 INFO - 'install', 15:11:10 INFO - 'setup-mitmproxy', 15:11:10 INFO - 'run-tests'), 15:11:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:11:10 INFO - 'disable_ccov_upload': False, 15:11:10 INFO - 'disable_stylo': False, 15:11:10 INFO - 'download_minidump_stackwalk': True, 15:11:10 INFO - 'download_symbols': 'ondemand', 15:11:10 INFO - 'enable_stylo': False, 15:11:10 INFO - 'enable_webrender': False, 15:11:10 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:11:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:11:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:11:10 INFO - 'gecko_profile': False, 15:11:10 INFO - 'gecko_profile_interval': 0, 15:11:10 INFO - 'installer_path': 'installer.exe', 15:11:10 INFO - 'log_level': 'info', 15:11:10 INFO - 'log_name': 'talos', 15:11:10 INFO - 'log_to_console': True, 15:11:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:11:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:11:10 INFO - 'opt_config_files': (), 15:11:10 INFO - 'pip_index': False, 15:11:10 INFO - 'suite': 'dromaeojs-e10s', 15:11:10 INFO - 'system_bits': '32', 15:11:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:11:10 INFO - 'title': 'talos-linux64-ix-076', 15:11:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:11:10 INFO - 'use_talos_json': True, 15:11:10 INFO - 'verify': 'False', 15:11:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:11:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:11:10 INFO - 'work_dir': 'build'} 15:11:10 INFO - [mozharness: 2017-09-16 22:11:10.019480Z] Running clobber step. 15:11:10 INFO - Running pre-action listener: _resource_record_pre_action 15:11:10 INFO - Running main action method: clobber 15:11:10 INFO - rmtree: /builds/slave/test/build 15:11:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:11:11 INFO - Running post-action listener: _resource_record_post_action 15:11:11 INFO - [mozharness: 2017-09-16 22:11:11.536601Z] Finished clobber step (success) 15:11:11 INFO - [mozharness: 2017-09-16 22:11:11.536696Z] Running read-buildbot-config step. 15:11:11 INFO - Running pre-action listener: _resource_record_pre_action 15:11:11 INFO - Running main action method: read_buildbot_config 15:11:11 INFO - Using buildbot properties: 15:11:11 INFO - { 15:11:11 INFO - "project": "", 15:11:11 INFO - "product": "firefox", 15:11:11 INFO - "who": "ryanvm@gmail.com", 15:11:11 INFO - "installer_path": "public/build/target.tar.bz2", 15:11:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:11:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:11:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 15:11:11 INFO - "stage_platform": "linux64-pgo", 15:11:11 INFO - "basedir": "/builds/slave/test", 15:11:11 INFO - "buildnumber": 169, 15:11:11 INFO - "platform": "ubuntu64_hw", 15:11:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:11:11 INFO - "slavebuilddir": "test", 15:11:11 INFO - "taskId": "JHbNY8wSS6y2SmowXxk3Fg", 15:11:11 INFO - "branch": "mozilla-central", 15:11:11 INFO - "script_repo_revision": "production", 15:11:11 INFO - "revision": "44e56a4d482a0959e00afb371872035caf3cd56d", 15:11:11 INFO - "slavename": "talos-linux64-ix-076", 15:11:11 INFO - "repo_path": "mozilla-central" 15:11:11 INFO - } 15:11:11 INFO - Finding installer, test and symbols from parent task. 15:11:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JHbNY8wSS6y2SmowXxk3Fg'}, attempt #1 15:11:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JHbNY8wSS6y2SmowXxk3Fg'}, attempt #1 15:11:12 INFO - Task dependencies: GxdTmOGBQj-VN93KhE7TqA 15:11:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA'}, attempt #1 15:11:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.tar.bz2 15:11:12 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.test_packages.json 15:11:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.crashreporter-symbols.zip 15:11:12 INFO - Running post-action listener: _resource_record_post_action 15:11:12 INFO - [mozharness: 2017-09-16 22:11:12.919548Z] Finished read-buildbot-config step (success) 15:11:12 INFO - [mozharness: 2017-09-16 22:11:12.919808Z] Running download-and-extract step. 15:11:12 INFO - Running pre-action listener: _resource_record_pre_action 15:11:12 INFO - Running main action method: download_and_extract 15:11:12 INFO - mkdir: /builds/slave/test/build/tests 15:11: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')]} 15:11:12 INFO - trying https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.test_packages.json 15:11:12 INFO - Downloading https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:11:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:11:13 INFO - Downloaded 989 bytes. 15:11:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:11:13 INFO - Using the following test package requirements: 15:11:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:11:13 INFO - u'common': [u'target.common.tests.zip'], 15:11:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:11:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:11:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:11:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:11:13 INFO - u'mozbase': [u'target.common.tests.zip'], 15:11:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:11:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:11:13 INFO - u'web-platform': [u'target.common.tests.zip', 15:11:13 INFO - u'target.web-platform.tests.tar.gz'], 15:11:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:11:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:11:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.common.tests.zip 15:11:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:11:13 INFO - Fetch https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.common.tests.zip into memory 15:11:14 INFO - Content-Length response header: 55282269 15:11:14 INFO - Bytes received: 55282269 15:11:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.talos.tests.zip 15:11:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:11:25 INFO - Fetch https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.talos.tests.zip into memory 15:11:25 INFO - Content-Length response header: 14508748 15:11:25 INFO - Bytes received: 14508748 15:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:26 INFO - trying https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.tar.bz2 15:11:26 INFO - Downloading https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:11:27 INFO - Downloaded 62079177 bytes. 15:11:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.tar.bz2 15:11:27 INFO - mkdir: /builds/slave/test/properties 15:11:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:11:27 INFO - Writing to file /builds/slave/test/properties/build_url 15:11:27 INFO - Contents: 15:11:27 INFO - build_url:https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.tar.bz2 15:11:27 INFO - Running post-action listener: _resource_record_post_action 15:11:27 INFO - Running post-action listener: find_tests_for_verification 15:11:27 INFO - Running post-action listener: set_extra_try_arguments 15:11:27 INFO - [mozharness: 2017-09-16 22:11:27.323509Z] Finished download-and-extract step (success) 15:11:27 INFO - [mozharness: 2017-09-16 22:11:27.323637Z] Running populate-webroot step. 15:11:27 INFO - Running pre-action listener: _resource_record_pre_action 15:11:27 INFO - Running main action method: populate_webroot 15:11:27 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:11:27 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:11:27 INFO - 'tests': ['tresize', 15:11:27 INFO - 'tcanvasmark']}, 15:11:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:11:27 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:11:27 INFO - 'tests': ['dromaeo_css', 15:11:27 INFO - 'kraken']}, 15:11:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:11:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:11:27 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:11:27 INFO - 'talos_options': ['--disable-stylo'], 15:11:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:11:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:11:27 INFO - 'tests': ['damp', 'tps']}, 15:11:27 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:11:27 INFO - 'talos_options': ['--disable-stylo'], 15:11:27 INFO - 'tests': ['damp', 'tps']}, 15:11:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:11:27 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:11:27 INFO - 'tests': ['dromaeo_dom']}, 15:11:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:11:27 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:11:27 INFO - 'tests': ['basic_compositor_video', 15:11:27 INFO - 'glvideo']}, 15:11:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:11:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:11:27 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:11:27 INFO - 'talos_options': ['--disable-stylo'], 15:11:27 INFO - 'tests': ['ts_paint_webext', 15:11:27 INFO - 'tp5o_webext']}, 15:11:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:11:27 INFO - 'ts_paint', 15:11:27 INFO - 'tpaint', 15:11:27 INFO - 'sessionrestore', 15:11:27 INFO - 'sessionrestore_many_windows', 15:11:27 INFO - 'sessionrestore_no_auto_restore', 15:11:27 INFO - 'tabpaint']}, 15:11:27 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:11:27 INFO - 'tests': ['a11yr', 15:11:27 INFO - 'ts_paint', 15:11:27 INFO - 'tpaint', 15:11:27 INFO - 'sessionrestore', 15:11:27 INFO - 'sessionrestore_many_windows', 15:11:27 INFO - 'sessionrestore_no_auto_restore', 15:11:27 INFO - 'tabpaint']}, 15:11:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:11:27 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:11:27 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:11:27 INFO - 'tests': ['perf_reftest_singletons']}, 15:11:27 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:11:27 INFO - 'tests': ['bloom_basic']}, 15:11:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:11:27 INFO - 'tsvgr_opacity', 15:11:27 INFO - 'tart', 15:11:27 INFO - 'tscrollx', 15:11:27 INFO - 'tsvg_static']}, 15:11:27 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:11:27 INFO - 'tests': ['tsvgx', 15:11:27 INFO - 'tsvgr_opacity', 15:11:27 INFO - 'tart', 15:11:27 INFO - 'tscrollx', 15:11:27 INFO - 'tsvg_static']}, 15:11:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:11:27 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:11:27 INFO - 'talos_options': ['--disable-stylo'], 15:11:27 INFO - 'tests': ['tp5o']}, 15:11:27 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:11:27 INFO - 'talos_options': ['--mitmproxy', 15:11:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:11:27 INFO - '--firstNonBlankPaint'], 15:11:27 INFO - 'tests': ['tp6_google', 15:11:27 INFO - 'tp6_youtube', 15:11:27 INFO - 'tp6_amazon', 15:11:27 INFO - 'tp6_facebook']}, 15:11:27 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:11:27 INFO - 'talos_options': ['--disable-stylo', 15:11:27 INFO - '--mitmproxy', 15:11:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:11:27 INFO - '--firstNonBlankPaint'], 15:11:27 INFO - 'tests': ['tp6_google', 15:11:27 INFO - 'tp6_youtube', 15:11:27 INFO - 'tp6_amazon', 15:11:27 INFO - 'tp6_facebook']}, 15:11:27 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:11:27 INFO - 'talos_options': ['--stylo-threads=1', 15:11:27 INFO - '--mitmproxy', 15:11:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:11:27 INFO - '--firstNonBlankPaint'], 15:11:27 INFO - 'tests': ['tp6_google', 15:11:27 INFO - 'tp6_youtube', 15:11:27 INFO - 'tp6_amazon', 15:11:27 INFO - 'tp6_facebook']}, 15:11:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:11:27 INFO - 'talos_options': ['--xperf_path', 15:11:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:11:27 INFO - 'tests': ['tp5n']}, 15:11:27 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:11:27 INFO - 'talos_options': ['--disable-stylo', 15:11:27 INFO - '--xperf_path', 15:11:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:11:27 INFO - 'tests': ['tp5n']}}} 15:11:27 INFO - Running post-action listener: _resource_record_post_action 15:11:27 INFO - [mozharness: 2017-09-16 22:11:27.341277Z] Finished populate-webroot step (success) 15:11:27 INFO - [mozharness: 2017-09-16 22:11:27.341366Z] Running create-virtualenv step. 15:11:27 INFO - Running pre-action listener: _resource_record_pre_action 15:11:27 INFO - Running main action method: create_virtualenv 15:11:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:11:27 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:11:27 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:11:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:11:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:11:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:11:27 INFO - Installing distribute.............................................................................................................................................................................................done. 15:11:28 INFO - Installing pip...............done. 15:11:28 INFO - Return code: 0 15:11:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:11:28 INFO - Reading from file tmpfile_stdout 15:11:28 INFO - Output received: 15:11:28 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:11:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:28 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 0x22951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2605090>, '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 0x2605d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', '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 15:11:28 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 15:11:28 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 15:11:28 INFO - Using env: {'DISPLAY': ':0', 15:11:28 INFO - 'HOME': '/home/cltbld', 15:11:28 INFO - 'LANG': 'en_US.UTF-8', 15:11:28 INFO - 'LANGUAGE': 'en_US:en', 15:11:28 INFO - 'LOGNAME': 'cltbld', 15:11:28 INFO - 'MAIL': '/var/mail/cltbld', 15:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:28 INFO - 'MOZ_NO_REMOTE': '1', 15:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:28 INFO - 'NO_EM_RESTART': '1', 15:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:28 INFO - 'PWD': '/builds/slave/test', 15:11:28 INFO - 'SHELL': '/bin/bash', 15:11:28 INFO - 'SHLVL': '1', 15:11:28 INFO - 'TERM': 'linux', 15:11:28 INFO - 'TMOUT': '86400', 15:11:28 INFO - 'USER': 'cltbld', 15:11:28 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:28 INFO - '_': '/tools/buildbot/bin/python'} 15:11:33 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:11:33 INFO - Downloading/unpacking pip>=1.5 15:11:33 INFO - Running setup.py egg_info for package pip 15:11:33 INFO - warning: no files found matching 'pip/cacert.pem' 15:11:33 INFO - warning: no files found matching '*.html' under directory 'docs' 15:11:33 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:11:33 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:11:33 INFO - Installing collected packages: pip 15:11:33 INFO - Found existing installation: pip 1.1 15:11:33 INFO - Uninstalling pip: 15:11:33 INFO - Successfully uninstalled pip 15:11:33 INFO - Running setup.py install for pip 15:11:33 INFO - warning: no files found matching 'pip/cacert.pem' 15:11:33 INFO - warning: no files found matching '*.html' under directory 'docs' 15:11:33 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:11:33 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:11:33 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:11:33 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:11:33 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:11:33 INFO - Successfully installed pip 15:11:33 INFO - Cleaning up... 15:11:33 INFO - Return code: 0 15:11:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:33 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 0x22951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2605090>, '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 0x2605d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', '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 15:11:33 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 15:11:33 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 15:11:33 INFO - Using env: {'DISPLAY': ':0', 15:11:33 INFO - 'HOME': '/home/cltbld', 15:11:33 INFO - 'LANG': 'en_US.UTF-8', 15:11:33 INFO - 'LANGUAGE': 'en_US:en', 15:11:33 INFO - 'LOGNAME': 'cltbld', 15:11:33 INFO - 'MAIL': '/var/mail/cltbld', 15:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:33 INFO - 'MOZ_NO_REMOTE': '1', 15:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:33 INFO - 'NO_EM_RESTART': '1', 15:11:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:33 INFO - 'PWD': '/builds/slave/test', 15:11:33 INFO - 'SHELL': '/bin/bash', 15:11:33 INFO - 'SHLVL': '1', 15:11:33 INFO - 'TERM': 'linux', 15:11:33 INFO - 'TMOUT': '86400', 15:11:33 INFO - 'USER': 'cltbld', 15:11:33 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:33 INFO - '_': '/tools/buildbot/bin/python'} 15:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:33 INFO - Downloading/unpacking psutil>=3.1.1 15:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:11:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:11:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:11:34 INFO - Installing collected packages: psutil 15:11:34 INFO - Running setup.py install for psutil 15:11:34 INFO - building 'psutil._psutil_linux' extension 15:11:34 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 15:11:34 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 15:11:34 INFO - building 'psutil._psutil_posix' extension 15:11:34 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 15:11:34 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 15:11:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:11:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:11:35 INFO - Successfully installed psutil 15:11:35 INFO - Cleaning up... 15:11:36 INFO - Return code: 0 15:11:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:11:36 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')]} 15:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:36 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')]} 15:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:36 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 0x22951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2605090>, '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 0x2605d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', '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 15:11:36 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 15:11:36 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 15:11:36 INFO - Using env: {'DISPLAY': ':0', 15:11:36 INFO - 'HOME': '/home/cltbld', 15:11:36 INFO - 'LANG': 'en_US.UTF-8', 15:11:36 INFO - 'LANGUAGE': 'en_US:en', 15:11:36 INFO - 'LOGNAME': 'cltbld', 15:11:36 INFO - 'MAIL': '/var/mail/cltbld', 15:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:36 INFO - 'MOZ_NO_REMOTE': '1', 15:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:36 INFO - 'NO_EM_RESTART': '1', 15:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:36 INFO - 'PWD': '/builds/slave/test', 15:11:36 INFO - 'SHELL': '/bin/bash', 15:11:36 INFO - 'SHLVL': '1', 15:11:36 INFO - 'TERM': 'linux', 15:11:36 INFO - 'TMOUT': '86400', 15:11:36 INFO - 'USER': 'cltbld', 15:11:36 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:36 INFO - '_': '/tools/buildbot/bin/python'} 15:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:11:36 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 15:11:36 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 15:11:36 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 15:11:36 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 15:11:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:11:37 INFO - Installing collected packages: mozsystemmonitor 15:11:37 INFO - Running setup.py install for mozsystemmonitor 15:11:37 INFO - Successfully installed mozsystemmonitor 15:11:37 INFO - Cleaning up... 15:11:37 INFO - Return code: 0 15:11:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:11:37 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')]} 15:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:37 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')]} 15:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:37 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 0x22951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2605090>, '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 0x2605d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', '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 15:11:37 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 15:11:37 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 15:11:37 INFO - Using env: {'DISPLAY': ':0', 15:11:37 INFO - 'HOME': '/home/cltbld', 15:11:37 INFO - 'LANG': 'en_US.UTF-8', 15:11:37 INFO - 'LANGUAGE': 'en_US:en', 15:11:37 INFO - 'LOGNAME': 'cltbld', 15:11:37 INFO - 'MAIL': '/var/mail/cltbld', 15:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:37 INFO - 'MOZ_NO_REMOTE': '1', 15:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:37 INFO - 'NO_EM_RESTART': '1', 15:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:37 INFO - 'PWD': '/builds/slave/test', 15:11:37 INFO - 'SHELL': '/bin/bash', 15:11:37 INFO - 'SHLVL': '1', 15:11:37 INFO - 'TERM': 'linux', 15:11:37 INFO - 'TMOUT': '86400', 15:11:37 INFO - 'USER': 'cltbld', 15:11:37 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:37 INFO - '_': '/tools/buildbot/bin/python'} 15:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:37 INFO - Downloading/unpacking jsonschema==2.5.1 15:11:37 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 15:11:37 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 15:11:37 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 15:11:37 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 15:11:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:11:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:11:38 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 15:11:38 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 15:11:38 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 15:11:38 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 15:11:39 INFO - Downloading functools32-3.2.3-2.tar.gz 15:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:11:39 INFO - warning: no files found matching '*.txt' 15:11:39 INFO - no previously-included directories found matching 'build' 15:11:39 INFO - no previously-included directories found matching 'dist' 15:11:39 INFO - no previously-included directories found matching '.git*' 15:11:39 INFO - Installing collected packages: jsonschema, functools32 15:11:39 INFO - Running setup.py install for functools32 15:11:39 INFO - warning: no files found matching '*.txt' 15:11:39 INFO - no previously-included directories found matching 'build' 15:11:39 INFO - no previously-included directories found matching 'dist' 15:11:39 INFO - no previously-included directories found matching '.git*' 15:11:39 INFO - Successfully installed jsonschema functools32 15:11:39 INFO - Cleaning up... 15:11:39 INFO - Return code: 0 15:11:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:11:39 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')]} 15:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:39 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')]} 15:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:39 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 0x22951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2605090>, '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 0x2605d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', '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 15:11:39 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 15:11:39 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 15:11:39 INFO - Using env: {'DISPLAY': ':0', 15:11:39 INFO - 'HOME': '/home/cltbld', 15:11:39 INFO - 'LANG': 'en_US.UTF-8', 15:11:39 INFO - 'LANGUAGE': 'en_US:en', 15:11:39 INFO - 'LOGNAME': 'cltbld', 15:11:39 INFO - 'MAIL': '/var/mail/cltbld', 15:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:39 INFO - 'MOZ_NO_REMOTE': '1', 15:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:39 INFO - 'NO_EM_RESTART': '1', 15:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:39 INFO - 'PWD': '/builds/slave/test', 15:11:39 INFO - 'SHELL': '/bin/bash', 15:11:39 INFO - 'SHLVL': '1', 15:11:39 INFO - 'TERM': 'linux', 15:11:39 INFO - 'TMOUT': '86400', 15:11:39 INFO - 'USER': 'cltbld', 15:11:39 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:39 INFO - '_': '/tools/buildbot/bin/python'} 15:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:11:39 INFO - Cleaning up... 15:11:39 INFO - Return code: 0 15:11:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:11:39 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')]} 15:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:39 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')]} 15:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:39 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 0x22951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2605090>, '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 0x2605d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', '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 15:11:39 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 15:11:39 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 15:11:39 INFO - Using env: {'DISPLAY': ':0', 15:11:39 INFO - 'HOME': '/home/cltbld', 15:11:39 INFO - 'LANG': 'en_US.UTF-8', 15:11:39 INFO - 'LANGUAGE': 'en_US:en', 15:11:39 INFO - 'LOGNAME': 'cltbld', 15:11:39 INFO - 'MAIL': '/var/mail/cltbld', 15:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:39 INFO - 'MOZ_NO_REMOTE': '1', 15:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:39 INFO - 'NO_EM_RESTART': '1', 15:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:39 INFO - 'PWD': '/builds/slave/test', 15:11:39 INFO - 'SHELL': '/bin/bash', 15:11:39 INFO - 'SHLVL': '1', 15:11:39 INFO - 'TERM': 'linux', 15:11:39 INFO - 'TMOUT': '86400', 15:11:39 INFO - 'USER': 'cltbld', 15:11:39 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:39 INFO - '_': '/tools/buildbot/bin/python'} 15:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:39 INFO - Downloading/unpacking blobuploader==1.2.4 15:11:39 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 15:11:39 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 15:11:39 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 15:11:39 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 15:11:40 INFO - Downloading blobuploader-1.2.4.tar.gz 15:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:11:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:11:40 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 15:11:40 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 15:11:40 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 15:11:40 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 15:11:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:11:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:11:41 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 15:11:41 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 15:11:41 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 15:11:41 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 15:11:41 INFO - Downloading docopt-0.6.1.tar.gz 15:11:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:11:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:11:41 INFO - Running setup.py install for blobuploader 15:11:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:11:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:11:41 INFO - Running setup.py install for requests 15:11:41 INFO - Running setup.py install for docopt 15:11:42 INFO - Successfully installed blobuploader requests docopt 15:11:42 INFO - Cleaning up... 15:11:42 INFO - Return code: 0 15:11:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11:42 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')]} 15:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:42 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')]} 15:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:42 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 0x22951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2605090>, '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 0x2605d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', '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 15:11:42 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 15:11:42 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 15:11:42 INFO - Using env: {'DISPLAY': ':0', 15:11:42 INFO - 'HOME': '/home/cltbld', 15:11:42 INFO - 'LANG': 'en_US.UTF-8', 15:11:42 INFO - 'LANGUAGE': 'en_US:en', 15:11:42 INFO - 'LOGNAME': 'cltbld', 15:11:42 INFO - 'MAIL': '/var/mail/cltbld', 15:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:42 INFO - 'MOZ_NO_REMOTE': '1', 15:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:42 INFO - 'NO_EM_RESTART': '1', 15:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:42 INFO - 'PWD': '/builds/slave/test', 15:11:42 INFO - 'SHELL': '/bin/bash', 15:11:42 INFO - 'SHLVL': '1', 15:11:42 INFO - 'TERM': 'linux', 15:11:42 INFO - 'TMOUT': '86400', 15:11:42 INFO - 'USER': 'cltbld', 15:11:42 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:42 INFO - '_': '/tools/buildbot/bin/python'} 15:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:11:42 INFO - Running setup.py (path:/tmp/pip-uKwmfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:11:42 INFO - Running setup.py (path:/tmp/pip-H4Lct2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:11:42 INFO - Running setup.py (path:/tmp/pip-B5b29L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:11:42 INFO - Running setup.py (path:/tmp/pip-1usVhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:11:42 INFO - Running setup.py (path:/tmp/pip-oLGFJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:11:42 INFO - Running setup.py (path:/tmp/pip-TvgAFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:11:42 INFO - Running setup.py (path:/tmp/pip-OIkDp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:11:42 INFO - Running setup.py (path:/tmp/pip-xGwboe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:11:42 INFO - Running setup.py (path:/tmp/pip-OvllB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:11:42 INFO - Running setup.py (path:/tmp/pip-HdxQ3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:11:42 INFO - Running setup.py (path:/tmp/pip-Wvz9Ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:11:43 INFO - Running setup.py (path:/tmp/pip-P0j8tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:11:43 INFO - Running setup.py (path:/tmp/pip-nmVMR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:11:43 INFO - Running setup.py (path:/tmp/pip-fOm0Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:43 INFO - Running setup.py (path:/tmp/pip-JYkTrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:11:43 INFO - Running setup.py (path:/tmp/pip-0ECz8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:11:43 INFO - Running setup.py (path:/tmp/pip-W4AZuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:11:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:11:43 INFO - Running setup.py install for manifestparser 15:11:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:11:43 INFO - Running setup.py install for mozcrash 15:11:43 INFO - Running setup.py install for mozdebug 15:11:43 INFO - Running setup.py install for mozdevice 15:11:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:11:43 INFO - Running setup.py install for mozfile 15:11:43 INFO - Running setup.py install for mozhttpd 15:11:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:11:44 INFO - Running setup.py install for mozinfo 15:11:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:11:44 INFO - Running setup.py install for mozInstall 15:11:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:11:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:11:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:11:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:11:44 INFO - Running setup.py install for mozleak 15:11:44 INFO - Running setup.py install for mozlog 15:11:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:11:44 INFO - Running setup.py install for moznetwork 15:11:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:11:44 INFO - Running setup.py install for mozprocess 15:11:44 INFO - Running setup.py install for mozprofile 15:11:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:11:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:11:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:11:44 INFO - Running setup.py install for mozrunner 15:11:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:11:44 INFO - Running setup.py install for mozscreenshot 15:11:45 INFO - Running setup.py install for moztest 15:11:45 INFO - Running setup.py install for mozversion 15:11:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:11:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:11:45 INFO - Cleaning up... 15:11:45 INFO - Return code: 0 15:11:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11:45 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')]} 15:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:45 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')]} 15:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:45 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 0x22951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2605090>, '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 0x2605d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', '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 15:11:45 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 15:11:45 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 15:11:45 INFO - Using env: {'DISPLAY': ':0', 15:11:45 INFO - 'HOME': '/home/cltbld', 15:11:45 INFO - 'LANG': 'en_US.UTF-8', 15:11:45 INFO - 'LANGUAGE': 'en_US:en', 15:11:45 INFO - 'LOGNAME': 'cltbld', 15:11:45 INFO - 'MAIL': '/var/mail/cltbld', 15:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:45 INFO - 'MOZ_NO_REMOTE': '1', 15:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:45 INFO - 'NO_EM_RESTART': '1', 15:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:45 INFO - 'PWD': '/builds/slave/test', 15:11:45 INFO - 'SHELL': '/bin/bash', 15:11:45 INFO - 'SHLVL': '1', 15:11:45 INFO - 'TERM': 'linux', 15:11:45 INFO - 'TMOUT': '86400', 15:11:45 INFO - 'USER': 'cltbld', 15:11:45 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:45 INFO - '_': '/tools/buildbot/bin/python'} 15:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:11:45 INFO - Running setup.py (path:/tmp/pip-0CCo_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:11:45 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)) 15:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:11:45 INFO - Running setup.py (path:/tmp/pip-jgc9KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:11:45 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)) 15:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:11:45 INFO - Running setup.py (path:/tmp/pip-OTZQXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:11:45 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)) 15:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:11:45 INFO - Running setup.py (path:/tmp/pip-eO_naV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:11:45 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)) 15:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:11:45 INFO - Running setup.py (path:/tmp/pip-UuR6wW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:11:45 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)) 15:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:11:45 INFO - Running setup.py (path:/tmp/pip-roZxup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:11:45 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)) 15:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:11:45 INFO - Running setup.py (path:/tmp/pip-ARwKoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:11:45 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)) 15:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:11:45 INFO - Running setup.py (path:/tmp/pip-ON8AIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:11:46 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)) 15:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:11:46 INFO - Running setup.py (path:/tmp/pip-ipcLPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:11:46 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)) 15:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:11:46 INFO - Running setup.py (path:/tmp/pip-I8eh2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:11:46 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)) 15:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:11:46 INFO - Running setup.py (path:/tmp/pip-M9yBtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:11:46 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)) 15:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:11:46 INFO - Running setup.py (path:/tmp/pip-35JVyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:11:46 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)) 15:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:11:46 INFO - Running setup.py (path:/tmp/pip-RUQFLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:11:46 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)) 15:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:11:46 INFO - Running setup.py (path:/tmp/pip-cO1ZHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:11:46 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)) 15:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:46 INFO - Running setup.py (path:/tmp/pip-xdObxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:46 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)) 15:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:11:46 INFO - Running setup.py (path:/tmp/pip-Vniisu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:11:46 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)) 15:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:11:46 INFO - Running setup.py (path:/tmp/pip-KXf0hO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:11:46 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)) 15:11:46 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)) 15:11:46 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)) 15:11:46 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)) 15:11:46 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)) 15:11:46 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)) 15:11:46 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)) 15:11:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:11:46 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 15:11:46 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 15:11:46 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 15:11:46 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 15:11:47 INFO - Downloading blessings-1.6.tar.gz 15:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:11:47 INFO - Installing collected packages: blessings 15:11:47 INFO - Running setup.py install for blessings 15:11:47 INFO - Successfully installed blessings 15:11:47 INFO - Cleaning up... 15:11:48 INFO - Return code: 0 15:11:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:48 INFO - Reading from file tmpfile_stdout 15:11:48 INFO - Current package versions: 15:11:48 INFO - argparse == 1.2.1 15:11:48 INFO - blessings == 1.6 15:11:48 INFO - blobuploader == 1.2.4 15:11:48 INFO - docopt == 0.6.1 15:11:48 INFO - functools32 == 3.2.3-2 15:11:48 INFO - jsonschema == 2.5.1 15:11:48 INFO - manifestparser == 1.1 15:11:48 INFO - mozInstall == 1.13 15:11:48 INFO - mozcrash == 1.0 15:11:48 INFO - mozdebug == 0.1 15:11:48 INFO - mozdevice == 0.51 15:11:48 INFO - mozfile == 1.2 15:11:48 INFO - mozhttpd == 0.7 15:11:48 INFO - mozinfo == 0.10 15:11:48 INFO - mozleak == 0.1 15:11:48 INFO - mozlog == 3.5 15:11:48 INFO - moznetwork == 0.27 15:11:48 INFO - mozprocess == 0.25 15:11:48 INFO - mozprofile == 0.28 15:11:48 INFO - mozrunner == 6.13 15:11:48 INFO - mozscreenshot == 0.1 15:11:48 INFO - mozsystemmonitor == 0.3 15:11:48 INFO - moztest == 0.8 15:11:48 INFO - mozversion == 1.4 15:11:48 INFO - psutil == 3.1.1 15:11:48 INFO - requests == 1.2.3 15:11:48 INFO - wsgiref == 0.1.2 15:11:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:48 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 0x22951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2605090>, '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 0x2605d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', '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 15:11:48 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 15:11:48 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 15:11:48 INFO - Using env: {'DISPLAY': ':0', 15:11:48 INFO - 'HOME': '/home/cltbld', 15:11:48 INFO - 'LANG': 'en_US.UTF-8', 15:11:48 INFO - 'LANGUAGE': 'en_US:en', 15:11:48 INFO - 'LOGNAME': 'cltbld', 15:11:48 INFO - 'MAIL': '/var/mail/cltbld', 15:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:48 INFO - 'MOZ_NO_REMOTE': '1', 15:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:48 INFO - 'NO_EM_RESTART': '1', 15:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:48 INFO - 'PWD': '/builds/slave/test', 15:11:48 INFO - 'SHELL': '/bin/bash', 15:11:48 INFO - 'SHLVL': '1', 15:11:48 INFO - 'TERM': 'linux', 15:11:48 INFO - 'TMOUT': '86400', 15:11:48 INFO - 'USER': 'cltbld', 15:11:48 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:48 INFO - '_': '/tools/buildbot/bin/python'} 15:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:48 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)) 15:11:48 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)) 15:11:48 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)) 15:11:48 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)) 15:11:48 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)) 15:11:48 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)) 15:11:48 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)) 15:11:48 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)) 15:11:48 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)) 15:11:48 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:11:49 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)) 15:11:49 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)) 15:11:49 INFO - Installing collected packages: simplejson 15:11:49 INFO - Running setup.py install for simplejson 15:11:49 INFO - building 'simplejson._speedups' extension 15:11:49 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 15:11:50 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 15:11:50 INFO - Successfully installed simplejson 15:11:50 INFO - Cleaning up... 15:11:50 INFO - Return code: 0 15:11:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2605090>, '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 0x2605d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fff90>, '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': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', '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 15:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:11:50 INFO - Using env: {'DISPLAY': ':0', 15:11:50 INFO - 'HOME': '/home/cltbld', 15:11:50 INFO - 'LANG': 'en_US.UTF-8', 15:11:50 INFO - 'LANGUAGE': 'en_US:en', 15:11:50 INFO - 'LOGNAME': 'cltbld', 15:11:50 INFO - 'MAIL': '/var/mail/cltbld', 15:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:50 INFO - 'MOZ_NO_REMOTE': '1', 15:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:50 INFO - 'NO_EM_RESTART': '1', 15:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:50 INFO - 'PWD': '/builds/slave/test', 15:11:50 INFO - 'SHELL': '/bin/bash', 15:11:50 INFO - 'SHLVL': '1', 15:11:50 INFO - 'TERM': 'linux', 15:11:50 INFO - 'TMOUT': '86400', 15:11:50 INFO - 'USER': 'cltbld', 15:11:50 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:50 INFO - '_': '/tools/buildbot/bin/python'} 15:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:11:50 INFO - Cleaning up... 15:11:50 INFO - Return code: 0 15:11:50 INFO - Running post-action listener: _resource_record_post_action 15:11:50 INFO - Running post-action listener: _start_resource_monitoring 15:11:50 INFO - Starting resource monitoring. 15:11:50 INFO - [mozharness: 2017-09-16 22:11:50.939505Z] Finished create-virtualenv step (success) 15:11:50 INFO - [mozharness: 2017-09-16 22:11:50.940108Z] Running install step. 15:11:50 INFO - Running pre-action listener: _resource_record_pre_action 15:11:50 INFO - Running main action method: install 15:11:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:51 INFO - Reading from file tmpfile_stdout 15:11:51 INFO - Detecting whether we're running mozinstall >=1.0... 15:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:11:51 INFO - Reading from file tmpfile_stdout 15:11:51 INFO - Output received: 15:11:51 INFO - Usage: mozinstall [options] installer 15:11:51 INFO - Options: 15:11:51 INFO - -h, --help show this help message and exit 15:11:51 INFO - -d DEST, --destination=DEST 15:11:51 INFO - Directory to install application into. [default: 15:11:51 INFO - "/builds/slave/test"] 15:11:51 INFO - --app=APP Application being installed. [default: firefox] 15:11:51 INFO - mkdir: /builds/slave/test/build/application 15:11:51 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'] 15:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:12:08 INFO - Reading from file tmpfile_stdout 15:12:08 INFO - Output received: 15:12:08 INFO - /builds/slave/test/build/application/firefox/firefox 15:12:08 INFO - Running post-action listener: _resource_record_post_action 15:12:08 INFO - [mozharness: 2017-09-16 22:12:08.854502Z] Finished install step (success) 15:12:08 INFO - [mozharness: 2017-09-16 22:12:08.854644Z] Running setup-mitmproxy step. 15:12:08 INFO - Running pre-action listener: _resource_record_pre_action 15:12:08 INFO - Running main action method: setup_mitmproxy 15:12:08 INFO - Skipping: mitmproxy is not required 15:12:08 INFO - Running post-action listener: _resource_record_post_action 15:12:08 INFO - [mozharness: 2017-09-16 22:12:08.855409Z] Finished setup-mitmproxy step (success) 15:12:08 INFO - [mozharness: 2017-09-16 22:12:08.855512Z] Running run-tests step. 15:12:08 INFO - Running pre-action listener: _resource_record_pre_action 15:12:08 INFO - Running pre-action listener: _set_gcov_prefix 15:12:08 INFO - Running main action method: run_tests 15:12:08 WARNING - Try message not found. 15:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:12:08 INFO - Python 2.7.3 15:12:08 INFO - Return code: 0 15:12:08 INFO - grabbing minidump binary from tooltool 15:12:08 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')]} 15:12:08 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 0x2605090>, '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 0x2605d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:12:08 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 15:12:08 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 15:12:08 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 15:12:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:12:08 INFO - Return code: 0 15:12:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:12:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:12:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:12:08 INFO - ENV: RUST_BACKTRACE is now full 15:12:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:12:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:12:08 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/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 15:12:08 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/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 15:12:08 INFO - Using env: {'DISPLAY': ':0', 15:12:08 INFO - 'HOME': '/home/cltbld', 15:12:08 INFO - 'LANG': 'en_US.UTF-8', 15:12:08 INFO - 'LANGUAGE': 'en_US:en', 15:12:08 INFO - 'LOGNAME': 'cltbld', 15:12:08 INFO - 'MAIL': '/var/mail/cltbld', 15:12:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:12:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:08 INFO - 'MOZ_NO_REMOTE': '1', 15:12:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:08 INFO - 'NO_EM_RESTART': '1', 15:12:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:08 INFO - 'PWD': '/builds/slave/test', 15:12:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:12:08 INFO - 'RUST_BACKTRACE': 'full', 15:12:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:12:08 INFO - 'SHELL': '/bin/bash', 15:12:08 INFO - 'SHLVL': '1', 15:12:08 INFO - 'TERM': 'linux', 15:12:08 INFO - 'TMOUT': '86400', 15:12:08 INFO - 'USER': 'cltbld', 15:12:08 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:08 INFO - '_': '/tools/buildbot/bin/python'} 15:12:08 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/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 15:12:09 INFO - mozversion application_buildid: 20170916205117 15:12:09 INFO - mozversion application_changeset: 44e56a4d482a0959e00afb371872035caf3cd56d 15:12:09 INFO - mozversion application_display_name: Nightly 15:12:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:12:09 INFO - mozversion application_name: Firefox 15:12:09 INFO - mozversion application_remotingname: firefox 15:12:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:12:09 INFO - mozversion application_vendor: Mozilla 15:12:09 INFO - mozversion application_version: 57.0a1 15:12:09 INFO - mozversion platform_buildid: 20170916205117 15:12:09 INFO - mozversion platform_changeset: 44e56a4d482a0959e00afb371872035caf3cd56d 15:12:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:12:09 INFO - mozversion platform_version: 57.0a1 15:12:09 INFO - using testdate: 1505599929 15:12:09 INFO - actual date: 1505599929 15:12:09 INFO - starting webserver on 'localhost:55100' 15:12:09 INFO - SUITE-START | Running 2 tests 15:12:09 INFO - TEST-START | dromaeo_css 15:12:09 INFO - Initialising browser for dromaeo_css test... 15:12:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55100/getInfo.html -profile /tmp/tmp3DxL8N/profile 15:12:09 INFO - TEST-INFO | started process 18385 (/builds/slave/test/build/application/firefox/firefox http://localhost:55100/getInfo.html) 15:12:14 INFO - TEST-INFO | 18385: exit 0 15:12:14 INFO - Browser initialized. 15:12:14 INFO - Running cycle 1/1 for dromaeo_css test... 15:12:14 INFO - Using env: {'DISPLAY': ':0', 15:12:14 INFO - 'HOME': '/home/cltbld', 15:12:14 INFO - 'JSGC_DISABLE_POISONING': '1', 15:12:14 INFO - 'LANG': 'en_US.UTF-8', 15:12:14 INFO - 'LANGUAGE': 'en_US:en', 15:12:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:12:14 INFO - 'LOGNAME': 'cltbld', 15:12:14 INFO - 'MAIL': '/var/mail/cltbld', 15:12:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:12:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:12:14 INFO - 'MOZ_CRASHREPORTER': '1', 15:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:12:14 INFO - 'MOZ_NO_REMOTE': '1', 15:12:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:14 INFO - 'NO_EM_RESTART': '1', 15:12:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:14 INFO - 'PWD': '/builds/slave/test', 15:12:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:12:14 INFO - 'RUST_BACKTRACE': 'full', 15:12:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:12:14 INFO - 'SHELL': '/bin/bash', 15:12:14 INFO - 'SHLVL': '1', 15:12:14 INFO - 'TERM': 'linux', 15:12:14 INFO - 'TMOUT': '86400', 15:12:14 INFO - 'USER': 'cltbld', 15:12:14 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:14 INFO - '_': '/tools/buildbot/bin/python'} 15:12:14 INFO - TEST-INFO | started process 18623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3DxL8N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:12:15 INFO - PID 18623 | 15:12:15 INFO - PID 18623 | (/builds/slave/test/build/application/firefox/firefox:18674): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:12:15 INFO - PID 18623 | 15:12:26 INFO - PID 18623 | RSS: Main: 148455424 15:12:26 INFO - PID 18623 | 15:15:23 INFO - PID 18623 | Cycle 1(1): loaded http://localhost:55100/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55100/tests/dromaeo/cssquery-ext.html) 15:15:24 INFO - PID 18623 | RSS: Main: 148897792 15:15:24 INFO - PID 18623 | 15:18:26 INFO - PID 18623 | Cycle 1(1): loaded http://localhost:55100/tests/dromaeo/cssquery-ext.html (next: http://localhost:55100/tests/dromaeo/cssquery-jquery.html) 15:18:27 INFO - PID 18623 | RSS: Main: 149045248 15:18:27 INFO - PID 18623 | 15:21:28 INFO - PID 18623 | Cycle 1(1): loaded http://localhost:55100/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55100/tests/dromaeo/cssquery-mootools.html) 15:21:29 INFO - PID 18623 | RSS: Main: 151044096 15:21:29 INFO - PID 18623 | 15:24:31 INFO - PID 18623 | Cycle 1(1): loaded http://localhost:55100/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55100/tests/dromaeo/cssquery-prototype.html) 15:24:31 INFO - PID 18623 | RSS: Main: 150036480 15:24:31 INFO - PID 18623 | 15:27:34 INFO - PID 18623 | Cycle 1(1): loaded http://localhost:55100/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55100/tests/dromaeo/cssquery-yui.html) 15:27:35 INFO - PID 18623 | RSS: Main: 151019520 15:27:35 INFO - PID 18623 | 15:30:36 INFO - PID 18623 | Cycle 1(1): loaded http://localhost:55100/tests/dromaeo/cssquery-yui.html (next: http://localhost:55100/tests/dromaeo/cssquery-dojo.html) 15:30:37 INFO - PID 18623 | RSS: Main: 153587712 15:30:37 INFO - PID 18623 | 15:30:37 INFO - PID 18623 | __start_tp_report 15:30:37 INFO - PID 18623 | _x_x_mozilla_page_load 15:30:37 INFO - PID 18623 | _x_x_mozilla_page_load_details 15:30:37 INFO - PID 18623 | |i|pagename|runs| 15:30:37 INFO - PID 18623 | |0;dojo.html;3863.864764733235;3874.806259687016;3901.239258344622;3901.3952837310208;3926.018495376156;6144.385561443864;6201.627902325864;6260.561760676755;6274.309825919151;6297.023961286008;6254.249490061199;6256.655883926383;6258.374162583739;6267.874642507147;6281.057841323793;5534.335879694422;5602.439756024395;5638.182463542784;5649.971750141243;5681.886362272752;5639.492445679888;5655.943440565604;5675.886482270352;5685.459881311269;5718.399568045358;5500.339959204921;5702.515286200657;5763.884722305552;5769.221155144065;5774.480296773289;5462.863428414282;5575.470330318613;5610.579206559524;5676.659400435987;5683.914741278884;5586.581006424534;5587.339326844515;5626.2967129108865;5676.659400435946;5686;6149.938500615026;6172.567920245585;6207.162033125561;6286.528510361742;6330.65181415022;6749.257581666013;6788.558743681645;6802.455803535705;6804.65976701163;6806.523543351967;6790.0493930849725;6873.140857392826;6878.037074809531;6887.070245516841;6898.482333886537;6123.510119190454;6165.722542485599;6190.350013248589;6349.8412539686415;6362.300146983828;6872.725090996404;6888.276730943279;6889.207741109736;6975.79072627822;6995.93004069963;6514.348565143448;6578.901316480256;6620.966895165493;6650.933490665128;6734.932650673529;6665.933340666628;6757.628330441873;6776.356246156607;6777.220619628707;6782.118324617768;6679.198496180489;6692.665366731644;6715.932840671629;6732.023856540774;6762.323767623198;6599.373059559334;6675.86648267032;6767.255601883789;6769.966150169218;6781.287964763727;4862.610991120702;4921.581665558468;4922.729249891218;4929.13740095489;4936.407631084293;4406.537313582092;4414.4702635683925;4441.733495990186;4444.155610434007;4525.932111018337;6223.937760622426;6224.408681175281;6282.591631543935;6284.308726040132;6287.182666253358;6663.267040625527;6710.865782684319;6791.660416979132;6803.693833777492;6815.625140617214;6208.782692605828;6210.5652604317265;6274;6276.811695649138;6279.591826531261;5398.568114550826;5445.618806683494;5449.509544140967;5451.591130665216;5463.590230732711;6833.111695479556;6894.379505844498;6918.377346038881;6919.550229235084;6945.062416573698;6656.167979002625;6739.797806065826;6770.289119642465;6808.62552559614;6823.044773731583;6746.561473504206;6915.204751453647;6936.306369363023;7005.159380874327;7030.402415794715;6613.834654133685;6654.268030516736;6659.367360100783;6680.665966701743;6709.429698475489;6756.358145976124;6760.594364338155;6812.65936703153;6848.520603557703;6856.005879147396;6510.056041873996;6511.7395304189195;6540.37866402691;6609.966950165219;6613.933860661332;6443.871122577616;6501.187351581052;6540.574862633914;6591.307912669101;6600.900986485302;6377.617342959437;6488.221413430419;6494.837629059122;6514.315996820455;6519.185101862267;6453.225612926479;6459.224893012869;6470.741170353133;6598.703058362481;6612.5040621952585;6256.843578910563;6262.06069089622;6309.747610095545;6315.747370105144;6356.364363563792 15:30:37 INFO - PID 18623 | |1;ext.html;925.3337596930207;935.2050756856669;962.470641147369;988.2390559269363;990.9108180263777;41352.793236033816;42614.57385426145;42632.36051459231;42691.57308426915;42816.78591607042;39764.20471590567;39990.8000459998;40031.59968400315;40040;40116;7235.67439465224;7319.963400182992;7322.414206863438;7333.339999400053;7343.339099481045;7341.302576255247;7433.070866141732;7435.553866768011;7437.405007599406;7438.739644112457;7427.442941779361;7901.130875603708;8034.517928924254;8037.5579343136105;8057.919420805775;7950.522968621873;8007.8798818017485;8012.238837310446;8015.398845086642;8017.87973180397;7896.407769417317;7919.841603167962;7955.721549745731;7955.920440795634;7979.56112413817;38548.42177367342;39205.80397098025;39320;39325.21349572993;39359;3641.6540428659237;3689.6494832990825;3690.6678398944223;3691.870784522556;3693.076730817296;31160.688393116234;31389.52915706266;31399.215019624462;31419.214519636964;31466.37067258642;5486.094794358926;5492.670439773587;5502.284702988586;5537.944620553783;5545.085060964936;212004;214434;214526;215773.99999999843;216954;50427.73930651763;50540;50566.74716626394;50700.49299506958;50733.492665073616;52805.2079218812;52838.20742688863;52848.20727689088;52888;52919.20621190685;16272.43046493367;16630;16683.749743753855;16730.6653866922;16803.747943780854;13668.384922678304;13787.931060344634;13792.448302067805;13794.517191898236;13805.654858628615;14686.706265874624;14725.705485890223;14809.333579988926;14953.177575233467;14975.801935845324;5802.82591522255;5916.201312822714;5993.550483713651;6078.908816367758;6136.417040381157;1062.4315990944808;1098.3849044535086;1101.6970333158285;1115.553778488611;1140.0309736723884;25168.622470662955;25181;25343.36641583975;25438.109666161596;25461.490770184493;1210.9878901211052;1211.0493262788668;1229.2317301686446;1231.119749379198;1238.7646347194184;13524.12093213938;13539.729205415837;13723.588292351245;13758.380872860746;13815.723685526233;283878;286173;286375;286835;287024;46979.29531057037;47928.5207147931;47962;48727.269090963666;48921.75539122282;1413.0744362442617;1526.351300697177;1545.7217700813737;1546.876249900028;1547.7214101461846;29488.11535653934;29832.25419364533;30016.549751753304;30062.849685751433;30221.09336719902;38138.42792358062;38158;38204;38243;38259;214110;216357;216639;217425;217432;32734.50898236481;33902.3219535603;34254.82872585621;34429.13927151841;34657.13357166091;45168.77415612901;45285;45360;45614.77192614148;45677.08645827131;32130;32673.509897352033;32907;32944.67055329416;33350.66649333476;32523.186920326236;32750;33048.33903321968;33183.336333273684;33387.83306083454;38192.80903595464;38334.424983625824;38403.615963840006;38471;38512;31879.52180717245;31974;32004.679953201103;32186.83906580546;32264.516032260006;24671.753282467664;25211.369715757253;25352.619710704723;25411.36471588225;25432.491350173263 15:30:37 INFO - PID 18623 | |2;jquery.html;591.5867627498861;601.765311528504;612.3539665652737;612.663035330568;613.3498491598905;23222.88388558057;23923.28230153096;24024.39939001526;24054.51890962182;24115;22004.175989555053;26997.73002269977;27047.864760676217;27120.18639440815;27129.05048323309;6790.5246632735725;6865.897011544831;6887.173539175306;6890.345417185385;6943;6441.066045423411;6633.402993730563;6674.799756007304;6697.497687673444;6752.763653272136;6590.8022759317055;6635.867282654344;6649.900251496231;6653.101831252768;6666.166729158856;6600;6668.966655166717;6854.828629284258;6865.897011544831;6870.072540207083;6358.364163583605;6359.300476947532;6365.586236894634;6369.554131210817;6370.745170193233;30918.22704432385;31316;31365.215869603213;31457.370852583048;31496.527552086736;2196.6595177747477;2227.0757635581213;2233.932982010542;2238.3285014495586;2239.6304609739373;20886.26898058576;21600.89199553992;21725.348239552837;21755.564888702294;21764.238251661114;2394.558089842479;2415.082268737886;2461.9753802462105;2465.60550311951;2472.7898128659085;132384.33807830996;137304.31347843297;143498;151176.2441187798;151399;15273.847261527242;16322.34710611586;16333.67332653364;17009.489715308562;17017.659646806995;25509.107181248568;25547;25639.743602563736;25642.23073307804;25742;10534.736631584272;10673.623814236282;10826.512806923707;10833.566657333777;10852.94573527143;9535.284853636005;9650.71047868565;9661.855072173923;9743.951280243695;9809.313348065567;9838.360506567193;9895.703128906145;10065.647702330383;10070.395776253448;10181.74545636365;2771;2799.762020228263;2933.506519458443;2939.3533422646983;3044.680308567613;1029.7631544744602;1030.3457304611625;1043.3426941027105;1060.48566445274;1062.5271754069365;20489.590208195754;20698.068586913625;20851.687224691643;20957.056932438078;21342.78657213439;1103.961361352365;1114.225613198819;1118.7315044389288;1127.7011591928147;1132.1715429581168;11357.432128393548;11381.487833047533;11599.478023488795;11612.187146899805;11665.183437159318;569665;577882;588616;595886;596940;122857;126901.36549317378;127982.36008819897;131277;134162;1136.471540733563;1173.3781096019125;1176.394157009141;1255.5480027190204;1265.3989355056274;22800.31599052031;23013.88493057524;23023.194188204;23377.298681039596;23473.41316467102;60230.397696022475;61005;61553.38446615656;61966.69016654888;63184.684076581165;78567.214327856;79085.60457197677;79229;79383.60308198653;79447.60276198582;15602.687946241238;15830.44593439224;15925.601859953595;15979.121148336488;15982.440614578434;25051;25418.491630167664;25605.871970640026;25670.358241044123;25790.742092578836;20481.897590512548;20649.27727529529;20750.481237968568;20834.58330833405;20866.165353386303;18035.729464057786;18195.81804181994;18346.266149353876;18565.628687426444;18752;20681.482962926046;20803.479913002295;21135.682964755233;21238.46903827417;21362.145514179258;15435.536933892;15673.294701738221;15752.527424177293;15774.9211253943;15810.446634367741;20351.287704930255;20358.491037724176;20395.388138355873;20541.89729051405;20671.379858604265 15:30:37 INFO - PID 18623 | |3;mootools.html;1374.9793753093704;1456.1336005076976;1464.6997365540064;1465.4504560789703;1467.4203689542628;16790.580235494104;17479.388221412253;17480.38818641348;17482.737758933625;17489.212985415656;16985.235664395103;17096.401625943065;17136.14319284037;17145.228464719086;17199.570010749736;2831.9858400707967;2906.854657267139;2950.5721670357784;2951.4982452983045;2955.2611847038243;2736.2475319287155;2763.0329384715287;2765.363966287755;2768.709285525021;2776.639036925207;2727.263638817528;2813.6342275504157;2903.5354343305075;2903.666078400979;2914.883404663811;2822.2238884306776;2846.985765071172;2874.798764086515;2880.7119288071235;2880.812747171427;2595.3122422558035;2597.7662010418962;2608.3479130217447;2608.360951566878;2619.4499155177436;16634.085125318103;16713.415030473876;16785.24466399015;16796.076215808127;16803.495895123044;8503.787405314855;8837.911620883837;8868.02451730309;8882.333824963154;8890.911090889073;5852.941470585325;5891;5927.525797936198;5968.7612495500125;6019.578629495937;2071.7513898332145;2078.9272375466785;2081.9791802081936;2083.854130210886;2125.883076430796;30796.692033079606;30891.536626950612;30952.226194345098;30955.38089238225;30992.225194370094;7374.446916481178;7441.813954651068;7466.25337466249;7524.548527088392;7603.315701586884;19565.217391304188;19831.20675172977;19840.206391744458;19842.70235946462;19857.60284794296;8628.568571571523;8742.606582703793;8772.385932984758;8780.253678437404;8795.51624660637;7605.543667379864;7791.727289544952;7900.525968441912;7976.840463190703;7990.240927111915;5569.053260945568;5663.263775709213;5718.399568045378;5800.274965629296;5805.82582522525;1657.3867668962562;1678.907660078683;1693.7798086248708;1710.6578684263197;1714.7770789797246;914.4650379527918;937.5078084005816;955.7037318431309;971.577363846729;972.1348000279756;8250.422470427133;8256.174382561696;8332;8348.373871959628;9205.861912071325;778.0974070078681;778.6184769462923;799.8280369720421;804.4610111225493;804.6379129391797;5633.6619802811965;6139.6009259398;6392.232932048091;6439.8068057958335;6465.515086368541;23623;23901.641475377884;23959.322847400865;24391;24792.504149916902;24229;24278.393040174138;24304.513909721707;24313.635295470584;24441.511169776506;11173.888261117285;12532.81200781989;12653.177543459646;12666.936665316614;12850.67873303175;9375.953120234355;9431.245500360092;9451.054894510495;9462.006489318523;9491.66779162726;19982.60034799267;20376.18495260173;20411.387658370273;20448.69326960067;20530.38408847737;20325;21478.785212148305;21496.462588435414;21601.459963501038;21768.782312176674;11939.82090268664;12099.939500302795;12104.636860894187;12119.212251203644;12119.939400302943;14797.704045919236;15688;15758.369665213264;15910.60223494422;15924.840751592335;11631.127665424958;11779.175457717878;11959.940200298943;12062.155649104478;12201.51193952232;11592.6522204334;11595.710107247049;11634.825477618011;11885.5840045598;11981.161318707955;11002.119830413707;11241.38172400493;11263.155263355446;11284.830727538929;11286.209965302678;8125.8781118282095;8191.631376587949;8193.71322003727;8304.086550479564;8348.791280218044;8278.420510564443;8492.405531612727;8504.404691671523;8523.872141918;8603.569821508774 15:30:37 INFO - PID 18623 | |4;prototype.html;550.5485501888451;551.8868631930452;577.3879687531216;578.0837372764169;580.0689892722183;5999.760009599616;6092.543059270556;6137.693115344237;6156.168917196177;6252.749890004406;6165.9383406165925;6182.876342473148;6203.596766210193;6206.565540412173;6265.436110750032;5107.055194788976;5164.845054648366;5175.741212939357;5199.168133098705;5203.2975548301065;4886.853394398174;4993.925091123636;5009.699418034929;5019.372578427697;5152.6650767699975;4915.483874193212;4927.802887884498;4972.328735620699;5015.288686372095;5017.422996355429;4925.187344088221;4938.333325001115;4978.800847966077;4982.850514484553;4983.700977941299;4442.444694413199;4576.885577860547;4586.564276393738;4591.563801438858;4611.976940115278;6188.164597779287;6195.845103872394;6237.688115594202;6248.4064013918605;6254.21822272216;5844;5882.764689412418;5897.73460194288;5910.290765108171;5930.911036334458;6542.54202205841;6578;6624.503162262801;6625.343664083979;6638.502112341545;5005.349304590416;5025.974870125662;5049.84850454487;5070.366204224472;5083.440821509631;6851.657417129173;6908;6928.411085057776;6938.444924406035;7012.754553590702;5142.61430392722;5182.585393168538;5184.11869982104;5206.219067139884;5209.869753256123;5265.1838964959725;5283.920741188886;5310.92033619496;5314.335708036496;5348.064088784525;5770.826875193751;5785.4793068623185;5842.1957460419235;5876.647401155944;5899.410058994152;6316.30520642729;6376.234851817811;6434.388733070351;6649.833754156185;6657.167854018247;1791.408835084419;1800.1089460717028;1807.8463330617044;1814.646144001907;1828.286968082449;1285.884270415667;1287.8518970318346;1289.007464252539;1292.780227361332;1315.2108734759067;6046.667433291123;6214.720337584819;6249.500039996789;6254.781082662176;6262.405071518198;6633.767818126343;6634.83412914681;6687.899681504781;6733.629650369178;6746.494012949049;6156.722947467375;6202.28673702521;6229.221347331583;6248.656323902138;6251.437370636664;3459.515667806509;3541.5395998520025;3550.4851796489365;3552.4138517144384;3588.959201831492;6892.827679308058;6940.548864323904;6954.513184077167;6970.51206415546;6995.26549712283;6781.220159681601;6904.378605925491;6978.197507286625;7014.824629384306;7043.647817609201;6882.939065951213;6968.09414776086;7001.439884809305;7018.403435708022;7101.2898710128575;6660;6714;6718.563293385914;6759.662016899037;6773.966130169515;6657.900131497934;6666.799996000128;6692.631905245258;6718.697658605277;6745.5952642841585;6908.821941906779;6928.376446119873;7002.404795592432;7016.22821489646;7036.19083805369;5174.120399532164;5198.16829307309;5200.6619569727845;5215.504527069922;5230.843074707765;6450.8064758057335;6524.67376631157;6704.296048914989;6842.965785171043;6862.245153033262;6549.100760779321;6609.537332386687;6630.668466576748;6634.137562116894;6657.900131497934;6505.902411463927;6542.476601871934;6575.0412314459645;6587;6621.602703837785;6352.396522330371;6448.290688024407;6486.5783724059675;6502.73989040452;6561.573497722633;6571.211454625475;6612.338766123349;6616.98182054478;6669.166354205724;6708.127943367526;6357.459615932513;6438.935610643834;6455.644314693967;6520.967395162994;6532.967335163294 15:30:37 INFO - PID 18623 | |5;yui.html;967.3132076225879;995.7908839143779;1011.1556850030224;1015.258861031447;1019.592163134746;18839.340623078195;19072.618547629056;19083.71374429383;19201.903990480063;19246.230150793985;19282;19434.41696749096;19549.218031278768;20082;20267.08798104085;1062.1184416933966;1080.8000519903803;1081.2647399768193;1082.3451811653915;1089.330062011861;1077.0037715113529;1081.361996422111;1081.848541204232;1082.1991726122692;1082.312731415549;1076.9515371808247;1116.6538373104363;1122.0406552397706;1122.0686829931137;1122.6351435783404;1113.3486910157567;1115.6429942418429;1117.0170250179872;1117.3910218930703;1117.4245263689206;828.668532586964;829.813292009293;830.2403300979596;830.796454868555;831;20747.68878466824;20848.791512084987;21386;21435.785642143535;21563.78436215649;23422.06311747528;23431.179908703285;23696.7630323698;23717;23802.523949520913;18046.097695115324;18111.45665630033;18126.63746725058;18229.270829166817;18270.725939110926;4070.328395814687;4099.836006559734;4100.261952848486;4102.261592913274;4103.4460347853255;146320;149013;150089.24955375152;150765;152815;16442.917785410995;16563.751543726852;16664;16843.747343789608;16879.15604219784;34526.48210276848;35435.468467973;35447.29105417929;35547.289054218774;35774.463383049275;8754.08082151365;8791.428557143765;8859.512726800089;8878.822423551494;8895.822083558292;4632.143053535106;4756.738379389167;4757.381540399726;4767.570918617272;4771.570558649738;6110.847228819226;6127.509799216141;6207.379262073757;6224;6226.315105338409;1122.0462606784167;1134.704976706046;1156.612534800851;1164.4527072276016;1166.102101381931;648.1023782061784;658.6904155047216;666.7799626123465;675.2234929830636;675.2740803636012;12545.310007949467;13189.736205276033;13331.466741330238;13858;13961.441542338396;652.9673516324165;655.8655475627485;658.2430205263889;674.1337381464795;674.4435840431663;5427.918581221206;5447.891042179134;5488.231647569263;5574.386817450078;5647.632903861236;137927;139340.30329848488;140486.2975685115;142689;145948;117902;132575;133843.33078334545;135131;137062.31468842592;114859;116912;117147.41426292984;117707.41146294214;117919.41040294916;14011.649708757363;14072.718545628826;14117.647058823612;14182.14907105577;14187;51194.74402627963;51626;51659.741701292754;51688.741556293484;53554.19668704895;67418;68957.65521172361;69055;69777.30222697911;71438.28561714316;17934;18448.354307599708;18791.24835006639;18818.905905470387;19024.809751902303;20491.38525844227;20628;20667.896660516602;20684.793152068887;20814.37556873296;18893.055347232857;18896.716549252047;19018.23927042903;19145.425637230906;19179.90410047941;17549.298028078734;17607.91196044063;17622.82377176212;17896.731549027034;17901.283948641907;17366.913165434093;17672.55818604545;17775.377861774778;17776.466705998842;17916.91041544784;12408.317542535247;12456.190347627375;12600.369981500706;12629.494820207088;12798.808017879554;13475.595732128051;13871.653208669864;13973.8122259605;14031.719365612835;14044.859551404355 15:30:37 INFO - PID 18623 | __end_tp_report 15:30:37 INFO - PID 18623 | __start_cc_report 15:30:37 INFO - PID 18623 | _x_x_mozilla_cycle_collect,269 15:30:37 INFO - PID 18623 | __end_cc_report 15:30:37 INFO - PID 18623 | __startTimestamp1505601037060__endTimestamp 15:30:37 INFO - PID 18623 | 15:30:37 INFO - PID 18623 | ------- Summary: start ------- 15:30:37 INFO - PID 18623 | Number of tests: 6 15:30:37 INFO - PID 18623 | 15:30:37 INFO - PID 18623 | [#0] dojo.html Cycles:165 Average:6212.13 Median:6453.23 stddev:725.37 (11.2%) stddev-sans-first:703.81 15:30:37 INFO - PID 18623 | Values: 3863.9 3874.8 3901.2 3901.4 3926.0 6144.4 6201.6 6260.6 6274.3 6297.0 6254.2 6256.7 6258.4 6267.9 6281.1 5534.3 5602.4 5638.2 5650.0 5681.9 5639.5 5655.9 5675.9 5685.5 5718.4 5500.3 5702.5 5763.9 5769.2 5774.5 5462.9 5575.5 5610.6 5676.7 5683.9 5586.6 5587.3 5626.3 5676.7 5686.0 6149.9 6172.6 6207.2 6286.5 6330.7 6749.3 6788.6 6802.5 6804.7 6806.5 6790.0 6873.1 6878.0 6887.1 6898.5 6123.5 6165.7 6190.4 6349.8 6362.3 6872.7 6888.3 6889.2 6975.8 6995.9 6514.3 6578.9 6621.0 6650.9 6734.9 6665.9 6757.6 6776.4 6777.2 6782.1 6679.2 6692.7 6715.9 6732.0 6762.3 6599.4 6675.9 6767.3 6770.0 6781.3 4862.6 4921.6 4922.7 4929.1 4936.4 4406.5 4414.5 4441.7 4444.2 4525.9 6223.9 6224.4 6282.6 6284.3 6287.2 6663.3 6710.9 6791.7 6803.7 6815.6 6208.8 6210.6 6274.0 6276.8 6279.6 5398.6 5445.6 5449.5 5451.6 5463.6 6833.1 6894.4 6918.4 6919.6 6945.1 6656.2 6739.8 6770.3 6808.6 6823.0 6746.6 6915.2 6936.3 7005.2 7030.4 6613.8 6654.3 6659.4 6680.7 6709.4 6756.4 6760.6 6812.7 6848.5 6856.0 6510.1 6511.7 6540.4 6610.0 6613.9 6443.9 6501.2 6540.6 6591.3 6600.9 6377.6 6488.2 6494.8 6514.3 6519.2 6453.2 6459.2 6470.7 6598.7 6612.5 6256.8 6262.1 6309.7 6315.7 6356.4 15:30:37 INFO - PID 18623 | 15:30:37 INFO - PID 18623 | [#1] ext.html Cycles:180 Average:40928.24 Median:3665.65 stddev:62718.84 (1711.0%) stddev-sans-first:62822.86 15:30:37 INFO - PID 18623 | Values: 925.3 935.2 962.5 988.2 990.9 41352.8 42614.6 42632.4 42691.6 42816.8 39764.2 39990.8 40031.6 40040.0 40116.0 7235.7 7320.0 7322.4 7333.3 7343.3 7341.3 7433.1 7435.6 7437.4 7438.7 7427.4 7901.1 8034.5 8037.6 8057.9 7950.5 8007.9 8012.2 8015.4 8017.9 7896.4 7919.8 7955.7 7955.9 7979.6 38548.4 39205.8 39320.0 39325.2 39359.0 3641.7 3689.6 3690.7 3691.9 3693.1 31160.7 31389.5 31399.2 31419.2 31466.4 5486.1 5492.7 5502.3 5537.9 5545.1 212004.0 214434.0 214526.0 215774.0 216954.0 50427.7 50540.0 50566.7 50700.5 50733.5 52805.2 52838.2 52848.2 52888.0 52919.2 16272.4 16630.0 16683.7 16730.7 16803.7 13668.4 13787.9 13792.4 13794.5 13805.7 14686.7 14725.7 14809.3 14953.2 14975.8 5802.8 5916.2 5993.6 6078.9 6136.4 1062.4 1098.4 1101.7 1115.6 1140.0 25168.6 25181.0 25343.4 25438.1 25461.5 1211.0 1211.0 1229.2 1231.1 1238.8 13524.1 13539.7 13723.6 13758.4 13815.7 283878.0 286173.0 286375.0 286835.0 287024.0 46979.3 47928.5 47962.0 48727.3 48921.8 1413.1 1526.4 1545.7 1546.9 1547.7 29488.1 29832.3 30016.5 30062.8 30221.1 38138.4 38158.0 38204.0 38243.0 38259.0 214110.0 216357.0 216639.0 217425.0 217432.0 32734.5 33902.3 34254.8 34429.1 34657.1 45168.8 45285.0 45360.0 45614.8 45677.1 32130.0 32673.5 32907.0 32944.7 33350.7 32523.2 32750.0 33048.3 33183.3 33387.8 38192.8 38334.4 38403.6 38471.0 38512.0 31879.5 31974.0 32004.7 32186.8 32264.5 24671.8 25211.4 25352.6 25411.4 25432.5 15:30:37 INFO - PID 18623 | 15:30:37 INFO - PID 18623 | [#2] jquery.html Cycles:180 Average:39210.20 Median:23018.54 stddev:97904.06 (425.3%) stddev-sans-first:98135.77 15:30:37 INFO - PID 18623 | Values: 591.6 601.8 612.4 612.7 613.3 23222.9 23923.3 24024.4 24054.5 24115.0 22004.2 26997.7 27047.9 27120.2 27129.1 6790.5 6865.9 6887.2 6890.3 6943.0 6441.1 6633.4 6674.8 6697.5 6752.8 6590.8 6635.9 6649.9 6653.1 6666.2 6600.0 6669.0 6854.8 6865.9 6870.1 6358.4 6359.3 6365.6 6369.6 6370.7 30918.2 31316.0 31365.2 31457.4 31496.5 2196.7 2227.1 2233.9 2238.3 2239.6 20886.3 21600.9 21725.3 21755.6 21764.2 2394.6 2415.1 2462.0 2465.6 2472.8 132384.3 137304.3 143498.0 151176.2 151399.0 15273.8 16322.3 16333.7 17009.5 17017.7 25509.1 25547.0 25639.7 25642.2 25742.0 10534.7 10673.6 10826.5 10833.6 10852.9 9535.3 9650.7 9661.9 9744.0 9809.3 9838.4 9895.7 10065.6 10070.4 10181.7 2771.0 2799.8 2933.5 2939.4 3044.7 1029.8 1030.3 1043.3 1060.5 1062.5 20489.6 20698.1 20851.7 20957.1 21342.8 1104.0 1114.2 1118.7 1127.7 1132.2 11357.4 11381.5 11599.5 11612.2 11665.2 569665.0 577882.0 588616.0 595886.0 596940.0 122857.0 126901.4 127982.4 131277.0 134162.0 1136.5 1173.4 1176.4 1255.5 1265.4 22800.3 23013.9 23023.2 23377.3 23473.4 60230.4 61005.0 61553.4 61966.7 63184.7 78567.2 79085.6 79229.0 79383.6 79447.6 15602.7 15830.4 15925.6 15979.1 15982.4 25051.0 25418.5 25605.9 25670.4 25790.7 20481.9 20649.3 20750.5 20834.6 20866.2 18035.7 18195.8 18346.3 18565.6 18752.0 20681.5 20803.5 21135.7 21238.5 21362.1 15435.5 15673.3 15752.5 15774.9 15810.4 20351.3 20358.5 20395.4 20541.9 20671.4 15:30:37 INFO - PID 18623 | 15:30:37 INFO - PID 18623 | [#3] mootools.html Cycles:180 Average:10370.13 Median:2731.76 stddev:7607.56 (278.5%) stddev-sans-first:7598.89 15:30:37 INFO - PID 18623 | Values: 1375.0 1456.1 1464.7 1465.5 1467.4 16790.6 17479.4 17480.4 17482.7 17489.2 16985.2 17096.4 17136.1 17145.2 17199.6 2832.0 2906.9 2950.6 2951.5 2955.3 2736.2 2763.0 2765.4 2768.7 2776.6 2727.3 2813.6 2903.5 2903.7 2914.9 2822.2 2847.0 2874.8 2880.7 2880.8 2595.3 2597.8 2608.3 2608.4 2619.4 16634.1 16713.4 16785.2 16796.1 16803.5 8503.8 8837.9 8868.0 8882.3 8890.9 5852.9 5891.0 5927.5 5968.8 6019.6 2071.8 2078.9 2082.0 2083.9 2125.9 30796.7 30891.5 30952.2 30955.4 30992.2 7374.4 7441.8 7466.3 7524.5 7603.3 19565.2 19831.2 19840.2 19842.7 19857.6 8628.6 8742.6 8772.4 8780.3 8795.5 7605.5 7791.7 7900.5 7976.8 7990.2 5569.1 5663.3 5718.4 5800.3 5805.8 1657.4 1678.9 1693.8 1710.7 1714.8 914.5 937.5 955.7 971.6 972.1 8250.4 8256.2 8332.0 8348.4 9205.9 778.1 778.6 799.8 804.5 804.6 5633.7 6139.6 6392.2 6439.8 6465.5 23623.0 23901.6 23959.3 24391.0 24792.5 24229.0 24278.4 24304.5 24313.6 24441.5 11173.9 12532.8 12653.2 12666.9 12850.7 9376.0 9431.2 9451.1 9462.0 9491.7 19982.6 20376.2 20411.4 20448.7 20530.4 20325.0 21478.8 21496.5 21601.5 21768.8 11939.8 12099.9 12104.6 12119.2 12119.9 14797.7 15688.0 15758.4 15910.6 15924.8 11631.1 11779.2 11959.9 12062.2 12201.5 11592.7 11595.7 11634.8 11885.6 11981.2 11002.1 11241.4 11263.2 11284.8 11286.2 8125.9 8191.6 8193.7 8304.1 8348.8 8278.4 8492.4 8504.4 8523.9 8603.6 15:30:37 INFO - PID 18623 | 15:30:37 INFO - PID 18623 | [#4] prototype.html Cycles:180 Average:5632.06 Median:6243.05 stddev:1567.99 (25.1%) stddev-sans-first:1525.30 15:30:37 INFO - PID 18623 | Values: 550.5 551.9 577.4 578.1 580.1 5999.8 6092.5 6137.7 6156.2 6252.7 6165.9 6182.9 6203.6 6206.6 6265.4 5107.1 5164.8 5175.7 5199.2 5203.3 4886.9 4993.9 5009.7 5019.4 5152.7 4915.5 4927.8 4972.3 5015.3 5017.4 4925.2 4938.3 4978.8 4982.9 4983.7 4442.4 4576.9 4586.6 4591.6 4612.0 6188.2 6195.8 6237.7 6248.4 6254.2 5844.0 5882.8 5897.7 5910.3 5930.9 6542.5 6578.0 6624.5 6625.3 6638.5 5005.3 5026.0 5049.8 5070.4 5083.4 6851.7 6908.0 6928.4 6938.4 7012.8 5142.6 5182.6 5184.1 5206.2 5209.9 5265.2 5283.9 5310.9 5314.3 5348.1 5770.8 5785.5 5842.2 5876.6 5899.4 6316.3 6376.2 6434.4 6649.8 6657.2 1791.4 1800.1 1807.8 1814.6 1828.3 1285.9 1287.9 1289.0 1292.8 1315.2 6046.7 6214.7 6249.5 6254.8 6262.4 6633.8 6634.8 6687.9 6733.6 6746.5 6156.7 6202.3 6229.2 6248.7 6251.4 3459.5 3541.5 3550.5 3552.4 3589.0 6892.8 6940.5 6954.5 6970.5 6995.3 6781.2 6904.4 6978.2 7014.8 7043.6 6882.9 6968.1 7001.4 7018.4 7101.3 6660.0 6714.0 6718.6 6759.7 6774.0 6657.9 6666.8 6692.6 6718.7 6745.6 6908.8 6928.4 7002.4 7016.2 7036.2 5174.1 5198.2 5200.7 5215.5 5230.8 6450.8 6524.7 6704.3 6843.0 6862.2 6549.1 6609.5 6630.7 6634.1 6657.9 6505.9 6542.5 6575.0 6587.0 6621.6 6352.4 6448.3 6486.6 6502.7 6561.6 6571.2 6612.3 6617.0 6669.2 6708.1 6357.5 6438.9 6455.6 6521.0 6533.0 15:30:37 INFO - PID 18623 | 15:30:37 INFO - PID 18623 | [#5] yui.html Cycles:180 Average:27780.11 Median:18805.08 stddev:40732.64 (216.6%) stddev-sans-first:40797.16 15:30:37 INFO - PID 18623 | Values: 967.3 995.8 1011.2 1015.3 1019.6 18839.3 19072.6 19083.7 19201.9 19246.2 19282.0 19434.4 19549.2 20082.0 20267.1 1062.1 1080.8 1081.3 1082.3 1089.3 1077.0 1081.4 1081.8 1082.2 1082.3 1077.0 1116.7 1122.0 1122.1 1122.6 1113.3 1115.6 1117.0 1117.4 1117.4 828.7 829.8 830.2 830.8 831.0 20747.7 20848.8 21386.0 21435.8 21563.8 23422.1 23431.2 23696.8 23717.0 23802.5 18046.1 18111.5 18126.6 18229.3 18270.7 4070.3 4099.8 4100.3 4102.3 4103.4 146320.0 149013.0 150089.2 150765.0 152815.0 16442.9 16563.8 16664.0 16843.7 16879.2 34526.5 35435.5 35447.3 35547.3 35774.5 8754.1 8791.4 8859.5 8878.8 8895.8 4632.1 4756.7 4757.4 4767.6 4771.6 6110.8 6127.5 6207.4 6224.0 6226.3 1122.0 1134.7 1156.6 1164.5 1166.1 648.1 658.7 666.8 675.2 675.3 12545.3 13189.7 13331.5 13858.0 13961.4 653.0 655.9 658.2 674.1 674.4 5427.9 5447.9 5488.2 5574.4 5647.6 137927.0 139340.3 140486.3 142689.0 145948.0 117902.0 132575.0 133843.3 135131.0 137062.3 114859.0 116912.0 117147.4 117707.4 117919.4 14011.6 14072.7 14117.6 14182.1 14187.0 51194.7 51626.0 51659.7 51688.7 53554.2 67418.0 68957.7 69055.0 69777.3 71438.3 17934.0 18448.4 18791.2 18818.9 19024.8 20491.4 20628.0 20667.9 20684.8 20814.4 18893.1 18896.7 19018.2 19145.4 19179.9 17549.3 17607.9 17622.8 17896.7 17901.3 17366.9 17672.6 17775.4 17776.5 17916.9 12408.3 12456.2 12600.4 12629.5 12798.8 13475.6 13871.7 13973.8 14031.7 14044.9 15:30:37 INFO - PID 18623 | -------- Summary: end -------- 15:30:37 INFO - PID 18623 | 15:30:37 INFO - TEST-INFO | 18623: exit 0 15:30:37 INFO - TEST-OK | dromaeo_css | took 1108498ms 15:30:37 INFO - TEST-START | kraken 15:30:37 INFO - Initialising browser for kraken test... 15:30:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55100/getInfo.html -profile /tmp/tmphxK_kU/profile 15:30:37 INFO - TEST-INFO | started process 19004 (/builds/slave/test/build/application/firefox/firefox http://localhost:55100/getInfo.html) 15:30:43 INFO - TEST-INFO | 19004: exit 0 15:30:43 INFO - Browser initialized. 15:30:43 INFO - Running cycle 1/1 for kraken test... 15:30:43 INFO - Using env: {'DISPLAY': ':0', 15:30:43 INFO - 'HOME': '/home/cltbld', 15:30:43 INFO - 'JSGC_DISABLE_POISONING': '1', 15:30:43 INFO - 'LANG': 'en_US.UTF-8', 15:30:43 INFO - 'LANGUAGE': 'en_US:en', 15:30:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:30:43 INFO - 'LOGNAME': 'cltbld', 15:30:43 INFO - 'MAIL': '/var/mail/cltbld', 15:30:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:30:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:30:43 INFO - 'MOZ_CRASHREPORTER': '1', 15:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:30:43 INFO - 'MOZ_NO_REMOTE': '1', 15:30:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:43 INFO - 'NO_EM_RESTART': '1', 15:30:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:43 INFO - 'PWD': '/builds/slave/test', 15:30:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:30:43 INFO - 'RUST_BACKTRACE': 'full', 15:30:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:30:43 INFO - 'SHELL': '/bin/bash', 15:30:43 INFO - 'SHLVL': '1', 15:30:43 INFO - 'TERM': 'linux', 15:30:43 INFO - 'TMOUT': '86400', 15:30:43 INFO - 'USER': 'cltbld', 15:30:43 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195', 15:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:43 INFO - '_': '/tools/buildbot/bin/python'} 15:30:43 INFO - TEST-INFO | started process 19240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphxK_kU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:30:43 INFO - PID 19240 | 15:30:43 INFO - PID 19240 | (/builds/slave/test/build/application/firefox/firefox:19289): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:30:43 INFO - PID 19240 | 15:30:54 INFO - PID 19240 | RSS: Main: 147705856 15:30:54 INFO - PID 19240 | 15:30:56 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55100/tests/kraken/driver.html?testName=audio-beat-detection) 15:30:57 INFO - PID 19240 | RSS: Main: 153632768 15:30:57 INFO - PID 19240 | 15:31:00 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55100/tests/kraken/driver.html?testName=audio-dft) 15:31:00 INFO - PID 19240 | RSS: Main: 154185728 15:31:00 INFO - PID 19240 | 15:31:03 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55100/tests/kraken/driver.html?testName=audio-fft) 15:31:04 INFO - PID 19240 | RSS: Main: 149766144 15:31:04 INFO - PID 19240 | 15:31:06 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55100/tests/kraken/driver.html?testName=audio-oscillator) 15:31:07 INFO - PID 19240 | RSS: Main: 150458368 15:31:07 INFO - PID 19240 | 15:31:09 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55100/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:31:09 INFO - PID 19240 | RSS: Main: 149946368 15:31:09 INFO - PID 19240 | 15:31:12 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55100/tests/kraken/driver.html?testName=imaging-darkroom) 15:31:13 INFO - PID 19240 | RSS: Main: 150093824 15:31:13 INFO - PID 19240 | 15:31:17 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55100/tests/kraken/driver.html?testName=imaging-desaturate) 15:31:17 INFO - PID 19240 | RSS: Main: 151916544 15:31:17 INFO - PID 19240 | 15:31:20 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55100/tests/kraken/driver.html?testName=json-parse-financial) 15:31:21 INFO - PID 19240 | RSS: Main: 153272320 15:31:21 INFO - PID 19240 | 15:31:22 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55100/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:31:23 INFO - PID 19240 | RSS: Main: 153055232 15:31:23 INFO - PID 19240 | 15:31:24 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55100/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:31:25 INFO - PID 19240 | RSS: Main: 152965120 15:31:25 INFO - PID 19240 | 15:31:27 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55100/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:31:28 INFO - PID 19240 | RSS: Main: 149790720 15:31:28 INFO - PID 19240 | 15:31:30 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:31:31 INFO - PID 19240 | RSS: Main: 150568960 15:31:31 INFO - PID 19240 | 15:31:33 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:31:34 INFO - PID 19240 | RSS: Main: 150716416 15:31:34 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:55100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55100/tests/kraken/driver.html?testName=ai-astar) 15:31:36 INFO - PID 19240 | RSS: Main: 152195072 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | __start_tp_report 15:31:36 INFO - PID 19240 | _x_x_mozilla_page_load 15:31:36 INFO - PID 19240 | _x_x_mozilla_page_load_details 15:31:36 INFO - PID 19240 | |i|pagename|runs| 15:31:36 INFO - PID 19240 | |0;ai-astar;106;105;105;107;107;106;109;107;105;104 15:31:36 INFO - PID 19240 | |1;audio-beat-detection;117;115;113;113;113;110;110;113;111;113 15:31:36 INFO - PID 19240 | |2;audio-dft;164;164;161;162;163;161;160;163;161;166 15:31:36 INFO - PID 19240 | |3;audio-fft;72;73;73;73;76;79;74;73;73;77 15:31:36 INFO - PID 19240 | |4;audio-oscillator;78;79;78;78;77;77;78;78;78;78 15:31:36 INFO - PID 19240 | |5;imaging-gaussian-blur;113;117;114;113;113;113;113;113;114;114 15:31:36 INFO - PID 19240 | |6;imaging-darkroom;149;149;154;149;148;149;149;149;149;150 15:31:36 INFO - PID 19240 | |7;imaging-desaturate;94;94;94;94;93;94;93;95;94;94 15:31:36 INFO - PID 19240 | |8;json-parse-financial;45;45;45;45;45;45;44;44;44;43 15:31:36 INFO - PID 19240 | |9;json-stringify-tinderbox;47;47;47;48;47;47;47;47;47;46 15:31:36 INFO - PID 19240 | |10;stanford-crypto-aes;73;71;71;72;70;70;71;74;73;69 15:31:36 INFO - PID 19240 | |11;stanford-crypto-ccm;108;103;106;105;105;108;105;106;108;104 15:31:36 INFO - PID 19240 | |12;stanford-crypto-pbkdf2;157;154;151;158;151;157;159;152;151;153 15:31:36 INFO - PID 19240 | |13;stanford-crypto-sha256-iterative;58;59;59;59;59;60;59;66;62;61 15:31:36 INFO - PID 19240 | __end_tp_report 15:31:36 INFO - PID 19240 | __start_cc_report 15:31:36 INFO - PID 19240 | _x_x_mozilla_cycle_collect,715 15:31:36 INFO - PID 19240 | __end_cc_report 15:31:36 INFO - PID 19240 | __startTimestamp1505601096299__endTimestamp 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | ------- Summary: start ------- 15:31:36 INFO - PID 19240 | Number of tests: 14 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#0] ai-astar Cycles:10 Average:106.10 Median:106.50 stddev:1.45 (1.4%) stddev-sans-first:1.54 15:31:36 INFO - PID 19240 | Values: 106.0 105.0 105.0 107.0 107.0 106.0 109.0 107.0 105.0 104.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#1] audio-beat-detection Cycles:10 Average:112.80 Median:113.00 stddev:2.15 (1.9%) stddev-sans-first:1.66 15:31:36 INFO - PID 19240 | Values: 117.0 115.0 113.0 113.0 113.0 110.0 110.0 113.0 111.0 113.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.84 (1.1%) stddev-sans-first:1.87 15:31:36 INFO - PID 19240 | Values: 164.0 164.0 161.0 162.0 163.0 161.0 160.0 163.0 161.0 166.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#3] audio-fft Cycles:10 Average:74.30 Median:73.50 stddev:2.26 (3.1%) stddev-sans-first:2.24 15:31:36 INFO - PID 19240 | Values: 72.0 73.0 73.0 73.0 76.0 79.0 74.0 73.0 73.0 77.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:78.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 15:31:36 INFO - PID 19240 | Values: 78.0 79.0 78.0 78.0 77.0 77.0 78.0 78.0 78.0 78.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:113.50 stddev:1.25 (1.1%) stddev-sans-first:1.30 15:31:36 INFO - PID 19240 | Values: 113.0 117.0 114.0 113.0 113.0 113.0 113.0 113.0 114.0 114.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.00 stddev:1.65 (1.1%) stddev-sans-first:1.74 15:31:36 INFO - PID 19240 | Values: 149.0 149.0 154.0 149.0 148.0 149.0 149.0 149.0 149.0 150.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 15:31:36 INFO - PID 19240 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 93.0 95.0 94.0 94.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#8] json-parse-financial Cycles:10 Average:44.50 Median:45.00 stddev:0.71 (1.6%) stddev-sans-first:0.73 15:31:36 INFO - PID 19240 | Values: 45.0 45.0 45.0 45.0 45.0 45.0 44.0 44.0 44.0 43.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#9] json-stringify-tinderbox Cycles:10 Average:47.00 Median:47.00 stddev:0.47 (1.0%) stddev-sans-first:0.50 15:31:36 INFO - PID 19240 | Values: 47.0 47.0 47.0 48.0 47.0 47.0 47.0 47.0 47.0 46.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#10] stanford-crypto-aes Cycles:10 Average:71.40 Median:71.50 stddev:1.58 (2.2%) stddev-sans-first:1.56 15:31:36 INFO - PID 19240 | Values: 73.0 71.0 71.0 72.0 70.0 70.0 71.0 74.0 73.0 69.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#11] stanford-crypto-ccm Cycles:10 Average:105.80 Median:106.00 stddev:1.75 (1.7%) stddev-sans-first:1.67 15:31:36 INFO - PID 19240 | Values: 108.0 103.0 106.0 105.0 105.0 108.0 105.0 106.0 108.0 104.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:155.50 stddev:3.16 (2.0%) stddev-sans-first:3.20 15:31:36 INFO - PID 19240 | Values: 157.0 154.0 151.0 158.0 151.0 157.0 159.0 152.0 151.0 153.0 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.20 Median:59.50 stddev:2.35 (3.9%) stddev-sans-first:2.35 15:31:36 INFO - PID 19240 | Values: 58.0 59.0 59.0 59.0 59.0 60.0 59.0 66.0 62.0 61.0 15:31:36 INFO - PID 19240 | -------- Summary: end -------- 15:31:36 INFO - PID 19240 | 15:31:36 INFO - PID 19240 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:31:36 INFO - TEST-INFO | 19240: exit 0 15:31:36 INFO - TEST-OK | kraken | took 59238ms 15:31:36 INFO - SUITE-END | took 1167s 15:31:37 INFO - Completed test suite (00:19:28) 15:31:37 INFO - javascript benchmark 15:31:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9004.76035608216, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3863.864764733235, 3874.806259687016, 3901.239258344622, 3901.3952837310208, 3926.018495376156, 6144.385561443864, 6201.627902325864, 6260.561760676755, 6274.309825919151, 6297.023961286008, 6254.249490061199, 6256.655883926383, 6258.374162583739, 6267.874642507147, 6281.057841323793, 5534.335879694422, 5602.439756024395, 5638.182463542784, 5649.971750141243, 5681.886362272752, 5639.492445679888, 5655.943440565604, 5675.886482270352, 5685.459881311269, 5718.399568045358, 5500.339959204921, 5702.515286200657, 5763.884722305552, 5769.221155144065, 5774.480296773289, 5462.863428414282, 5575.470330318613, 5610.579206559524, 5676.659400435987, 5683.914741278884, 5586.581006424534, 5587.339326844515, 5626.2967129108865, 5676.659400435946, 5686.0, 6149.938500615026, 6172.567920245585, 6207.162033125561, 6286.528510361742, 6330.65181415022, 6749.257581666013, 6788.558743681645, 6802.455803535705, 6804.65976701163, 6806.523543351967, 6790.0493930849725, 6873.140857392826, 6878.037074809531, 6887.070245516841, 6898.482333886537, 6123.510119190454, 6165.722542485599, 6190.350013248589, 6349.8412539686415, 6362.300146983828, 6872.725090996404, 6888.276730943279, 6889.207741109736, 6975.79072627822, 6995.93004069963, 6514.348565143448, 6578.901316480256, 6620.966895165493, 6650.933490665128, 6734.932650673529, 6665.933340666628, 6757.628330441873, 6776.356246156607, 6777.220619628707, 6782.118324617768, 6679.198496180489, 6692.665366731644, 6715.932840671629, 6732.023856540774, 6762.323767623198, 6599.373059559334, 6675.86648267032, 6767.255601883789, 6769.966150169218, 6781.287964763727, 4862.610991120702, 4921.581665558468, 4922.729249891218, 4929.13740095489, 4936.407631084293, 4406.537313582092, 4414.4702635683925, 4441.733495990186, 4444.155610434007, 4525.932111018337, 6223.937760622426, 6224.408681175281, 6282.591631543935, 6284.308726040132, 6287.182666253358, 6663.267040625527, 6710.865782684319, 6791.660416979132, 6803.693833777492, 6815.625140617214, 6208.782692605828, 6210.5652604317265, 6274.0, 6276.811695649138, 6279.591826531261, 5398.568114550826, 5445.618806683494, 5449.509544140967, 5451.591130665216, 5463.590230732711, 6833.111695479556, 6894.379505844498, 6918.377346038881, 6919.550229235084, 6945.062416573698, 6656.167979002625, 6739.797806065826, 6770.289119642465, 6808.62552559614, 6823.044773731583, 6746.561473504206, 6915.204751453647, 6936.306369363023, 7005.159380874327, 7030.402415794715, 6613.834654133685, 6654.268030516736, 6659.367360100783, 6680.665966701743, 6709.429698475489, 6756.358145976124, 6760.594364338155, 6812.65936703153, 6848.520603557703, 6856.005879147396, 6510.056041873996, 6511.7395304189195, 6540.37866402691, 6609.966950165219, 6613.933860661332, 6443.871122577616, 6501.187351581052, 6540.574862633914, 6591.307912669101, 6600.900986485302, 6377.617342959437, 6488.221413430419, 6494.837629059122, 6514.315996820455, 6519.185101862267, 6453.225612926479, 6459.224893012869, 6470.741170353133, 6598.703058362481, 6612.5040621952585, 6256.843578910563, 6262.06069089622, 6309.747610095545, 6315.747370105144, 6356.364363563792], "value": 6163.665107129557, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [925.3337596930207, 935.2050756856669, 962.470641147369, 988.2390559269363, 990.9108180263777, 41352.793236033816, 42614.57385426145, 42632.36051459231, 42691.57308426915, 42816.78591607042, 39764.20471590567, 39990.8000459998, 40031.59968400315, 40040.0, 40116.0, 7235.67439465224, 7319.963400182992, 7322.414206863438, 7333.339999400053, 7343.339099481045, 7341.302576255247, 7433.070866141732, 7435.553866768011, 7437.405007599406, 7438.739644112457, 7427.442941779361, 7901.130875603708, 8034.517928924254, 8037.5579343136105, 8057.919420805775, 7950.522968621873, 8007.8798818017485, 8012.238837310446, 8015.398845086642, 8017.87973180397, 7896.407769417317, 7919.841603167962, 7955.721549745731, 7955.920440795634, 7979.56112413817, 38548.42177367342, 39205.80397098025, 39320.0, 39325.21349572993, 39359.0, 3641.6540428659237, 3689.6494832990825, 3690.6678398944223, 3691.870784522556, 3693.076730817296, 31160.688393116234, 31389.52915706266, 31399.215019624462, 31419.214519636964, 31466.37067258642, 5486.094794358926, 5492.670439773587, 5502.284702988586, 5537.944620553783, 5545.085060964936, 212004.0, 214434.0, 214526.0, 215773.99999999843, 216954.0, 50427.73930651763, 50540.0, 50566.74716626394, 50700.49299506958, 50733.492665073616, 52805.2079218812, 52838.20742688863, 52848.20727689088, 52888.0, 52919.20621190685, 16272.43046493367, 16630.0, 16683.749743753855, 16730.6653866922, 16803.747943780854, 13668.384922678304, 13787.931060344634, 13792.448302067805, 13794.517191898236, 13805.654858628615, 14686.706265874624, 14725.705485890223, 14809.333579988926, 14953.177575233467, 14975.801935845324, 5802.82591522255, 5916.201312822714, 5993.550483713651, 6078.908816367758, 6136.417040381157, 1062.4315990944808, 1098.3849044535086, 1101.6970333158285, 1115.553778488611, 1140.0309736723884, 25168.622470662955, 25181.0, 25343.36641583975, 25438.109666161596, 25461.490770184493, 1210.9878901211052, 1211.0493262788668, 1229.2317301686446, 1231.119749379198, 1238.7646347194184, 13524.12093213938, 13539.729205415837, 13723.588292351245, 13758.380872860746, 13815.723685526233, 283878.0, 286173.0, 286375.0, 286835.0, 287024.0, 46979.29531057037, 47928.5207147931, 47962.0, 48727.269090963666, 48921.75539122282, 1413.0744362442617, 1526.351300697177, 1545.7217700813737, 1546.876249900028, 1547.7214101461846, 29488.11535653934, 29832.25419364533, 30016.549751753304, 30062.849685751433, 30221.09336719902, 38138.42792358062, 38158.0, 38204.0, 38243.0, 38259.0, 214110.0, 216357.0, 216639.0, 217425.0, 217432.0, 32734.50898236481, 33902.3219535603, 34254.82872585621, 34429.13927151841, 34657.13357166091, 45168.77415612901, 45285.0, 45360.0, 45614.77192614148, 45677.08645827131, 32130.0, 32673.509897352033, 32907.0, 32944.67055329416, 33350.66649333476, 32523.186920326236, 32750.0, 33048.33903321968, 33183.336333273684, 33387.83306083454, 38192.80903595464, 38334.424983625824, 38403.615963840006, 38471.0, 38512.0, 31879.52180717245, 31974.0, 32004.679953201103, 32186.83906580546, 32264.516032260006, 24671.753282467664, 25211.369715757253, 25352.619710704723, 25411.36471588225, 25432.491350173263], "value": 18021.853818715248, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.5867627498861, 601.765311528504, 612.3539665652737, 612.663035330568, 613.3498491598905, 23222.88388558057, 23923.28230153096, 24024.39939001526, 24054.51890962182, 24115.0, 22004.175989555053, 26997.73002269977, 27047.864760676217, 27120.18639440815, 27129.05048323309, 6790.5246632735725, 6865.897011544831, 6887.173539175306, 6890.345417185385, 6943.0, 6441.066045423411, 6633.402993730563, 6674.799756007304, 6697.497687673444, 6752.763653272136, 6590.8022759317055, 6635.867282654344, 6649.900251496231, 6653.101831252768, 6666.166729158856, 6600.0, 6668.966655166717, 6854.828629284258, 6865.897011544831, 6870.072540207083, 6358.364163583605, 6359.300476947532, 6365.586236894634, 6369.554131210817, 6370.745170193233, 30918.22704432385, 31316.0, 31365.215869603213, 31457.370852583048, 31496.527552086736, 2196.6595177747477, 2227.0757635581213, 2233.932982010542, 2238.3285014495586, 2239.6304609739373, 20886.26898058576, 21600.89199553992, 21725.348239552837, 21755.564888702294, 21764.238251661114, 2394.558089842479, 2415.082268737886, 2461.9753802462105, 2465.60550311951, 2472.7898128659085, 132384.33807830996, 137304.31347843297, 143498.0, 151176.2441187798, 151399.0, 15273.847261527242, 16322.34710611586, 16333.67332653364, 17009.489715308562, 17017.659646806995, 25509.107181248568, 25547.0, 25639.743602563736, 25642.23073307804, 25742.0, 10534.736631584272, 10673.623814236282, 10826.512806923707, 10833.566657333777, 10852.94573527143, 9535.284853636005, 9650.71047868565, 9661.855072173923, 9743.951280243695, 9809.313348065567, 9838.360506567193, 9895.703128906145, 10065.647702330383, 10070.395776253448, 10181.74545636365, 2771.0, 2799.762020228263, 2933.506519458443, 2939.3533422646983, 3044.680308567613, 1029.7631544744602, 1030.3457304611625, 1043.3426941027105, 1060.48566445274, 1062.5271754069365, 20489.590208195754, 20698.068586913625, 20851.687224691643, 20957.056932438078, 21342.78657213439, 1103.961361352365, 1114.225613198819, 1118.7315044389288, 1127.7011591928147, 1132.1715429581168, 11357.432128393548, 11381.487833047533, 11599.478023488795, 11612.187146899805, 11665.183437159318, 569665.0, 577882.0, 588616.0, 595886.0, 596940.0, 122857.0, 126901.36549317378, 127982.36008819897, 131277.0, 134162.0, 1136.471540733563, 1173.3781096019125, 1176.394157009141, 1255.5480027190204, 1265.3989355056274, 22800.31599052031, 23013.88493057524, 23023.194188204, 23377.298681039596, 23473.41316467102, 60230.397696022475, 61005.0, 61553.38446615656, 61966.69016654888, 63184.684076581165, 78567.214327856, 79085.60457197677, 79229.0, 79383.60308198653, 79447.60276198582, 15602.687946241238, 15830.44593439224, 15925.601859953595, 15979.121148336488, 15982.440614578434, 25051.0, 25418.491630167664, 25605.871970640026, 25670.358241044123, 25790.742092578836, 20481.897590512548, 20649.27727529529, 20750.481237968568, 20834.58330833405, 20866.165353386303, 18035.729464057786, 18195.81804181994, 18346.266149353876, 18565.628687426444, 18752.0, 20681.482962926046, 20803.479913002295, 21135.682964755233, 21238.46903827417, 21362.145514179258, 15435.536933892, 15673.294701738221, 15752.527424177293, 15774.9211253943, 15810.446634367741, 20351.287704930255, 20358.491037724176, 20395.388138355873, 20541.89729051405, 20671.379858604265], "value": 12910.01711736183, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.9793753093704, 1456.1336005076976, 1464.6997365540064, 1465.4504560789703, 1467.4203689542628, 16790.580235494104, 17479.388221412253, 17480.38818641348, 17482.737758933625, 17489.212985415656, 16985.235664395103, 17096.401625943065, 17136.14319284037, 17145.228464719086, 17199.570010749736, 2831.9858400707967, 2906.854657267139, 2950.5721670357784, 2951.4982452983045, 2955.2611847038243, 2736.2475319287155, 2763.0329384715287, 2765.363966287755, 2768.709285525021, 2776.639036925207, 2727.263638817528, 2813.6342275504157, 2903.5354343305075, 2903.666078400979, 2914.883404663811, 2822.2238884306776, 2846.985765071172, 2874.798764086515, 2880.7119288071235, 2880.812747171427, 2595.3122422558035, 2597.7662010418962, 2608.3479130217447, 2608.360951566878, 2619.4499155177436, 16634.085125318103, 16713.415030473876, 16785.24466399015, 16796.076215808127, 16803.495895123044, 8503.787405314855, 8837.911620883837, 8868.02451730309, 8882.333824963154, 8890.911090889073, 5852.941470585325, 5891.0, 5927.525797936198, 5968.7612495500125, 6019.578629495937, 2071.7513898332145, 2078.9272375466785, 2081.9791802081936, 2083.854130210886, 2125.883076430796, 30796.692033079606, 30891.536626950612, 30952.226194345098, 30955.38089238225, 30992.225194370094, 7374.446916481178, 7441.813954651068, 7466.25337466249, 7524.548527088392, 7603.315701586884, 19565.217391304188, 19831.20675172977, 19840.206391744458, 19842.70235946462, 19857.60284794296, 8628.568571571523, 8742.606582703793, 8772.385932984758, 8780.253678437404, 8795.51624660637, 7605.543667379864, 7791.727289544952, 7900.525968441912, 7976.840463190703, 7990.240927111915, 5569.053260945568, 5663.263775709213, 5718.399568045378, 5800.274965629296, 5805.82582522525, 1657.3867668962562, 1678.907660078683, 1693.7798086248708, 1710.6578684263197, 1714.7770789797246, 914.4650379527918, 937.5078084005816, 955.7037318431309, 971.577363846729, 972.1348000279756, 8250.422470427133, 8256.174382561696, 8332.0, 8348.373871959628, 9205.861912071325, 778.0974070078681, 778.6184769462923, 799.8280369720421, 804.4610111225493, 804.6379129391797, 5633.6619802811965, 6139.6009259398, 6392.232932048091, 6439.8068057958335, 6465.515086368541, 23623.0, 23901.641475377884, 23959.322847400865, 24391.0, 24792.504149916902, 24229.0, 24278.393040174138, 24304.513909721707, 24313.635295470584, 24441.511169776506, 11173.888261117285, 12532.81200781989, 12653.177543459646, 12666.936665316614, 12850.67873303175, 9375.953120234355, 9431.245500360092, 9451.054894510495, 9462.006489318523, 9491.66779162726, 19982.60034799267, 20376.18495260173, 20411.387658370273, 20448.69326960067, 20530.38408847737, 20325.0, 21478.785212148305, 21496.462588435414, 21601.459963501038, 21768.782312176674, 11939.82090268664, 12099.939500302795, 12104.636860894187, 12119.212251203644, 12119.939400302943, 14797.704045919236, 15688.0, 15758.369665213264, 15910.60223494422, 15924.840751592335, 11631.127665424958, 11779.175457717878, 11959.940200298943, 12062.155649104478, 12201.51193952232, 11592.6522204334, 11595.710107247049, 11634.825477618011, 11885.5840045598, 11981.161318707955, 11002.119830413707, 11241.38172400493, 11263.155263355446, 11284.830727538929, 11286.209965302678, 8125.8781118282095, 8191.631376587949, 8193.71322003727, 8304.086550479564, 8348.791280218044, 8278.420510564443, 8492.405531612727, 8504.404691671523, 8523.872141918, 8603.569821508774], "value": 7262.827395562675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.5485501888451, 551.8868631930452, 577.3879687531216, 578.0837372764169, 580.0689892722183, 5999.760009599616, 6092.543059270556, 6137.693115344237, 6156.168917196177, 6252.749890004406, 6165.9383406165925, 6182.876342473148, 6203.596766210193, 6206.565540412173, 6265.436110750032, 5107.055194788976, 5164.845054648366, 5175.741212939357, 5199.168133098705, 5203.2975548301065, 4886.853394398174, 4993.925091123636, 5009.699418034929, 5019.372578427697, 5152.6650767699975, 4915.483874193212, 4927.802887884498, 4972.328735620699, 5015.288686372095, 5017.422996355429, 4925.187344088221, 4938.333325001115, 4978.800847966077, 4982.850514484553, 4983.700977941299, 4442.444694413199, 4576.885577860547, 4586.564276393738, 4591.563801438858, 4611.976940115278, 6188.164597779287, 6195.845103872394, 6237.688115594202, 6248.4064013918605, 6254.21822272216, 5844.0, 5882.764689412418, 5897.73460194288, 5910.290765108171, 5930.911036334458, 6542.54202205841, 6578.0, 6624.503162262801, 6625.343664083979, 6638.502112341545, 5005.349304590416, 5025.974870125662, 5049.84850454487, 5070.366204224472, 5083.440821509631, 6851.657417129173, 6908.0, 6928.411085057776, 6938.444924406035, 7012.754553590702, 5142.61430392722, 5182.585393168538, 5184.11869982104, 5206.219067139884, 5209.869753256123, 5265.1838964959725, 5283.920741188886, 5310.92033619496, 5314.335708036496, 5348.064088784525, 5770.826875193751, 5785.4793068623185, 5842.1957460419235, 5876.647401155944, 5899.410058994152, 6316.30520642729, 6376.234851817811, 6434.388733070351, 6649.833754156185, 6657.167854018247, 1791.408835084419, 1800.1089460717028, 1807.8463330617044, 1814.646144001907, 1828.286968082449, 1285.884270415667, 1287.8518970318346, 1289.007464252539, 1292.780227361332, 1315.2108734759067, 6046.667433291123, 6214.720337584819, 6249.500039996789, 6254.781082662176, 6262.405071518198, 6633.767818126343, 6634.83412914681, 6687.899681504781, 6733.629650369178, 6746.494012949049, 6156.722947467375, 6202.28673702521, 6229.221347331583, 6248.656323902138, 6251.437370636664, 3459.515667806509, 3541.5395998520025, 3550.4851796489365, 3552.4138517144384, 3588.959201831492, 6892.827679308058, 6940.548864323904, 6954.513184077167, 6970.51206415546, 6995.26549712283, 6781.220159681601, 6904.378605925491, 6978.197507286625, 7014.824629384306, 7043.647817609201, 6882.939065951213, 6968.09414776086, 7001.439884809305, 7018.403435708022, 7101.2898710128575, 6660.0, 6714.0, 6718.563293385914, 6759.662016899037, 6773.966130169515, 6657.900131497934, 6666.799996000128, 6692.631905245258, 6718.697658605277, 6745.5952642841585, 6908.821941906779, 6928.376446119873, 7002.404795592432, 7016.22821489646, 7036.19083805369, 5174.120399532164, 5198.16829307309, 5200.6619569727845, 5215.504527069922, 5230.843074707765, 6450.8064758057335, 6524.67376631157, 6704.296048914989, 6842.965785171043, 6862.245153033262, 6549.100760779321, 6609.537332386687, 6630.668466576748, 6634.137562116894, 6657.900131497934, 6505.902411463927, 6542.476601871934, 6575.0412314459645, 6587.0, 6621.602703837785, 6352.396522330371, 6448.290688024407, 6486.5783724059675, 6502.73989040452, 6561.573497722633, 6571.211454625475, 6612.338766123349, 6616.98182054478, 6669.166354205724, 6708.127943367526, 6357.459615932513, 6438.935610643834, 6455.644314693967, 6520.967395162994, 6532.967335163294], "value": 5182.094237874126, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [967.3132076225879, 995.7908839143779, 1011.1556850030224, 1015.258861031447, 1019.592163134746, 18839.340623078195, 19072.618547629056, 19083.71374429383, 19201.903990480063, 19246.230150793985, 19282.0, 19434.41696749096, 19549.218031278768, 20082.0, 20267.08798104085, 1062.1184416933966, 1080.8000519903803, 1081.2647399768193, 1082.3451811653915, 1089.330062011861, 1077.0037715113529, 1081.361996422111, 1081.848541204232, 1082.1991726122692, 1082.312731415549, 1076.9515371808247, 1116.6538373104363, 1122.0406552397706, 1122.0686829931137, 1122.6351435783404, 1113.3486910157567, 1115.6429942418429, 1117.0170250179872, 1117.3910218930703, 1117.4245263689206, 828.668532586964, 829.813292009293, 830.2403300979596, 830.796454868555, 831.0, 20747.68878466824, 20848.791512084987, 21386.0, 21435.785642143535, 21563.78436215649, 23422.06311747528, 23431.179908703285, 23696.7630323698, 23717.0, 23802.523949520913, 18046.097695115324, 18111.45665630033, 18126.63746725058, 18229.270829166817, 18270.725939110926, 4070.328395814687, 4099.836006559734, 4100.261952848486, 4102.261592913274, 4103.4460347853255, 146320.0, 149013.0, 150089.24955375152, 150765.0, 152815.0, 16442.917785410995, 16563.751543726852, 16664.0, 16843.747343789608, 16879.15604219784, 34526.48210276848, 35435.468467973, 35447.29105417929, 35547.289054218774, 35774.463383049275, 8754.08082151365, 8791.428557143765, 8859.512726800089, 8878.822423551494, 8895.822083558292, 4632.143053535106, 4756.738379389167, 4757.381540399726, 4767.570918617272, 4771.570558649738, 6110.847228819226, 6127.509799216141, 6207.379262073757, 6224.0, 6226.315105338409, 1122.0462606784167, 1134.704976706046, 1156.612534800851, 1164.4527072276016, 1166.102101381931, 648.1023782061784, 658.6904155047216, 666.7799626123465, 675.2234929830636, 675.2740803636012, 12545.310007949467, 13189.736205276033, 13331.466741330238, 13858.0, 13961.441542338396, 652.9673516324165, 655.8655475627485, 658.2430205263889, 674.1337381464795, 674.4435840431663, 5427.918581221206, 5447.891042179134, 5488.231647569263, 5574.386817450078, 5647.632903861236, 137927.0, 139340.30329848488, 140486.2975685115, 142689.0, 145948.0, 117902.0, 132575.0, 133843.33078334545, 135131.0, 137062.31468842592, 114859.0, 116912.0, 117147.41426292984, 117707.41146294214, 117919.41040294916, 14011.649708757363, 14072.718545628826, 14117.647058823612, 14182.14907105577, 14187.0, 51194.74402627963, 51626.0, 51659.741701292754, 51688.741556293484, 53554.19668704895, 67418.0, 68957.65521172361, 69055.0, 69777.30222697911, 71438.28561714316, 17934.0, 18448.354307599708, 18791.24835006639, 18818.905905470387, 19024.809751902303, 20491.38525844227, 20628.0, 20667.896660516602, 20684.793152068887, 20814.37556873296, 18893.055347232857, 18896.716549252047, 19018.23927042903, 19145.425637230906, 19179.90410047941, 17549.298028078734, 17607.91196044063, 17622.82377176212, 17896.731549027034, 17901.283948641907, 17366.913165434093, 17672.55818604545, 17775.377861774778, 17776.466705998842, 17916.91041544784, 12408.317542535247, 12456.190347627375, 12600.369981500706, 12629.494820207088, 12798.808017879554, 13475.595732128051, 13871.653208669864, 13973.8122259605, 14031.719365612835, 14044.859551404355], "value": 9877.117555416851, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1373.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 105.0, 107.0, 107.0, 106.0, 109.0, 107.0, 105.0, 104.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 113.0, 113.0, 113.0, 110.0, 110.0, 113.0, 111.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 162.0, 163.0, 161.0, 160.0, 163.0, 161.0, 166.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 73.0, 76.0, 79.0, 74.0, 73.0, 73.0, 77.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 78.0, 77.0, 77.0, 78.0, 78.0, 78.0, 78.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 154.0, 149.0, 148.0, 149.0, 149.0, 149.0, 149.0, 150.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 95.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 45.0, 45.0, 45.0, 45.0, 44.0, 44.0, 44.0, 43.0], "value": 44.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 47.0, 48.0, 47.0, 47.0, 47.0, 47.0, 47.0, 46.0], "value": 47.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 71.0, 72.0, 70.0, 70.0, 71.0, 74.0, 73.0, 69.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 103.0, 106.0, 105.0, 105.0, 108.0, 105.0, 106.0, 108.0, 104.0], "value": 105.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 151.0, 158.0, 151.0, 157.0, 159.0, 152.0, 151.0, 153.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 66.0, 62.0, 61.0], "value": 60.2, "unit": "score"}]}]} 15:31:37 INFO - Return code: 0 15:31:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:31:37 INFO - # TBPL SUCCESS # 15:31:37 INFO - Running post-action listener: _package_coverage_data 15:31:37 INFO - Running post-action listener: _resource_record_post_action 15:31:37 INFO - [mozharness: 2017-09-16 22:31:37.584283Z] Finished run-tests step (success) 15:31:37 INFO - Running post-run listener: _resource_record_post_run 15:31:37 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 340619264; Read time: 12; Write time: 256608 15:31:37 INFO - TinderboxPrint: CPU usage
13.1% 15:31:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:31:37 INFO - TinderboxPrint: I/O write bytes / time
340,619,264 / 256,608 15:31:37 INFO - TinderboxPrint: CPU idle
8,220.1 (86.9%) 15:31:37 INFO - TinderboxPrint: CPU user
1,187.3 (12.6%) 15:31:37 INFO - TinderboxPrint: Swap in / out
0 / 0 15:31:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13189120; Read time: 0; Write time: 1080 15:31:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:31:37 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327430144; Read time: 12; Write time: 255528 15:31:38 INFO - Running post-run listener: _upload_blobber_files 15:31:38 INFO - Blob upload gear active. 15:31:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:31:38 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 15:31:38 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'] 15:31:38 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 15:31:38 INFO - (blobuploader) - INFO - Open directory for files ... 15:31:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:31:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:31:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:39 INFO - (blobuploader) - INFO - Done attempting. 15:31:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:31:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:31:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:46 INFO - (blobuploader) - INFO - Done attempting. 15:31:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:31:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:31:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:46 INFO - (blobuploader) - INFO - Done attempting. 15:31:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:31:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:31:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:48 INFO - (blobuploader) - INFO - Done attempting. 15:31:48 INFO - (blobuploader) - INFO - Iteration through files over. 15:31:48 INFO - Return code: 0 15:31:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:31:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:31:48 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60d30c660012f369c95d04a6873a792da89547f8664a9cfde772dc16ffc9ff446f8fd5e8f547dbe28308a34f233f1c6b02cb1c8e7d3aafc30150f5d1fee57201", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0daf53fe6034a3d0614113748b924694a1ff332e03ae2f0b9f256e922a2fdc32197545d47e7a75a874d4e4e19b9e28f0fbaf50dcd80e7fb9f7987996a1c0103e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4f0d95d536ed73f88ea047dda9807e19791bc4cdf965f98550493bff05170d1af5a119dc91af6a3cbe9bf1fb0e91d5c032c3e9bd3b81121fb924769062cb1d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1d9d11c0a67ed447489ee80a57c5394d2be94449c12c20b3b7f68529ae220e253d16091637eef9106d6e5af2c490c54188cfa5458ac590d9ed44f5277718789"} 15:31:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:31:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:31:48 INFO - Contents: 15:31:48 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60d30c660012f369c95d04a6873a792da89547f8664a9cfde772dc16ffc9ff446f8fd5e8f547dbe28308a34f233f1c6b02cb1c8e7d3aafc30150f5d1fee57201", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0daf53fe6034a3d0614113748b924694a1ff332e03ae2f0b9f256e922a2fdc32197545d47e7a75a874d4e4e19b9e28f0fbaf50dcd80e7fb9f7987996a1c0103e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4f0d95d536ed73f88ea047dda9807e19791bc4cdf965f98550493bff05170d1af5a119dc91af6a3cbe9bf1fb0e91d5c032c3e9bd3b81121fb924769062cb1d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1d9d11c0a67ed447489ee80a57c5394d2be94449c12c20b3b7f68529ae220e253d16091637eef9106d6e5af2c490c54188cfa5458ac590d9ed44f5277718789"} 15:31:48 INFO - Running post-run listener: copy_logs_to_upload_dir 15:31:48 INFO - Copying logs to upload dir... 15:31:48 INFO - mkdir: /builds/slave/test/build/upload/logs 15:31:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.301370 ========= master_lag: 0.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-16 15:31:48.148240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 15:31:48.151325) ========= 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=9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195 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/60d30c660012f369c95d04a6873a792da89547f8664a9cfde772dc16ffc9ff446f8fd5e8f547dbe28308a34f233f1c6b02cb1c8e7d3aafc30150f5d1fee57201", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0daf53fe6034a3d0614113748b924694a1ff332e03ae2f0b9f256e922a2fdc32197545d47e7a75a874d4e4e19b9e28f0fbaf50dcd80e7fb9f7987996a1c0103e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4f0d95d536ed73f88ea047dda9807e19791bc4cdf965f98550493bff05170d1af5a119dc91af6a3cbe9bf1fb0e91d5c032c3e9bd3b81121fb924769062cb1d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1d9d11c0a67ed447489ee80a57c5394d2be94449c12c20b3b7f68529ae220e253d16091637eef9106d6e5af2c490c54188cfa5458ac590d9ed44f5277718789"} build_url:https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011702 build_url: 'https://queue.taskcluster.net/v1/task/GxdTmOGBQj-VN93KhE7TqA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60d30c660012f369c95d04a6873a792da89547f8664a9cfde772dc16ffc9ff446f8fd5e8f547dbe28308a34f233f1c6b02cb1c8e7d3aafc30150f5d1fee57201", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0daf53fe6034a3d0614113748b924694a1ff332e03ae2f0b9f256e922a2fdc32197545d47e7a75a874d4e4e19b9e28f0fbaf50dcd80e7fb9f7987996a1c0103e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4f0d95d536ed73f88ea047dda9807e19791bc4cdf965f98550493bff05170d1af5a119dc91af6a3cbe9bf1fb0e91d5c032c3e9bd3b81121fb924769062cb1d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1d9d11c0a67ed447489ee80a57c5394d2be94449c12c20b3b7f68529ae220e253d16091637eef9106d6e5af2c490c54188cfa5458ac590d9ed44f5277718789"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 15:31:48.181462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:31:48.181775) ========= 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=9bfb7e13875ed353a705960e000001c0-1505599229.684870-2038175195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:31:48.265770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 15:31:48.266086) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 15:31:48.266381) ========= ========= Total master_lag: 0.60 =========