builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-072 starttime: 1505170846.77 results: success (0) revision: 85157b4b361ab9fdf7b3c3d7cf129bd3d422feac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:46.769258) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:46.769691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:46.770009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:46.838396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:46.838959) ========= 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=199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-11 16:00:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 108M=0s 2017-09-11 16:00:46 (108 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.199354 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:47.072121) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:47.072485) ========= 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=199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019370 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:47.123371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:47.123732) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 85157b4b361ab9fdf7b3c3d7cf129bd3d422feac --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 85157b4b361ab9fdf7b3c3d7cf129bd3d422feac --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=199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-11 16:00:47,116 truncating revision to first 12 chars 2017-09-11 16:00:47,116 Setting DEBUG logging. 2017-09-11 16:00:47,116 attempt 1/10 2017-09-11 16:00:47,116 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/85157b4b361a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-11 16:00:47,381 unpacking tar archive at: mozilla-central-85157b4b361a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585765 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:47.725260) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:47.725600) ========= script_repo_revision: 85157b4b361ab9fdf7b3c3d7cf129bd3d422feac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:47.725952) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:47.726252) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 16:00:47.743020) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-11 16:00:47.743280) ========= /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=199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:00:47 INFO - MultiFileLogger online at 20170911 16:00:47 in /builds/slave/test 16:00:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:00:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:00:47 INFO - {'append_to_log': False, 16:00:47 INFO - 'base_work_dir': '/builds/slave/test', 16:00:47 INFO - 'blob_upload_branch': 'Firefox', 16:00:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:00:47 INFO - 'branch': 'Firefox', 16:00:47 INFO - 'buildbot_json_path': 'buildprops.json', 16:00:47 INFO - 'code_coverage': False, 16:00:47 INFO - 'config_files': ('talos/linux_config.py',), 16:00:47 INFO - 'default_actions': ('clobber', 16:00:47 INFO - 'read-buildbot-config', 16:00:47 INFO - 'download-and-extract', 16:00:47 INFO - 'populate-webroot', 16:00:47 INFO - 'create-virtualenv', 16:00:47 INFO - 'install', 16:00:47 INFO - 'setup-mitmproxy', 16:00:47 INFO - 'run-tests'), 16:00:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:00:47 INFO - 'disable_ccov_upload': False, 16:00:47 INFO - 'disable_stylo': False, 16:00:47 INFO - 'download_minidump_stackwalk': True, 16:00:47 INFO - 'download_symbols': 'ondemand', 16:00:47 INFO - 'enable_stylo': False, 16:00:47 INFO - 'enable_webrender': False, 16:00:47 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:00:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:00:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:00:47 INFO - 'gecko_profile': False, 16:00:47 INFO - 'gecko_profile_interval': 0, 16:00:47 INFO - 'installer_path': 'installer.exe', 16:00:47 INFO - 'log_level': 'info', 16:00:47 INFO - 'log_name': 'talos', 16:00:47 INFO - 'log_to_console': True, 16:00:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:00:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:00:47 INFO - 'opt_config_files': (), 16:00:47 INFO - 'pip_index': False, 16:00:47 INFO - 'suite': 'dromaeojs-e10s', 16:00:47 INFO - 'system_bits': '32', 16:00:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:00:47 INFO - 'title': 'talos-linux64-ix-072', 16:00:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:00:47 INFO - 'use_talos_json': True, 16:00:47 INFO - 'verify': 'False', 16:00:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:00:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:00:47 INFO - 'work_dir': 'build'} 16:00:47 INFO - [mozharness: 2017-09-11 23:00:47.958595Z] Running clobber step. 16:00:47 INFO - Running pre-action listener: _resource_record_pre_action 16:00:47 INFO - Running main action method: clobber 16:00:47 INFO - rmtree: /builds/slave/test/build 16:00:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:00:48 INFO - Running post-action listener: _resource_record_post_action 16:00:48 INFO - [mozharness: 2017-09-11 23:00:48.927340Z] Finished clobber step (success) 16:00:48 INFO - [mozharness: 2017-09-11 23:00:48.927435Z] Running read-buildbot-config step. 16:00:48 INFO - Running pre-action listener: _resource_record_pre_action 16:00:48 INFO - Running main action method: read_buildbot_config 16:00:48 INFO - Using buildbot properties: 16:00:48 INFO - { 16:00:48 INFO - "project": "", 16:00:48 INFO - "product": "firefox", 16:00:48 INFO - "who": "kwierso@gmail.com", 16:00:48 INFO - "installer_path": "public/build/target.tar.bz2", 16:00:48 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:00:48 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:00:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:00:48 INFO - "stage_platform": "linux64-pgo", 16:00:48 INFO - "basedir": "/builds/slave/test", 16:00:48 INFO - "buildnumber": 177, 16:00:48 INFO - "platform": "ubuntu64_hw", 16:00:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:00:48 INFO - "slavebuilddir": "test", 16:00:48 INFO - "taskId": "Ce6ugAroQUe8bzYdDk-BwA", 16:00:48 INFO - "branch": "mozilla-central", 16:00:48 INFO - "script_repo_revision": "production", 16:00:48 INFO - "revision": "85157b4b361ab9fdf7b3c3d7cf129bd3d422feac", 16:00:48 INFO - "slavename": "talos-linux64-ix-072", 16:00:48 INFO - "repo_path": "mozilla-central" 16:00:48 INFO - } 16:00:48 INFO - Finding installer, test and symbols from parent task. 16:00:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ce6ugAroQUe8bzYdDk-BwA'}, attempt #1 16:00:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ce6ugAroQUe8bzYdDk-BwA'}, attempt #1 16:00:49 INFO - Task dependencies: TlO0iBDDTAWlTFRvv0Z9LQ 16:00:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ'}, attempt #1 16:00:50 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.tar.bz2 16:00:50 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.test_packages.json 16:00:50 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.crashreporter-symbols.zip 16:00:50 INFO - Running post-action listener: _resource_record_post_action 16:00:50 INFO - [mozharness: 2017-09-11 23:00:50.319279Z] Finished read-buildbot-config step (success) 16:00:50 INFO - [mozharness: 2017-09-11 23:00:50.319493Z] Running download-and-extract step. 16:00:50 INFO - Running pre-action listener: _resource_record_pre_action 16:00:50 INFO - Running main action method: download_and_extract 16:00:50 INFO - mkdir: /builds/slave/test/build/tests 16:00: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')]} 16:00:50 INFO - trying https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.test_packages.json 16:00:50 INFO - Downloading https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:00:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:00:50 INFO - Downloaded 989 bytes. 16:00:50 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:00:50 INFO - Using the following test package requirements: 16:00:50 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:00:50 INFO - u'common': [u'target.common.tests.zip'], 16:00:50 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:00:50 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:00:50 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:00:50 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:00:50 INFO - u'mozbase': [u'target.common.tests.zip'], 16:00:50 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:00:50 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:00:50 INFO - u'web-platform': [u'target.common.tests.zip', 16:00:50 INFO - u'target.web-platform.tests.tar.gz'], 16:00:50 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:00:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:00:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.common.tests.zip 16:00:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:00:50 INFO - Fetch https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.common.tests.zip into memory 16:00:53 INFO - Content-Length response header: 55693891 16:00:53 INFO - Bytes received: 55693891 16:01:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.talos.tests.zip 16:01:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:01:04 INFO - Fetch https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.talos.tests.zip into memory 16:01:05 INFO - Content-Length response header: 14497963 16:01:05 INFO - Bytes received: 14497963 16:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:05 INFO - trying https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.tar.bz2 16:01:05 INFO - Downloading https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:01:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:01:08 INFO - Downloaded 63630653 bytes. 16:01:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.tar.bz2 16:01:08 INFO - mkdir: /builds/slave/test/properties 16:01:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:01:08 INFO - Writing to file /builds/slave/test/properties/build_url 16:01:08 INFO - Contents: 16:01:08 INFO - build_url:https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.tar.bz2 16:01:08 INFO - Running post-action listener: _resource_record_post_action 16:01:08 INFO - Running post-action listener: find_tests_for_verification 16:01:08 INFO - Running post-action listener: set_extra_try_arguments 16:01:08 INFO - [mozharness: 2017-09-11 23:01:08.487314Z] Finished download-and-extract step (success) 16:01:08 INFO - [mozharness: 2017-09-11 23:01:08.487541Z] Running populate-webroot step. 16:01:08 INFO - Running pre-action listener: _resource_record_pre_action 16:01:08 INFO - Running main action method: populate_webroot 16:01:08 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:01:08 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:01:08 INFO - 'tests': ['tresize', 16:01:08 INFO - 'tcanvasmark']}, 16:01:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:01:08 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:01:08 INFO - 'tests': ['dromaeo_css', 16:01:08 INFO - 'kraken']}, 16:01:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:01:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:08 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:01:08 INFO - 'talos_options': ['--disable-stylo'], 16:01:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:01:08 INFO - 'tests': ['damp', 'tps']}, 16:01:08 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:01:08 INFO - 'talos_options': ['--disable-stylo'], 16:01:08 INFO - 'tests': ['damp', 'tps']}, 16:01:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:01:08 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:01:08 INFO - 'tests': ['dromaeo_dom']}, 16:01:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:01:08 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:01:08 INFO - 'tests': ['basic_compositor_video', 16:01:08 INFO - 'glvideo']}, 16:01:08 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:01:08 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:01:08 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:01:08 INFO - 'talos_options': ['--disable-stylo'], 16:01:08 INFO - 'tests': ['ts_paint_webext', 16:01:08 INFO - 'tp5o_webext']}, 16:01:08 INFO - 'other-e10s': {'tests': ['a11yr', 16:01:08 INFO - 'ts_paint', 16:01:08 INFO - 'tpaint', 16:01:08 INFO - 'sessionrestore', 16:01:08 INFO - 'sessionrestore_many_windows', 16:01:08 INFO - 'sessionrestore_no_auto_restore', 16:01:08 INFO - 'tabpaint']}, 16:01:08 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:01:08 INFO - 'tests': ['a11yr', 16:01:08 INFO - 'ts_paint', 16:01:08 INFO - 'tpaint', 16:01:08 INFO - 'sessionrestore', 16:01:08 INFO - 'sessionrestore_many_windows', 16:01:08 INFO - 'sessionrestore_no_auto_restore', 16:01:08 INFO - 'tabpaint']}, 16:01:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:01:08 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:01:08 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:01:08 INFO - 'tests': ['bloom_basic_singleton']}, 16:01:08 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:01:08 INFO - 'tests': ['bloom_basic']}, 16:01:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:01:08 INFO - 'tsvgr_opacity', 16:01:08 INFO - 'tart', 16:01:08 INFO - 'tscrollx', 16:01:08 INFO - 'tsvg_static']}, 16:01:08 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:01:08 INFO - 'tests': ['tsvgx', 16:01:08 INFO - 'tsvgr_opacity', 16:01:08 INFO - 'tart', 16:01:08 INFO - 'tscrollx', 16:01:08 INFO - 'tsvg_static']}, 16:01:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:01:08 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:01:08 INFO - 'talos_options': ['--disable-stylo'], 16:01:08 INFO - 'tests': ['tp5o']}, 16:01:08 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:01:08 INFO - 'talos_options': ['--mitmproxy', 16:01:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:01:08 INFO - '--firstNonBlankPaint'], 16:01:08 INFO - 'tests': ['tp6_google', 16:01:08 INFO - 'tp6_youtube', 16:01:08 INFO - 'tp6_amazon', 16:01:08 INFO - 'tp6_facebook']}, 16:01:08 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:01:08 INFO - 'talos_options': ['--disable-stylo', 16:01:08 INFO - '--mitmproxy', 16:01:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:01:08 INFO - '--firstNonBlankPaint'], 16:01:08 INFO - 'tests': ['tp6_google', 16:01:08 INFO - 'tp6_youtube', 16:01:08 INFO - 'tp6_amazon', 16:01:08 INFO - 'tp6_facebook']}, 16:01:08 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:01:08 INFO - 'talos_options': ['--stylo-threads=1', 16:01:08 INFO - '--mitmproxy', 16:01:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:01:08 INFO - '--firstNonBlankPaint'], 16:01:08 INFO - 'tests': ['tp6_google', 16:01:08 INFO - 'tp6_youtube', 16:01:08 INFO - 'tp6_amazon', 16:01:08 INFO - 'tp6_facebook']}, 16:01:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:01:08 INFO - 'talos_options': ['--xperf_path', 16:01:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:08 INFO - 'tests': ['tp5n']}, 16:01:08 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:01:08 INFO - 'talos_options': ['--disable-stylo', 16:01:08 INFO - '--xperf_path', 16:01:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:08 INFO - 'tests': ['tp5n']}}} 16:01:08 INFO - Running post-action listener: _resource_record_post_action 16:01:08 INFO - [mozharness: 2017-09-11 23:01:08.506089Z] Finished populate-webroot step (success) 16:01:08 INFO - [mozharness: 2017-09-11 23:01:08.506177Z] Running create-virtualenv step. 16:01:08 INFO - Running pre-action listener: _resource_record_pre_action 16:01:08 INFO - Running main action method: create_virtualenv 16:01:08 INFO - Creating virtualenv /builds/slave/test/build/venv 16:01:08 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:01:08 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:01:08 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:01:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:01:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:01:09 INFO - Installing distribute.............................................................................................................................................................................................done. 16:01:09 INFO - Installing pip...............done. 16:01:09 INFO - Return code: 0 16:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:01:09 INFO - Reading from file tmpfile_stdout 16:01:09 INFO - Output received: 16:01:09 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:01:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2696a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a090>, '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 0x269ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2694f90>, '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': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:01:09 INFO - Using env: {'DISPLAY': ':0', 16:01:09 INFO - 'HOME': '/home/cltbld', 16:01:09 INFO - 'LANG': 'en_US.UTF-8', 16:01:09 INFO - 'LANGUAGE': 'en_US:en', 16:01:09 INFO - 'LOGNAME': 'cltbld', 16:01:09 INFO - 'MAIL': '/var/mail/cltbld', 16:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:09 INFO - 'MOZ_NO_REMOTE': '1', 16:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:09 INFO - 'NO_EM_RESTART': '1', 16:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:09 INFO - 'PWD': '/builds/slave/test', 16:01:09 INFO - 'SHELL': '/bin/bash', 16:01:09 INFO - 'SHLVL': '1', 16:01:09 INFO - 'TERM': 'linux', 16:01:09 INFO - 'TMOUT': '86400', 16:01:09 INFO - 'USER': 'cltbld', 16:01:09 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:09 INFO - '_': '/tools/buildbot/bin/python'} 16:01:11 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:01:11 INFO - Downloading/unpacking pip>=1.5 16:01:11 INFO - Running setup.py egg_info for package pip 16:01:11 INFO - warning: no files found matching 'pip/cacert.pem' 16:01:11 INFO - warning: no files found matching '*.html' under directory 'docs' 16:01:11 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:01:11 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:01:11 INFO - Installing collected packages: pip 16:01:11 INFO - Found existing installation: pip 1.1 16:01:11 INFO - Uninstalling pip: 16:01:11 INFO - Successfully uninstalled pip 16:01:11 INFO - Running setup.py install for pip 16:01:11 INFO - warning: no files found matching 'pip/cacert.pem' 16:01:11 INFO - warning: no files found matching '*.html' under directory 'docs' 16:01:11 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:01:11 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:01:11 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:01:11 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:01:11 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:01:11 INFO - Successfully installed pip 16:01:11 INFO - Cleaning up... 16:01:11 INFO - Return code: 0 16:01:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:01:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:11 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 0x232a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2696a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a090>, '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 0x269ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2694f90>, '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': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:01:11 INFO - Using env: {'DISPLAY': ':0', 16:01:11 INFO - 'HOME': '/home/cltbld', 16:01:11 INFO - 'LANG': 'en_US.UTF-8', 16:01:11 INFO - 'LANGUAGE': 'en_US:en', 16:01:11 INFO - 'LOGNAME': 'cltbld', 16:01:11 INFO - 'MAIL': '/var/mail/cltbld', 16:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:11 INFO - 'MOZ_NO_REMOTE': '1', 16:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:11 INFO - 'NO_EM_RESTART': '1', 16:01:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:11 INFO - 'PWD': '/builds/slave/test', 16:01:11 INFO - 'SHELL': '/bin/bash', 16:01:11 INFO - 'SHLVL': '1', 16:01:11 INFO - 'TERM': 'linux', 16:01:11 INFO - 'TMOUT': '86400', 16:01:11 INFO - 'USER': 'cltbld', 16:01:11 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:11 INFO - '_': '/tools/buildbot/bin/python'} 16:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:11 INFO - Downloading/unpacking psutil>=3.1.1 16:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:01:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:12 INFO - Installing collected packages: psutil 16:01:12 INFO - Running setup.py install for psutil 16:01:12 INFO - building 'psutil._psutil_linux' extension 16:01:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:01:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:01:14 INFO - building 'psutil._psutil_posix' extension 16:01:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:01:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:01:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:14 INFO - Successfully installed psutil 16:01:14 INFO - Cleaning up... 16:01:14 INFO - Return code: 0 16:01:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:14 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 0x232a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2696a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a090>, '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 0x269ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2694f90>, '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': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:01:14 INFO - Using env: {'DISPLAY': ':0', 16:01:14 INFO - 'HOME': '/home/cltbld', 16:01:14 INFO - 'LANG': 'en_US.UTF-8', 16:01:14 INFO - 'LANGUAGE': 'en_US:en', 16:01:14 INFO - 'LOGNAME': 'cltbld', 16:01:14 INFO - 'MAIL': '/var/mail/cltbld', 16:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:14 INFO - 'MOZ_NO_REMOTE': '1', 16:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:14 INFO - 'NO_EM_RESTART': '1', 16:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:14 INFO - 'PWD': '/builds/slave/test', 16:01:14 INFO - 'SHELL': '/bin/bash', 16:01:14 INFO - 'SHLVL': '1', 16:01:14 INFO - 'TERM': 'linux', 16:01:14 INFO - 'TMOUT': '86400', 16:01:14 INFO - 'USER': 'cltbld', 16:01:14 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:14 INFO - '_': '/tools/buildbot/bin/python'} 16:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:01:16 INFO - Installing collected packages: mozsystemmonitor 16:01:16 INFO - Running setup.py install for mozsystemmonitor 16:01:16 INFO - Successfully installed mozsystemmonitor 16:01:16 INFO - Cleaning up... 16:01:16 INFO - Return code: 0 16:01:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:16 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 0x232a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2696a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a090>, '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 0x269ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2694f90>, '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': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:01:16 INFO - Using env: {'DISPLAY': ':0', 16:01:16 INFO - 'HOME': '/home/cltbld', 16:01:16 INFO - 'LANG': 'en_US.UTF-8', 16:01:16 INFO - 'LANGUAGE': 'en_US:en', 16:01:16 INFO - 'LOGNAME': 'cltbld', 16:01:16 INFO - 'MAIL': '/var/mail/cltbld', 16:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:16 INFO - 'MOZ_NO_REMOTE': '1', 16:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:16 INFO - 'NO_EM_RESTART': '1', 16:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:16 INFO - 'PWD': '/builds/slave/test', 16:01:16 INFO - 'SHELL': '/bin/bash', 16:01:16 INFO - 'SHLVL': '1', 16:01:16 INFO - 'TERM': 'linux', 16:01:16 INFO - 'TMOUT': '86400', 16:01:16 INFO - 'USER': 'cltbld', 16:01:16 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:16 INFO - '_': '/tools/buildbot/bin/python'} 16:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:16 INFO - Downloading/unpacking jsonschema==2.5.1 16:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:01:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:17 INFO - Downloading functools32-3.2.3-2.tar.gz 16:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:01:17 INFO - warning: no files found matching '*.txt' 16:01:17 INFO - no previously-included directories found matching 'build' 16:01:17 INFO - no previously-included directories found matching 'dist' 16:01:17 INFO - no previously-included directories found matching '.git*' 16:01:17 INFO - Installing collected packages: jsonschema, functools32 16:01:17 INFO - Running setup.py install for functools32 16:01:18 INFO - warning: no files found matching '*.txt' 16:01:18 INFO - no previously-included directories found matching 'build' 16:01:18 INFO - no previously-included directories found matching 'dist' 16:01:18 INFO - no previously-included directories found matching '.git*' 16:01:18 INFO - Successfully installed jsonschema functools32 16:01:18 INFO - Cleaning up... 16:01:18 INFO - Return code: 0 16:01:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:18 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 0x232a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2696a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a090>, '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 0x269ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2694f90>, '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': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:01:18 INFO - Using env: {'DISPLAY': ':0', 16:01:18 INFO - 'HOME': '/home/cltbld', 16:01:18 INFO - 'LANG': 'en_US.UTF-8', 16:01:18 INFO - 'LANGUAGE': 'en_US:en', 16:01:18 INFO - 'LOGNAME': 'cltbld', 16:01:18 INFO - 'MAIL': '/var/mail/cltbld', 16:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:18 INFO - 'MOZ_NO_REMOTE': '1', 16:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:18 INFO - 'NO_EM_RESTART': '1', 16:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:18 INFO - 'PWD': '/builds/slave/test', 16:01:18 INFO - 'SHELL': '/bin/bash', 16:01:18 INFO - 'SHLVL': '1', 16:01:18 INFO - 'TERM': 'linux', 16:01:18 INFO - 'TMOUT': '86400', 16:01:18 INFO - 'USER': 'cltbld', 16:01:18 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:18 INFO - '_': '/tools/buildbot/bin/python'} 16:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:01:18 INFO - Cleaning up... 16:01:18 INFO - Return code: 0 16:01:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:18 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 0x232a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2696a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a090>, '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 0x269ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2694f90>, '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': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:01:18 INFO - Using env: {'DISPLAY': ':0', 16:01:18 INFO - 'HOME': '/home/cltbld', 16:01:18 INFO - 'LANG': 'en_US.UTF-8', 16:01:18 INFO - 'LANGUAGE': 'en_US:en', 16:01:18 INFO - 'LOGNAME': 'cltbld', 16:01:18 INFO - 'MAIL': '/var/mail/cltbld', 16:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:18 INFO - 'MOZ_NO_REMOTE': '1', 16:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:18 INFO - 'NO_EM_RESTART': '1', 16:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:18 INFO - 'PWD': '/builds/slave/test', 16:01:18 INFO - 'SHELL': '/bin/bash', 16:01:18 INFO - 'SHLVL': '1', 16:01:18 INFO - 'TERM': 'linux', 16:01:18 INFO - 'TMOUT': '86400', 16:01:18 INFO - 'USER': 'cltbld', 16:01:18 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:18 INFO - '_': '/tools/buildbot/bin/python'} 16:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:18 INFO - Downloading/unpacking blobuploader==1.2.4 16:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:19 INFO - Downloading blobuploader-1.2.4.tar.gz 16:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:01:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:01:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:20 INFO - Downloading docopt-0.6.1.tar.gz 16:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:01:20 INFO - Installing collected packages: blobuploader, requests, docopt 16:01:20 INFO - Running setup.py install for blobuploader 16:01:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:01:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:01:20 INFO - Running setup.py install for requests 16:01:20 INFO - Running setup.py install for docopt 16:01:20 INFO - Successfully installed blobuploader requests docopt 16:01:20 INFO - Cleaning up... 16:01:20 INFO - Return code: 0 16:01:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:20 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 0x232a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2696a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a090>, '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 0x269ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2694f90>, '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': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:01:20 INFO - Using env: {'DISPLAY': ':0', 16:01:20 INFO - 'HOME': '/home/cltbld', 16:01:20 INFO - 'LANG': 'en_US.UTF-8', 16:01:20 INFO - 'LANGUAGE': 'en_US:en', 16:01:20 INFO - 'LOGNAME': 'cltbld', 16:01:20 INFO - 'MAIL': '/var/mail/cltbld', 16:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:20 INFO - 'MOZ_NO_REMOTE': '1', 16:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:20 INFO - 'NO_EM_RESTART': '1', 16:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:20 INFO - 'PWD': '/builds/slave/test', 16:01:20 INFO - 'SHELL': '/bin/bash', 16:01:20 INFO - 'SHLVL': '1', 16:01:20 INFO - 'TERM': 'linux', 16:01:20 INFO - 'TMOUT': '86400', 16:01:20 INFO - 'USER': 'cltbld', 16:01:20 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:20 INFO - '_': '/tools/buildbot/bin/python'} 16:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:21 INFO - Running setup.py (path:/tmp/pip-d0Drgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:21 INFO - Running setup.py (path:/tmp/pip-kK0vYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:21 INFO - Running setup.py (path:/tmp/pip-m3LrZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:21 INFO - Running setup.py (path:/tmp/pip-t37Kxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:21 INFO - Running setup.py (path:/tmp/pip-GUTUSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:21 INFO - Running setup.py (path:/tmp/pip-5LR2EU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:21 INFO - Running setup.py (path:/tmp/pip-O9u7to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:21 INFO - Running setup.py (path:/tmp/pip-b9gPdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:21 INFO - Running setup.py (path:/tmp/pip-0qJZ02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:21 INFO - Running setup.py (path:/tmp/pip-_t88Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:21 INFO - Running setup.py (path:/tmp/pip-4agLui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:21 INFO - Running setup.py (path:/tmp/pip-kXWOcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:21 INFO - Running setup.py (path:/tmp/pip-CKFt1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:21 INFO - Running setup.py (path:/tmp/pip-AfevgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:22 INFO - Running setup.py (path:/tmp/pip-fhhXVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:22 INFO - Running setup.py (path:/tmp/pip-d_WdoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:22 INFO - Running setup.py (path:/tmp/pip-fDIZy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:01:22 INFO - Running setup.py install for manifestparser 16:01:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:01:22 INFO - Running setup.py install for mozcrash 16:01:22 INFO - Running setup.py install for mozdebug 16:01:22 INFO - Running setup.py install for mozdevice 16:01:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:01:22 INFO - Running setup.py install for mozfile 16:01:22 INFO - Running setup.py install for mozhttpd 16:01:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:01:22 INFO - Running setup.py install for mozinfo 16:01:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:01:22 INFO - Running setup.py install for mozInstall 16:01:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:01:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:01:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:01:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:01:23 INFO - Running setup.py install for mozleak 16:01:23 INFO - Running setup.py install for mozlog 16:01:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:01:23 INFO - Running setup.py install for moznetwork 16:01:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:01:23 INFO - Running setup.py install for mozprocess 16:01:23 INFO - Running setup.py install for mozprofile 16:01:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:01:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:01:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:01:23 INFO - Running setup.py install for mozrunner 16:01:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:01:23 INFO - Running setup.py install for mozscreenshot 16:01:23 INFO - Running setup.py install for moztest 16:01:23 INFO - Running setup.py install for mozversion 16:01:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:01:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:01:24 INFO - Cleaning up... 16:01:24 INFO - Return code: 0 16:01:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:24 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 0x232a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2696a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a090>, '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 0x269ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2694f90>, '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': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:01:24 INFO - Using env: {'DISPLAY': ':0', 16:01:24 INFO - 'HOME': '/home/cltbld', 16:01:24 INFO - 'LANG': 'en_US.UTF-8', 16:01:24 INFO - 'LANGUAGE': 'en_US:en', 16:01:24 INFO - 'LOGNAME': 'cltbld', 16:01:24 INFO - 'MAIL': '/var/mail/cltbld', 16:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:24 INFO - 'MOZ_NO_REMOTE': '1', 16:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:24 INFO - 'NO_EM_RESTART': '1', 16:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:24 INFO - 'PWD': '/builds/slave/test', 16:01:24 INFO - 'SHELL': '/bin/bash', 16:01:24 INFO - 'SHLVL': '1', 16:01:24 INFO - 'TERM': 'linux', 16:01:24 INFO - 'TMOUT': '86400', 16:01:24 INFO - 'USER': 'cltbld', 16:01:24 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:24 INFO - '_': '/tools/buildbot/bin/python'} 16:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:24 INFO - Running setup.py (path:/tmp/pip-LQ515R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:24 INFO - Running setup.py (path:/tmp/pip-CbEVJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:24 INFO - Running setup.py (path:/tmp/pip-BTNUge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:24 INFO - Running setup.py (path:/tmp/pip-3BD7KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:24 INFO - Running setup.py (path:/tmp/pip-IL3OPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:24 INFO - Running setup.py (path:/tmp/pip-7He_kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:24 INFO - Running setup.py (path:/tmp/pip-LEjzjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:24 INFO - Running setup.py (path:/tmp/pip-B5JPfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:24 INFO - Running setup.py (path:/tmp/pip-w9Jal5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:24 INFO - Running setup.py (path:/tmp/pip-eZMrW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:24 INFO - Running setup.py (path:/tmp/pip-rQKakd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:25 INFO - Running setup.py (path:/tmp/pip-a8RWo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:25 INFO - Running setup.py (path:/tmp/pip-ogQpAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:25 INFO - Running setup.py (path:/tmp/pip-olrBTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:25 INFO - Running setup.py (path:/tmp/pip-I5L2B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:25 INFO - Running setup.py (path:/tmp/pip-NN9gYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:25 INFO - Running setup.py (path:/tmp/pip-4wiheA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:01:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:26 INFO - Downloading blessings-1.6.tar.gz 16:01:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:01:26 INFO - Installing collected packages: blessings 16:01:26 INFO - Running setup.py install for blessings 16:01:26 INFO - Successfully installed blessings 16:01:26 INFO - Cleaning up... 16:01:26 INFO - Return code: 0 16:01:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:01:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:27 INFO - Reading from file tmpfile_stdout 16:01:27 INFO - Current package versions: 16:01:27 INFO - argparse == 1.2.1 16:01:27 INFO - blessings == 1.6 16:01:27 INFO - blobuploader == 1.2.4 16:01:27 INFO - docopt == 0.6.1 16:01:27 INFO - functools32 == 3.2.3-2 16:01:27 INFO - jsonschema == 2.5.1 16:01:27 INFO - manifestparser == 1.1 16:01:27 INFO - mozInstall == 1.13 16:01:27 INFO - mozcrash == 1.0 16:01:27 INFO - mozdebug == 0.1 16:01:27 INFO - mozdevice == 0.51 16:01:27 INFO - mozfile == 1.2 16:01:27 INFO - mozhttpd == 0.7 16:01:27 INFO - mozinfo == 0.10 16:01:27 INFO - mozleak == 0.1 16:01:27 INFO - mozlog == 3.5 16:01:27 INFO - moznetwork == 0.27 16:01:27 INFO - mozprocess == 0.25 16:01:27 INFO - mozprofile == 0.28 16:01:27 INFO - mozrunner == 6.13 16:01:27 INFO - mozscreenshot == 0.1 16:01:27 INFO - mozsystemmonitor == 0.3 16:01:27 INFO - moztest == 0.8 16:01:27 INFO - mozversion == 1.4 16:01:27 INFO - psutil == 3.1.1 16:01:27 INFO - requests == 1.2.3 16:01:27 INFO - wsgiref == 0.1.2 16:01:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:27 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 0x232a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2696a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a090>, '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 0x269ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2694f90>, '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': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:01:27 INFO - Using env: {'DISPLAY': ':0', 16:01:27 INFO - 'HOME': '/home/cltbld', 16:01:27 INFO - 'LANG': 'en_US.UTF-8', 16:01:27 INFO - 'LANGUAGE': 'en_US:en', 16:01:27 INFO - 'LOGNAME': 'cltbld', 16:01:27 INFO - 'MAIL': '/var/mail/cltbld', 16:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:27 INFO - 'MOZ_NO_REMOTE': '1', 16:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:27 INFO - 'NO_EM_RESTART': '1', 16:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:27 INFO - 'PWD': '/builds/slave/test', 16:01:27 INFO - 'SHELL': '/bin/bash', 16:01:27 INFO - 'SHLVL': '1', 16:01:27 INFO - 'TERM': 'linux', 16:01:27 INFO - 'TMOUT': '86400', 16:01:27 INFO - 'USER': 'cltbld', 16:01:27 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:27 INFO - '_': '/tools/buildbot/bin/python'} 16:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:01:27 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:01:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:01:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:01:28 INFO - Installing collected packages: simplejson 16:01:28 INFO - Running setup.py install for simplejson 16:01:28 INFO - building 'simplejson._speedups' extension 16:01:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 16:01:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 16:01:29 INFO - Successfully installed simplejson 16:01:29 INFO - Cleaning up... 16:01:29 INFO - Return code: 0 16:01:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:29 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 0x232a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2696a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a090>, '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 0x269ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2694f90>, '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': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:01:29 INFO - Using env: {'DISPLAY': ':0', 16:01:29 INFO - 'HOME': '/home/cltbld', 16:01:29 INFO - 'LANG': 'en_US.UTF-8', 16:01:29 INFO - 'LANGUAGE': 'en_US:en', 16:01:29 INFO - 'LOGNAME': 'cltbld', 16:01:29 INFO - 'MAIL': '/var/mail/cltbld', 16:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:29 INFO - 'MOZ_NO_REMOTE': '1', 16:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:29 INFO - 'NO_EM_RESTART': '1', 16:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:29 INFO - 'PWD': '/builds/slave/test', 16:01:29 INFO - 'SHELL': '/bin/bash', 16:01:29 INFO - 'SHLVL': '1', 16:01:29 INFO - 'TERM': 'linux', 16:01:29 INFO - 'TMOUT': '86400', 16:01:29 INFO - 'USER': 'cltbld', 16:01:29 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:29 INFO - '_': '/tools/buildbot/bin/python'} 16:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:01:29 INFO - Cleaning up... 16:01:29 INFO - Return code: 0 16:01:29 INFO - Running post-action listener: _resource_record_post_action 16:01:29 INFO - Running post-action listener: _start_resource_monitoring 16:01:29 INFO - Starting resource monitoring. 16:01:29 INFO - [mozharness: 2017-09-11 23:01:29.763245Z] Finished create-virtualenv step (success) 16:01:29 INFO - [mozharness: 2017-09-11 23:01:29.764259Z] Running install step. 16:01:29 INFO - Running pre-action listener: _resource_record_pre_action 16:01:29 INFO - Running main action method: install 16:01:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:29 INFO - Reading from file tmpfile_stdout 16:01:29 INFO - Detecting whether we're running mozinstall >=1.0... 16:01:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:01:30 INFO - Reading from file tmpfile_stdout 16:01:30 INFO - Output received: 16:01:30 INFO - Usage: mozinstall [options] installer 16:01:30 INFO - Options: 16:01:30 INFO - -h, --help show this help message and exit 16:01:30 INFO - -d DEST, --destination=DEST 16:01:30 INFO - Directory to install application into. [default: 16:01:30 INFO - "/builds/slave/test"] 16:01:30 INFO - --app=APP Application being installed. [default: firefox] 16:01:30 INFO - mkdir: /builds/slave/test/build/application 16:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:01:46 INFO - Reading from file tmpfile_stdout 16:01:46 INFO - Output received: 16:01:46 INFO - /builds/slave/test/build/application/firefox/firefox 16:01:46 INFO - Running post-action listener: _resource_record_post_action 16:01:46 INFO - [mozharness: 2017-09-11 23:01:46.517312Z] Finished install step (success) 16:01:46 INFO - [mozharness: 2017-09-11 23:01:46.517630Z] Running setup-mitmproxy step. 16:01:46 INFO - Running pre-action listener: _resource_record_pre_action 16:01:46 INFO - Running main action method: setup_mitmproxy 16:01:46 INFO - Skipping: mitmproxy is not required 16:01:46 INFO - Running post-action listener: _resource_record_post_action 16:01:46 INFO - [mozharness: 2017-09-11 23:01:46.518753Z] Finished setup-mitmproxy step (success) 16:01:46 INFO - [mozharness: 2017-09-11 23:01:46.518971Z] Running run-tests step. 16:01:46 INFO - Running pre-action listener: _resource_record_pre_action 16:01:46 INFO - Running pre-action listener: _set_gcov_prefix 16:01:46 INFO - Running main action method: run_tests 16:01:46 WARNING - Try message not found. 16:01:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:01:46 INFO - Python 2.7.3 16:01:46 INFO - Return code: 0 16:01:46 INFO - grabbing minidump binary from tooltool 16:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:46 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 0x269a090>, '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 0x269ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2694f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:01:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:01:46 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:01:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:01:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:01:46 INFO - Return code: 0 16:01:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:01:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:01:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:01:46 INFO - ENV: RUST_BACKTRACE is now full 16:01:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:01:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:01:46 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/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:01:46 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/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:01:46 INFO - Using env: {'DISPLAY': ':0', 16:01:46 INFO - 'HOME': '/home/cltbld', 16:01:46 INFO - 'LANG': 'en_US.UTF-8', 16:01:46 INFO - 'LANGUAGE': 'en_US:en', 16:01:46 INFO - 'LOGNAME': 'cltbld', 16:01:46 INFO - 'MAIL': '/var/mail/cltbld', 16:01:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:01:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:46 INFO - 'MOZ_NO_REMOTE': '1', 16:01:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:46 INFO - 'NO_EM_RESTART': '1', 16:01:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:46 INFO - 'PWD': '/builds/slave/test', 16:01:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:01:46 INFO - 'RUST_BACKTRACE': 'full', 16:01:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:01:46 INFO - 'SHELL': '/bin/bash', 16:01:46 INFO - 'SHLVL': '1', 16:01:46 INFO - 'TERM': 'linux', 16:01:46 INFO - 'TMOUT': '86400', 16:01:46 INFO - 'USER': 'cltbld', 16:01:46 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:46 INFO - '_': '/tools/buildbot/bin/python'} 16:01:46 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/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:01:46 INFO - mozversion application_buildid: 20170911214158 16:01:46 INFO - mozversion application_changeset: 85157b4b361ab9fdf7b3c3d7cf129bd3d422feac 16:01:46 INFO - mozversion application_display_name: Nightly 16:01:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:01:46 INFO - mozversion application_name: Firefox 16:01:46 INFO - mozversion application_remotingname: firefox 16:01:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:01:46 INFO - mozversion application_vendor: Mozilla 16:01:46 INFO - mozversion application_version: 57.0a1 16:01:46 INFO - mozversion platform_buildid: 20170911214158 16:01:46 INFO - mozversion platform_changeset: 85157b4b361ab9fdf7b3c3d7cf129bd3d422feac 16:01:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:01:46 INFO - mozversion platform_version: 57.0a1 16:01:46 INFO - using testdate: 1505170906 16:01:46 INFO - actual date: 1505170906 16:01:46 INFO - starting webserver on 'localhost:60224' 16:01:46 INFO - SUITE-START | Running 2 tests 16:01:46 INFO - TEST-START | dromaeo_css 16:01:46 INFO - Initialising browser for dromaeo_css test... 16:01:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60224/getInfo.html -profile /tmp/tmpPQuP6Y/profile 16:01:46 INFO - TEST-INFO | started process 3507 (/builds/slave/test/build/application/firefox/firefox http://localhost:60224/getInfo.html) 16:01:55 INFO - TEST-INFO | 3507: exit 0 16:01:55 INFO - Browser initialized. 16:01:55 INFO - Running cycle 1/1 for dromaeo_css test... 16:01:55 INFO - Using env: {'DISPLAY': ':0', 16:01:55 INFO - 'HOME': '/home/cltbld', 16:01:55 INFO - 'JSGC_DISABLE_POISONING': '1', 16:01:55 INFO - 'LANG': 'en_US.UTF-8', 16:01:55 INFO - 'LANGUAGE': 'en_US:en', 16:01:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:01:55 INFO - 'LOGNAME': 'cltbld', 16:01:55 INFO - 'MAIL': '/var/mail/cltbld', 16:01:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:01:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:01:55 INFO - 'MOZ_CRASHREPORTER': '1', 16:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:01:55 INFO - 'MOZ_NO_REMOTE': '1', 16:01:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:55 INFO - 'NO_EM_RESTART': '1', 16:01:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:55 INFO - 'PWD': '/builds/slave/test', 16:01:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:01:55 INFO - 'RUST_BACKTRACE': 'full', 16:01:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:01:55 INFO - 'SHELL': '/bin/bash', 16:01:55 INFO - 'SHLVL': '1', 16:01:55 INFO - 'TERM': 'linux', 16:01:55 INFO - 'TMOUT': '86400', 16:01:55 INFO - 'USER': 'cltbld', 16:01:55 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:55 INFO - '_': '/tools/buildbot/bin/python'} 16:01:55 INFO - TEST-INFO | started process 3708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPQuP6Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:01:56 INFO - PID 3708 | 16:01:56 INFO - PID 3708 | (/builds/slave/test/build/application/firefox/firefox:3759): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:01:56 INFO - PID 3708 | 16:02:06 INFO - PID 3708 | RSS: Main: 164020224 16:02:06 INFO - PID 3708 | 16:05:04 INFO - PID 3708 | Cycle 1(1): loaded http://localhost:60224/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60224/tests/dromaeo/cssquery-ext.html) 16:05:05 INFO - PID 3708 | RSS: Main: 167268352 16:05:05 INFO - PID 3708 | 16:08:07 INFO - PID 3708 | Cycle 1(1): loaded http://localhost:60224/tests/dromaeo/cssquery-ext.html (next: http://localhost:60224/tests/dromaeo/cssquery-jquery.html) 16:08:07 INFO - PID 3708 | RSS: Main: 163262464 16:08:07 INFO - PID 3708 | 16:11:09 INFO - PID 3708 | Cycle 1(1): loaded http://localhost:60224/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60224/tests/dromaeo/cssquery-mootools.html) 16:11:10 INFO - PID 3708 | RSS: Main: 166088704 16:11:10 INFO - PID 3708 | 16:14:11 INFO - PID 3708 | Cycle 1(1): loaded http://localhost:60224/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60224/tests/dromaeo/cssquery-prototype.html) 16:14:12 INFO - PID 3708 | RSS: Main: 164061184 16:14:12 INFO - PID 3708 | 16:17:15 INFO - PID 3708 | Cycle 1(1): loaded http://localhost:60224/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60224/tests/dromaeo/cssquery-yui.html) 16:17:16 INFO - PID 3708 | RSS: Main: 165728256 16:17:16 INFO - PID 3708 | 16:20:17 INFO - PID 3708 | Cycle 1(1): loaded http://localhost:60224/tests/dromaeo/cssquery-yui.html (next: http://localhost:60224/tests/dromaeo/cssquery-dojo.html) 16:20:17 INFO - PID 3708 | RSS: Main: 168898560 16:20:17 INFO - PID 3708 | 16:20:17 INFO - PID 3708 | __start_tp_report 16:20:17 INFO - PID 3708 | _x_x_mozilla_page_load 16:20:17 INFO - PID 3708 | _x_x_mozilla_page_load_details 16:20:17 INFO - PID 3708 | |i|pagename|runs| 16:20:17 INFO - PID 3708 | |0;dojo.html;3901.980490097549;3918.2555314490246;3919.647231749142;3929.4695216145847;3947.6644485218753;6228.314885362606;6306.117143599889;6404.327545607708;6411.775587854426;6458.838529036776;6363.777267795628;6423.454006409461;6475.287718350989;6479.384458476449;6505.154329937113;5730.36965933747;5739.339975902762;5749.338826034997;5787.681677507735;5798.594098413102;5534.418886016971;5623.606347555673;5779.133130030508;5854.73653685583;5857.355690874;5634.549236061105;5736.311642602873;5771.50942169916;5792.507636850873;5808.128780682931;5732.455416735404;5732.856678583027;5775.913361299584;5793.304803423616;5802.767889284423;5669.291338582677;5704.315482142128;5741.33974592923;5753.050746626802;5779.3642699303045;6324.272708638519;6407.038944158367;6419;6440.420362167428;6467;6925.203601585781;6939.23668396476;6987.510874238806;7003.159620845531;7011.158660960667;6883.208431030395;6984.02223688684;6988.056612357317;6998.125234345707;7000.439964802855;6464.547481676284;6485.156929599122;6498.285188629295;6524.93475065248;6531.085648009187;7072;7170.067891174114;7250.927490725131;7272.672729727175;7289.70841166358;6746.966265168741;6916.3429474199875;6921.584704917721;6976.197737260179;7025.227225005246;6927.3419025192525;6973.721051157999;6997.4052205562075;7021.473389495808;7032.859342813115;6845.760398386033;6960.37356637905;6984.511084224056;7005.229424763272;7023.789286321418;6851.897221541681;6942.965285173542;6951.096357473496;7023.508354415244;7041.683124259421;5061.291419201315;5076.18780995039;5084.720340381241;5093.2105523643895;5097.770600322994;4596;4608.9308660370125;4616.838410655611;4626.583607475276;4648.721076735406;6265.561410701298;6352.174217351715;6406.4554512866;6449.097126402307;6449.580777249464;6910.2744211858035;6916.688749006206;6991.475639327071;6995.650217489105;7008.614526201006;6248.625082495065;6309.716062777186;6329.2721337045905;6359.427651511386;6364.109024736541;5587.413321601254;5610.382857885629;5618.6628802272;5618.91571626426;5642.689652069175;7150.249223831527;7177.03110080143;7183.60490173035;7264.23725508814;7281.417486601059;6945.305469453015;6946.409555187865;7012.614306213207;7033.015377847208;7039;7053.964730176522;7152.177499587406;7160.534565253451;7173.569585824867;7228.096487939008;6866.279040700654;6941.722331106699;6943.166819981635;6950.131233595801;6953.061336719478;6966.9651651741415;6969.756058537927;7040.542364746275;7046.612436315847;7052.858942821217;6683.198016238082;6691.899621505779;6697.430718388797;6782.220044694726;6794;6634.369734875179;6690.799276021728;6691.799246022627;6699.899501507384;6704.363085506869;6554.8361290968105;6612.437942774918;6617.933820661732;6627.072209890523;6637.70130344126;6656.800295991128;6736.528443008942;6759;6781.932180678327;6860.451163906776;6594.934050659432;6601;6668.799936001734;6693.230278518033;6699.464042876656 16:20:17 INFO - PID 3708 | |1;ext.html;942.9434233945959;967.8016006718622;994.4530508220486;994.8109859126765;995.9103680668738;42738;43314.783426082904;43723.56276437235;43760;43784.781076094616;42628.78685606575;43498.782506087424;43556.56443435565;43633.7818310908;43801.342979855326;6826.010228516862;6828;6828.726850925957;6828.897566536506;6856.314368563154;7689.307962283393;7747.186545412735;7747.535147891116;7749.34130598897;7754.651040703182;7720.7297744578955;7736.419768517356;7741.5355078695175;7780.6887724491235;7783.727569535067;7671.117821450549;7707.190744971781;7707.922920770777;7710.7686769397005;7711.113221979432;8068.596570171468;8111.634976426016;8115.75652730419;8121.228483294078;8130.837383252361;38455.230895382214;39844;39938;39962.80018599918;40195.39706904399;3691.1325838427947;3729.384651532494;3729.4592284118653;3731.8693845715543;3732.850685972558;31450.37099258002;31621.683783162105;31644.208894777585;31658.208544786336;31785.364292714017;5523.889522209573;5546.084895992197;5546.667199968015;5549.38956714761;5623.240862483553;204611;208818;216716;222204;224530;50252;50757.746211268706;51040.74479627652;51064;51109.23336149961;53369.733151333996;53415.73292133592;53471.465285347425;53500.73249633727;53820.73089634605;16509.09199994012;16639.33442662304;16640.83359166393;16666.749998750027;16896.239669214916;13987.160770353812;13990.86009139916;13995.440182392591;13999.090059146327;14003.229822359868;13709.520166794115;13792.586222413343;13806.723865522634;13816.101953372998;13930.721385572231;5347.117725575315;5387.060658163058;5411.188321751769;5422.3764267109;5426.918596220981;1100.8954149355798;1108.5344155454568;1112.193659596786;1121.43928035982;1131.1742428027585;25716.742832571435;25849;25961.221163365128;26025.349366265615;26049;1206.149664486535;1209.8911098001222;1214.6173955204083;1233.6545767185203;1247.8253044573767;13734;13855.16868987864;13943.372548235353;14045.85954140466;14073.507427239998;274164;276784;276897;277096;277648;56463.15305270424;56537.71731141318;56568.71715641396;56712;56796;1473.8968272221057;1476.217604669527;1499.5501349595295;1514.2655811931425;1534.0105631867384;25374.365640859127;25532.872335638203;25590.36024099338;25699.614505782803;25844.224673259832;40140.79929600333;40165.59834401735;40283.59716402798;40289.59710402859;40344.1931161381;230658;230732;230744;230976;231264;35761.28477430489;35884;38334.424983625824;39137.80431097826;39139;47823.28265075957;49444;49639.00721985468;49691;49826.25260621021;36051.819740901126;36526.26947461089;36554;36723.63276367309;36747;35426.46860297046;35769.82115089408;35817.82091089528;35885.820570898024;36348;40794;41445.79277103595;42134.578654213066;42400.36399454073;42417.36373954455;34613.48079778856;34863.65136348604;34986.47520287248;35114.648853511135;35640.28719425649;26298.73701262963;26385.34036649022;26671;26957.191284261502;27202.455950880474 16:20:17 INFO - PID 3708 | |2;jquery.html;566.76195997681;592.9436703513168;614.5974386776658;616.5961295351545;632.0961025733201;23453.882730586367;24207.636885446733;24211.03155873765;24237.878810605966;24249.39376515588;24187;25840.22479325623;26166.869165654192;26179.345516362053;26200;6492.448141907944;6493.8376540586505;6531.052997315386;6531.118299029617;6534.836629084287;6276.529260305495;6452.128962590061;6720.126383570129;6730.226024007253;6739.123913891187;6651.501137414689;6658.234303055138;6682.4319932805765;6687.398134167924;6687.83280417991;6677.198736151644;6679.93320066798;6689.866202675919;6695.096162018114;6702.7654032108885;5944.197533332988;6167.7532898684;6198.194234749454;6198.907016394758;6247.875042499125;29816.70183298161;29905.700942990727;29984.400311993857;30204;30226.395472090437;2247.71903512061;2263.0608297556496;2276.430892276931;2278.3734473019886;2278.703768510083;19834.702479462674;20248.898755506274;20612.175512979462;20850.58298834015;20967;2425;2441.5116976604572;2497.8751062446986;2520.4455019895595;2522.672052633146;128434.3578282112;133980.33009834887;143337;146458;147836.2608186963;15383.846161538466;15648.009757511762;16067;16170.919145404432;16196.433124840574;25587;25622.231333060037;25632.102876399236;25640.358991025;25661.61507577388;10288.742781430525;10447.111995480469;10500.632477863239;10509.159267258601;10758.40828754426;9506.239500839916;9545.809083818285;9626.278029147841;9715;9734.269929755297;9387.953060234791;9440.48077355752;9618.807623847484;9860.753481162885;9876.308658393988;2790.4558611070647;2894.1462268630803;2914.417116576693;2971.4799910015663;2981.8658160382834;1037.7353774787382;1038.4755698372273;1051.365127227169;1060.1201003167353;1063.0273299930632;20662.17351305961;20793;20811.8959405202;21281.36155915325;21392.465188370414;1113.2151832957745;1122.4163435013747;1126.4592995362273;1131.7453572946022;1136.664683918246;10974.396408197626;11302.547898083985;11322.660320190407;11491.023263022737;11597.186138534775;633791;635934;641269;649374;667607;126004.36997814952;126576;126715.36642316729;127228;128271;1215.1311812054423;1218.2142518075968;1237.127824883455;1249.044480972057;1254.956076537317;18358.81641183571;18664.720029199845;18702;19009.33467328637;19192.232310707415;57486;58183;58296.4170358291;59202.70398647979;60292.39707603044;75604.62197688976;75605.24394756202;75795.24204757882;75837;76093;14869.851301486846;15311;15351.769723453934;15373.231338433257;15398.46105386306;23165.07339706393;23746.525069498857;23867.283981480585;23925.521489569765;24128.396790079685;19145.04274786283;19269.903650482218;19296.71054934149;19678.704819427432;19703.11335989855;16288.511344659679;16720.916395417946;16824.747628785823;17006.829931700526;17236.569085772957;19330.71003934914;19462;19690.21239150418;19950.90024549926;19980.600387991868;14801.333939972512;15018.924905375403;15036.699266014399;15055;15065;18639.161237744604;18642.81357186465;19015.52461188426;19052.428427147206;19158.712619311 16:20:17 INFO - PID 3708 | |3;mootools.html;1399.7760358342664;1488.8957772955898;1494.6861159156576;1501.391936265812;1507.1183357735724;16642.75035874461;17342.046187459684;17388.56528586786;17398.913005434955;17399.130043497837;16882.324707011736;17044.488665340028;17085.487435376926;17090.31638734449;17111.57221069474;2849.586809912572;2865.928351791201;2869.0962346860674;2881.034853324139;2882.6540815102217;2850.2446851584345;2850.5011622966003;2865.957010644842;2876.654801423832;2889.855507224641;2787.790915681332;2822.77417806576;2837.645294338208;2898.116074597247;2898.724621160997;2864.4414339203863;2883.4377296427206;2889.696581858906;2892.4215156968585;2892.537194048963;2642.2733748219202;2677.42435376395;2678.08944958715;2716.2801857507775;2798.790090743182;16563.66872662552;16601.584960375967;16654.916725416417;16672.83327166725;16691.08199049052;8352.081271060179;8647.178518040777;8662.913370866338;8663.913360866374;8668;5585.8603534911545;5677.772889084432;5691.800786972436;5694.829155125353;5746.166805813175;1977.2684106880547;1981.2075169931998;1987.4633848860726;2039.2760569997586;2064.5148390128306;29984.8500757497;30202.848985754932;30249;30337.393252135054;30430.087097387113;7048.400885924651;7092.5389849659605;7141.607211603307;7235.710571577078;7265.564066156047;19932;19949.00254987245;20055.899720501304;20067;20068.799312006984;8559.101294364127;8763.56182190888;8766.60550275239;8769.429987050822;8781.912180878237;7683.884741728879;7715;7807.375409967189;7818.765437036898;7832.960835195901;5439;5657.349404818417;5682.7442765075675;5695.088785794253;5736.110902810071;1654.8510634042993;1657.2293883344303;1660.2943748906666;1684.0232665054239;1684.5956970327034;944.8582712593166;963.7761687156451;972.8103019911191;973.8003709239589;980.4166520920041;8515.872261916076;8520.233179013794;8567.914320856711;8573.528455934984;8597.441166324168;721.5490318550906;753.5817621220166;753.796474951771;754.4944886925773;757.8938948547208;5272.578193744491;5364.892702145935;5424.267723857229;5464.535514481234;5833.766649334064;24521.509569808502;24637.753622463544;24877.253682389557;25436.618450723254;25495.745042549337;23610.64584031241;24453.633195502083;25055.12307069244;25206.495870082497;25231.495370092496;12155.574554890536;12157.635270941886;12166.209196402206;12212.32832194238;12258.938705306595;9118.452892826186;9473;9569.234461243223;9637.951810240904;9671.70984870455;20736.377908662766;21067.8946605266;21086.683699744208;21234.575308493433;22016;21829.345119646438;21897.562048758617;22053;22119.225827095976;22398.77601223967;11852.229605075643;11869.109816763605;11964.401779911144;11968.820467693165;11981.400929953641;15365;15527.45653902108;15542.9222853885;15621;15667.059976401453;12709.87290127124;12820.551280705131;12893.355332233163;12939.158954667917;12967.157134786208;12318.50725970987;12693.238405695687;12802.295873727035;12869.09916305887;12956.676083097998;11077.778444430905;11302.886971130183;11320.660380188607;11336.546538138711;11338.829917551078;8530.360222983178;8556.10160933093;8693.261072808882;8700.825983480421;8738.825223495622;8009.399295052778;8243.670253189804;8258.752237432887;8280.71017514384;8314.210150035737 16:20:17 INFO - PID 3708 | |4;prototype.html;543.2964311216971;557.7573755416392;574.4887050525032;579.5218944370893;581.9796307129251;6225.813225603228;6236;6240.9999999999945;6243.313235544092;6266.749330026799;6091.14723938649;6120;6124.162751174641;6130.846728831771;6220.222472190976;5004.5746111580465;5043.84868453947;5077.213031980049;5084.4661310562415;5095.286659867622;4853.441854186761;4983.426905905831;5004.299398084271;5007.198848184291;5093.923591146117;4942.481039490855;4944.357233559632;4949.480304568023;4973.626977976666;4978.850634480971;4909.036385445815;4933.901321973576;4954.47977962316;4967.907060446696;4980.277859710358;4495.348174514677;4507.504174540798;4508.436445444319;4514.210013247669;4589.5639914208095;6153.876922461571;6197.938020619781;6206.844828879269;6249.406306400884;6279;5803.361630220672;5812.593118481708;5822.184894114827;5841.299044114691;5844.620099693507;6541.182352205974;6602.405783479462;6612.636305003223;6619.602823830585;6648.368405001517;4848.224284114524;5045.344105266292;5056.115179843513;5068.72122033288;5075.670081444731;6661.9000714989315;6773.06967514256;6827.283135270774;6830.248672646005;6843.281455447156;5154.14956532168;5164.302819119446;5167.379914410295;5170.1727723564045;5175.197844334134;5232.372115346183;5242.18746094356;5251.897101608705;5263.184206448007;5267.104592219255;5770.6249093808765;5780.942190578125;5817.346123101502;5859.560532960045;5861.589688721834;6650.600963942179;6658.234303055114;6676.432503237182;6678.532502724763;6704.9607310866895;1790.6866298397729;1817.4547635709498;1825.2151574822954;1829.9176537055864;1844.9169787359601;1219;1279.814426908093;1300.13540995239;1304.6086174147717;1316.0918965913488;6107.175531303306;6149.477294429934;6150.169727086786;6153.538484613672;6156.569040167145;6577.736890524421;6647.734090636321;6699.296573859772;6709.36261055199;6744.7976560703255;6071.571371451455;6111.572189946661;6119.143319935212;6136.969315153396;6156.384361563808;3501.28223714138;3506.859725610998;3515.6132825389186;3530.8234588270484;3586.444101164324;6897.965510172417;6904.171499420102;6905.689243984033;6932.861342773217;6949.965250173716;6833.453323734089;6883.311668833177;6900.758473453506;6907.792766217021;6937.618430986243;6859.691313890987;6869.622170780555;6899.206591241971;6904.758333458305;6909.7581584644295;6529.118568993125;6610.735570577315;6654.567453115532;6716.529842910949;6758;6666.533342665967;6676.632785196666;6683.966580167263;6716.29478904708;6769.796906092825;6833.658317084225;6910.239873613999;6928.722851086101;6956.513044086865;6974.33743794359;5104.770285337243;5141.611764823402;5147.124988751996;5148.7425628717665;5158.638895277295;6618.635975021228;6675.499337549606;6681.33186681328;6723.966380168068;6764.3573860483175;6430.389113034442;6482.740690372332;6485.44873685742;6487.351264873475;6501.284858665637;6323.841903952438;6424.599149582551;6427.742890284337;6443.903341449975;6508.349165083454;6234.781782637586;6306.859909174009;6331;6336;6431.260405053479;6492.285848556749;6497.173729427714;6540.803775886731;6548.410643042149;6574.704138313692;6319.210098737658;6339.429451349216;6360.141380913517;6379.712912918837;6392.3927226913365 16:20:17 INFO - PID 3708 | |5;yui.html;950.6150009246257;989.144390102561;993.2749093161991;993.8956409576995;1021.1473419694553;18519.907400462995;18971.810281897193;19046.809531904677;19240.903795481005;19307.903460482677;19115.617687646238;19341.129649165785;19350.806491935076;19941.50146246341;20122.798772012276;1037.3309215555944;1069.3263244156171;1069.3690722473777;1069.443889177631;1069.6684027951321;1048.9318194317384;1083.3662307550053;1096.4682129167347;1098.807708650983;1099.4282972854112;1163.6392718257325;1168.1414160591958;1168.3106966889534;1169.5731058163751;1170.9987960293954;1089.4008295437477;1126.0203622848094;1130.8642962844428;1146.9426528673575;1154.797910365687;815.7715839564872;815.8368326334756;816.302061737218;816.7427260412951;819.9877001844977;19591.11839967205;19591.608167836705;19600.607987840165;19674.70487942682;19678.80321196784;22770.54458910829;23357.766422335728;23454.06183752648;23497.530049398916;23506.294811155694;18117.728234076498;18537.629247414978;18676.43970680882;18697.34559290432;18836.905815470836;3997.760134391946;4011.0373510357595;4023.4568333274924;4024.5170579530645;4026.71812973092;158879;158890;160382;161120.19439902843;162428.18785906112;17352.826471735374;17830.286788528574;17933.7309940351;18131.909340453214;18284.725729114074;33787.324253514795;33971.49042764361;34190.829045855106;34257.31485370328;34461.31077378438;9792.510374481248;9801.656942006995;9819.06718861707;9838.852417213748;9850.802983940424;4311.676624253194;4336.913261734748;4447.599716025508;4456.153330867125;4547.226971414867;6044.546659000593;6165.198524191826;6167.136600875881;6189.752409903644;6215.627062376272;1111.8776934537195;1298.6363818130937;1336.3852627791325;1338.732253549294;1345.8048582955416;692.6640579319027;703.6868593475956;710.3074502360157;713.4149997002512;723.3995783499682;12245.448954797055;12448.937755311166;12765.361731913366;12853.485860565472;12959.740805183843;741.4957828676444;747.0475144191091;750.0699133074947;750.4521699159535;753.8944547763317;6132.448079672851;6232.56372053961;6263.749450021948;6336.144620476269;6354.23749150105;145189;145527.27236363752;147666;147948;155077.2246138762;132614;134265;134667;134998.3250083763;135092;113700.43149784363;113907.43046284716;114826;115522.42238788921;119946.40026799985;11700.47347869365;11774.470148843151;11823.645290641294;11973.521059157885;11993.40032998364;54614;55278;55615.165772512635;56340.154897677385;57377.713111434176;71781.28218717746;72256;72690;74099;74473;17097.658046839242;17117.914410427868;17664.470065898044;17666.734998975284;17772.289108435518;18301.450956471326;18702.251909923452;18932.905335473235;18942.621147576694;18957.241710331982;17293.308267669152;17296.22167002513;17314.480565582548;17409.47771566855;17534.386296479563;16251.918740406223;16466.506004819876;16540.33838646489;16605;16610.50168494947;17675.646487070444;17905.641887162445;17923.193456294757;17989;18057.18742656557;12951.481940722266;13097.672558186121;13113.541026064042;13200.735985280433;13206.537771177962;12058.15592908488;12168.391580421121;12473.376331183586;12506.43721032574;12570.371481426075 16:20:17 INFO - PID 3708 | __end_tp_report 16:20:17 INFO - PID 3708 | __start_cc_report 16:20:17 INFO - PID 3708 | _x_x_mozilla_cycle_collect,342 16:20:17 INFO - PID 3708 | __end_cc_report 16:20:17 INFO - PID 3708 | __startTimestamp1505172017793__endTimestamp 16:20:17 INFO - PID 3708 | 16:20:17 INFO - PID 3708 | ------- Summary: start ------- 16:20:17 INFO - PID 3708 | Number of tests: 6 16:20:17 INFO - PID 3708 | 16:20:17 INFO - PID 3708 | [#0] dojo.html Cycles:165 Average:6397.04 Median:6637.70 stddev:770.03 (11.6%) stddev-sans-first:747.10 16:20:17 INFO - PID 3708 | Values: 3902.0 3918.3 3919.6 3929.5 3947.7 6228.3 6306.1 6404.3 6411.8 6458.8 6363.8 6423.5 6475.3 6479.4 6505.2 5730.4 5739.3 5749.3 5787.7 5798.6 5534.4 5623.6 5779.1 5854.7 5857.4 5634.5 5736.3 5771.5 5792.5 5808.1 5732.5 5732.9 5775.9 5793.3 5802.8 5669.3 5704.3 5741.3 5753.1 5779.4 6324.3 6407.0 6419.0 6440.4 6467.0 6925.2 6939.2 6987.5 7003.2 7011.2 6883.2 6984.0 6988.1 6998.1 7000.4 6464.5 6485.2 6498.3 6524.9 6531.1 7072.0 7170.1 7250.9 7272.7 7289.7 6747.0 6916.3 6921.6 6976.2 7025.2 6927.3 6973.7 6997.4 7021.5 7032.9 6845.8 6960.4 6984.5 7005.2 7023.8 6851.9 6943.0 6951.1 7023.5 7041.7 5061.3 5076.2 5084.7 5093.2 5097.8 4596.0 4608.9 4616.8 4626.6 4648.7 6265.6 6352.2 6406.5 6449.1 6449.6 6910.3 6916.7 6991.5 6995.7 7008.6 6248.6 6309.7 6329.3 6359.4 6364.1 5587.4 5610.4 5618.7 5618.9 5642.7 7150.2 7177.0 7183.6 7264.2 7281.4 6945.3 6946.4 7012.6 7033.0 7039.0 7054.0 7152.2 7160.5 7173.6 7228.1 6866.3 6941.7 6943.2 6950.1 6953.1 6967.0 6969.8 7040.5 7046.6 7052.9 6683.2 6691.9 6697.4 6782.2 6794.0 6634.4 6690.8 6691.8 6699.9 6704.4 6554.8 6612.4 6617.9 6627.1 6637.7 6656.8 6736.5 6759.0 6781.9 6860.5 6594.9 6601.0 6668.8 6693.2 6699.5 16:20:17 INFO - PID 3708 | 16:20:17 INFO - PID 3708 | [#1] ext.html Cycles:180 Average:42017.94 Median:3732.36 stddev:62979.30 (1687.4%) stddev-sans-first:63080.46 16:20:17 INFO - PID 3708 | Values: 942.9 967.8 994.5 994.8 995.9 42738.0 43314.8 43723.6 43760.0 43784.8 42628.8 43498.8 43556.6 43633.8 43801.3 6826.0 6828.0 6828.7 6828.9 6856.3 7689.3 7747.2 7747.5 7749.3 7754.7 7720.7 7736.4 7741.5 7780.7 7783.7 7671.1 7707.2 7707.9 7710.8 7711.1 8068.6 8111.6 8115.8 8121.2 8130.8 38455.2 39844.0 39938.0 39962.8 40195.4 3691.1 3729.4 3729.5 3731.9 3732.9 31450.4 31621.7 31644.2 31658.2 31785.4 5523.9 5546.1 5546.7 5549.4 5623.2 204611.0 208818.0 216716.0 222204.0 224530.0 50252.0 50757.7 51040.7 51064.0 51109.2 53369.7 53415.7 53471.5 53500.7 53820.7 16509.1 16639.3 16640.8 16666.7 16896.2 13987.2 13990.9 13995.4 13999.1 14003.2 13709.5 13792.6 13806.7 13816.1 13930.7 5347.1 5387.1 5411.2 5422.4 5426.9 1100.9 1108.5 1112.2 1121.4 1131.2 25716.7 25849.0 25961.2 26025.3 26049.0 1206.1 1209.9 1214.6 1233.7 1247.8 13734.0 13855.2 13943.4 14045.9 14073.5 274164.0 276784.0 276897.0 277096.0 277648.0 56463.2 56537.7 56568.7 56712.0 56796.0 1473.9 1476.2 1499.6 1514.3 1534.0 25374.4 25532.9 25590.4 25699.6 25844.2 40140.8 40165.6 40283.6 40289.6 40344.2 230658.0 230732.0 230744.0 230976.0 231264.0 35761.3 35884.0 38334.4 39137.8 39139.0 47823.3 49444.0 49639.0 49691.0 49826.3 36051.8 36526.3 36554.0 36723.6 36747.0 35426.5 35769.8 35817.8 35885.8 36348.0 40794.0 41445.8 42134.6 42400.4 42417.4 34613.5 34863.7 34986.5 35114.6 35640.3 26298.7 26385.3 26671.0 26957.2 27202.5 16:20:17 INFO - PID 3708 | 16:20:17 INFO - PID 3708 | [#2] jquery.html Cycles:180 Average:40080.21 Median:23309.48 stddev:107203.59 (459.9%) stddev-sans-first:107463.27 16:20:17 INFO - PID 3708 | Values: 566.8 592.9 614.6 616.6 632.1 23453.9 24207.6 24211.0 24237.9 24249.4 24187.0 25840.2 26166.9 26179.3 26200.0 6492.4 6493.8 6531.1 6531.1 6534.8 6276.5 6452.1 6720.1 6730.2 6739.1 6651.5 6658.2 6682.4 6687.4 6687.8 6677.2 6679.9 6689.9 6695.1 6702.8 5944.2 6167.8 6198.2 6198.9 6247.9 29816.7 29905.7 29984.4 30204.0 30226.4 2247.7 2263.1 2276.4 2278.4 2278.7 19834.7 20248.9 20612.2 20850.6 20967.0 2425.0 2441.5 2497.9 2520.4 2522.7 128434.4 133980.3 143337.0 146458.0 147836.3 15383.8 15648.0 16067.0 16170.9 16196.4 25587.0 25622.2 25632.1 25640.4 25661.6 10288.7 10447.1 10500.6 10509.2 10758.4 9506.2 9545.8 9626.3 9715.0 9734.3 9388.0 9440.5 9618.8 9860.8 9876.3 2790.5 2894.1 2914.4 2971.5 2981.9 1037.7 1038.5 1051.4 1060.1 1063.0 20662.2 20793.0 20811.9 21281.4 21392.5 1113.2 1122.4 1126.5 1131.7 1136.7 10974.4 11302.5 11322.7 11491.0 11597.2 633791.0 635934.0 641269.0 649374.0 667607.0 126004.4 126576.0 126715.4 127228.0 128271.0 1215.1 1218.2 1237.1 1249.0 1255.0 18358.8 18664.7 18702.0 19009.3 19192.2 57486.0 58183.0 58296.4 59202.7 60292.4 75604.6 75605.2 75795.2 75837.0 76093.0 14869.9 15311.0 15351.8 15373.2 15398.5 23165.1 23746.5 23867.3 23925.5 24128.4 19145.0 19269.9 19296.7 19678.7 19703.1 16288.5 16720.9 16824.7 17006.8 17236.6 19330.7 19462.0 19690.2 19950.9 19980.6 14801.3 15018.9 15036.7 15055.0 15065.0 18639.2 18642.8 19015.5 19052.4 19158.7 16:20:17 INFO - PID 3708 | 16:20:17 INFO - PID 3708 | [#3] mootools.html Cycles:180 Average:10436.14 Median:2810.78 stddev:7716.12 (274.5%) stddev-sans-first:7707.90 16:20:17 INFO - PID 3708 | Values: 1399.8 1488.9 1494.7 1501.4 1507.1 16642.8 17342.0 17388.6 17398.9 17399.1 16882.3 17044.5 17085.5 17090.3 17111.6 2849.6 2865.9 2869.1 2881.0 2882.7 2850.2 2850.5 2866.0 2876.7 2889.9 2787.8 2822.8 2837.6 2898.1 2898.7 2864.4 2883.4 2889.7 2892.4 2892.5 2642.3 2677.4 2678.1 2716.3 2798.8 16563.7 16601.6 16654.9 16672.8 16691.1 8352.1 8647.2 8662.9 8663.9 8668.0 5585.9 5677.8 5691.8 5694.8 5746.2 1977.3 1981.2 1987.5 2039.3 2064.5 29984.9 30202.8 30249.0 30337.4 30430.1 7048.4 7092.5 7141.6 7235.7 7265.6 19932.0 19949.0 20055.9 20067.0 20068.8 8559.1 8763.6 8766.6 8769.4 8781.9 7683.9 7715.0 7807.4 7818.8 7833.0 5439.0 5657.3 5682.7 5695.1 5736.1 1654.9 1657.2 1660.3 1684.0 1684.6 944.9 963.8 972.8 973.8 980.4 8515.9 8520.2 8567.9 8573.5 8597.4 721.5 753.6 753.8 754.5 757.9 5272.6 5364.9 5424.3 5464.5 5833.8 24521.5 24637.8 24877.3 25436.6 25495.7 23610.6 24453.6 25055.1 25206.5 25231.5 12155.6 12157.6 12166.2 12212.3 12258.9 9118.5 9473.0 9569.2 9638.0 9671.7 20736.4 21067.9 21086.7 21234.6 22016.0 21829.3 21897.6 22053.0 22119.2 22398.8 11852.2 11869.1 11964.4 11968.8 11981.4 15365.0 15527.5 15542.9 15621.0 15667.1 12709.9 12820.6 12893.4 12939.2 12967.2 12318.5 12693.2 12802.3 12869.1 12956.7 11077.8 11302.9 11320.7 11336.5 11338.8 8530.4 8556.1 8693.3 8700.8 8738.8 8009.4 8243.7 8258.8 8280.7 8314.2 16:20:17 INFO - PID 3708 | 16:20:17 INFO - PID 3708 | [#4] prototype.html Cycles:180 Average:5591.40 Median:6202.39 stddev:1552.90 (25.0%) stddev-sans-first:1510.33 16:20:17 INFO - PID 3708 | Values: 543.3 557.8 574.5 579.5 582.0 6225.8 6236.0 6241.0 6243.3 6266.7 6091.1 6120.0 6124.2 6130.8 6220.2 5004.6 5043.8 5077.2 5084.5 5095.3 4853.4 4983.4 5004.3 5007.2 5093.9 4942.5 4944.4 4949.5 4973.6 4978.9 4909.0 4933.9 4954.5 4967.9 4980.3 4495.3 4507.5 4508.4 4514.2 4589.6 6153.9 6197.9 6206.8 6249.4 6279.0 5803.4 5812.6 5822.2 5841.3 5844.6 6541.2 6602.4 6612.6 6619.6 6648.4 4848.2 5045.3 5056.1 5068.7 5075.7 6661.9 6773.1 6827.3 6830.2 6843.3 5154.1 5164.3 5167.4 5170.2 5175.2 5232.4 5242.2 5251.9 5263.2 5267.1 5770.6 5780.9 5817.3 5859.6 5861.6 6650.6 6658.2 6676.4 6678.5 6705.0 1790.7 1817.5 1825.2 1829.9 1844.9 1219.0 1279.8 1300.1 1304.6 1316.1 6107.2 6149.5 6150.2 6153.5 6156.6 6577.7 6647.7 6699.3 6709.4 6744.8 6071.6 6111.6 6119.1 6137.0 6156.4 3501.3 3506.9 3515.6 3530.8 3586.4 6898.0 6904.2 6905.7 6932.9 6950.0 6833.5 6883.3 6900.8 6907.8 6937.6 6859.7 6869.6 6899.2 6904.8 6909.8 6529.1 6610.7 6654.6 6716.5 6758.0 6666.5 6676.6 6684.0 6716.3 6769.8 6833.7 6910.2 6928.7 6956.5 6974.3 5104.8 5141.6 5147.1 5148.7 5158.6 6618.6 6675.5 6681.3 6724.0 6764.4 6430.4 6482.7 6485.4 6487.4 6501.3 6323.8 6424.6 6427.7 6443.9 6508.3 6234.8 6306.9 6331.0 6336.0 6431.3 6492.3 6497.2 6540.8 6548.4 6574.7 6319.2 6339.4 6360.1 6379.7 6392.4 16:20:17 INFO - PID 3708 | 16:20:17 INFO - PID 3708 | [#5] yui.html Cycles:180 Average:28256.68 Median:18208.32 stddev:42523.43 (233.5%) stddev-sans-first:42593.29 16:20:17 INFO - PID 3708 | Values: 950.6 989.1 993.3 993.9 1021.1 18519.9 18971.8 19046.8 19240.9 19307.9 19115.6 19341.1 19350.8 19941.5 20122.8 1037.3 1069.3 1069.4 1069.4 1069.7 1048.9 1083.4 1096.5 1098.8 1099.4 1163.6 1168.1 1168.3 1169.6 1171.0 1089.4 1126.0 1130.9 1146.9 1154.8 815.8 815.8 816.3 816.7 820.0 19591.1 19591.6 19600.6 19674.7 19678.8 22770.5 23357.8 23454.1 23497.5 23506.3 18117.7 18537.6 18676.4 18697.3 18836.9 3997.8 4011.0 4023.5 4024.5 4026.7 158879.0 158890.0 160382.0 161120.2 162428.2 17352.8 17830.3 17933.7 18131.9 18284.7 33787.3 33971.5 34190.8 34257.3 34461.3 9792.5 9801.7 9819.1 9838.9 9850.8 4311.7 4336.9 4447.6 4456.2 4547.2 6044.5 6165.2 6167.1 6189.8 6215.6 1111.9 1298.6 1336.4 1338.7 1345.8 692.7 703.7 710.3 713.4 723.4 12245.4 12448.9 12765.4 12853.5 12959.7 741.5 747.0 750.1 750.5 753.9 6132.4 6232.6 6263.7 6336.1 6354.2 145189.0 145527.3 147666.0 147948.0 155077.2 132614.0 134265.0 134667.0 134998.3 135092.0 113700.4 113907.4 114826.0 115522.4 119946.4 11700.5 11774.5 11823.6 11973.5 11993.4 54614.0 55278.0 55615.2 56340.2 57377.7 71781.3 72256.0 72690.0 74099.0 74473.0 17097.7 17117.9 17664.5 17666.7 17772.3 18301.5 18702.3 18932.9 18942.6 18957.2 17293.3 17296.2 17314.5 17409.5 17534.4 16251.9 16466.5 16540.3 16605.0 16610.5 17675.6 17905.6 17923.2 17989.0 18057.2 12951.5 13097.7 13113.5 13200.7 13206.5 12058.2 12168.4 12473.4 12506.4 12570.4 16:20:17 INFO - PID 3708 | -------- Summary: end -------- 16:20:17 INFO - PID 3708 | 16:20:18 INFO - TEST-INFO | 3708: exit 0 16:20:18 INFO - TEST-OK | dromaeo_css | took 1111644ms 16:20:18 INFO - TEST-START | kraken 16:20:18 INFO - Initialising browser for kraken test... 16:20:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60224/getInfo.html -profile /tmp/tmpUoOLbi/profile 16:20:18 INFO - TEST-INFO | started process 4088 (/builds/slave/test/build/application/firefox/firefox http://localhost:60224/getInfo.html) 16:20:24 INFO - TEST-INFO | 4088: exit 0 16:20:24 INFO - Browser initialized. 16:20:24 INFO - Running cycle 1/1 for kraken test... 16:20:24 INFO - Using env: {'DISPLAY': ':0', 16:20:24 INFO - 'HOME': '/home/cltbld', 16:20:24 INFO - 'JSGC_DISABLE_POISONING': '1', 16:20:24 INFO - 'LANG': 'en_US.UTF-8', 16:20:24 INFO - 'LANGUAGE': 'en_US:en', 16:20:24 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:20:24 INFO - 'LOGNAME': 'cltbld', 16:20:24 INFO - 'MAIL': '/var/mail/cltbld', 16:20:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:20:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:20:24 INFO - 'MOZ_CRASHREPORTER': '1', 16:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:24 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:20:24 INFO - 'MOZ_NO_REMOTE': '1', 16:20:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:24 INFO - 'NO_EM_RESTART': '1', 16:20:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:24 INFO - 'PWD': '/builds/slave/test', 16:20:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:20:24 INFO - 'RUST_BACKTRACE': 'full', 16:20:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:20:24 INFO - 'SHELL': '/bin/bash', 16:20:24 INFO - 'SHLVL': '1', 16:20:24 INFO - 'TERM': 'linux', 16:20:24 INFO - 'TMOUT': '86400', 16:20:24 INFO - 'USER': 'cltbld', 16:20:24 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510', 16:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:24 INFO - '_': '/tools/buildbot/bin/python'} 16:20:24 INFO - TEST-INFO | started process 4290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUoOLbi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:25 INFO - PID 4290 | 16:20:25 INFO - PID 4290 | (/builds/slave/test/build/application/firefox/firefox:4342): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:20:25 INFO - PID 4290 | 16:20:36 INFO - PID 4290 | RSS: Main: 160739328 16:20:36 INFO - PID 4290 | 16:20:38 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60224/tests/kraken/driver.html?testName=audio-beat-detection) 16:20:39 INFO - PID 4290 | RSS: Main: 165867520 16:20:39 INFO - PID 4290 | 16:20:42 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60224/tests/kraken/driver.html?testName=audio-dft) 16:20:42 INFO - PID 4290 | RSS: Main: 166215680 16:20:42 INFO - PID 4290 | 16:20:45 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60224/tests/kraken/driver.html?testName=audio-fft) 16:20:46 INFO - PID 4290 | RSS: Main: 161652736 16:20:46 INFO - PID 4290 | 16:20:48 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60224/tests/kraken/driver.html?testName=audio-oscillator) 16:20:48 INFO - PID 4290 | RSS: Main: 162873344 16:20:48 INFO - PID 4290 | 16:20:50 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60224/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:20:51 INFO - PID 4290 | RSS: Main: 163012608 16:20:51 INFO - PID 4290 | 16:20:54 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60224/tests/kraken/driver.html?testName=imaging-darkroom) 16:20:55 INFO - PID 4290 | RSS: Main: 165937152 16:20:55 INFO - PID 4290 | 16:20:58 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60224/tests/kraken/driver.html?testName=imaging-desaturate) 16:20:59 INFO - PID 4290 | RSS: Main: 165355520 16:20:59 INFO - PID 4290 | 16:21:02 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60224/tests/kraken/driver.html?testName=json-parse-financial) 16:21:03 INFO - PID 4290 | RSS: Main: 165552128 16:21:03 INFO - PID 4290 | 16:21:04 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60224/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:21:05 INFO - PID 4290 | RSS: Main: 165609472 16:21:05 INFO - PID 4290 | 16:21:06 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60224/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:21:07 INFO - PID 4290 | RSS: Main: 165621760 16:21:07 INFO - PID 4290 | 16:21:09 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60224/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:21:10 INFO - PID 4290 | RSS: Main: 165904384 16:21:10 INFO - PID 4290 | 16:21:12 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:21:13 INFO - PID 4290 | RSS: Main: 166043648 16:21:13 INFO - PID 4290 | 16:21:16 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:21:17 INFO - PID 4290 | RSS: Main: 166539264 16:21:17 INFO - PID 4290 | 16:21:18 INFO - PID 4290 | Cycle 1(1): loaded http://localhost:60224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60224/tests/kraken/driver.html?testName=ai-astar) 16:21:19 INFO - PID 4290 | RSS: Main: 167813120 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | __start_tp_report 16:21:19 INFO - PID 4290 | _x_x_mozilla_page_load 16:21:19 INFO - PID 4290 | _x_x_mozilla_page_load_details 16:21:19 INFO - PID 4290 | |i|pagename|runs| 16:21:19 INFO - PID 4290 | |0;ai-astar;105;105;105;106;106;96;105;105;106;106 16:21:19 INFO - PID 4290 | |1;audio-beat-detection;115;111;111;110;115;119;113;111;111;113 16:21:19 INFO - PID 4290 | |2;audio-dft;160;169;163;162;161;160;161;160;163;174 16:21:19 INFO - PID 4290 | |3;audio-fft;73;76;74;74;73;76;73;74;74;76 16:21:19 INFO - PID 4290 | |4;audio-oscillator;80;78;77;79;78;78;80;77;80;78 16:21:19 INFO - PID 4290 | |5;imaging-gaussian-blur;113;113;110;113;117;118;114;114;110;114 16:21:19 INFO - PID 4290 | |6;imaging-darkroom;150;154;151;149;149;150;149;152;150;151 16:21:19 INFO - PID 4290 | |7;imaging-desaturate;94;93;95;99;94;94;95;95;94;95 16:21:19 INFO - PID 4290 | |8;json-parse-financial;43;44;44;43;44;45;45;44;44;43 16:21:19 INFO - PID 4290 | |9;json-stringify-tinderbox;37;37;37;37;37;37;37;36;36;37 16:21:19 INFO - PID 4290 | |10;stanford-crypto-aes;71;72;72;73;72;71;73;73;73;75 16:21:19 INFO - PID 4290 | |11;stanford-crypto-ccm;106;107;104;111;106;110;110;104;102;104 16:21:19 INFO - PID 4290 | |12;stanford-crypto-pbkdf2;155;159;156;161;159;153;152;161;154;165 16:21:19 INFO - PID 4290 | |13;stanford-crypto-sha256-iterative;63;62;60;59;61;62;66;60;60;60 16:21:19 INFO - PID 4290 | __end_tp_report 16:21:19 INFO - PID 4290 | __start_cc_report 16:21:19 INFO - PID 4290 | _x_x_mozilla_cycle_collect,863 16:21:19 INFO - PID 4290 | __end_cc_report 16:21:19 INFO - PID 4290 | __startTimestamp1505172079030__endTimestamp 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | ------- Summary: start ------- 16:21:19 INFO - PID 4290 | Number of tests: 14 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#0] ai-astar Cycles:10 Average:104.50 Median:106.00 stddev:3.03 (2.9%) stddev-sans-first:3.21 16:21:19 INFO - PID 4290 | Values: 105.0 105.0 105.0 106.0 106.0 96.0 105.0 105.0 106.0 106.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#1] audio-beat-detection Cycles:10 Average:112.90 Median:113.00 stddev:2.77 (2.4%) stddev-sans-first:2.83 16:21:19 INFO - PID 4290 | Values: 115.0 111.0 111.0 110.0 115.0 119.0 113.0 111.0 111.0 113.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#2] audio-dft Cycles:10 Average:163.30 Median:162.50 stddev:4.62 (2.8%) stddev-sans-first:4.74 16:21:19 INFO - PID 4290 | Values: 160.0 169.0 163.0 162.0 161.0 160.0 161.0 160.0 163.0 174.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#3] audio-fft Cycles:10 Average:74.30 Median:74.00 stddev:1.25 (1.7%) stddev-sans-first:1.24 16:21:19 INFO - PID 4290 | Values: 73.0 76.0 74.0 74.0 73.0 76.0 73.0 74.0 74.0 76.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:78.50 stddev:1.18 (1.5%) stddev-sans-first:1.12 16:21:19 INFO - PID 4290 | Values: 80.0 78.0 77.0 79.0 78.0 78.0 80.0 77.0 80.0 78.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:2.55 (2.2%) stddev-sans-first:2.69 16:21:19 INFO - PID 4290 | Values: 113.0 113.0 110.0 113.0 117.0 118.0 114.0 114.0 110.0 114.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:1.58 (1.1%) stddev-sans-first:1.67 16:21:19 INFO - PID 4290 | Values: 150.0 154.0 151.0 149.0 149.0 150.0 149.0 152.0 150.0 151.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:1.62 (1.7%) stddev-sans-first:1.69 16:21:19 INFO - PID 4290 | Values: 94.0 93.0 95.0 99.0 94.0 94.0 95.0 95.0 94.0 95.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#8] json-parse-financial Cycles:10 Average:43.90 Median:44.00 stddev:0.74 (1.7%) stddev-sans-first:0.71 16:21:19 INFO - PID 4290 | Values: 43.0 44.0 44.0 43.0 44.0 45.0 45.0 44.0 44.0 43.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#9] json-stringify-tinderbox Cycles:10 Average:36.80 Median:37.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 16:21:19 INFO - PID 4290 | Values: 37.0 37.0 37.0 37.0 37.0 37.0 37.0 36.0 36.0 37.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#10] stanford-crypto-aes Cycles:10 Average:72.50 Median:73.00 stddev:1.18 (1.6%) stddev-sans-first:1.12 16:21:19 INFO - PID 4290 | Values: 71.0 72.0 72.0 73.0 72.0 71.0 73.0 73.0 73.0 75.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#11] stanford-crypto-ccm Cycles:10 Average:106.40 Median:106.50 stddev:3.06 (2.9%) stddev-sans-first:3.24 16:21:19 INFO - PID 4290 | Values: 106.0 107.0 104.0 111.0 106.0 110.0 110.0 104.0 102.0 104.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:159.00 stddev:4.17 (2.6%) stddev-sans-first:4.32 16:21:19 INFO - PID 4290 | Values: 155.0 159.0 156.0 161.0 159.0 153.0 152.0 161.0 154.0 165.0 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.50 stddev:2.06 (3.3%) stddev-sans-first:2.09 16:21:19 INFO - PID 4290 | Values: 63.0 62.0 60.0 59.0 61.0 62.0 66.0 60.0 60.0 60.0 16:21:19 INFO - PID 4290 | -------- Summary: end -------- 16:21:19 INFO - PID 4290 | 16:21:19 INFO - PID 4290 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:21:19 INFO - TEST-INFO | 4290: exit 0 16:21:19 INFO - TEST-OK | kraken | took 61195ms 16:21:19 INFO - SUITE-END | took 1172s 16:21:20 INFO - Completed test suite (00:19:33) 16:21:20 INFO - javascript benchmark 16:21:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9030.926491447019, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3901.980490097549, 3918.2555314490246, 3919.647231749142, 3929.4695216145847, 3947.6644485218753, 6228.314885362606, 6306.117143599889, 6404.327545607708, 6411.775587854426, 6458.838529036776, 6363.777267795628, 6423.454006409461, 6475.287718350989, 6479.384458476449, 6505.154329937113, 5730.36965933747, 5739.339975902762, 5749.338826034997, 5787.681677507735, 5798.594098413102, 5534.418886016971, 5623.606347555673, 5779.133130030508, 5854.73653685583, 5857.355690874, 5634.549236061105, 5736.311642602873, 5771.50942169916, 5792.507636850873, 5808.128780682931, 5732.455416735404, 5732.856678583027, 5775.913361299584, 5793.304803423616, 5802.767889284423, 5669.291338582677, 5704.315482142128, 5741.33974592923, 5753.050746626802, 5779.3642699303045, 6324.272708638519, 6407.038944158367, 6419.0, 6440.420362167428, 6467.0, 6925.203601585781, 6939.23668396476, 6987.510874238806, 7003.159620845531, 7011.158660960667, 6883.208431030395, 6984.02223688684, 6988.056612357317, 6998.125234345707, 7000.439964802855, 6464.547481676284, 6485.156929599122, 6498.285188629295, 6524.93475065248, 6531.085648009187, 7072.0, 7170.067891174114, 7250.927490725131, 7272.672729727175, 7289.70841166358, 6746.966265168741, 6916.3429474199875, 6921.584704917721, 6976.197737260179, 7025.227225005246, 6927.3419025192525, 6973.721051157999, 6997.4052205562075, 7021.473389495808, 7032.859342813115, 6845.760398386033, 6960.37356637905, 6984.511084224056, 7005.229424763272, 7023.789286321418, 6851.897221541681, 6942.965285173542, 6951.096357473496, 7023.508354415244, 7041.683124259421, 5061.291419201315, 5076.18780995039, 5084.720340381241, 5093.2105523643895, 5097.770600322994, 4596.0, 4608.9308660370125, 4616.838410655611, 4626.583607475276, 4648.721076735406, 6265.561410701298, 6352.174217351715, 6406.4554512866, 6449.097126402307, 6449.580777249464, 6910.2744211858035, 6916.688749006206, 6991.475639327071, 6995.650217489105, 7008.614526201006, 6248.625082495065, 6309.716062777186, 6329.2721337045905, 6359.427651511386, 6364.109024736541, 5587.413321601254, 5610.382857885629, 5618.6628802272, 5618.91571626426, 5642.689652069175, 7150.249223831527, 7177.03110080143, 7183.60490173035, 7264.23725508814, 7281.417486601059, 6945.305469453015, 6946.409555187865, 7012.614306213207, 7033.015377847208, 7039.0, 7053.964730176522, 7152.177499587406, 7160.534565253451, 7173.569585824867, 7228.096487939008, 6866.279040700654, 6941.722331106699, 6943.166819981635, 6950.131233595801, 6953.061336719478, 6966.9651651741415, 6969.756058537927, 7040.542364746275, 7046.612436315847, 7052.858942821217, 6683.198016238082, 6691.899621505779, 6697.430718388797, 6782.220044694726, 6794.0, 6634.369734875179, 6690.799276021728, 6691.799246022627, 6699.899501507384, 6704.363085506869, 6554.8361290968105, 6612.437942774918, 6617.933820661732, 6627.072209890523, 6637.70130344126, 6656.800295991128, 6736.528443008942, 6759.0, 6781.932180678327, 6860.451163906776, 6594.934050659432, 6601.0, 6668.799936001734, 6693.230278518033, 6699.464042876656], "value": 6344.00462894577, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [942.9434233945959, 967.8016006718622, 994.4530508220486, 994.8109859126765, 995.9103680668738, 42738.0, 43314.783426082904, 43723.56276437235, 43760.0, 43784.781076094616, 42628.78685606575, 43498.782506087424, 43556.56443435565, 43633.7818310908, 43801.342979855326, 6826.010228516862, 6828.0, 6828.726850925957, 6828.897566536506, 6856.314368563154, 7689.307962283393, 7747.186545412735, 7747.535147891116, 7749.34130598897, 7754.651040703182, 7720.7297744578955, 7736.419768517356, 7741.5355078695175, 7780.6887724491235, 7783.727569535067, 7671.117821450549, 7707.190744971781, 7707.922920770777, 7710.7686769397005, 7711.113221979432, 8068.596570171468, 8111.634976426016, 8115.75652730419, 8121.228483294078, 8130.837383252361, 38455.230895382214, 39844.0, 39938.0, 39962.80018599918, 40195.39706904399, 3691.1325838427947, 3729.384651532494, 3729.4592284118653, 3731.8693845715543, 3732.850685972558, 31450.37099258002, 31621.683783162105, 31644.208894777585, 31658.208544786336, 31785.364292714017, 5523.889522209573, 5546.084895992197, 5546.667199968015, 5549.38956714761, 5623.240862483553, 204611.0, 208818.0, 216716.0, 222204.0, 224530.0, 50252.0, 50757.746211268706, 51040.74479627652, 51064.0, 51109.23336149961, 53369.733151333996, 53415.73292133592, 53471.465285347425, 53500.73249633727, 53820.73089634605, 16509.09199994012, 16639.33442662304, 16640.83359166393, 16666.749998750027, 16896.239669214916, 13987.160770353812, 13990.86009139916, 13995.440182392591, 13999.090059146327, 14003.229822359868, 13709.520166794115, 13792.586222413343, 13806.723865522634, 13816.101953372998, 13930.721385572231, 5347.117725575315, 5387.060658163058, 5411.188321751769, 5422.3764267109, 5426.918596220981, 1100.8954149355798, 1108.5344155454568, 1112.193659596786, 1121.43928035982, 1131.1742428027585, 25716.742832571435, 25849.0, 25961.221163365128, 26025.349366265615, 26049.0, 1206.149664486535, 1209.8911098001222, 1214.6173955204083, 1233.6545767185203, 1247.8253044573767, 13734.0, 13855.16868987864, 13943.372548235353, 14045.85954140466, 14073.507427239998, 274164.0, 276784.0, 276897.0, 277096.0, 277648.0, 56463.15305270424, 56537.71731141318, 56568.71715641396, 56712.0, 56796.0, 1473.8968272221057, 1476.217604669527, 1499.5501349595295, 1514.2655811931425, 1534.0105631867384, 25374.365640859127, 25532.872335638203, 25590.36024099338, 25699.614505782803, 25844.224673259832, 40140.79929600333, 40165.59834401735, 40283.59716402798, 40289.59710402859, 40344.1931161381, 230658.0, 230732.0, 230744.0, 230976.0, 231264.0, 35761.28477430489, 35884.0, 38334.424983625824, 39137.80431097826, 39139.0, 47823.28265075957, 49444.0, 49639.00721985468, 49691.0, 49826.25260621021, 36051.819740901126, 36526.26947461089, 36554.0, 36723.63276367309, 36747.0, 35426.46860297046, 35769.82115089408, 35817.82091089528, 35885.820570898024, 36348.0, 40794.0, 41445.79277103595, 42134.578654213066, 42400.36399454073, 42417.36373954455, 34613.48079778856, 34863.65136348604, 34986.47520287248, 35114.648853511135, 35640.28719425649, 26298.73701262963, 26385.34036649022, 26671.0, 26957.191284261502, 27202.455950880474], "value": 18380.405954624883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.76195997681, 592.9436703513168, 614.5974386776658, 616.5961295351545, 632.0961025733201, 23453.882730586367, 24207.636885446733, 24211.03155873765, 24237.878810605966, 24249.39376515588, 24187.0, 25840.22479325623, 26166.869165654192, 26179.345516362053, 26200.0, 6492.448141907944, 6493.8376540586505, 6531.052997315386, 6531.118299029617, 6534.836629084287, 6276.529260305495, 6452.128962590061, 6720.126383570129, 6730.226024007253, 6739.123913891187, 6651.501137414689, 6658.234303055138, 6682.4319932805765, 6687.398134167924, 6687.83280417991, 6677.198736151644, 6679.93320066798, 6689.866202675919, 6695.096162018114, 6702.7654032108885, 5944.197533332988, 6167.7532898684, 6198.194234749454, 6198.907016394758, 6247.875042499125, 29816.70183298161, 29905.700942990727, 29984.400311993857, 30204.0, 30226.395472090437, 2247.71903512061, 2263.0608297556496, 2276.430892276931, 2278.3734473019886, 2278.703768510083, 19834.702479462674, 20248.898755506274, 20612.175512979462, 20850.58298834015, 20967.0, 2425.0, 2441.5116976604572, 2497.8751062446986, 2520.4455019895595, 2522.672052633146, 128434.3578282112, 133980.33009834887, 143337.0, 146458.0, 147836.2608186963, 15383.846161538466, 15648.009757511762, 16067.0, 16170.919145404432, 16196.433124840574, 25587.0, 25622.231333060037, 25632.102876399236, 25640.358991025, 25661.61507577388, 10288.742781430525, 10447.111995480469, 10500.632477863239, 10509.159267258601, 10758.40828754426, 9506.239500839916, 9545.809083818285, 9626.278029147841, 9715.0, 9734.269929755297, 9387.953060234791, 9440.48077355752, 9618.807623847484, 9860.753481162885, 9876.308658393988, 2790.4558611070647, 2894.1462268630803, 2914.417116576693, 2971.4799910015663, 2981.8658160382834, 1037.7353774787382, 1038.4755698372273, 1051.365127227169, 1060.1201003167353, 1063.0273299930632, 20662.17351305961, 20793.0, 20811.8959405202, 21281.36155915325, 21392.465188370414, 1113.2151832957745, 1122.4163435013747, 1126.4592995362273, 1131.7453572946022, 1136.664683918246, 10974.396408197626, 11302.547898083985, 11322.660320190407, 11491.023263022737, 11597.186138534775, 633791.0, 635934.0, 641269.0, 649374.0, 667607.0, 126004.36997814952, 126576.0, 126715.36642316729, 127228.0, 128271.0, 1215.1311812054423, 1218.2142518075968, 1237.127824883455, 1249.044480972057, 1254.956076537317, 18358.81641183571, 18664.720029199845, 18702.0, 19009.33467328637, 19192.232310707415, 57486.0, 58183.0, 58296.4170358291, 59202.70398647979, 60292.39707603044, 75604.62197688976, 75605.24394756202, 75795.24204757882, 75837.0, 76093.0, 14869.851301486846, 15311.0, 15351.769723453934, 15373.231338433257, 15398.46105386306, 23165.07339706393, 23746.525069498857, 23867.283981480585, 23925.521489569765, 24128.396790079685, 19145.04274786283, 19269.903650482218, 19296.71054934149, 19678.704819427432, 19703.11335989855, 16288.511344659679, 16720.916395417946, 16824.747628785823, 17006.829931700526, 17236.569085772957, 19330.71003934914, 19462.0, 19690.21239150418, 19950.90024549926, 19980.600387991868, 14801.333939972512, 15018.924905375403, 15036.699266014399, 15055.0, 15065.0, 18639.161237744604, 18642.81357186465, 19015.52461188426, 19052.428427147206, 19158.712619311], "value": 12582.3407498746, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.7760358342664, 1488.8957772955898, 1494.6861159156576, 1501.391936265812, 1507.1183357735724, 16642.75035874461, 17342.046187459684, 17388.56528586786, 17398.913005434955, 17399.130043497837, 16882.324707011736, 17044.488665340028, 17085.487435376926, 17090.31638734449, 17111.57221069474, 2849.586809912572, 2865.928351791201, 2869.0962346860674, 2881.034853324139, 2882.6540815102217, 2850.2446851584345, 2850.5011622966003, 2865.957010644842, 2876.654801423832, 2889.855507224641, 2787.790915681332, 2822.77417806576, 2837.645294338208, 2898.116074597247, 2898.724621160997, 2864.4414339203863, 2883.4377296427206, 2889.696581858906, 2892.4215156968585, 2892.537194048963, 2642.2733748219202, 2677.42435376395, 2678.08944958715, 2716.2801857507775, 2798.790090743182, 16563.66872662552, 16601.584960375967, 16654.916725416417, 16672.83327166725, 16691.08199049052, 8352.081271060179, 8647.178518040777, 8662.913370866338, 8663.913360866374, 8668.0, 5585.8603534911545, 5677.772889084432, 5691.800786972436, 5694.829155125353, 5746.166805813175, 1977.2684106880547, 1981.2075169931998, 1987.4633848860726, 2039.2760569997586, 2064.5148390128306, 29984.8500757497, 30202.848985754932, 30249.0, 30337.393252135054, 30430.087097387113, 7048.400885924651, 7092.5389849659605, 7141.607211603307, 7235.710571577078, 7265.564066156047, 19932.0, 19949.00254987245, 20055.899720501304, 20067.0, 20068.799312006984, 8559.101294364127, 8763.56182190888, 8766.60550275239, 8769.429987050822, 8781.912180878237, 7683.884741728879, 7715.0, 7807.375409967189, 7818.765437036898, 7832.960835195901, 5439.0, 5657.349404818417, 5682.7442765075675, 5695.088785794253, 5736.110902810071, 1654.8510634042993, 1657.2293883344303, 1660.2943748906666, 1684.0232665054239, 1684.5956970327034, 944.8582712593166, 963.7761687156451, 972.8103019911191, 973.8003709239589, 980.4166520920041, 8515.872261916076, 8520.233179013794, 8567.914320856711, 8573.528455934984, 8597.441166324168, 721.5490318550906, 753.5817621220166, 753.796474951771, 754.4944886925773, 757.8938948547208, 5272.578193744491, 5364.892702145935, 5424.267723857229, 5464.535514481234, 5833.766649334064, 24521.509569808502, 24637.753622463544, 24877.253682389557, 25436.618450723254, 25495.745042549337, 23610.64584031241, 24453.633195502083, 25055.12307069244, 25206.495870082497, 25231.495370092496, 12155.574554890536, 12157.635270941886, 12166.209196402206, 12212.32832194238, 12258.938705306595, 9118.452892826186, 9473.0, 9569.234461243223, 9637.951810240904, 9671.70984870455, 20736.377908662766, 21067.8946605266, 21086.683699744208, 21234.575308493433, 22016.0, 21829.345119646438, 21897.562048758617, 22053.0, 22119.225827095976, 22398.77601223967, 11852.229605075643, 11869.109816763605, 11964.401779911144, 11968.820467693165, 11981.400929953641, 15365.0, 15527.45653902108, 15542.9222853885, 15621.0, 15667.059976401453, 12709.87290127124, 12820.551280705131, 12893.355332233163, 12939.158954667917, 12967.157134786208, 12318.50725970987, 12693.238405695687, 12802.295873727035, 12869.09916305887, 12956.676083097998, 11077.778444430905, 11302.886971130183, 11320.660380188607, 11336.546538138711, 11338.829917551078, 8530.360222983178, 8556.10160933093, 8693.261072808882, 8700.825983480421, 8738.825223495622, 8009.399295052778, 8243.670253189804, 8258.752237432887, 8280.71017514384, 8314.210150035737], "value": 7261.244009535183, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.2964311216971, 557.7573755416392, 574.4887050525032, 579.5218944370893, 581.9796307129251, 6225.813225603228, 6236.0, 6240.9999999999945, 6243.313235544092, 6266.749330026799, 6091.14723938649, 6120.0, 6124.162751174641, 6130.846728831771, 6220.222472190976, 5004.5746111580465, 5043.84868453947, 5077.213031980049, 5084.4661310562415, 5095.286659867622, 4853.441854186761, 4983.426905905831, 5004.299398084271, 5007.198848184291, 5093.923591146117, 4942.481039490855, 4944.357233559632, 4949.480304568023, 4973.626977976666, 4978.850634480971, 4909.036385445815, 4933.901321973576, 4954.47977962316, 4967.907060446696, 4980.277859710358, 4495.348174514677, 4507.504174540798, 4508.436445444319, 4514.210013247669, 4589.5639914208095, 6153.876922461571, 6197.938020619781, 6206.844828879269, 6249.406306400884, 6279.0, 5803.361630220672, 5812.593118481708, 5822.184894114827, 5841.299044114691, 5844.620099693507, 6541.182352205974, 6602.405783479462, 6612.636305003223, 6619.602823830585, 6648.368405001517, 4848.224284114524, 5045.344105266292, 5056.115179843513, 5068.72122033288, 5075.670081444731, 6661.9000714989315, 6773.06967514256, 6827.283135270774, 6830.248672646005, 6843.281455447156, 5154.14956532168, 5164.302819119446, 5167.379914410295, 5170.1727723564045, 5175.197844334134, 5232.372115346183, 5242.18746094356, 5251.897101608705, 5263.184206448007, 5267.104592219255, 5770.6249093808765, 5780.942190578125, 5817.346123101502, 5859.560532960045, 5861.589688721834, 6650.600963942179, 6658.234303055114, 6676.432503237182, 6678.532502724763, 6704.9607310866895, 1790.6866298397729, 1817.4547635709498, 1825.2151574822954, 1829.9176537055864, 1844.9169787359601, 1219.0, 1279.814426908093, 1300.13540995239, 1304.6086174147717, 1316.0918965913488, 6107.175531303306, 6149.477294429934, 6150.169727086786, 6153.538484613672, 6156.569040167145, 6577.736890524421, 6647.734090636321, 6699.296573859772, 6709.36261055199, 6744.7976560703255, 6071.571371451455, 6111.572189946661, 6119.143319935212, 6136.969315153396, 6156.384361563808, 3501.28223714138, 3506.859725610998, 3515.6132825389186, 3530.8234588270484, 3586.444101164324, 6897.965510172417, 6904.171499420102, 6905.689243984033, 6932.861342773217, 6949.965250173716, 6833.453323734089, 6883.311668833177, 6900.758473453506, 6907.792766217021, 6937.618430986243, 6859.691313890987, 6869.622170780555, 6899.206591241971, 6904.758333458305, 6909.7581584644295, 6529.118568993125, 6610.735570577315, 6654.567453115532, 6716.529842910949, 6758.0, 6666.533342665967, 6676.632785196666, 6683.966580167263, 6716.29478904708, 6769.796906092825, 6833.658317084225, 6910.239873613999, 6928.722851086101, 6956.513044086865, 6974.33743794359, 5104.770285337243, 5141.611764823402, 5147.124988751996, 5148.7425628717665, 5158.638895277295, 6618.635975021228, 6675.499337549606, 6681.33186681328, 6723.966380168068, 6764.3573860483175, 6430.389113034442, 6482.740690372332, 6485.44873685742, 6487.351264873475, 6501.284858665637, 6323.841903952438, 6424.599149582551, 6427.742890284337, 6443.903341449975, 6508.349165083454, 6234.781782637586, 6306.859909174009, 6331.0, 6336.0, 6431.260405053479, 6492.285848556749, 6497.173729427714, 6540.803775886731, 6548.410643042149, 6574.704138313692, 6319.210098737658, 6339.429451349216, 6360.141380913517, 6379.712912918837, 6392.3927226913365], "value": 5147.233876042086, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [950.6150009246257, 989.144390102561, 993.2749093161991, 993.8956409576995, 1021.1473419694553, 18519.907400462995, 18971.810281897193, 19046.809531904677, 19240.903795481005, 19307.903460482677, 19115.617687646238, 19341.129649165785, 19350.806491935076, 19941.50146246341, 20122.798772012276, 1037.3309215555944, 1069.3263244156171, 1069.3690722473777, 1069.443889177631, 1069.6684027951321, 1048.9318194317384, 1083.3662307550053, 1096.4682129167347, 1098.807708650983, 1099.4282972854112, 1163.6392718257325, 1168.1414160591958, 1168.3106966889534, 1169.5731058163751, 1170.9987960293954, 1089.4008295437477, 1126.0203622848094, 1130.8642962844428, 1146.9426528673575, 1154.797910365687, 815.7715839564872, 815.8368326334756, 816.302061737218, 816.7427260412951, 819.9877001844977, 19591.11839967205, 19591.608167836705, 19600.607987840165, 19674.70487942682, 19678.80321196784, 22770.54458910829, 23357.766422335728, 23454.06183752648, 23497.530049398916, 23506.294811155694, 18117.728234076498, 18537.629247414978, 18676.43970680882, 18697.34559290432, 18836.905815470836, 3997.760134391946, 4011.0373510357595, 4023.4568333274924, 4024.5170579530645, 4026.71812973092, 158879.0, 158890.0, 160382.0, 161120.19439902843, 162428.18785906112, 17352.826471735374, 17830.286788528574, 17933.7309940351, 18131.909340453214, 18284.725729114074, 33787.324253514795, 33971.49042764361, 34190.829045855106, 34257.31485370328, 34461.31077378438, 9792.510374481248, 9801.656942006995, 9819.06718861707, 9838.852417213748, 9850.802983940424, 4311.676624253194, 4336.913261734748, 4447.599716025508, 4456.153330867125, 4547.226971414867, 6044.546659000593, 6165.198524191826, 6167.136600875881, 6189.752409903644, 6215.627062376272, 1111.8776934537195, 1298.6363818130937, 1336.3852627791325, 1338.732253549294, 1345.8048582955416, 692.6640579319027, 703.6868593475956, 710.3074502360157, 713.4149997002512, 723.3995783499682, 12245.448954797055, 12448.937755311166, 12765.361731913366, 12853.485860565472, 12959.740805183843, 741.4957828676444, 747.0475144191091, 750.0699133074947, 750.4521699159535, 753.8944547763317, 6132.448079672851, 6232.56372053961, 6263.749450021948, 6336.144620476269, 6354.23749150105, 145189.0, 145527.27236363752, 147666.0, 147948.0, 155077.2246138762, 132614.0, 134265.0, 134667.0, 134998.3250083763, 135092.0, 113700.43149784363, 113907.43046284716, 114826.0, 115522.42238788921, 119946.40026799985, 11700.47347869365, 11774.470148843151, 11823.645290641294, 11973.521059157885, 11993.40032998364, 54614.0, 55278.0, 55615.165772512635, 56340.154897677385, 57377.713111434176, 71781.28218717746, 72256.0, 72690.0, 74099.0, 74473.0, 17097.658046839242, 17117.914410427868, 17664.470065898044, 17666.734998975284, 17772.289108435518, 18301.450956471326, 18702.251909923452, 18932.905335473235, 18942.621147576694, 18957.241710331982, 17293.308267669152, 17296.22167002513, 17314.480565582548, 17409.47771566855, 17534.386296479563, 16251.918740406223, 16466.506004819876, 16540.33838646489, 16605.0, 16610.50168494947, 17675.646487070444, 17905.641887162445, 17923.193456294757, 17989.0, 18057.18742656557, 12951.481940722266, 13097.672558186121, 13113.541026064042, 13200.735985280433, 13206.537771177962, 12058.15592908488, 12168.391580421121, 12473.376331183586, 12506.43721032574, 12570.371481426075], "value": 9892.424271836964, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1370.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 106.0, 106.0, 96.0, 105.0, 105.0, 106.0, 106.0], "value": 104.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 111.0, 110.0, 115.0, 119.0, 113.0, 111.0, 111.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 169.0, 163.0, 162.0, 161.0, 160.0, 161.0, 160.0, 163.0, 174.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 74.0, 74.0, 73.0, 76.0, 73.0, 74.0, 74.0, 76.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 77.0, 79.0, 78.0, 78.0, 80.0, 77.0, 80.0, 78.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 110.0, 113.0, 117.0, 118.0, 114.0, 114.0, 110.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 151.0, 149.0, 149.0, 150.0, 149.0, 152.0, 150.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 99.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 44.0, 43.0, 44.0, 45.0, 45.0, 44.0, 44.0, 43.0], "value": 43.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 36.0, 36.0, 37.0], "value": 36.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 72.0, 73.0, 72.0, 71.0, 73.0, 73.0, 73.0, 75.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 107.0, 104.0, 111.0, 106.0, 110.0, 110.0, 104.0, 102.0, 104.0], "value": 106.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 159.0, 156.0, 161.0, 159.0, 153.0, 152.0, 161.0, 154.0, 165.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 60.0, 59.0, 61.0, 62.0, 66.0, 60.0, 60.0, 60.0], "value": 61.3, "unit": "score"}]}]} 16:21:20 INFO - Return code: 0 16:21:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:21:20 INFO - # TBPL SUCCESS # 16:21:20 INFO - Running post-action listener: _package_coverage_data 16:21:20 INFO - Running post-action listener: _resource_record_post_action 16:21:20 INFO - [mozharness: 2017-09-11 23:21:20.309560Z] Finished run-tests step (success) 16:21:20 INFO - Running post-run listener: _resource_record_post_run 16:21:20 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8650752; Write bytes: 418381824; Read time: 2476; Write time: 365392 16:21:20 INFO - TinderboxPrint: CPU usage
13.1% 16:21:20 INFO - TinderboxPrint: I/O read bytes / time
8,650,752 / 2,476 16:21:20 INFO - TinderboxPrint: I/O write bytes / time
418,381,824 / 365,392 16:21:20 INFO - TinderboxPrint: CPU idle
8,247.3 (86.9%) 16:21:20 INFO - TinderboxPrint: CPU user
1,187.4 (12.5%) 16:21:20 INFO - TinderboxPrint: Swap in / out
0 / 0 16:21:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12320768; Read time: 0; Write time: 908 16:21:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:21:20 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 6619136; Write bytes: 406061056; Read time: 2428; Write time: 364484 16:21:20 INFO - Running post-run listener: _upload_blobber_files 16:21:20 INFO - Blob upload gear active. 16:21:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:21:20 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 16:21:20 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'] 16:21:20 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 16:21:21 INFO - (blobuploader) - INFO - Open directory for files ... 16:21:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:21:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:21:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:28 INFO - (blobuploader) - INFO - Done attempting. 16:21:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:21:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:21:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:29 INFO - (blobuploader) - INFO - Done attempting. 16:21:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:21:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:30 INFO - (blobuploader) - INFO - Done attempting. 16:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:21:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:31 INFO - (blobuploader) - INFO - Done attempting. 16:21:31 INFO - (blobuploader) - INFO - Iteration through files over. 16:21:31 INFO - Return code: 0 16:21:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:21:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:21:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07fbfe5a08149d9cc3bbd2c439cc3dd9bbe46368d102733a2b63c56edb2b3c3ad1d8e79f7619962acc0ce00bf7e841049d47b3f99b1684f38a1142e20b094f21", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b7b6e0b8ca309458ce86e213caed8bba6687b9cd5ab22773131649bd4113772e9eecefc03fa5aa8e1aca40e90a553e3564eee264be142a0b9ab982d0bf226aa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8fcae1713b4324d63d85ea4c2787be50cea8eceaf62959b6ff80b6ee91cfc0351bf9df7f07bfb7f3cc0b2222fd8a8ceb5c08914276efcc3836890dd9fed18ac", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/697872af91c878094a68401d4f888bfbd3a26a9b322958e77b77eef206ce253d77b26fb3070172c49c0671dc8619aca4b7cf1ad5d435dc21148bcf189c81a724"} 16:21:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:21:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:21:31 INFO - Contents: 16:21:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07fbfe5a08149d9cc3bbd2c439cc3dd9bbe46368d102733a2b63c56edb2b3c3ad1d8e79f7619962acc0ce00bf7e841049d47b3f99b1684f38a1142e20b094f21", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b7b6e0b8ca309458ce86e213caed8bba6687b9cd5ab22773131649bd4113772e9eecefc03fa5aa8e1aca40e90a553e3564eee264be142a0b9ab982d0bf226aa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8fcae1713b4324d63d85ea4c2787be50cea8eceaf62959b6ff80b6ee91cfc0351bf9df7f07bfb7f3cc0b2222fd8a8ceb5c08914276efcc3836890dd9fed18ac", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/697872af91c878094a68401d4f888bfbd3a26a9b322958e77b77eef206ce253d77b26fb3070172c49c0671dc8619aca4b7cf1ad5d435dc21148bcf189c81a724"} 16:21:31 INFO - Running post-run listener: copy_logs_to_upload_dir 16:21:31 INFO - Copying logs to upload dir... 16:21:31 INFO - mkdir: /builds/slave/test/build/upload/logs 16:21:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.558611 ========= master_lag: -0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-11 16:21:31.234521) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 16:21:31.237978) ========= 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=199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07fbfe5a08149d9cc3bbd2c439cc3dd9bbe46368d102733a2b63c56edb2b3c3ad1d8e79f7619962acc0ce00bf7e841049d47b3f99b1684f38a1142e20b094f21", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b7b6e0b8ca309458ce86e213caed8bba6687b9cd5ab22773131649bd4113772e9eecefc03fa5aa8e1aca40e90a553e3564eee264be142a0b9ab982d0bf226aa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8fcae1713b4324d63d85ea4c2787be50cea8eceaf62959b6ff80b6ee91cfc0351bf9df7f07bfb7f3cc0b2222fd8a8ceb5c08914276efcc3836890dd9fed18ac", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/697872af91c878094a68401d4f888bfbd3a26a9b322958e77b77eef206ce253d77b26fb3070172c49c0671dc8619aca4b7cf1ad5d435dc21148bcf189c81a724"} build_url:https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://queue.taskcluster.net/v1/task/TlO0iBDDTAWlTFRvv0Z9LQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07fbfe5a08149d9cc3bbd2c439cc3dd9bbe46368d102733a2b63c56edb2b3c3ad1d8e79f7619962acc0ce00bf7e841049d47b3f99b1684f38a1142e20b094f21", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b7b6e0b8ca309458ce86e213caed8bba6687b9cd5ab22773131649bd4113772e9eecefc03fa5aa8e1aca40e90a553e3564eee264be142a0b9ab982d0bf226aa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8fcae1713b4324d63d85ea4c2787be50cea8eceaf62959b6ff80b6ee91cfc0351bf9df7f07bfb7f3cc0b2222fd8a8ceb5c08914276efcc3836890dd9fed18ac", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/697872af91c878094a68401d4f888bfbd3a26a9b322958e77b77eef206ce253d77b26fb3070172c49c0671dc8619aca4b7cf1ad5d435dc21148bcf189c81a724"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 16:21:31.266679) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 16:21:31.267028) ========= 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=199fb4c72b90437b990b419b000001c5-1505170321.448466-54605510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 16:21:31.349782) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 16:21:31.350104) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 16:21:31.350434) ========= ========= Total master_lag: 0.11 =========