builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1505905715.33 results: success (0) revision: a20de99fa3c1ba6287fe47d493a859a4e95120b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:35.329905) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:35.330384) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:35.330668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:35.360149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:35.360551) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 04:08:35-- 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% 47.0M=0s 2017-09-20 04:08:35 (47.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.251695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:35.629966) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:35.630301) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016745 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:35.680419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:35.680792) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a20de99fa3c1ba6287fe47d493a859a4e95120b0 --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 a20de99fa3c1ba6287fe47d493a859a4e95120b0 --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=82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 04:08:35,734 truncating revision to first 12 chars 2017-09-20 04:08:35,734 Setting DEBUG logging. 2017-09-20 04:08:35,734 attempt 1/10 2017-09-20 04:08:35,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a20de99fa3c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 04:08:36,139 unpacking tar archive at: mozilla-central-a20de99fa3c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.745256 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:36.440033) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:36.440364) ========= script_repo_revision: a20de99fa3c1ba6287fe47d493a859a4e95120b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:36.440785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:36.441068) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 04:08:36.454395) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-20 04:08:36.454793) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:36 INFO - MultiFileLogger online at 20170920 04:08:36 in /builds/slave/test 04:08:36 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 04:08:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:36 INFO - {'append_to_log': False, 04:08:36 INFO - 'base_work_dir': '/builds/slave/test', 04:08:36 INFO - 'blob_upload_branch': 'Firefox', 04:08:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:36 INFO - 'branch': 'Firefox', 04:08:36 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:36 INFO - 'code_coverage': False, 04:08:36 INFO - 'config_files': ('talos/linux_config.py',), 04:08:36 INFO - 'default_actions': ('clobber', 04:08:36 INFO - 'read-buildbot-config', 04:08:36 INFO - 'download-and-extract', 04:08:36 INFO - 'populate-webroot', 04:08:36 INFO - 'create-virtualenv', 04:08:36 INFO - 'install', 04:08:36 INFO - 'setup-mitmproxy', 04:08:36 INFO - 'run-tests'), 04:08:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:36 INFO - 'disable_ccov_upload': False, 04:08:36 INFO - 'disable_stylo': False, 04:08:36 INFO - 'download_minidump_stackwalk': True, 04:08:36 INFO - 'download_symbols': 'ondemand', 04:08:36 INFO - 'enable_stylo': False, 04:08:36 INFO - 'enable_webrender': False, 04:08:36 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:08:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:36 INFO - 'gecko_profile': False, 04:08:36 INFO - 'gecko_profile_interval': 0, 04:08:36 INFO - 'installer_path': 'installer.exe', 04:08:36 INFO - 'log_level': 'info', 04:08:36 INFO - 'log_name': 'talos', 04:08:36 INFO - 'log_to_console': True, 04:08:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:36 INFO - 'opt_config_files': (), 04:08:36 INFO - 'pip_index': False, 04:08:36 INFO - 'suite': 'dromaeojs-e10s', 04:08:36 INFO - 'system_bits': '32', 04:08:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:36 INFO - 'title': 'talos-linux64-ix-066', 04:08:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:36 INFO - 'use_talos_json': True, 04:08:36 INFO - 'verify': 'False', 04:08:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:36 INFO - 'work_dir': 'build'} 04:08:36 INFO - [mozharness: 2017-09-20 11:08:36.732105Z] Running clobber step. 04:08:36 INFO - Running pre-action listener: _resource_record_pre_action 04:08:36 INFO - Running main action method: clobber 04:08:36 INFO - rmtree: /builds/slave/test/build 04:08:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:37 INFO - Running post-action listener: _resource_record_post_action 04:08:37 INFO - [mozharness: 2017-09-20 11:08:37.695842Z] Finished clobber step (success) 04:08:37 INFO - [mozharness: 2017-09-20 11:08:37.696000Z] Running read-buildbot-config step. 04:08:37 INFO - Running pre-action listener: _resource_record_pre_action 04:08:37 INFO - Running main action method: read_buildbot_config 04:08:37 INFO - Using buildbot properties: 04:08:37 INFO - { 04:08:37 INFO - "project": "", 04:08:37 INFO - "product": "firefox", 04:08:37 INFO - "who": "archaeopteryx@coole-files.de", 04:08:37 INFO - "installer_path": "public/build/target.tar.bz2", 04:08:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:08:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:08:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 04:08:37 INFO - "stage_platform": "linux64-pgo", 04:08:37 INFO - "basedir": "/builds/slave/test", 04:08:37 INFO - "buildnumber": 195, 04:08:37 INFO - "platform": "ubuntu64_hw", 04:08:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:08:37 INFO - "slavebuilddir": "test", 04:08:37 INFO - "taskId": "EyN4FvYwSgen0sv24WfNEA", 04:08:37 INFO - "branch": "mozilla-central", 04:08:37 INFO - "script_repo_revision": "production", 04:08:37 INFO - "revision": "a20de99fa3c1ba6287fe47d493a859a4e95120b0", 04:08:37 INFO - "slavename": "talos-linux64-ix-066", 04:08:37 INFO - "repo_path": "mozilla-central" 04:08:37 INFO - } 04:08:37 INFO - Finding installer, test and symbols from parent task. 04:08:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EyN4FvYwSgen0sv24WfNEA'}, attempt #1 04:08:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EyN4FvYwSgen0sv24WfNEA'}, attempt #1 04:08:38 INFO - Task dependencies: J47zVnrxSO6MxQgSw6iInA 04:08:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA'}, attempt #1 04:08:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.tar.bz2 04:08:39 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.test_packages.json 04:08:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.crashreporter-symbols.zip 04:08:39 INFO - Running post-action listener: _resource_record_post_action 04:08:39 INFO - [mozharness: 2017-09-20 11:08:39.084229Z] Finished read-buildbot-config step (success) 04:08:39 INFO - [mozharness: 2017-09-20 11:08:39.084446Z] Running download-and-extract step. 04:08:39 INFO - Running pre-action listener: _resource_record_pre_action 04:08:39 INFO - Running main action method: download_and_extract 04:08:39 INFO - mkdir: /builds/slave/test/build/tests 04:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:39 INFO - trying https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.test_packages.json 04:08:39 INFO - Downloading https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:08:39 INFO - Downloaded 989 bytes. 04:08:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:08:39 INFO - Using the following test package requirements: 04:08:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:08:39 INFO - u'common': [u'target.common.tests.zip'], 04:08:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:08:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:08:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:08:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:08:39 INFO - u'mozbase': [u'target.common.tests.zip'], 04:08:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:08:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:08:39 INFO - u'web-platform': [u'target.common.tests.zip', 04:08:39 INFO - u'target.web-platform.tests.tar.gz'], 04:08:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:08:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:08:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.common.tests.zip 04:08:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:08:39 INFO - Fetch https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.common.tests.zip into memory 04:08:40 INFO - Content-Length response header: 55286702 04:08:40 INFO - Bytes received: 55286702 04:08:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.talos.tests.zip 04:08:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:08:51 INFO - Fetch https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.talos.tests.zip into memory 04:08:52 INFO - Content-Length response header: 14508893 04:08:52 INFO - Bytes received: 14508893 04:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:52 INFO - trying https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.tar.bz2 04:08:52 INFO - Downloading https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:08:53 INFO - Downloaded 62197784 bytes. 04:08:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.tar.bz2 04:08:53 INFO - mkdir: /builds/slave/test/properties 04:08:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:53 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:53 INFO - Contents: 04:08:53 INFO - build_url:https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.tar.bz2 04:08:53 INFO - Running post-action listener: _resource_record_post_action 04:08:53 INFO - Running post-action listener: find_tests_for_verification 04:08:53 INFO - Running post-action listener: set_extra_try_arguments 04:08:53 INFO - [mozharness: 2017-09-20 11:08:53.826130Z] Finished download-and-extract step (success) 04:08:53 INFO - [mozharness: 2017-09-20 11:08:53.826226Z] Running populate-webroot step. 04:08:53 INFO - Running pre-action listener: _resource_record_pre_action 04:08:53 INFO - Running main action method: populate_webroot 04:08:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:08:53 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:53 INFO - 'tests': ['tresize', 04:08:53 INFO - 'tcanvasmark']}, 04:08:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:08:53 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:53 INFO - 'tests': ['dromaeo_css', 04:08:53 INFO - 'kraken']}, 04:08:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:08:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:53 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:08:53 INFO - 'talos_options': ['--disable-stylo'], 04:08:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:08:53 INFO - 'tests': ['damp', 'tps']}, 04:08:53 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:08:53 INFO - 'talos_options': ['--disable-stylo'], 04:08:53 INFO - 'tests': ['damp', 'tps']}, 04:08:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:53 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:53 INFO - 'tests': ['dromaeo_dom']}, 04:08:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:08:53 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:53 INFO - 'tests': ['basic_compositor_video', 04:08:53 INFO - 'glvideo']}, 04:08:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:08:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:08:53 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:08:53 INFO - 'talos_options': ['--disable-stylo'], 04:08:53 INFO - 'tests': ['ts_paint_webext', 04:08:53 INFO - 'tp5o_webext']}, 04:08:53 INFO - 'other-e10s': {'tests': ['a11yr', 04:08:53 INFO - 'ts_paint', 04:08:53 INFO - 'tpaint', 04:08:53 INFO - 'sessionrestore', 04:08:53 INFO - 'sessionrestore_many_windows', 04:08:53 INFO - 'sessionrestore_no_auto_restore', 04:08:53 INFO - 'tabpaint']}, 04:08:53 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:53 INFO - 'tests': ['a11yr', 04:08:53 INFO - 'ts_paint', 04:08:53 INFO - 'tpaint', 04:08:53 INFO - 'sessionrestore', 04:08:53 INFO - 'sessionrestore_many_windows', 04:08:53 INFO - 'sessionrestore_no_auto_restore', 04:08:53 INFO - 'tabpaint']}, 04:08:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:08:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:08:53 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:53 INFO - 'tests': ['perf_reftest_singletons']}, 04:08:53 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:53 INFO - 'tests': ['bloom_basic']}, 04:08:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:08:53 INFO - 'tsvgr_opacity', 04:08:53 INFO - 'tart', 04:08:53 INFO - 'tscrollx', 04:08:53 INFO - 'tsvg_static']}, 04:08:53 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:53 INFO - 'tests': ['tsvgx', 04:08:53 INFO - 'tsvgr_opacity', 04:08:53 INFO - 'tart', 04:08:53 INFO - 'tscrollx', 04:08:53 INFO - 'tsvg_static']}, 04:08:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:08:53 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:08:53 INFO - 'talos_options': ['--disable-stylo'], 04:08:53 INFO - 'tests': ['tp5o']}, 04:08:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:08:53 INFO - 'talos_options': ['--mitmproxy', 04:08:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:08:53 INFO - '--firstNonBlankPaint'], 04:08:53 INFO - 'tests': ['tp6_google', 04:08:53 INFO - 'tp6_youtube', 04:08:53 INFO - 'tp6_amazon', 04:08:53 INFO - 'tp6_facebook']}, 04:08:53 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:08:53 INFO - 'talos_options': ['--disable-stylo', 04:08:53 INFO - '--mitmproxy', 04:08:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:08:53 INFO - '--firstNonBlankPaint'], 04:08:53 INFO - 'tests': ['tp6_google', 04:08:53 INFO - 'tp6_youtube', 04:08:53 INFO - 'tp6_amazon', 04:08:53 INFO - 'tp6_facebook']}, 04:08:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:08:53 INFO - 'talos_options': ['--stylo-threads=1', 04:08:53 INFO - '--mitmproxy', 04:08:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:08:53 INFO - '--firstNonBlankPaint'], 04:08:53 INFO - 'tests': ['tp6_google', 04:08:53 INFO - 'tp6_youtube', 04:08:53 INFO - 'tp6_amazon', 04:08:53 INFO - 'tp6_facebook']}, 04:08:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:08:53 INFO - 'talos_options': ['--xperf_path', 04:08:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:53 INFO - 'tests': ['tp5n']}, 04:08:53 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:08:53 INFO - 'talos_options': ['--disable-stylo', 04:08:53 INFO - '--xperf_path', 04:08:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:53 INFO - 'tests': ['tp5n']}}} 04:08:53 INFO - Running post-action listener: _resource_record_post_action 04:08:53 INFO - [mozharness: 2017-09-20 11:08:53.841127Z] Finished populate-webroot step (success) 04:08:53 INFO - [mozharness: 2017-09-20 11:08:53.841237Z] Running create-virtualenv step. 04:08:53 INFO - Running pre-action listener: _resource_record_pre_action 04:08:53 INFO - Running main action method: create_virtualenv 04:08:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:53 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:08:53 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:08:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:08:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:55 INFO - Installing pip...............done. 04:08:55 INFO - Return code: 0 04:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:08:55 INFO - Reading from file tmpfile_stdout 04:08:55 INFO - Output received: 04:08:55 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:08:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:08:55 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')]} 04:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:55 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')]} 04:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:55 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 0xfc71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1190a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337090>, '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 0x1337d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1331f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', '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 04:08:55 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 04:08:55 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 04:08:55 INFO - Using env: {'DISPLAY': ':0', 04:08:55 INFO - 'HOME': '/home/cltbld', 04:08:55 INFO - 'LANG': 'en_US.UTF-8', 04:08:55 INFO - 'LANGUAGE': 'en_US:en', 04:08:55 INFO - 'LOGNAME': 'cltbld', 04:08:55 INFO - 'MAIL': '/var/mail/cltbld', 04:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:55 INFO - 'MOZ_NO_REMOTE': '1', 04:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:55 INFO - 'NO_EM_RESTART': '1', 04:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:55 INFO - 'PWD': '/builds/slave/test', 04:08:55 INFO - 'SHELL': '/bin/bash', 04:08:55 INFO - 'SHLVL': '1', 04:08:55 INFO - 'TERM': 'linux', 04:08:55 INFO - 'TMOUT': '86400', 04:08:55 INFO - 'USER': 'cltbld', 04:08:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:55 INFO - '_': '/tools/buildbot/bin/python'} 04:08:56 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:08:56 INFO - Downloading/unpacking pip>=1.5 04:08:56 INFO - Running setup.py egg_info for package pip 04:08:56 INFO - warning: no files found matching 'pip/cacert.pem' 04:08:56 INFO - warning: no files found matching '*.html' under directory 'docs' 04:08:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:08:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:08:56 INFO - Installing collected packages: pip 04:08:56 INFO - Found existing installation: pip 1.1 04:08:56 INFO - Uninstalling pip: 04:08:56 INFO - Successfully uninstalled pip 04:08:56 INFO - Running setup.py install for pip 04:08:56 INFO - warning: no files found matching 'pip/cacert.pem' 04:08:56 INFO - warning: no files found matching '*.html' under directory 'docs' 04:08:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:08:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:08:56 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:08:56 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:08:56 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:08:56 INFO - Successfully installed pip 04:08:56 INFO - Cleaning up... 04:08:56 INFO - Return code: 0 04:08:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfc71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1190a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337090>, '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 0x1337d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1331f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', '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 04:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:08:56 INFO - Using env: {'DISPLAY': ':0', 04:08:56 INFO - 'HOME': '/home/cltbld', 04:08:56 INFO - 'LANG': 'en_US.UTF-8', 04:08:56 INFO - 'LANGUAGE': 'en_US:en', 04:08:56 INFO - 'LOGNAME': 'cltbld', 04:08:56 INFO - 'MAIL': '/var/mail/cltbld', 04:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:56 INFO - 'MOZ_NO_REMOTE': '1', 04:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:56 INFO - 'NO_EM_RESTART': '1', 04:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:56 INFO - 'PWD': '/builds/slave/test', 04:08:56 INFO - 'SHELL': '/bin/bash', 04:08:56 INFO - 'SHLVL': '1', 04:08:56 INFO - 'TERM': 'linux', 04:08:56 INFO - 'TMOUT': '86400', 04:08:56 INFO - 'USER': 'cltbld', 04:08:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:56 INFO - '_': '/tools/buildbot/bin/python'} 04:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:57 INFO - Downloading/unpacking psutil>=3.1.1 04:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:58 INFO - Installing collected packages: psutil 04:08:58 INFO - Running setup.py install for psutil 04:08:58 INFO - building 'psutil._psutil_linux' extension 04:08:58 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 04:09:00 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 04:09:00 INFO - building 'psutil._psutil_posix' extension 04:09:00 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 04:09:01 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 04:09:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:01 INFO - Successfully installed psutil 04:09:01 INFO - Cleaning up... 04:09:01 INFO - Return code: 0 04:09:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1190a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337090>, '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 0x1337d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1331f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', '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 04:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:09:01 INFO - Using env: {'DISPLAY': ':0', 04:09:01 INFO - 'HOME': '/home/cltbld', 04:09:01 INFO - 'LANG': 'en_US.UTF-8', 04:09:01 INFO - 'LANGUAGE': 'en_US:en', 04:09:01 INFO - 'LOGNAME': 'cltbld', 04:09:01 INFO - 'MAIL': '/var/mail/cltbld', 04:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:01 INFO - 'MOZ_NO_REMOTE': '1', 04:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:01 INFO - 'NO_EM_RESTART': '1', 04:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:01 INFO - 'PWD': '/builds/slave/test', 04:09:01 INFO - 'SHELL': '/bin/bash', 04:09:01 INFO - 'SHLVL': '1', 04:09:01 INFO - 'TERM': 'linux', 04:09:01 INFO - 'TMOUT': '86400', 04:09:01 INFO - 'USER': 'cltbld', 04:09:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:01 INFO - '_': '/tools/buildbot/bin/python'} 04:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:09:02 INFO - Installing collected packages: mozsystemmonitor 04:09:02 INFO - Running setup.py install for mozsystemmonitor 04:09:03 INFO - Successfully installed mozsystemmonitor 04:09:03 INFO - Cleaning up... 04:09:03 INFO - Return code: 0 04:09:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:03 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 0xfc71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1190a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337090>, '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 0x1337d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1331f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', '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 04:09:03 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 04:09:03 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 04:09:03 INFO - Using env: {'DISPLAY': ':0', 04:09:03 INFO - 'HOME': '/home/cltbld', 04:09:03 INFO - 'LANG': 'en_US.UTF-8', 04:09:03 INFO - 'LANGUAGE': 'en_US:en', 04:09:03 INFO - 'LOGNAME': 'cltbld', 04:09:03 INFO - 'MAIL': '/var/mail/cltbld', 04:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:03 INFO - 'MOZ_NO_REMOTE': '1', 04:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:03 INFO - 'NO_EM_RESTART': '1', 04:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:03 INFO - 'PWD': '/builds/slave/test', 04:09:03 INFO - 'SHELL': '/bin/bash', 04:09:03 INFO - 'SHLVL': '1', 04:09:03 INFO - 'TERM': 'linux', 04:09:03 INFO - 'TMOUT': '86400', 04:09:03 INFO - 'USER': 'cltbld', 04:09:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:03 INFO - '_': '/tools/buildbot/bin/python'} 04:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:03 INFO - Downloading/unpacking jsonschema==2.5.1 04:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:04 INFO - warning: no files found matching '*.txt' 04:09:04 INFO - no previously-included directories found matching 'build' 04:09:04 INFO - no previously-included directories found matching 'dist' 04:09:04 INFO - no previously-included directories found matching '.git*' 04:09:04 INFO - Installing collected packages: jsonschema, functools32 04:09:04 INFO - Running setup.py install for functools32 04:09:04 INFO - warning: no files found matching '*.txt' 04:09:04 INFO - no previously-included directories found matching 'build' 04:09:04 INFO - no previously-included directories found matching 'dist' 04:09:04 INFO - no previously-included directories found matching '.git*' 04:09:04 INFO - Successfully installed jsonschema functools32 04:09:04 INFO - Cleaning up... 04:09:04 INFO - Return code: 0 04:09:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:09:04 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')]} 04:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:04 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')]} 04:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:04 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 0xfc71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1190a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337090>, '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 0x1337d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1331f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', '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 04:09:04 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 04:09:04 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 04:09:04 INFO - Using env: {'DISPLAY': ':0', 04:09:04 INFO - 'HOME': '/home/cltbld', 04:09:04 INFO - 'LANG': 'en_US.UTF-8', 04:09:04 INFO - 'LANGUAGE': 'en_US:en', 04:09:04 INFO - 'LOGNAME': 'cltbld', 04:09:04 INFO - 'MAIL': '/var/mail/cltbld', 04:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:04 INFO - 'MOZ_NO_REMOTE': '1', 04:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:04 INFO - 'NO_EM_RESTART': '1', 04:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:04 INFO - 'PWD': '/builds/slave/test', 04:09:04 INFO - 'SHELL': '/bin/bash', 04:09:04 INFO - 'SHLVL': '1', 04:09:04 INFO - 'TERM': 'linux', 04:09:04 INFO - 'TMOUT': '86400', 04:09:04 INFO - 'USER': 'cltbld', 04:09:04 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:04 INFO - '_': '/tools/buildbot/bin/python'} 04:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:09:05 INFO - Cleaning up... 04:09:05 INFO - Return code: 0 04:09:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09: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')]} 04:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:05 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 0xfc71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1190a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337090>, '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 0x1337d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1331f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', '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 04:09:05 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 04:09:05 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 04:09:05 INFO - Using env: {'DISPLAY': ':0', 04:09:05 INFO - 'HOME': '/home/cltbld', 04:09:05 INFO - 'LANG': 'en_US.UTF-8', 04:09:05 INFO - 'LANGUAGE': 'en_US:en', 04:09:05 INFO - 'LOGNAME': 'cltbld', 04:09:05 INFO - 'MAIL': '/var/mail/cltbld', 04:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:05 INFO - 'MOZ_NO_REMOTE': '1', 04:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:05 INFO - 'NO_EM_RESTART': '1', 04:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:05 INFO - 'PWD': '/builds/slave/test', 04:09:05 INFO - 'SHELL': '/bin/bash', 04:09:05 INFO - 'SHLVL': '1', 04:09:05 INFO - 'TERM': 'linux', 04:09:05 INFO - 'TMOUT': '86400', 04:09:05 INFO - 'USER': 'cltbld', 04:09:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:05 INFO - '_': '/tools/buildbot/bin/python'} 04:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:05 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:06 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:06 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 04:09:06 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 04:09:06 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 04:09:06 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 04:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:06 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 04:09:06 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 04:09:06 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 04:09:06 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 04:09:06 INFO - Downloading docopt-0.6.1.tar.gz 04:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:07 INFO - Running setup.py install for blobuploader 04:09:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:07 INFO - Running setup.py install for requests 04:09:07 INFO - Running setup.py install for docopt 04:09:07 INFO - Successfully installed blobuploader requests docopt 04:09:07 INFO - Cleaning up... 04:09:07 INFO - Return code: 0 04:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:07 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 0xfc71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1190a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337090>, '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 0x1337d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1331f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', '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 04:09:07 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 04:09:07 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 04:09:07 INFO - Using env: {'DISPLAY': ':0', 04:09:07 INFO - 'HOME': '/home/cltbld', 04:09:07 INFO - 'LANG': 'en_US.UTF-8', 04:09:07 INFO - 'LANGUAGE': 'en_US:en', 04:09:07 INFO - 'LOGNAME': 'cltbld', 04:09:07 INFO - 'MAIL': '/var/mail/cltbld', 04:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:07 INFO - 'MOZ_NO_REMOTE': '1', 04:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:07 INFO - 'NO_EM_RESTART': '1', 04:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:07 INFO - 'PWD': '/builds/slave/test', 04:09:07 INFO - 'SHELL': '/bin/bash', 04:09:07 INFO - 'SHLVL': '1', 04:09:07 INFO - 'TERM': 'linux', 04:09:07 INFO - 'TMOUT': '86400', 04:09:07 INFO - 'USER': 'cltbld', 04:09:07 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:07 INFO - '_': '/tools/buildbot/bin/python'} 04:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:07 INFO - Running setup.py (path:/tmp/pip-1PCzd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:07 INFO - Running setup.py (path:/tmp/pip-drtzx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:07 INFO - Running setup.py (path:/tmp/pip-qiW5B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:08 INFO - Running setup.py (path:/tmp/pip-Cy77BP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:08 INFO - Running setup.py (path:/tmp/pip-Wzv6zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:08 INFO - Running setup.py (path:/tmp/pip-aOoczR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:08 INFO - Running setup.py (path:/tmp/pip-Ex2tL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:08 INFO - Running setup.py (path:/tmp/pip-lEMB52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:08 INFO - Running setup.py (path:/tmp/pip-N6X65Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:08 INFO - Running setup.py (path:/tmp/pip-2gMHoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:08 INFO - Running setup.py (path:/tmp/pip-l6R75h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:08 INFO - Running setup.py (path:/tmp/pip-QyW1lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:08 INFO - Running setup.py (path:/tmp/pip-Sjbshq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:08 INFO - Running setup.py (path:/tmp/pip-iCsHJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:08 INFO - Running setup.py (path:/tmp/pip-3dbxhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:08 INFO - Running setup.py (path:/tmp/pip-fOT9qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:08 INFO - Running setup.py (path:/tmp/pip-n3OIku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:08 INFO - Running setup.py install for manifestparser 04:09:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:09 INFO - Running setup.py install for mozcrash 04:09:09 INFO - Running setup.py install for mozdebug 04:09:09 INFO - Running setup.py install for mozdevice 04:09:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:09 INFO - Running setup.py install for mozfile 04:09:09 INFO - Running setup.py install for mozhttpd 04:09:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:09 INFO - Running setup.py install for mozinfo 04:09:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:09 INFO - Running setup.py install for mozInstall 04:09:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:09 INFO - Running setup.py install for mozleak 04:09:09 INFO - Running setup.py install for mozlog 04:09:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:09 INFO - Running setup.py install for moznetwork 04:09:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:10 INFO - Running setup.py install for mozprocess 04:09:10 INFO - Running setup.py install for mozprofile 04:09:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:10 INFO - Running setup.py install for mozrunner 04:09:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:10 INFO - Running setup.py install for mozscreenshot 04:09:10 INFO - Running setup.py install for moztest 04:09:10 INFO - Running setup.py install for mozversion 04:09:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:10 INFO - Cleaning up... 04:09:10 INFO - Return code: 0 04:09:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:10 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')]} 04:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:10 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')]} 04:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:10 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 0xfc71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1190a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337090>, '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 0x1337d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1331f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', '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 04:09:10 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 04:09:10 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 04:09:10 INFO - Using env: {'DISPLAY': ':0', 04:09:10 INFO - 'HOME': '/home/cltbld', 04:09:10 INFO - 'LANG': 'en_US.UTF-8', 04:09:10 INFO - 'LANGUAGE': 'en_US:en', 04:09:10 INFO - 'LOGNAME': 'cltbld', 04:09:10 INFO - 'MAIL': '/var/mail/cltbld', 04:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:10 INFO - 'MOZ_NO_REMOTE': '1', 04:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:10 INFO - 'NO_EM_RESTART': '1', 04:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:10 INFO - 'PWD': '/builds/slave/test', 04:09:10 INFO - 'SHELL': '/bin/bash', 04:09:10 INFO - 'SHLVL': '1', 04:09:10 INFO - 'TERM': 'linux', 04:09:10 INFO - 'TMOUT': '86400', 04:09:10 INFO - 'USER': 'cltbld', 04:09:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:10 INFO - '_': '/tools/buildbot/bin/python'} 04:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:10 INFO - Running setup.py (path:/tmp/pip-uUFC4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:11 INFO - Running setup.py (path:/tmp/pip-q7jSyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:11 INFO - Running setup.py (path:/tmp/pip-jAa8Ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:11 INFO - Running setup.py (path:/tmp/pip-jnUabD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:11 INFO - Running setup.py (path:/tmp/pip-Z61m5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:11 INFO - Running setup.py (path:/tmp/pip-BtGaUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:11 INFO - Running setup.py (path:/tmp/pip-Evp3Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:11 INFO - Running setup.py (path:/tmp/pip-pJg3zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:11 INFO - Running setup.py (path:/tmp/pip-FP12l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:11 INFO - Running setup.py (path:/tmp/pip-MZLM76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:11 INFO - Running setup.py (path:/tmp/pip-78I_M8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:11 INFO - Running setup.py (path:/tmp/pip-776jtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:11 INFO - Running setup.py (path:/tmp/pip-C203Z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:11 INFO - Running setup.py (path:/tmp/pip-FPYPif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:11 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)) 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:11 INFO - Running setup.py (path:/tmp/pip-mtc6Rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:12 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)) 04:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:12 INFO - Running setup.py (path:/tmp/pip-EEXUhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:12 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)) 04:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:12 INFO - Running setup.py (path:/tmp/pip-aV5S5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:12 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)) 04:09:12 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)) 04:09:12 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)) 04:09:12 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)) 04:09:12 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)) 04:09:12 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)) 04:09:12 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)) 04:09:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:12 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 04:09:12 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 04:09:12 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 04:09:12 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 04:09:13 INFO - Downloading blessings-1.6.tar.gz 04:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:13 INFO - Installing collected packages: blessings 04:09:13 INFO - Running setup.py install for blessings 04:09:13 INFO - Successfully installed blessings 04:09:13 INFO - Cleaning up... 04:09:13 INFO - Return code: 0 04:09:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:13 INFO - Reading from file tmpfile_stdout 04:09:13 INFO - Current package versions: 04:09:13 INFO - argparse == 1.2.1 04:09:13 INFO - blessings == 1.6 04:09:13 INFO - blobuploader == 1.2.4 04:09:13 INFO - docopt == 0.6.1 04:09:13 INFO - functools32 == 3.2.3-2 04:09:13 INFO - jsonschema == 2.5.1 04:09:13 INFO - manifestparser == 1.1 04:09:13 INFO - mozInstall == 1.13 04:09:13 INFO - mozcrash == 1.0 04:09:13 INFO - mozdebug == 0.1 04:09:13 INFO - mozdevice == 0.51 04:09:13 INFO - mozfile == 1.2 04:09:13 INFO - mozhttpd == 0.7 04:09:13 INFO - mozinfo == 0.10 04:09:13 INFO - mozleak == 0.1 04:09:13 INFO - mozlog == 3.5 04:09:13 INFO - moznetwork == 0.27 04:09:13 INFO - mozprocess == 0.25 04:09:13 INFO - mozprofile == 0.28 04:09:13 INFO - mozrunner == 6.13 04:09:13 INFO - mozscreenshot == 0.1 04:09:13 INFO - mozsystemmonitor == 0.3 04:09:13 INFO - moztest == 0.8 04:09:13 INFO - mozversion == 1.4 04:09:13 INFO - psutil == 3.1.1 04:09:13 INFO - requests == 1.2.3 04:09:13 INFO - wsgiref == 0.1.2 04:09:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:13 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')]} 04:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:13 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')]} 04:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:13 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 0xfc71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1190a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337090>, '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 0x1337d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1331f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', '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 04:09:13 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 04:09:13 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 04:09:13 INFO - Using env: {'DISPLAY': ':0', 04:09:13 INFO - 'HOME': '/home/cltbld', 04:09:13 INFO - 'LANG': 'en_US.UTF-8', 04:09:13 INFO - 'LANGUAGE': 'en_US:en', 04:09:13 INFO - 'LOGNAME': 'cltbld', 04:09:13 INFO - 'MAIL': '/var/mail/cltbld', 04:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:13 INFO - 'MOZ_NO_REMOTE': '1', 04:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:13 INFO - 'NO_EM_RESTART': '1', 04:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:13 INFO - 'PWD': '/builds/slave/test', 04:09:13 INFO - 'SHELL': '/bin/bash', 04:09:13 INFO - 'SHLVL': '1', 04:09:13 INFO - 'TERM': 'linux', 04:09:13 INFO - 'TMOUT': '86400', 04:09:13 INFO - 'USER': 'cltbld', 04:09:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:13 INFO - '_': '/tools/buildbot/bin/python'} 04:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:13 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)) 04:09:13 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)) 04:09:13 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)) 04:09:13 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)) 04:09:13 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)) 04:09:13 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)) 04:09:13 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)) 04:09:13 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)) 04:09:13 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)) 04:09:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:09:13 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 04:09:13 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 04:09:13 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 04:09:13 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 04:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:09:15 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)) 04:09:15 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)) 04:09:15 INFO - Installing collected packages: simplejson 04:09:15 INFO - Running setup.py install for simplejson 04:09:15 INFO - building 'simplejson._speedups' extension 04:09:15 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 04:09:16 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 04:09:16 INFO - Successfully installed simplejson 04:09:16 INFO - Cleaning up... 04:09:16 INFO - Return code: 0 04:09:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09: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')]} 04:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1190a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337090>, '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 0x1337d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1331f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', '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 04:09: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'] in /builds/slave/test/build 04:09: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 04:09:16 INFO - Using env: {'DISPLAY': ':0', 04:09:16 INFO - 'HOME': '/home/cltbld', 04:09:16 INFO - 'LANG': 'en_US.UTF-8', 04:09:16 INFO - 'LANGUAGE': 'en_US:en', 04:09:16 INFO - 'LOGNAME': 'cltbld', 04:09:16 INFO - 'MAIL': '/var/mail/cltbld', 04:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:16 INFO - 'MOZ_NO_REMOTE': '1', 04:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:16 INFO - 'NO_EM_RESTART': '1', 04:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:16 INFO - 'PWD': '/builds/slave/test', 04:09:16 INFO - 'SHELL': '/bin/bash', 04:09:16 INFO - 'SHLVL': '1', 04:09:16 INFO - 'TERM': 'linux', 04:09:16 INFO - 'TMOUT': '86400', 04:09:16 INFO - 'USER': 'cltbld', 04:09:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:16 INFO - '_': '/tools/buildbot/bin/python'} 04:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:09:16 INFO - Cleaning up... 04:09:16 INFO - Return code: 0 04:09:16 INFO - Running post-action listener: _resource_record_post_action 04:09:16 INFO - Running post-action listener: _start_resource_monitoring 04:09:16 INFO - Starting resource monitoring. 04:09:16 INFO - [mozharness: 2017-09-20 11:09:16.444175Z] Finished create-virtualenv step (success) 04:09:16 INFO - [mozharness: 2017-09-20 11:09:16.445127Z] Running install step. 04:09:16 INFO - Running pre-action listener: _resource_record_pre_action 04:09:16 INFO - Running main action method: install 04:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:16 INFO - Reading from file tmpfile_stdout 04:09:16 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:16 INFO - Reading from file tmpfile_stdout 04:09:16 INFO - Output received: 04:09:16 INFO - Usage: mozinstall [options] installer 04:09:16 INFO - Options: 04:09:16 INFO - -h, --help show this help message and exit 04:09:16 INFO - -d DEST, --destination=DEST 04:09:16 INFO - Directory to install application into. [default: 04:09:16 INFO - "/builds/slave/test"] 04:09:16 INFO - --app=APP Application being installed. [default: firefox] 04:09:16 INFO - mkdir: /builds/slave/test/build/application 04:09:16 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'] 04:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:09:34 INFO - Reading from file tmpfile_stdout 04:09:34 INFO - Output received: 04:09:34 INFO - /builds/slave/test/build/application/firefox/firefox 04:09:34 INFO - Running post-action listener: _resource_record_post_action 04:09:34 INFO - [mozharness: 2017-09-20 11:09:34.403317Z] Finished install step (success) 04:09:34 INFO - [mozharness: 2017-09-20 11:09:34.403656Z] Running setup-mitmproxy step. 04:09:34 INFO - Running pre-action listener: _resource_record_pre_action 04:09:34 INFO - Running main action method: setup_mitmproxy 04:09:34 INFO - Skipping: mitmproxy is not required 04:09:34 INFO - Running post-action listener: _resource_record_post_action 04:09:34 INFO - [mozharness: 2017-09-20 11:09:34.405380Z] Finished setup-mitmproxy step (success) 04:09:34 INFO - [mozharness: 2017-09-20 11:09:34.405576Z] Running run-tests step. 04:09:34 INFO - Running pre-action listener: _resource_record_pre_action 04:09:34 INFO - Running pre-action listener: _set_gcov_prefix 04:09:34 INFO - Running main action method: run_tests 04:09:34 WARNING - Try message not found. 04:09:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:34 INFO - Python 2.7.3 04:09:34 INFO - Return code: 0 04:09:34 INFO - grabbing minidump binary from tooltool 04:09:34 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')]} 04:09:34 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 0x1337090>, '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 0x1337d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1331f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:34 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 04:09:34 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 04:09:34 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 04:09:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:34 INFO - Return code: 0 04:09:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:09:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:34 INFO - ENV: RUST_BACKTRACE is now full 04:09:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:09:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:34 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/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 04:09:34 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/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 04:09:34 INFO - Using env: {'DISPLAY': ':0', 04:09:34 INFO - 'HOME': '/home/cltbld', 04:09:34 INFO - 'LANG': 'en_US.UTF-8', 04:09:34 INFO - 'LANGUAGE': 'en_US:en', 04:09:34 INFO - 'LOGNAME': 'cltbld', 04:09:34 INFO - 'MAIL': '/var/mail/cltbld', 04:09:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:34 INFO - 'MOZ_NO_REMOTE': '1', 04:09:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:34 INFO - 'NO_EM_RESTART': '1', 04:09:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:34 INFO - 'PWD': '/builds/slave/test', 04:09:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:34 INFO - 'RUST_BACKTRACE': 'full', 04:09:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:09:34 INFO - 'SHELL': '/bin/bash', 04:09:34 INFO - 'SHLVL': '1', 04:09:34 INFO - 'TERM': 'linux', 04:09:34 INFO - 'TMOUT': '86400', 04:09:34 INFO - 'USER': 'cltbld', 04:09:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:34 INFO - '_': '/tools/buildbot/bin/python'} 04:09:34 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/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 04:09:35 INFO - mozversion application_buildid: 20170920094823 04:09:35 INFO - mozversion application_changeset: a20de99fa3c1ba6287fe47d493a859a4e95120b0 04:09:35 INFO - mozversion application_display_name: Nightly 04:09:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:35 INFO - mozversion application_name: Firefox 04:09:35 INFO - mozversion application_remotingname: firefox 04:09:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:09:35 INFO - mozversion application_vendor: Mozilla 04:09:35 INFO - mozversion application_version: 57.0a1 04:09:35 INFO - mozversion platform_buildid: 20170920094823 04:09:35 INFO - mozversion platform_changeset: a20de99fa3c1ba6287fe47d493a859a4e95120b0 04:09:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:09:35 INFO - mozversion platform_version: 57.0a1 04:09:35 INFO - using testdate: 1505905775 04:09:35 INFO - actual date: 1505905775 04:09:35 INFO - starting webserver on 'localhost:37594' 04:09:35 INFO - SUITE-START | Running 2 tests 04:09:35 INFO - TEST-START | dromaeo_css 04:09:35 INFO - Initialising browser for dromaeo_css test... 04:09:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37594/getInfo.html -profile /tmp/tmppU7LNo/profile 04:09:35 INFO - TEST-INFO | started process 3566 (/builds/slave/test/build/application/firefox/firefox http://localhost:37594/getInfo.html) 04:09:43 INFO - TEST-INFO | 3566: exit 0 04:09:43 INFO - Browser initialized. 04:09:43 INFO - Running cycle 1/1 for dromaeo_css test... 04:09:43 INFO - Using env: {'DISPLAY': ':0', 04:09:43 INFO - 'HOME': '/home/cltbld', 04:09:43 INFO - 'JSGC_DISABLE_POISONING': '1', 04:09:43 INFO - 'LANG': 'en_US.UTF-8', 04:09:43 INFO - 'LANGUAGE': 'en_US:en', 04:09:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:09:43 INFO - 'LOGNAME': 'cltbld', 04:09:43 INFO - 'MAIL': '/var/mail/cltbld', 04:09:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:43 INFO - 'MOZ_CRASHREPORTER': '1', 04:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:09:43 INFO - 'MOZ_NO_REMOTE': '1', 04:09:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:43 INFO - 'NO_EM_RESTART': '1', 04:09:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:43 INFO - 'PWD': '/builds/slave/test', 04:09:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:43 INFO - 'RUST_BACKTRACE': 'full', 04:09:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:09:43 INFO - 'SHELL': '/bin/bash', 04:09:43 INFO - 'SHLVL': '1', 04:09:43 INFO - 'TERM': 'linux', 04:09:43 INFO - 'TMOUT': '86400', 04:09:43 INFO - 'USER': 'cltbld', 04:09:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:43 INFO - '_': '/tools/buildbot/bin/python'} 04:09:43 INFO - TEST-INFO | started process 3804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppU7LNo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:44 INFO - PID 3804 | 04:09:44 INFO - PID 3804 | (/builds/slave/test/build/application/firefox/firefox:3856): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:09:44 INFO - PID 3804 | 04:09:54 INFO - PID 3804 | RSS: Main: 147324928 04:09:54 INFO - PID 3804 | 04:12:52 INFO - PID 3804 | Cycle 1(1): loaded http://localhost:37594/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37594/tests/dromaeo/cssquery-ext.html) 04:12:53 INFO - PID 3804 | RSS: Main: 148721664 04:12:53 INFO - PID 3804 | 04:15:55 INFO - PID 3804 | Cycle 1(1): loaded http://localhost:37594/tests/dromaeo/cssquery-ext.html (next: http://localhost:37594/tests/dromaeo/cssquery-jquery.html) 04:15:55 INFO - PID 3804 | RSS: Main: 149098496 04:15:55 INFO - PID 3804 | 04:18:57 INFO - PID 3804 | Cycle 1(1): loaded http://localhost:37594/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37594/tests/dromaeo/cssquery-mootools.html) 04:18:58 INFO - PID 3804 | RSS: Main: 150638592 04:18:58 INFO - PID 3804 | 04:21:59 INFO - PID 3804 | Cycle 1(1): loaded http://localhost:37594/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37594/tests/dromaeo/cssquery-prototype.html) 04:22:00 INFO - PID 3804 | RSS: Main: 147791872 04:22:00 INFO - PID 3804 | 04:25:03 INFO - PID 3804 | Cycle 1(1): loaded http://localhost:37594/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37594/tests/dromaeo/cssquery-yui.html) 04:25:04 INFO - PID 3804 | RSS: Main: 150507520 04:25:04 INFO - PID 3804 | 04:28:05 INFO - PID 3804 | Cycle 1(1): loaded http://localhost:37594/tests/dromaeo/cssquery-yui.html (next: http://localhost:37594/tests/dromaeo/cssquery-dojo.html) 04:28:05 INFO - PID 3804 | RSS: Main: 153190400 04:28:05 INFO - PID 3804 | 04:28:05 INFO - PID 3804 | __start_tp_report 04:28:05 INFO - PID 3804 | _x_x_mozilla_page_load 04:28:05 INFO - PID 3804 | _x_x_mozilla_page_load_details 04:28:05 INFO - PID 3804 | |i|pagename|runs| 04:28:05 INFO - PID 3804 | |0;dojo.html;3888.3195440797854;3893.98053009735;3909.980450097749;3914.980425097874;3919.6864250859935;6327;6347.079673447347;6384.872302553946;6412;6445.742170313182;6410.391012853772;6416.839579010527;6421.068945002972;6459.5478316517865;6465.8706825863455;5616.269884914956;5704.11586204137;5745.770169193248;5751.65490070595;5822.068469044953;5776.249087618604;5803;5821.126830975345;5832.416758324176;5833.037548804442;5786.826395208151;5798.130280457944;5860.443257890493;5867.55993300502;5898.1447690084915;5606.6636001840025;5722.570807189478;5722.856928576777;5731.484166425;5757.568182386338;5714.914276285859;5738.254026976467;5806.767729290823;5814.127880817869;5824.854378640525;6373.936260637381;6400.167978162855;6419.422251997343;6457.999010153434;6485.54601177913;6915.861682766316;6938.479614028968;6957.199922008983;6983.89524157138;7024.981377700205;6931.168259808805;7041;7044.823879403005;7054.92945070553;7059.294070592951;6444.581102228387;6471.061696054093;6480.287168411471;6545.312742162052;6575.572587781827;7047.612381319077;7112.466565007645;7139.535930164523;7144.749933752294;7167.283271672791;6755.1556055493065;6837.897431538531;6852.486063545254;6853.211880633691;6917.412019978257;7025.40284075849;7037.22590515043;7041.3310735480045;7045.612491313027;7047.330503602149;6898.793036208922;6941.7223311068;6950.895736563854;6992.370686638227;7028.964855175692;6798.830029249309;6931.826704332432;6968;7041.4718896082995;7053.823654408681;5008.1486147355035;5033.421156566968;5038.874028149326;5040.1179793535985;5043.142665746832;4577.22187228172;4590.655700822452;4632;4639.002614437912;4653.046125544255;6438.806835794933;6441.291457939623;6450.41946224842;6528.249251336062;6542.3130571290285;6930.48021398387;6972.721091156398;7005.964970175219;7008.159020917523;7053.188883278489;6449.32282110381;6489.059086432441;6494.285628580852;6500.544961852719;6513.511486638521;5564.360098588633;5571.721413929287;5655.4344565543115;5671.688057156814;5678.744456499468;7052.788416347517;7155.534890232118;7169.96415017932;7185.137783466018;7231.421486281085;6975.651217439209;6985.965070174617;7021.508494405547;7027.086478757728;7030.367266945999;7158.821029474305;7163.31948464895;7241.710331586678;7250.166230883516;7252.202257751537;6828.180618325634;6853;6861.2109607393795;6894.931285650732;6946;6934.341237582422;7003.299670032956;7019.262977387505;7022.508424410242;7036.683349249399;6711.966440167963;6726.596404215763;6737.225219099866;6753.088333074972;6820.965895170492;6601;6735.4611631070375;6739.797806065826;6799.796006119825;6824.454043676593;6578.144841170809;6742.393184613408;6760.830979225559;6761.594304341756;6768.018637297466;6756.966215168893;6770.187577490733;6797.422219111431;6844.452443804584;6861.039454476278;6442.710078046405;6503.122078519339;6535.705893234721;6536.967315163584;6547.9672601636685 04:28:05 INFO - PID 3804 | |1;ext.html;941.576290669199;950.6577632052459;979.1481411172281;1005.4972513743127;1006.6979906028195;43846;44626.776866115666;44694.776526117326;44723;44748.105037899266;42103.36844947328;42107;42130.36804447936;42168.36747448791;42413.57586424135;7686.884696729568;7765.339946104588;7779.922200777976;7804.453688241825;7837.960810195941;7746.302832745052;7821.921780782176;7833.255840695153;7843.764687059397;7855.8821617675785;8016.158303378149;8165.142660020701;8167.264946154844;8177.264046235838;8184.877226841572;8049.839003219932;8128.59357032149;8134.064582572962;8140.796480088015;8344.41589088764;8381.874271885927;8468.364872634515;8468.491890486528;8502.532360720157;8503.447275927045;40284;40514;40612;40677.18645627071;40776.59223407787;3700.85196592136;3720.683741881943;3721.7580857244193;3736.75711078779;3737.4206997915367;32396.190095247573;32580.511292330633;32629;32635.83682081598;32677.673223267702;5369.463053694639;5390.0836857734275;5412.91880621791;5449.700266485342;5471.23402723619;226016;226617;226837.99999999834;226936;227939;52769.2084618731;52868.73565632147;52872.47127528753;52878;52935.470645293055;54886.72556637191;54974.17538736922;55070.72464637651;55270;55338;16842.663146736995;17234.482965511055;17329.48011559655;17339;17391.65216695659;14179.291035448186;14264.714705705828;14265.42938282457;14277.78583321251;14305.57083287503;15006.62483437901;15157;15180.089194648357;15198.240087995557;15304.923475382551;6166.414190651881;6223.0397424811035;6242.843928901813;6257.5932564383165;6311.526635502356;1061.9522121504551;1084.7505073833063;1090.7545802194443;1094.4363652718855;1099.2140619457127;24964.87517562437;25106.748932510807;25228.369290767878;25475.61786573203;25540.489190216093;1177.6937996121071;1198.2870192235605;1202.0383693045703;1202.7714734200474;1208.1361826294242;13267.668308292177;13268.668283292802;13346.733065338638;13387.330633468287;13410.195388276734;282971;284306;284667;284833;285009.5749521239;57780.422195778345;57986.420135798944;58042.12936805951;58425;62601.37398626046;1486.8067151270266;1499.392745937897;1501.714674211918;1521.9619509512352;1523.413485807972;30057.69942300549;30066.549001764553;30096.398072038875;30144;30234.395312094075;41212;41300;41320.38019429771;41353.379699303936;41453.1709365817;247847;248035;249009;249897;250458;35288.82355588206;35409.760658376836;35425;35543.28913421769;35578;44813.551864482244;46166.30750538812;46618.13527458864;46806.297905530766;46890.06219875652;33986.32027359489;34199.487007694406;34343.48484772781;34585.827070864485;34958.30083398369;33686;34138.65861341355;34196.48705269373;34661.48007779835;34733.826330868185;38663.806680967544;40126.59873401229;40172.598274016884;40348.193036138524;40693.79653101716;33009.66990330066;33246.16884577905;33489.497657534666;33500;33874.49188262129;25021.12426065079;25125.497490050464;25131.49737005286;25206.74793252044;25419.237422877344 04:28:05 INFO - PID 3804 | |2;jquery.html;588.4586180713745;614.9262088549375;617.9474744646704;618.2025187508115;618.6875627807956;22965.77034229657;23665.881670591643;23795.881020594872;23798.16706415276;23838.76161238387;24441.75558244417;26342.868285658544;26459.338516537096;26589.202323930313;26635.733642663567;6798;6952.374286314231;6962;6962.1297337832775;6969.6166710830885;6433.22801263849;6682.298358672342;6812.523123381366;6908.240093589701;6913.4123599494105;6671.833204169886;6678.76624318149;6680.365365290289;6682.599044057348;6686.0305255737885;6666.666666666696;6675.198976122872;6697.2967838377;6698.83252918676;6699.933000670004;6105.725242364104;6204.565680402374;6363.331850155713;6393.680315984182;6400.295967443624;30824;31124.53313200304;31243.37513249745;31325.373492530023;31420.21449463759;2201.7137772089686;2222.4554984028855;2226.142934970032;2238.992453395962;2245.090738251011;20724.48188795277;20946;21305.467363315885;21584.24455144078;21783.67324490134;2508.761667641571;2515.5975043993058;2570.0233911113846;2629.0272599138443;2651.907183248577;139700;145995;153022.9999999989;159332.20333898257;159713;15550.300236489385;15827;15979.443289073692;15995.60010999711;16169.191540423168;25528.617070743952;25555.36111597188;25564.744352556238;25603.487930241292;25635.615465768027;10465.37207767521;10532;10565.04914557678;10604.681859544226;10653.73365665849;9522;9558.90441095594;9589.472579008221;9628.71113866585;9665;9815.607375704893;10033.849492257623;10138.138258248131;10236.846447303296;10336.793264134676;2948.7346138847606;2996.9850150749107;3003.339265361617;3012.9002913936692;3031.10582378199;1037.1702637889657;1038.901304376083;1046.199657262195;1049.9107575855985;1051.805415998043;21042;21886.23398181056;22032.88983555104;22151.667724984138;22263;1115.4199816095747;1120.0535547462382;1123.3652986062848;1123.702218911989;1124.966251012471;11903.345316007702;12261.080418968435;12266.81599776004;12283.385830708428;12372.948299394653;600880;601517;604320;611249;623606;133499;133820.3308983449;134914;135278.3236083833;137198;1119.1158984402393;1211.4608998995539;1215.295128825279;1228.2384921348641;1271.6566527037833;22776.562943628636;22888.96999634987;23056.04023658008;23147.189848355225;23314;60683.39316606778;60834;61020.694896527006;61205.69397153164;61493.38506614877;73710;74754.62622686852;76929.23070769444;77774;77931.61034194793;15810.60473488172;15838.68322633564;15980.760288595447;16013.759793602872;16064.839351606803;25492.49015019652;25539.36151596225;25628.74371256338;25758.227253182435;25998.87000564985;20041.298554551104;20233.69649455289;20477.590448190655;20539.79460205379;20713.17147314151;18192.272309108015;18227.726584101514;18420.07899605041;18651.720224196375;18936.95846728388;20801.1679532817;20890;21079.57840843205;21425.25011624648;21454.141834326452;15773.842261577238;15822.920885395499;15887.920560397124;15910.840891590937;15931.283092260644;20183.899080504503;20265.189392424138;20473.795262047188;20614.793852061288;20839 04:28:05 INFO - PID 3804 | |3;mootools.html;1423.5658124272097;1501.1818558885402;1505.6536996490806;1522.9390824367026;1523.542937118864;16653.916730416346;17287.30850765968;17292.221850016766;17301.74047389287;17336.739948900762;16819.747703784422;16932.068736219502;16994.83005169948;16996.575085622833;17005.149742512887;2659.8670066496693;2707.4991126641635;2738.438620082878;2739.8356098634044;2743.3827388837453;2651.4431969286475;2707.1743118348895;2708.634334364855;2709.376843326036;2716.4702882937836;2757.8621068946572;2781.1100447856593;2791.4138031013513;2812.8874845006176;2815.5776633504934;2682.0746842339363;2716.253030416641;2721.102036328007;2724.6594175728032;2727.6317697110935;2447.889844956981;2489.9004039838383;2493.3268017635137;2495.75042495749;2516.119358224625;13411.798823017663;13836.654083647889;13871.029027968047;15962;16072.357105715757;8158.061822890384;8412.32701383894;8417.410781245255;8419.452735572168;8434.325253979729;5263.6578622389425;5528.391876893538;5567.359753628344;5634.661920284796;5687.687177205252;2011.4669612552684;2026.2097781865084;2056.7017782421467;2064.298138632872;2083.364573804989;29804.70195298041;29903.700962990308;29954.400911981855;29983.250418739488;30000.849995749883;7201.991721159042;7357.77926662201;7409.110906691231;7548.245175482408;7588.392928565812;19251.4224573263;22412.66381004286;22516.774832251795;22552.887235563718;22580.20969266068;8311;8521.786955326166;8531.530765807816;8560.657573696983;8570.571471426403;7421.517601355895;7446.85106297871;7460.701571937062;7560.432967527458;7673.654685539164;5392.811251606175;5518;5530.529904958124;5545.500904918576;5584.022796010682;1430.7210094031773;1448.1745405118982;1454.9563513094624;1470.7279153356662;1477.793108964746;921.9308551858637;947.7535840681335;956.6030097509595;960.5917485068818;962.8796400449944;8080.39397045224;8139.4709343892455;8178.631961561625;8185.3042491387705;8225.424220304641;781.7811012916279;787.649495974286;793.6587267474926;795.9840803183904;796.6853093028221;5323.893522129536;5614.1859430382365;5823.4467725566;5879.176915231871;5995.760169593254;23677.408064798517;24639.753602464105;24657.5068498629;24717;24858.50282994366;23208.53582928332;24760.13339533108;24811.13161039355;24812.37969050788;24871;12456.377181140906;12483.313417761929;12589.685257868627;12602.87397126017;12614.117011809269;8910.777230569287;9353;9694.75763105928;9714.174295184706;9726.221902247944;20933.476663082936;21041.789582103982;21189.152433902473;21421.46446338854;21916.561668766215;21519.892400537898;22014;22144.33566992993;22186.44533886666;22191.667124993462;12192.08559358034;12387.69030774238;12399.442025108712;12421.068419868727;12440.315782632042;15299.23503824782;15524.14617196065;15583.610409739847;15627.843721563093;15704.29330680145;12223.266604003788;12536.874631253935;12787.808182877077;13017;13117.34413279313;12347.69130771738;12502.624921252376;12652.87347126517;12743.553975610808;12752.74494510123;11429;11502.769944601228;11525.596604119151;11578.247413918069;11585.88414115848;8462.19609137131;8508.446950948168;8509.659613615386;8555.786105347415;8629.223369896488;8446.28206602421;8580.528070955908;8628.094050124646;8730.65077396897;8812.2950163988 04:28:05 INFO - PID 3804 | |4;prototype.html;537.5135502370356;573.9397363276854;577.457190241173;579.4668904607757;583.5710752596841;6359.3640635936445;6376.202974628171;6398.552101352907;6431.549791514596;6448.548601597884;6238.906416403746;6250.062480631008;6269.122322874801;6272.905906411407;6324.462420694246;5138.7173705446185;5173.896522069556;5184.522411112834;5187.584993200535;5196.740162991854;5126.769295381698;5133.12736834739;5174.628723388305;5179.715115668637;5202.843914682547;5002.399712034561;5127.33344665193;5157.5358217760395;5207.166853303473;5225.451327610604;5214.374275087014;5226.08543504887;5243.318368612094;5255.76349064293;5257.501612040588;4833.927491087637;4910.754462276907;4917.606591472673;4951.207806750938;4957.3059771632;6210.441060304594;6226.412264872429;6258.1551490548645;6258.468030217391;6276.560640755149;6176.783812566584;6179.69101544921;6191.349908259613;6223.782167624111;6231.688415579203;6736.541162475661;6736.898946515757;6749.966250168767;6764.086848275519;6783.72865085396;5527.198556209327;5540.418256083093;5544.889102217933;5549.916751248735;5568.1091025435735;6801.93198068018;6866.622335771531;6943.479239057091;6976.7209311627985;7040.155181378216;5637;5681.57388195887;5694.231278777394;5723.828285151452;5738.655680659173;5817.912731309034;5830.737616807254;5843.211166492554;5850.5904586678525;5854.18041474194;6187.566870319034;6199.690015499207;6217.533684973645;6218.471429928507;6225.221847269091;6673.299303573055;6721.93278067213;6747.325267473311;6752.291009444036;6795.490338224653;1954.6872500399868;1964.838677454817;1965.1353404501974;1978.0999645161417;1988.8508361872916;1464.6850927050734;1485.695432436348;1502.6168327076525;1546.1650708617447;1550.449590395416;6047.758089676364;6183.505319574423;6194.628322300677;6206.875862482725;6229.563930524911;6657.700403481855;6683.799486015428;6762.932370676329;6764.526483146231;6779.762708305284;6095.481884039907;6095.878082438415;6162.137300777895;6250.656213908279;6261.154744109578;3515.33208690348;3547.4324108142573;3548.520949671813;3551.911202219965;3561.1453251220037;6815.284395138439;6895.275996020346;6990.335918087773;7030.191527974246;7037.331453511908;6918.619475928772;6928.584284942919;6932.861342773217;7065.82335441618;7066.470014748915;6841.760538381332;6875.862482750217;6924.861502769916;6933.237343892168;7023.682184878978;6685.832854178684;6699.732010719712;6712.597244165366;6739.966300168468;6752.291009444134;6714;6715.93284067153;6758.391744742997;6768.526203165731;6829.89755153683;6809.148856392951;6875.346842049998;6971.6862741175755;7019.157701075904;7039.788806335818;5191.351081114861;5199;5237.512181713808;5239.05696974533;5256.132738098171;6642.90035649456;6761.594304341756;6818.488613354118;6835.4189893859575;6884.277150899284;6608.4382827458285;6613.016095171333;6652.73389064432;6669.166354205724;6701.229358623626;6523.510736694861;6526.836829079311;6587.604743715392;6604;6610.331266147142;6492.415682588589;6511;6524.9673751630935;6566.179227596551;6575.27671956094;6595.703193356407;6682.131322927989;6714.321419645089;6716.227633821977;6765.695543700644;6451.387118223761;6469.5794773339585;6482.935170648233;6516.478681705547;6533.118029066015 04:28:05 INFO - PID 3804 | |5;yui.html;927.6938610258616;970.5680971967478;971.2618410008391;981.283662926064;1009.8737657792776;18828.811711882878;19370.612587748237;19424.320148794795;19440.513987150294;19444.70832937507;18241.7263741044;18806.52983675409;18881.811181888177;19040.33358832441;19162.90418547909;1038.9532471038804;1065.211743309949;1066.5787014129414;1066.6426747039711;1068.2682362581618;1047.9371237725722;1081.0648788797712;1085.7502774361901;1085.8371244313378;1085.940273284969;1145.3357052909334;1156.242661057009;1156.7512984708287;1157.213095095335;1158.9188756787028;1068.8022715797601;1117.8490903727975;1140.3158105136893;1144.3820337018;1154.3247200387784;823.1480417767582;825.8059356051323;827.0530242871878;827.6730691376872;828.3787159630277;19444.611107777906;19636.214551417925;19650.115744791517;19687.21251149952;19747.40757777269;22446.88776556123;23360.532789344117;23415.297541073796;23415.88292058546;23451.88274058636;17312.567185820455;17877.553061173574;18023.459296221135;18179;18179.818201817943;3823.6558709715982;3844.1158533537164;3846.653801157909;3854.6530812227033;3856.325143099946;160254.19872900678;160653.19673401676;162682.9999999988;163379;164775;17997.19012644408;18046.2781488739;18189.81810181881;18293.451196464128;18403.263869445072;33560.1609959753;33700.49449258263;33701.32597348088;33755.66244337525;34112;8753.562321884008;8822.691205807765;8837.779055523535;8844.690435834715;8845.336599754915;4734.100520901018;4774.474807771142;4904.705717656952;4915.87710307238;4918.311436398907;6035.185249991283;6152.969235153885;6171.382861713792;6174.320824709278;6181.8454538636;1106.1537923488538;1112.8108221602347;1132.17351333527;1135.0579019413867;1137.6643890052455;724.5181954000531;737.4800765460337;748.5284270909401;749.1160430691835;764.1556080530934;12980.286084265268;13129;13300.135491193041;13976.650583735285;14109.223992680501;734.2987446988113;742.9257074292527;747.6523416611193;754.7169811320755;762.954222746637;6240.500759939285;6243.313235544087;6263.185785847811;6272.902242107613;6275.937240627627;160512;160664;161899;164386;166096;136616;136914;137382;140925.29537352247;142144;116628;118069;118334.4083279578;118637.8136218644;118947.8105218954;11366;11463.135361178805;11558.306501609593;11623.418829058683;11726.179167458196;54305;54384.184237235684;54918.725406372716;56032.43967560272;57618.71190644187;69607;72154;72177.27822721706;72296.27703722895;72707.09393591003;15966.760498592763;16100.597485062966;16117.113558754381;16175.838241617434;16263.918680406523;16824.663506729554;16852.57868553247;16938.830611693724;17118.48644540666;17140.228689708743;16369;16439.09584972838;16439.67120657604;16441.342346306013;16565.337386504405;14426.134431934117;14708.852911470749;14794.408223670933;14804.925975370053;14817.110973341203;13854.37655305534;13920.164790112625;13968.231747253592;14029.579112626638;14172.362243698852;12608.92824109961;12783.80824287655;13001.349932503148;13029.934850325688;13165.078444508792;12712.74574508523;12849.550265740654;12918.483260669844;12962.675933101747;13121.147125436815 04:28:05 INFO - PID 3804 | __end_tp_report 04:28:05 INFO - PID 3804 | __start_cc_report 04:28:05 INFO - PID 3804 | _x_x_mozilla_cycle_collect,269 04:28:05 INFO - PID 3804 | __end_cc_report 04:28:05 INFO - PID 3804 | __startTimestamp1505906885812__endTimestamp 04:28:05 INFO - PID 3804 | 04:28:05 INFO - PID 3804 | ------- Summary: start ------- 04:28:05 INFO - PID 3804 | Number of tests: 6 04:28:05 INFO - PID 3804 | 04:28:05 INFO - PID 3804 | [#0] dojo.html Cycles:165 Average:6408.40 Median:6711.97 stddev:770.32 (11.5%) stddev-sans-first:746.88 04:28:05 INFO - PID 3804 | Values: 3888.3 3894.0 3910.0 3915.0 3919.7 6327.0 6347.1 6384.9 6412.0 6445.7 6410.4 6416.8 6421.1 6459.5 6465.9 5616.3 5704.1 5745.8 5751.7 5822.1 5776.2 5803.0 5821.1 5832.4 5833.0 5786.8 5798.1 5860.4 5867.6 5898.1 5606.7 5722.6 5722.9 5731.5 5757.6 5714.9 5738.3 5806.8 5814.1 5824.9 6373.9 6400.2 6419.4 6458.0 6485.5 6915.9 6938.5 6957.2 6983.9 7025.0 6931.2 7041.0 7044.8 7054.9 7059.3 6444.6 6471.1 6480.3 6545.3 6575.6 7047.6 7112.5 7139.5 7144.7 7167.3 6755.2 6837.9 6852.5 6853.2 6917.4 7025.4 7037.2 7041.3 7045.6 7047.3 6898.8 6941.7 6950.9 6992.4 7029.0 6798.8 6931.8 6968.0 7041.5 7053.8 5008.1 5033.4 5038.9 5040.1 5043.1 4577.2 4590.7 4632.0 4639.0 4653.0 6438.8 6441.3 6450.4 6528.2 6542.3 6930.5 6972.7 7006.0 7008.2 7053.2 6449.3 6489.1 6494.3 6500.5 6513.5 5564.4 5571.7 5655.4 5671.7 5678.7 7052.8 7155.5 7170.0 7185.1 7231.4 6975.7 6986.0 7021.5 7027.1 7030.4 7158.8 7163.3 7241.7 7250.2 7252.2 6828.2 6853.0 6861.2 6894.9 6946.0 6934.3 7003.3 7019.3 7022.5 7036.7 6712.0 6726.6 6737.2 6753.1 6821.0 6601.0 6735.5 6739.8 6799.8 6824.5 6578.1 6742.4 6760.8 6761.6 6768.0 6757.0 6770.2 6797.4 6844.5 6861.0 6442.7 6503.1 6535.7 6537.0 6548.0 04:28:05 INFO - PID 3804 | 04:28:05 INFO - PID 3804 | [#1] ext.html Cycles:180 Average:43147.50 Median:35560.64 stddev:66181.11 (186.1%) stddev-sans-first:66290.89 04:28:05 INFO - PID 3804 | Values: 941.6 950.7 979.1 1005.5 1006.7 43846.0 44626.8 44694.8 44723.0 44748.1 42103.4 42107.0 42130.4 42168.4 42413.6 7686.9 7765.3 7779.9 7804.5 7838.0 7746.3 7821.9 7833.3 7843.8 7855.9 8016.2 8165.1 8167.3 8177.3 8184.9 8049.8 8128.6 8134.1 8140.8 8344.4 8381.9 8468.4 8468.5 8502.5 8503.4 40284.0 40514.0 40612.0 40677.2 40776.6 3700.9 3720.7 3721.8 3736.8 3737.4 32396.2 32580.5 32629.0 32635.8 32677.7 5369.5 5390.1 5412.9 5449.7 5471.2 226016.0 226617.0 226838.0 226936.0 227939.0 52769.2 52868.7 52872.5 52878.0 52935.5 54886.7 54974.2 55070.7 55270.0 55338.0 16842.7 17234.5 17329.5 17339.0 17391.7 14179.3 14264.7 14265.4 14277.8 14305.6 15006.6 15157.0 15180.1 15198.2 15304.9 6166.4 6223.0 6242.8 6257.6 6311.5 1062.0 1084.8 1090.8 1094.4 1099.2 24964.9 25106.7 25228.4 25475.6 25540.5 1177.7 1198.3 1202.0 1202.8 1208.1 13267.7 13268.7 13346.7 13387.3 13410.2 282971.0 284306.0 284667.0 284833.0 285009.6 57780.4 57986.4 58042.1 58425.0 62601.4 1486.8 1499.4 1501.7 1522.0 1523.4 30057.7 30066.5 30096.4 30144.0 30234.4 41212.0 41300.0 41320.4 41353.4 41453.2 247847.0 248035.0 249009.0 249897.0 250458.0 35288.8 35409.8 35425.0 35543.3 35578.0 44813.6 46166.3 46618.1 46806.3 46890.1 33986.3 34199.5 34343.5 34585.8 34958.3 33686.0 34138.7 34196.5 34661.5 34733.8 38663.8 40126.6 40172.6 40348.2 40693.8 33009.7 33246.2 33489.5 33500.0 33874.5 25021.1 25125.5 25131.5 25206.7 25419.2 04:28:05 INFO - PID 3804 | 04:28:05 INFO - PID 3804 | [#2] jquery.html Cycles:180 Average:40173.05 Median:22927.37 stddev:101781.70 (443.9%) stddev-sans-first:102023.83 04:28:05 INFO - PID 3804 | Values: 588.5 614.9 617.9 618.2 618.7 22965.8 23665.9 23795.9 23798.2 23838.8 24441.8 26342.9 26459.3 26589.2 26635.7 6798.0 6952.4 6962.0 6962.1 6969.6 6433.2 6682.3 6812.5 6908.2 6913.4 6671.8 6678.8 6680.4 6682.6 6686.0 6666.7 6675.2 6697.3 6698.8 6699.9 6105.7 6204.6 6363.3 6393.7 6400.3 30824.0 31124.5 31243.4 31325.4 31420.2 2201.7 2222.5 2226.1 2239.0 2245.1 20724.5 20946.0 21305.5 21584.2 21783.7 2508.8 2515.6 2570.0 2629.0 2651.9 139700.0 145995.0 153023.0 159332.2 159713.0 15550.3 15827.0 15979.4 15995.6 16169.2 25528.6 25555.4 25564.7 25603.5 25635.6 10465.4 10532.0 10565.0 10604.7 10653.7 9522.0 9558.9 9589.5 9628.7 9665.0 9815.6 10033.8 10138.1 10236.8 10336.8 2948.7 2997.0 3003.3 3012.9 3031.1 1037.2 1038.9 1046.2 1049.9 1051.8 21042.0 21886.2 22032.9 22151.7 22263.0 1115.4 1120.1 1123.4 1123.7 1125.0 11903.3 12261.1 12266.8 12283.4 12372.9 600880.0 601517.0 604320.0 611249.0 623606.0 133499.0 133820.3 134914.0 135278.3 137198.0 1119.1 1211.5 1215.3 1228.2 1271.7 22776.6 22889.0 23056.0 23147.2 23314.0 60683.4 60834.0 61020.7 61205.7 61493.4 73710.0 74754.6 76929.2 77774.0 77931.6 15810.6 15838.7 15980.8 16013.8 16064.8 25492.5 25539.4 25628.7 25758.2 25998.9 20041.3 20233.7 20477.6 20539.8 20713.2 18192.3 18227.7 18420.1 18651.7 18937.0 20801.2 20890.0 21079.6 21425.3 21454.1 15773.8 15822.9 15887.9 15910.8 15931.3 20183.9 20265.2 20473.8 20614.8 20839.0 04:28:05 INFO - PID 3804 | 04:28:05 INFO - PID 3804 | [#3] mootools.html Cycles:180 Average:10381.47 Median:2655.66 stddev:7726.01 (290.9%) stddev-sans-first:7718.37 04:28:05 INFO - PID 3804 | Values: 1423.6 1501.2 1505.7 1522.9 1523.5 16653.9 17287.3 17292.2 17301.7 17336.7 16819.7 16932.1 16994.8 16996.6 17005.1 2659.9 2707.5 2738.4 2739.8 2743.4 2651.4 2707.2 2708.6 2709.4 2716.5 2757.9 2781.1 2791.4 2812.9 2815.6 2682.1 2716.3 2721.1 2724.7 2727.6 2447.9 2489.9 2493.3 2495.8 2516.1 13411.8 13836.7 13871.0 15962.0 16072.4 8158.1 8412.3 8417.4 8419.5 8434.3 5263.7 5528.4 5567.4 5634.7 5687.7 2011.5 2026.2 2056.7 2064.3 2083.4 29804.7 29903.7 29954.4 29983.3 30000.8 7202.0 7357.8 7409.1 7548.2 7588.4 19251.4 22412.7 22516.8 22552.9 22580.2 8311.0 8521.8 8531.5 8560.7 8570.6 7421.5 7446.9 7460.7 7560.4 7673.7 5392.8 5518.0 5530.5 5545.5 5584.0 1430.7 1448.2 1455.0 1470.7 1477.8 921.9 947.8 956.6 960.6 962.9 8080.4 8139.5 8178.6 8185.3 8225.4 781.8 787.6 793.7 796.0 796.7 5323.9 5614.2 5823.4 5879.2 5995.8 23677.4 24639.8 24657.5 24717.0 24858.5 23208.5 24760.1 24811.1 24812.4 24871.0 12456.4 12483.3 12589.7 12602.9 12614.1 8910.8 9353.0 9694.8 9714.2 9726.2 20933.5 21041.8 21189.2 21421.5 21916.6 21519.9 22014.0 22144.3 22186.4 22191.7 12192.1 12387.7 12399.4 12421.1 12440.3 15299.2 15524.1 15583.6 15627.8 15704.3 12223.3 12536.9 12787.8 13017.0 13117.3 12347.7 12502.6 12652.9 12743.6 12752.7 11429.0 11502.8 11525.6 11578.2 11585.9 8462.2 8508.4 8509.7 8555.8 8629.2 8446.3 8580.5 8628.1 8730.7 8812.3 04:28:05 INFO - PID 3804 | 04:28:05 INFO - PID 3804 | [#4] prototype.html Cycles:180 Average:5760.09 Median:6265.14 stddev:1538.41 (24.6%) stddev-sans-first:1491.95 04:28:05 INFO - PID 3804 | Values: 537.5 573.9 577.5 579.5 583.6 6359.4 6376.2 6398.6 6431.5 6448.5 6238.9 6250.1 6269.1 6272.9 6324.5 5138.7 5173.9 5184.5 5187.6 5196.7 5126.8 5133.1 5174.6 5179.7 5202.8 5002.4 5127.3 5157.5 5207.2 5225.5 5214.4 5226.1 5243.3 5255.8 5257.5 4833.9 4910.8 4917.6 4951.2 4957.3 6210.4 6226.4 6258.2 6258.5 6276.6 6176.8 6179.7 6191.3 6223.8 6231.7 6736.5 6736.9 6750.0 6764.1 6783.7 5527.2 5540.4 5544.9 5549.9 5568.1 6801.9 6866.6 6943.5 6976.7 7040.2 5637.0 5681.6 5694.2 5723.8 5738.7 5817.9 5830.7 5843.2 5850.6 5854.2 6187.6 6199.7 6217.5 6218.5 6225.2 6673.3 6721.9 6747.3 6752.3 6795.5 1954.7 1964.8 1965.1 1978.1 1988.9 1464.7 1485.7 1502.6 1546.2 1550.4 6047.8 6183.5 6194.6 6206.9 6229.6 6657.7 6683.8 6762.9 6764.5 6779.8 6095.5 6095.9 6162.1 6250.7 6261.2 3515.3 3547.4 3548.5 3551.9 3561.1 6815.3 6895.3 6990.3 7030.2 7037.3 6918.6 6928.6 6932.9 7065.8 7066.5 6841.8 6875.9 6924.9 6933.2 7023.7 6685.8 6699.7 6712.6 6740.0 6752.3 6714.0 6715.9 6758.4 6768.5 6829.9 6809.1 6875.3 6971.7 7019.2 7039.8 5191.4 5199.0 5237.5 5239.1 5256.1 6642.9 6761.6 6818.5 6835.4 6884.3 6608.4 6613.0 6652.7 6669.2 6701.2 6523.5 6526.8 6587.6 6604.0 6610.3 6492.4 6511.0 6525.0 6566.2 6575.3 6595.7 6682.1 6714.3 6716.2 6765.7 6451.4 6469.6 6482.9 6516.5 6533.1 04:28:05 INFO - PID 3804 | 04:28:05 INFO - PID 3804 | [#5] yui.html Cycles:180 Average:28554.06 Median:17226.40 stddev:44366.61 (257.6%) stddev-sans-first:44442.58 04:28:05 INFO - PID 3804 | Values: 927.7 970.6 971.3 981.3 1009.9 18828.8 19370.6 19424.3 19440.5 19444.7 18241.7 18806.5 18881.8 19040.3 19162.9 1039.0 1065.2 1066.6 1066.6 1068.3 1047.9 1081.1 1085.8 1085.8 1085.9 1145.3 1156.2 1156.8 1157.2 1158.9 1068.8 1117.8 1140.3 1144.4 1154.3 823.1 825.8 827.1 827.7 828.4 19444.6 19636.2 19650.1 19687.2 19747.4 22446.9 23360.5 23415.3 23415.9 23451.9 17312.6 17877.6 18023.5 18179.0 18179.8 3823.7 3844.1 3846.7 3854.7 3856.3 160254.2 160653.2 162683.0 163379.0 164775.0 17997.2 18046.3 18189.8 18293.5 18403.3 33560.2 33700.5 33701.3 33755.7 34112.0 8753.6 8822.7 8837.8 8844.7 8845.3 4734.1 4774.5 4904.7 4915.9 4918.3 6035.2 6153.0 6171.4 6174.3 6181.8 1106.2 1112.8 1132.2 1135.1 1137.7 724.5 737.5 748.5 749.1 764.2 12980.3 13129.0 13300.1 13976.7 14109.2 734.3 742.9 747.7 754.7 763.0 6240.5 6243.3 6263.2 6272.9 6275.9 160512.0 160664.0 161899.0 164386.0 166096.0 136616.0 136914.0 137382.0 140925.3 142144.0 116628.0 118069.0 118334.4 118637.8 118947.8 11366.0 11463.1 11558.3 11623.4 11726.2 54305.0 54384.2 54918.7 56032.4 57618.7 69607.0 72154.0 72177.3 72296.3 72707.1 15966.8 16100.6 16117.1 16175.8 16263.9 16824.7 16852.6 16938.8 17118.5 17140.2 16369.0 16439.1 16439.7 16441.3 16565.3 14426.1 14708.9 14794.4 14804.9 14817.1 13854.4 13920.2 13968.2 14029.6 14172.4 12608.9 12783.8 13001.3 13029.9 13165.1 12712.7 12849.6 12918.5 12962.7 13121.1 04:28:05 INFO - PID 3804 | -------- Summary: end -------- 04:28:05 INFO - PID 3804 | 04:28:06 INFO - TEST-INFO | 3804: exit 0 04:28:06 INFO - TEST-OK | dromaeo_css | took 1111232ms 04:28:06 INFO - TEST-START | kraken 04:28:06 INFO - Initialising browser for kraken test... 04:28:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37594/getInfo.html -profile /tmp/tmpKRQWBq/profile 04:28:06 INFO - TEST-INFO | started process 4179 (/builds/slave/test/build/application/firefox/firefox http://localhost:37594/getInfo.html) 04:28:11 INFO - TEST-INFO | 4179: exit 0 04:28:11 INFO - Browser initialized. 04:28:11 INFO - Running cycle 1/1 for kraken test... 04:28:11 INFO - Using env: {'DISPLAY': ':0', 04:28:11 INFO - 'HOME': '/home/cltbld', 04:28:11 INFO - 'JSGC_DISABLE_POISONING': '1', 04:28:11 INFO - 'LANG': 'en_US.UTF-8', 04:28:11 INFO - 'LANGUAGE': 'en_US:en', 04:28:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:28:11 INFO - 'LOGNAME': 'cltbld', 04:28:11 INFO - 'MAIL': '/var/mail/cltbld', 04:28:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:28:11 INFO - 'MOZ_CRASHREPORTER': '1', 04:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:28:11 INFO - 'MOZ_NO_REMOTE': '1', 04:28:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:11 INFO - 'NO_EM_RESTART': '1', 04:28:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:11 INFO - 'PWD': '/builds/slave/test', 04:28:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:11 INFO - 'RUST_BACKTRACE': 'full', 04:28:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:28:11 INFO - 'SHELL': '/bin/bash', 04:28:11 INFO - 'SHLVL': '1', 04:28:11 INFO - 'TERM': 'linux', 04:28:11 INFO - 'TMOUT': '86400', 04:28:11 INFO - 'USER': 'cltbld', 04:28:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694', 04:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:11 INFO - '_': '/tools/buildbot/bin/python'} 04:28:11 INFO - TEST-INFO | started process 4416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKRQWBq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:12 INFO - PID 4416 | 04:28:12 INFO - PID 4416 | (/builds/slave/test/build/application/firefox/firefox:4466): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:28:12 INFO - PID 4416 | 04:28:22 INFO - PID 4416 | RSS: Main: 147611648 04:28:22 INFO - PID 4416 | 04:28:25 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37594/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:26 INFO - PID 4416 | RSS: Main: 152961024 04:28:26 INFO - PID 4416 | 04:28:28 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37594/tests/kraken/driver.html?testName=audio-dft) 04:28:29 INFO - PID 4416 | RSS: Main: 153227264 04:28:29 INFO - PID 4416 | 04:28:32 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37594/tests/kraken/driver.html?testName=audio-fft) 04:28:32 INFO - PID 4416 | RSS: Main: 150224896 04:28:32 INFO - PID 4416 | 04:28:35 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37594/tests/kraken/driver.html?testName=audio-oscillator) 04:28:35 INFO - PID 4416 | RSS: Main: 151244800 04:28:35 INFO - PID 4416 | 04:28:37 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37594/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:38 INFO - PID 4416 | RSS: Main: 150745088 04:28:38 INFO - PID 4416 | 04:28:41 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37594/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:41 INFO - PID 4416 | RSS: Main: 150646784 04:28:41 INFO - PID 4416 | 04:28:45 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37594/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:46 INFO - PID 4416 | RSS: Main: 151982080 04:28:46 INFO - PID 4416 | 04:28:49 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37594/tests/kraken/driver.html?testName=json-parse-financial) 04:28:49 INFO - PID 4416 | RSS: Main: 153702400 04:28:49 INFO - PID 4416 | 04:28:51 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37594/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:51 INFO - PID 4416 | RSS: Main: 154071040 04:28:51 INFO - PID 4416 | 04:28:53 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37594/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:53 INFO - PID 4416 | RSS: Main: 154062848 04:28:53 INFO - PID 4416 | 04:28:55 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37594/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:56 INFO - PID 4416 | RSS: Main: 150765568 04:28:56 INFO - PID 4416 | 04:28:59 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:59 INFO - PID 4416 | RSS: Main: 151257088 04:28:59 INFO - PID 4416 | 04:29:02 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:02 INFO - PID 4416 | RSS: Main: 151572480 04:29:02 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | Cycle 1(1): loaded http://localhost:37594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37594/tests/kraken/driver.html?testName=ai-astar) 04:29:04 INFO - PID 4416 | RSS: Main: 152920064 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | __start_tp_report 04:29:04 INFO - PID 4416 | _x_x_mozilla_page_load 04:29:04 INFO - PID 4416 | _x_x_mozilla_page_load_details 04:29:04 INFO - PID 4416 | |i|pagename|runs| 04:29:04 INFO - PID 4416 | |0;ai-astar;108;105;105;104;105;107;109;105;104;105 04:29:04 INFO - PID 4416 | |1;audio-beat-detection;113;112;116;111;112;113;113;114;137;116 04:29:04 INFO - PID 4416 | |2;audio-dft;162;163;162;162;163;163;160;162;161;166 04:29:04 INFO - PID 4416 | |3;audio-fft;75;72;75;74;74;74;73;73;71;80 04:29:04 INFO - PID 4416 | |4;audio-oscillator;79;80;79;77;77;78;84;76;77;81 04:29:04 INFO - PID 4416 | |5;imaging-gaussian-blur;115;113;114;113;112;114;114;113;114;113 04:29:04 INFO - PID 4416 | |6;imaging-darkroom;149;149;150;156;151;151;150;150;149;157 04:29:04 INFO - PID 4416 | |7;imaging-desaturate;94;94;94;94;94;96;94;93;94;99 04:29:04 INFO - PID 4416 | |8;json-parse-financial;43;46;45;43;46;46;44;46;48;46 04:29:04 INFO - PID 4416 | |9;json-stringify-tinderbox;36;36;36;36;36;36;36;36;36;36 04:29:04 INFO - PID 4416 | |10;stanford-crypto-aes;73;72;76;71;71;77;71;71;72;70 04:29:04 INFO - PID 4416 | |11;stanford-crypto-ccm;111;109;105;113;107;104;105;105;107;106 04:29:04 INFO - PID 4416 | |12;stanford-crypto-pbkdf2;159;155;156;155;152;158;153;154;151;158 04:29:04 INFO - PID 4416 | |13;stanford-crypto-sha256-iterative;61;60;61;61;61;59;61;60;65;83 04:29:04 INFO - PID 4416 | __end_tp_report 04:29:04 INFO - PID 4416 | __start_cc_report 04:29:04 INFO - PID 4416 | _x_x_mozilla_cycle_collect,711 04:29:04 INFO - PID 4416 | __end_cc_report 04:29:04 INFO - PID 4416 | __startTimestamp1505906944955__endTimestamp 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | ------- Summary: start ------- 04:29:04 INFO - PID 4416 | Number of tests: 14 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#0] ai-astar Cycles:10 Average:105.70 Median:105.00 stddev:1.70 (1.6%) stddev-sans-first:1.59 04:29:04 INFO - PID 4416 | Values: 108.0 105.0 105.0 104.0 105.0 107.0 109.0 105.0 104.0 105.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:113.50 stddev:7.66 (6.7%) stddev-sans-first:8.06 04:29:04 INFO - PID 4416 | Values: 113.0 112.0 116.0 111.0 112.0 113.0 113.0 114.0 137.0 116.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.58 (1.0%) stddev-sans-first:1.67 04:29:04 INFO - PID 4416 | Values: 162.0 163.0 162.0 162.0 163.0 163.0 160.0 162.0 161.0 166.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.00 stddev:2.42 (3.3%) stddev-sans-first:2.55 04:29:04 INFO - PID 4416 | Values: 75.0 72.0 75.0 74.0 74.0 74.0 73.0 73.0 71.0 80.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:79.00 stddev:2.39 (3.0%) stddev-sans-first:2.54 04:29:04 INFO - PID 4416 | Values: 79.0 80.0 79.0 77.0 77.0 78.0 84.0 76.0 77.0 81.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.85 (0.7%) stddev-sans-first:0.71 04:29:04 INFO - PID 4416 | Values: 115.0 113.0 114.0 113.0 112.0 114.0 114.0 113.0 114.0 113.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:150.50 stddev:2.90 (1.9%) stddev-sans-first:2.96 04:29:04 INFO - PID 4416 | Values: 149.0 149.0 150.0 156.0 151.0 151.0 150.0 150.0 149.0 157.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.71 (1.8%) stddev-sans-first:1.80 04:29:04 INFO - PID 4416 | Values: 94.0 94.0 94.0 94.0 94.0 96.0 94.0 93.0 94.0 99.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#8] json-parse-financial Cycles:10 Average:45.30 Median:46.00 stddev:1.57 (3.4%) stddev-sans-first:1.42 04:29:04 INFO - PID 4416 | Values: 43.0 46.0 45.0 43.0 46.0 46.0 44.0 46.0 48.0 46.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#9] json-stringify-tinderbox Cycles:10 Average:36.00 Median:36.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:29:04 INFO - PID 4416 | Values: 36.0 36.0 36.0 36.0 36.0 36.0 36.0 36.0 36.0 36.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:72.00 stddev:2.32 (3.2%) stddev-sans-first:2.45 04:29:04 INFO - PID 4416 | Values: 73.0 72.0 76.0 71.0 71.0 77.0 71.0 71.0 72.0 70.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#11] stanford-crypto-ccm Cycles:10 Average:107.20 Median:107.00 stddev:2.94 (2.7%) stddev-sans-first:2.77 04:29:04 INFO - PID 4416 | Values: 111.0 109.0 105.0 113.0 107.0 104.0 105.0 105.0 107.0 106.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:155.50 stddev:2.69 (1.7%) stddev-sans-first:2.45 04:29:04 INFO - PID 4416 | Values: 159.0 155.0 156.0 155.0 152.0 158.0 153.0 154.0 151.0 158.0 04:29:04 INFO - PID 4416 | 04:29:04 INFO - PID 4416 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:61.00 stddev:7.13 (11.7%) stddev-sans-first:7.52 04:29:04 INFO - PID 4416 | Values: 61.0 60.0 61.0 61.0 61.0 59.0 61.0 60.0 65.0 83.0 04:29:04 INFO - PID 4416 | -------- Summary: end -------- 04:29:04 INFO - PID 4416 | 04:29:05 INFO - PID 4416 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:29:05 INFO - TEST-INFO | 4416: exit 0 04:29:05 INFO - TEST-OK | kraken | took 59169ms 04:29:05 INFO - SUITE-END | took 1170s 04:29:05 INFO - Completed test suite (00:19:30) 04:29:05 INFO - javascript benchmark 04:29:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9114.173144390556, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3888.3195440797854, 3893.98053009735, 3909.980450097749, 3914.980425097874, 3919.6864250859935, 6327.0, 6347.079673447347, 6384.872302553946, 6412.0, 6445.742170313182, 6410.391012853772, 6416.839579010527, 6421.068945002972, 6459.5478316517865, 6465.8706825863455, 5616.269884914956, 5704.11586204137, 5745.770169193248, 5751.65490070595, 5822.068469044953, 5776.249087618604, 5803.0, 5821.126830975345, 5832.416758324176, 5833.037548804442, 5786.826395208151, 5798.130280457944, 5860.443257890493, 5867.55993300502, 5898.1447690084915, 5606.6636001840025, 5722.570807189478, 5722.856928576777, 5731.484166425, 5757.568182386338, 5714.914276285859, 5738.254026976467, 5806.767729290823, 5814.127880817869, 5824.854378640525, 6373.936260637381, 6400.167978162855, 6419.422251997343, 6457.999010153434, 6485.54601177913, 6915.861682766316, 6938.479614028968, 6957.199922008983, 6983.89524157138, 7024.981377700205, 6931.168259808805, 7041.0, 7044.823879403005, 7054.92945070553, 7059.294070592951, 6444.581102228387, 6471.061696054093, 6480.287168411471, 6545.312742162052, 6575.572587781827, 7047.612381319077, 7112.466565007645, 7139.535930164523, 7144.749933752294, 7167.283271672791, 6755.1556055493065, 6837.897431538531, 6852.486063545254, 6853.211880633691, 6917.412019978257, 7025.40284075849, 7037.22590515043, 7041.3310735480045, 7045.612491313027, 7047.330503602149, 6898.793036208922, 6941.7223311068, 6950.895736563854, 6992.370686638227, 7028.964855175692, 6798.830029249309, 6931.826704332432, 6968.0, 7041.4718896082995, 7053.823654408681, 5008.1486147355035, 5033.421156566968, 5038.874028149326, 5040.1179793535985, 5043.142665746832, 4577.22187228172, 4590.655700822452, 4632.0, 4639.002614437912, 4653.046125544255, 6438.806835794933, 6441.291457939623, 6450.41946224842, 6528.249251336062, 6542.3130571290285, 6930.48021398387, 6972.721091156398, 7005.964970175219, 7008.159020917523, 7053.188883278489, 6449.32282110381, 6489.059086432441, 6494.285628580852, 6500.544961852719, 6513.511486638521, 5564.360098588633, 5571.721413929287, 5655.4344565543115, 5671.688057156814, 5678.744456499468, 7052.788416347517, 7155.534890232118, 7169.96415017932, 7185.137783466018, 7231.421486281085, 6975.651217439209, 6985.965070174617, 7021.508494405547, 7027.086478757728, 7030.367266945999, 7158.821029474305, 7163.31948464895, 7241.710331586678, 7250.166230883516, 7252.202257751537, 6828.180618325634, 6853.0, 6861.2109607393795, 6894.931285650732, 6946.0, 6934.341237582422, 7003.299670032956, 7019.262977387505, 7022.508424410242, 7036.683349249399, 6711.966440167963, 6726.596404215763, 6737.225219099866, 6753.088333074972, 6820.965895170492, 6601.0, 6735.4611631070375, 6739.797806065826, 6799.796006119825, 6824.454043676593, 6578.144841170809, 6742.393184613408, 6760.830979225559, 6761.594304341756, 6768.018637297466, 6756.966215168893, 6770.187577490733, 6797.422219111431, 6844.452443804584, 6861.039454476278, 6442.710078046405, 6503.122078519339, 6535.705893234721, 6536.967315163584, 6547.9672601636685], "value": 6354.987091244798, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [941.576290669199, 950.6577632052459, 979.1481411172281, 1005.4972513743127, 1006.6979906028195, 43846.0, 44626.776866115666, 44694.776526117326, 44723.0, 44748.105037899266, 42103.36844947328, 42107.0, 42130.36804447936, 42168.36747448791, 42413.57586424135, 7686.884696729568, 7765.339946104588, 7779.922200777976, 7804.453688241825, 7837.960810195941, 7746.302832745052, 7821.921780782176, 7833.255840695153, 7843.764687059397, 7855.8821617675785, 8016.158303378149, 8165.142660020701, 8167.264946154844, 8177.264046235838, 8184.877226841572, 8049.839003219932, 8128.59357032149, 8134.064582572962, 8140.796480088015, 8344.41589088764, 8381.874271885927, 8468.364872634515, 8468.491890486528, 8502.532360720157, 8503.447275927045, 40284.0, 40514.0, 40612.0, 40677.18645627071, 40776.59223407787, 3700.85196592136, 3720.683741881943, 3721.7580857244193, 3736.75711078779, 3737.4206997915367, 32396.190095247573, 32580.511292330633, 32629.0, 32635.83682081598, 32677.673223267702, 5369.463053694639, 5390.0836857734275, 5412.91880621791, 5449.700266485342, 5471.23402723619, 226016.0, 226617.0, 226837.99999999834, 226936.0, 227939.0, 52769.2084618731, 52868.73565632147, 52872.47127528753, 52878.0, 52935.470645293055, 54886.72556637191, 54974.17538736922, 55070.72464637651, 55270.0, 55338.0, 16842.663146736995, 17234.482965511055, 17329.48011559655, 17339.0, 17391.65216695659, 14179.291035448186, 14264.714705705828, 14265.42938282457, 14277.78583321251, 14305.57083287503, 15006.62483437901, 15157.0, 15180.089194648357, 15198.240087995557, 15304.923475382551, 6166.414190651881, 6223.0397424811035, 6242.843928901813, 6257.5932564383165, 6311.526635502356, 1061.9522121504551, 1084.7505073833063, 1090.7545802194443, 1094.4363652718855, 1099.2140619457127, 24964.87517562437, 25106.748932510807, 25228.369290767878, 25475.61786573203, 25540.489190216093, 1177.6937996121071, 1198.2870192235605, 1202.0383693045703, 1202.7714734200474, 1208.1361826294242, 13267.668308292177, 13268.668283292802, 13346.733065338638, 13387.330633468287, 13410.195388276734, 282971.0, 284306.0, 284667.0, 284833.0, 285009.5749521239, 57780.422195778345, 57986.420135798944, 58042.12936805951, 58425.0, 62601.37398626046, 1486.8067151270266, 1499.392745937897, 1501.714674211918, 1521.9619509512352, 1523.413485807972, 30057.69942300549, 30066.549001764553, 30096.398072038875, 30144.0, 30234.395312094075, 41212.0, 41300.0, 41320.38019429771, 41353.379699303936, 41453.1709365817, 247847.0, 248035.0, 249009.0, 249897.0, 250458.0, 35288.82355588206, 35409.760658376836, 35425.0, 35543.28913421769, 35578.0, 44813.551864482244, 46166.30750538812, 46618.13527458864, 46806.297905530766, 46890.06219875652, 33986.32027359489, 34199.487007694406, 34343.48484772781, 34585.827070864485, 34958.30083398369, 33686.0, 34138.65861341355, 34196.48705269373, 34661.48007779835, 34733.826330868185, 38663.806680967544, 40126.59873401229, 40172.598274016884, 40348.193036138524, 40693.79653101716, 33009.66990330066, 33246.16884577905, 33489.497657534666, 33500.0, 33874.49188262129, 25021.12426065079, 25125.497490050464, 25131.49737005286, 25206.74793252044, 25419.237422877344], "value": 18670.030327073087, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.4586180713745, 614.9262088549375, 617.9474744646704, 618.2025187508115, 618.6875627807956, 22965.77034229657, 23665.881670591643, 23795.881020594872, 23798.16706415276, 23838.76161238387, 24441.75558244417, 26342.868285658544, 26459.338516537096, 26589.202323930313, 26635.733642663567, 6798.0, 6952.374286314231, 6962.0, 6962.1297337832775, 6969.6166710830885, 6433.22801263849, 6682.298358672342, 6812.523123381366, 6908.240093589701, 6913.4123599494105, 6671.833204169886, 6678.76624318149, 6680.365365290289, 6682.599044057348, 6686.0305255737885, 6666.666666666696, 6675.198976122872, 6697.2967838377, 6698.83252918676, 6699.933000670004, 6105.725242364104, 6204.565680402374, 6363.331850155713, 6393.680315984182, 6400.295967443624, 30824.0, 31124.53313200304, 31243.37513249745, 31325.373492530023, 31420.21449463759, 2201.7137772089686, 2222.4554984028855, 2226.142934970032, 2238.992453395962, 2245.090738251011, 20724.48188795277, 20946.0, 21305.467363315885, 21584.24455144078, 21783.67324490134, 2508.761667641571, 2515.5975043993058, 2570.0233911113846, 2629.0272599138443, 2651.907183248577, 139700.0, 145995.0, 153022.9999999989, 159332.20333898257, 159713.0, 15550.300236489385, 15827.0, 15979.443289073692, 15995.60010999711, 16169.191540423168, 25528.617070743952, 25555.36111597188, 25564.744352556238, 25603.487930241292, 25635.615465768027, 10465.37207767521, 10532.0, 10565.04914557678, 10604.681859544226, 10653.73365665849, 9522.0, 9558.90441095594, 9589.472579008221, 9628.71113866585, 9665.0, 9815.607375704893, 10033.849492257623, 10138.138258248131, 10236.846447303296, 10336.793264134676, 2948.7346138847606, 2996.9850150749107, 3003.339265361617, 3012.9002913936692, 3031.10582378199, 1037.1702637889657, 1038.901304376083, 1046.199657262195, 1049.9107575855985, 1051.805415998043, 21042.0, 21886.23398181056, 22032.88983555104, 22151.667724984138, 22263.0, 1115.4199816095747, 1120.0535547462382, 1123.3652986062848, 1123.702218911989, 1124.966251012471, 11903.345316007702, 12261.080418968435, 12266.81599776004, 12283.385830708428, 12372.948299394653, 600880.0, 601517.0, 604320.0, 611249.0, 623606.0, 133499.0, 133820.3308983449, 134914.0, 135278.3236083833, 137198.0, 1119.1158984402393, 1211.4608998995539, 1215.295128825279, 1228.2384921348641, 1271.6566527037833, 22776.562943628636, 22888.96999634987, 23056.04023658008, 23147.189848355225, 23314.0, 60683.39316606778, 60834.0, 61020.694896527006, 61205.69397153164, 61493.38506614877, 73710.0, 74754.62622686852, 76929.23070769444, 77774.0, 77931.61034194793, 15810.60473488172, 15838.68322633564, 15980.760288595447, 16013.759793602872, 16064.839351606803, 25492.49015019652, 25539.36151596225, 25628.74371256338, 25758.227253182435, 25998.87000564985, 20041.298554551104, 20233.69649455289, 20477.590448190655, 20539.79460205379, 20713.17147314151, 18192.272309108015, 18227.726584101514, 18420.07899605041, 18651.720224196375, 18936.95846728388, 20801.1679532817, 20890.0, 21079.57840843205, 21425.25011624648, 21454.141834326452, 15773.842261577238, 15822.920885395499, 15887.920560397124, 15910.840891590937, 15931.283092260644, 20183.899080504503, 20265.189392424138, 20473.795262047188, 20614.793852061288, 20839.0], "value": 13000.622366382113, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.5658124272097, 1501.1818558885402, 1505.6536996490806, 1522.9390824367026, 1523.542937118864, 16653.916730416346, 17287.30850765968, 17292.221850016766, 17301.74047389287, 17336.739948900762, 16819.747703784422, 16932.068736219502, 16994.83005169948, 16996.575085622833, 17005.149742512887, 2659.8670066496693, 2707.4991126641635, 2738.438620082878, 2739.8356098634044, 2743.3827388837453, 2651.4431969286475, 2707.1743118348895, 2708.634334364855, 2709.376843326036, 2716.4702882937836, 2757.8621068946572, 2781.1100447856593, 2791.4138031013513, 2812.8874845006176, 2815.5776633504934, 2682.0746842339363, 2716.253030416641, 2721.102036328007, 2724.6594175728032, 2727.6317697110935, 2447.889844956981, 2489.9004039838383, 2493.3268017635137, 2495.75042495749, 2516.119358224625, 13411.798823017663, 13836.654083647889, 13871.029027968047, 15962.0, 16072.357105715757, 8158.061822890384, 8412.32701383894, 8417.410781245255, 8419.452735572168, 8434.325253979729, 5263.6578622389425, 5528.391876893538, 5567.359753628344, 5634.661920284796, 5687.687177205252, 2011.4669612552684, 2026.2097781865084, 2056.7017782421467, 2064.298138632872, 2083.364573804989, 29804.70195298041, 29903.700962990308, 29954.400911981855, 29983.250418739488, 30000.849995749883, 7201.991721159042, 7357.77926662201, 7409.110906691231, 7548.245175482408, 7588.392928565812, 19251.4224573263, 22412.66381004286, 22516.774832251795, 22552.887235563718, 22580.20969266068, 8311.0, 8521.786955326166, 8531.530765807816, 8560.657573696983, 8570.571471426403, 7421.517601355895, 7446.85106297871, 7460.701571937062, 7560.432967527458, 7673.654685539164, 5392.811251606175, 5518.0, 5530.529904958124, 5545.500904918576, 5584.022796010682, 1430.7210094031773, 1448.1745405118982, 1454.9563513094624, 1470.7279153356662, 1477.793108964746, 921.9308551858637, 947.7535840681335, 956.6030097509595, 960.5917485068818, 962.8796400449944, 8080.39397045224, 8139.4709343892455, 8178.631961561625, 8185.3042491387705, 8225.424220304641, 781.7811012916279, 787.649495974286, 793.6587267474926, 795.9840803183904, 796.6853093028221, 5323.893522129536, 5614.1859430382365, 5823.4467725566, 5879.176915231871, 5995.760169593254, 23677.408064798517, 24639.753602464105, 24657.5068498629, 24717.0, 24858.50282994366, 23208.53582928332, 24760.13339533108, 24811.13161039355, 24812.37969050788, 24871.0, 12456.377181140906, 12483.313417761929, 12589.685257868627, 12602.87397126017, 12614.117011809269, 8910.777230569287, 9353.0, 9694.75763105928, 9714.174295184706, 9726.221902247944, 20933.476663082936, 21041.789582103982, 21189.152433902473, 21421.46446338854, 21916.561668766215, 21519.892400537898, 22014.0, 22144.33566992993, 22186.44533886666, 22191.667124993462, 12192.08559358034, 12387.69030774238, 12399.442025108712, 12421.068419868727, 12440.315782632042, 15299.23503824782, 15524.14617196065, 15583.610409739847, 15627.843721563093, 15704.29330680145, 12223.266604003788, 12536.874631253935, 12787.808182877077, 13017.0, 13117.34413279313, 12347.69130771738, 12502.624921252376, 12652.87347126517, 12743.553975610808, 12752.74494510123, 11429.0, 11502.769944601228, 11525.596604119151, 11578.247413918069, 11585.88414115848, 8462.19609137131, 8508.446950948168, 8509.659613615386, 8555.786105347415, 8629.223369896488, 8446.28206602421, 8580.528070955908, 8628.094050124646, 8730.65077396897, 8812.2950163988], "value": 7174.745405683461, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.5135502370356, 573.9397363276854, 577.457190241173, 579.4668904607757, 583.5710752596841, 6359.3640635936445, 6376.202974628171, 6398.552101352907, 6431.549791514596, 6448.548601597884, 6238.906416403746, 6250.062480631008, 6269.122322874801, 6272.905906411407, 6324.462420694246, 5138.7173705446185, 5173.896522069556, 5184.522411112834, 5187.584993200535, 5196.740162991854, 5126.769295381698, 5133.12736834739, 5174.628723388305, 5179.715115668637, 5202.843914682547, 5002.399712034561, 5127.33344665193, 5157.5358217760395, 5207.166853303473, 5225.451327610604, 5214.374275087014, 5226.08543504887, 5243.318368612094, 5255.76349064293, 5257.501612040588, 4833.927491087637, 4910.754462276907, 4917.606591472673, 4951.207806750938, 4957.3059771632, 6210.441060304594, 6226.412264872429, 6258.1551490548645, 6258.468030217391, 6276.560640755149, 6176.783812566584, 6179.69101544921, 6191.349908259613, 6223.782167624111, 6231.688415579203, 6736.541162475661, 6736.898946515757, 6749.966250168767, 6764.086848275519, 6783.72865085396, 5527.198556209327, 5540.418256083093, 5544.889102217933, 5549.916751248735, 5568.1091025435735, 6801.93198068018, 6866.622335771531, 6943.479239057091, 6976.7209311627985, 7040.155181378216, 5637.0, 5681.57388195887, 5694.231278777394, 5723.828285151452, 5738.655680659173, 5817.912731309034, 5830.737616807254, 5843.211166492554, 5850.5904586678525, 5854.18041474194, 6187.566870319034, 6199.690015499207, 6217.533684973645, 6218.471429928507, 6225.221847269091, 6673.299303573055, 6721.93278067213, 6747.325267473311, 6752.291009444036, 6795.490338224653, 1954.6872500399868, 1964.838677454817, 1965.1353404501974, 1978.0999645161417, 1988.8508361872916, 1464.6850927050734, 1485.695432436348, 1502.6168327076525, 1546.1650708617447, 1550.449590395416, 6047.758089676364, 6183.505319574423, 6194.628322300677, 6206.875862482725, 6229.563930524911, 6657.700403481855, 6683.799486015428, 6762.932370676329, 6764.526483146231, 6779.762708305284, 6095.481884039907, 6095.878082438415, 6162.137300777895, 6250.656213908279, 6261.154744109578, 3515.33208690348, 3547.4324108142573, 3548.520949671813, 3551.911202219965, 3561.1453251220037, 6815.284395138439, 6895.275996020346, 6990.335918087773, 7030.191527974246, 7037.331453511908, 6918.619475928772, 6928.584284942919, 6932.861342773217, 7065.82335441618, 7066.470014748915, 6841.760538381332, 6875.862482750217, 6924.861502769916, 6933.237343892168, 7023.682184878978, 6685.832854178684, 6699.732010719712, 6712.597244165366, 6739.966300168468, 6752.291009444134, 6714.0, 6715.93284067153, 6758.391744742997, 6768.526203165731, 6829.89755153683, 6809.148856392951, 6875.346842049998, 6971.6862741175755, 7019.157701075904, 7039.788806335818, 5191.351081114861, 5199.0, 5237.512181713808, 5239.05696974533, 5256.132738098171, 6642.90035649456, 6761.594304341756, 6818.488613354118, 6835.4189893859575, 6884.277150899284, 6608.4382827458285, 6613.016095171333, 6652.73389064432, 6669.166354205724, 6701.229358623626, 6523.510736694861, 6526.836829079311, 6587.604743715392, 6604.0, 6610.331266147142, 6492.415682588589, 6511.0, 6524.9673751630935, 6566.179227596551, 6575.27671956094, 6595.703193356407, 6682.131322927989, 6714.321419645089, 6716.227633821977, 6765.695543700644, 6451.387118223761, 6469.5794773339585, 6482.935170648233, 6516.478681705547, 6533.118029066015], "value": 5327.706423178928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [927.6938610258616, 970.5680971967478, 971.2618410008391, 981.283662926064, 1009.8737657792776, 18828.811711882878, 19370.612587748237, 19424.320148794795, 19440.513987150294, 19444.70832937507, 18241.7263741044, 18806.52983675409, 18881.811181888177, 19040.33358832441, 19162.90418547909, 1038.9532471038804, 1065.211743309949, 1066.5787014129414, 1066.6426747039711, 1068.2682362581618, 1047.9371237725722, 1081.0648788797712, 1085.7502774361901, 1085.8371244313378, 1085.940273284969, 1145.3357052909334, 1156.242661057009, 1156.7512984708287, 1157.213095095335, 1158.9188756787028, 1068.8022715797601, 1117.8490903727975, 1140.3158105136893, 1144.3820337018, 1154.3247200387784, 823.1480417767582, 825.8059356051323, 827.0530242871878, 827.6730691376872, 828.3787159630277, 19444.611107777906, 19636.214551417925, 19650.115744791517, 19687.21251149952, 19747.40757777269, 22446.88776556123, 23360.532789344117, 23415.297541073796, 23415.88292058546, 23451.88274058636, 17312.567185820455, 17877.553061173574, 18023.459296221135, 18179.0, 18179.818201817943, 3823.6558709715982, 3844.1158533537164, 3846.653801157909, 3854.6530812227033, 3856.325143099946, 160254.19872900678, 160653.19673401676, 162682.9999999988, 163379.0, 164775.0, 17997.19012644408, 18046.2781488739, 18189.81810181881, 18293.451196464128, 18403.263869445072, 33560.1609959753, 33700.49449258263, 33701.32597348088, 33755.66244337525, 34112.0, 8753.562321884008, 8822.691205807765, 8837.779055523535, 8844.690435834715, 8845.336599754915, 4734.100520901018, 4774.474807771142, 4904.705717656952, 4915.87710307238, 4918.311436398907, 6035.185249991283, 6152.969235153885, 6171.382861713792, 6174.320824709278, 6181.8454538636, 1106.1537923488538, 1112.8108221602347, 1132.17351333527, 1135.0579019413867, 1137.6643890052455, 724.5181954000531, 737.4800765460337, 748.5284270909401, 749.1160430691835, 764.1556080530934, 12980.286084265268, 13129.0, 13300.135491193041, 13976.650583735285, 14109.223992680501, 734.2987446988113, 742.9257074292527, 747.6523416611193, 754.7169811320755, 762.954222746637, 6240.500759939285, 6243.313235544087, 6263.185785847811, 6272.902242107613, 6275.937240627627, 160512.0, 160664.0, 161899.0, 164386.0, 166096.0, 136616.0, 136914.0, 137382.0, 140925.29537352247, 142144.0, 116628.0, 118069.0, 118334.4083279578, 118637.8136218644, 118947.8105218954, 11366.0, 11463.135361178805, 11558.306501609593, 11623.418829058683, 11726.179167458196, 54305.0, 54384.184237235684, 54918.725406372716, 56032.43967560272, 57618.71190644187, 69607.0, 72154.0, 72177.27822721706, 72296.27703722895, 72707.09393591003, 15966.760498592763, 16100.597485062966, 16117.113558754381, 16175.838241617434, 16263.918680406523, 16824.663506729554, 16852.57868553247, 16938.830611693724, 17118.48644540666, 17140.228689708743, 16369.0, 16439.09584972838, 16439.67120657604, 16441.342346306013, 16565.337386504405, 14426.134431934117, 14708.852911470749, 14794.408223670933, 14804.925975370053, 14817.110973341203, 13854.37655305534, 13920.164790112625, 13968.231747253592, 14029.579112626638, 14172.362243698852, 12608.92824109961, 12783.80824287655, 13001.349932503148, 13029.934850325688, 13165.078444508792, 12712.74574508523, 12849.550265740654, 12918.483260669844, 12962.675933101747, 13121.147125436815], "value": 9720.916375079187, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1375.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 105.0, 105.0, 104.0, 105.0, 107.0, 109.0, 105.0, 104.0, 105.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 116.0, 111.0, 112.0, 113.0, 113.0, 114.0, 137.0, 116.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 163.0, 163.0, 160.0, 162.0, 161.0, 166.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 75.0, 74.0, 74.0, 74.0, 73.0, 73.0, 71.0, 80.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 77.0, 77.0, 78.0, 84.0, 76.0, 77.0, 81.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 114.0, 113.0, 112.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 156.0, 151.0, 151.0, 150.0, 150.0, 149.0, 157.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0, 93.0, 94.0, 99.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 46.0, 45.0, 43.0, 46.0, 46.0, 44.0, 46.0, 48.0, 46.0], "value": 45.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0], "value": 36.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 76.0, 71.0, 71.0, 77.0, 71.0, 71.0, 72.0, 70.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 105.0, 113.0, 107.0, 104.0, 105.0, 105.0, 107.0, 106.0], "value": 107.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 156.0, 155.0, 152.0, 158.0, 153.0, 154.0, 151.0, 158.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 59.0, 61.0, 60.0, 65.0, 83.0], "value": 63.2, "unit": "score"}]}]} 04:29:05 INFO - Return code: 0 04:29:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:29:05 INFO - # TBPL SUCCESS # 04:29:05 INFO - Running post-action listener: _package_coverage_data 04:29:05 INFO - Running post-action listener: _resource_record_post_action 04:29:05 INFO - [mozharness: 2017-09-20 11:29:05.731693Z] Finished run-tests step (success) 04:29:05 INFO - Running post-run listener: _resource_record_post_run 04:29:05 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 9940992; Write bytes: 445292544; Read time: 5036; Write time: 463656 04:29:05 INFO - TinderboxPrint: CPU usage
13.1% 04:29:05 INFO - TinderboxPrint: I/O read bytes / time
9,940,992 / 5,036 04:29:05 INFO - TinderboxPrint: I/O write bytes / time
445,292,544 / 463,656 04:29:05 INFO - TinderboxPrint: CPU idle
8,238.8 (86.9%) 04:29:05 INFO - TinderboxPrint: CPU user
1,186.5 (12.5%) 04:29:05 INFO - TinderboxPrint: Swap in / out
0 / 0 04:29:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 335872; Read time: 0; Write time: 44 04:29:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:29:05 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 9940992; Write bytes: 422023168; Read time: 5036; Write time: 457832 04:29:06 INFO - Running post-run listener: _upload_blobber_files 04:29:06 INFO - Blob upload gear active. 04:29:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:29:06 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 04:29:06 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'] 04:29:06 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 04:29:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:29:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:29:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:07 INFO - (blobuploader) - INFO - Done attempting. 04:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:09 INFO - (blobuploader) - INFO - Done attempting. 04:29:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:29:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:29:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:16 INFO - (blobuploader) - INFO - Done attempting. 04:29:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:29:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:29:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:16 INFO - (blobuploader) - INFO - Done attempting. 04:29:16 INFO - (blobuploader) - INFO - Iteration through files over. 04:29:16 INFO - Return code: 0 04:29:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:29:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:29:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af905d4021ce73634b6712e53098115a6b4416f73ff24d1ba5ca54257bb21eb06f038601ca404728ddcbfad83c68f1011092a3af5d1d67ada733ca7c2400f82a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab546f0e9ceb02d448e862302eb8431899277e112dff3f5fde28eef97442088e0cfa91867ab9f887a7704dbaebf28c4727bb168522d4b8aa25cc204f5b036450", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15dd6ddff699d59e19ad83643473f7cebe910807a6ea814fdf9dbe1faeb085d0c4cdccf87494cb1d34714edd43d44e55ad71bd819335f539d064e703933fe505", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/670703e6344f185375bb5483e99b437c2dce42f4dde2c2efe98666221bb91cde750b00ca211ede7873721d7e3d4f31aa74208d89106a7d745bf7bedd4203dc15"} 04:29:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:29:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:29:16 INFO - Contents: 04:29:16 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af905d4021ce73634b6712e53098115a6b4416f73ff24d1ba5ca54257bb21eb06f038601ca404728ddcbfad83c68f1011092a3af5d1d67ada733ca7c2400f82a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab546f0e9ceb02d448e862302eb8431899277e112dff3f5fde28eef97442088e0cfa91867ab9f887a7704dbaebf28c4727bb168522d4b8aa25cc204f5b036450", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15dd6ddff699d59e19ad83643473f7cebe910807a6ea814fdf9dbe1faeb085d0c4cdccf87494cb1d34714edd43d44e55ad71bd819335f539d064e703933fe505", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/670703e6344f185375bb5483e99b437c2dce42f4dde2c2efe98666221bb91cde750b00ca211ede7873721d7e3d4f31aa74208d89106a7d745bf7bedd4203dc15"} 04:29:16 INFO - Running post-run listener: copy_logs_to_upload_dir 04:29:16 INFO - Copying logs to upload dir... 04:29:16 INFO - mkdir: /builds/slave/test/build/upload/logs 04:29:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.401246 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-20 04:29:16.891212) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 04:29:16.895446) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af905d4021ce73634b6712e53098115a6b4416f73ff24d1ba5ca54257bb21eb06f038601ca404728ddcbfad83c68f1011092a3af5d1d67ada733ca7c2400f82a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab546f0e9ceb02d448e862302eb8431899277e112dff3f5fde28eef97442088e0cfa91867ab9f887a7704dbaebf28c4727bb168522d4b8aa25cc204f5b036450", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15dd6ddff699d59e19ad83643473f7cebe910807a6ea814fdf9dbe1faeb085d0c4cdccf87494cb1d34714edd43d44e55ad71bd819335f539d064e703933fe505", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/670703e6344f185375bb5483e99b437c2dce42f4dde2c2efe98666221bb91cde750b00ca211ede7873721d7e3d4f31aa74208d89106a7d745bf7bedd4203dc15"} build_url:https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011788 build_url: 'https://queue.taskcluster.net/v1/task/J47zVnrxSO6MxQgSw6iInA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af905d4021ce73634b6712e53098115a6b4416f73ff24d1ba5ca54257bb21eb06f038601ca404728ddcbfad83c68f1011092a3af5d1d67ada733ca7c2400f82a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab546f0e9ceb02d448e862302eb8431899277e112dff3f5fde28eef97442088e0cfa91867ab9f887a7704dbaebf28c4727bb168522d4b8aa25cc204f5b036450", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15dd6ddff699d59e19ad83643473f7cebe910807a6ea814fdf9dbe1faeb085d0c4cdccf87494cb1d34714edd43d44e55ad71bd819335f539d064e703933fe505", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/670703e6344f185375bb5483e99b437c2dce42f4dde2c2efe98666221bb91cde750b00ca211ede7873721d7e3d4f31aa74208d89106a7d745bf7bedd4203dc15"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 04:29:16.925177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 04:29:16.925561) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1505905713.579686-1562812694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 04:29:17.008153) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 04:29:17.008610) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 04:29:17.008987) ========= ========= Total master_lag: 0.20 =========