builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1505382733.68 results: success (0) revision: dd6b788f149763c4014c27f2fe1a1d13228bda82 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:13.675435) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:13.679950) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:13.680321) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:14.143203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:14.143497) ========= 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=5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 02:52:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 91.2M=0s 2017-09-14 02:52:14 (91.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130492 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:14.439225) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:14.439604) ========= 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=5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020440 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:14.555656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-14 02:52:14.561329) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd6b788f149763c4014c27f2fe1a1d13228bda82 --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 dd6b788f149763c4014c27f2fe1a1d13228bda82 --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=5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 02:52:14,805 truncating revision to first 12 chars 2017-09-14 02:52:14,805 Setting DEBUG logging. 2017-09-14 02:52:14,805 attempt 1/10 2017-09-14 02:52:14,805 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd6b788f1497?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 02:52:15,722 unpacking tar archive at: mozilla-central-dd6b788f1497/testing/mozharness/ program finished with exit code 0 elapsedTime=1.208330 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-14 02:52:15.871189) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.871468) ========= script_repo_revision: dd6b788f149763c4014c27f2fe1a1d13228bda82 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.871831) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.872096) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:15.992355) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-14 02:52:15.992620) ========= /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=5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:52:16 INFO - MultiFileLogger online at 20170914 02:52:16 in /builds/slave/test 02:52:16 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 02:52:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:52:16 INFO - {'append_to_log': False, 02:52:16 INFO - 'base_work_dir': '/builds/slave/test', 02:52:16 INFO - 'blob_upload_branch': 'Firefox', 02:52:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:52:16 INFO - 'branch': 'Firefox', 02:52:16 INFO - 'buildbot_json_path': 'buildprops.json', 02:52:16 INFO - 'code_coverage': False, 02:52:16 INFO - 'config_files': ('talos/linux_config.py',), 02:52:16 INFO - 'default_actions': ('clobber', 02:52:16 INFO - 'read-buildbot-config', 02:52:16 INFO - 'download-and-extract', 02:52:16 INFO - 'populate-webroot', 02:52:16 INFO - 'create-virtualenv', 02:52:16 INFO - 'install', 02:52:16 INFO - 'setup-mitmproxy', 02:52:16 INFO - 'run-tests'), 02:52:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:52:16 INFO - 'disable_ccov_upload': False, 02:52:16 INFO - 'disable_stylo': False, 02:52:16 INFO - 'download_minidump_stackwalk': True, 02:52:16 INFO - 'download_symbols': 'ondemand', 02:52:16 INFO - 'enable_stylo': False, 02:52:16 INFO - 'enable_webrender': False, 02:52:16 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:52:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:52:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:52:16 INFO - 'gecko_profile': False, 02:52:16 INFO - 'gecko_profile_interval': 0, 02:52:16 INFO - 'installer_path': 'installer.exe', 02:52:16 INFO - 'log_level': 'info', 02:52:16 INFO - 'log_name': 'talos', 02:52:16 INFO - 'log_to_console': True, 02:52:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:52:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:52:16 INFO - 'opt_config_files': (), 02:52:16 INFO - 'pip_index': False, 02:52:16 INFO - 'suite': 'dromaeojs-e10s', 02:52:16 INFO - 'system_bits': '32', 02:52:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:52:16 INFO - 'title': 'talos-linux64-ix-039', 02:52:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:52:16 INFO - 'use_talos_json': True, 02:52:16 INFO - 'verify': 'False', 02:52:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:52:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:52:16 INFO - 'work_dir': 'build'} 02:52:16 INFO - [mozharness: 2017-09-14 09:52:16.327549Z] Running clobber step. 02:52:16 INFO - Running pre-action listener: _resource_record_pre_action 02:52:16 INFO - Running main action method: clobber 02:52:16 INFO - rmtree: /builds/slave/test/build 02:52:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:52:17 INFO - Running post-action listener: _resource_record_post_action 02:52:17 INFO - [mozharness: 2017-09-14 09:52:17.314490Z] Finished clobber step (success) 02:52:17 INFO - [mozharness: 2017-09-14 09:52:17.314586Z] Running read-buildbot-config step. 02:52:17 INFO - Running pre-action listener: _resource_record_pre_action 02:52:17 INFO - Running main action method: read_buildbot_config 02:52:17 INFO - Using buildbot properties: 02:52:17 INFO - { 02:52:17 INFO - "project": "", 02:52:17 INFO - "product": "firefox", 02:52:17 INFO - "who": "archaeopteryx@coole-files.de", 02:52:17 INFO - "installer_path": "public/build/target.tar.bz2", 02:52:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 02:52:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:52:17 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 02:52:17 INFO - "stage_platform": "linux64-qr", 02:52:17 INFO - "basedir": "/builds/slave/test", 02:52:17 INFO - "buildnumber": 54, 02:52:17 INFO - "platform": "ubuntu64_hw_qr", 02:52:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:52:17 INFO - "slavebuilddir": "test", 02:52:17 INFO - "taskId": "NV9sn04uT2Cjb57E6mnstA", 02:52:17 INFO - "branch": "mozilla-central", 02:52:17 INFO - "script_repo_revision": "production", 02:52:17 INFO - "revision": "dd6b788f149763c4014c27f2fe1a1d13228bda82", 02:52:17 INFO - "slavename": "talos-linux64-ix-039", 02:52:17 INFO - "repo_path": "mozilla-central" 02:52:17 INFO - } 02:52:17 INFO - Finding installer, test and symbols from parent task. 02:52:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NV9sn04uT2Cjb57E6mnstA'}, attempt #1 02:52:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NV9sn04uT2Cjb57E6mnstA'}, attempt #1 02:52:18 INFO - Task dependencies: GD7UpAmZSbaM79RoUDeOdw 02:52:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw'}, attempt #1 02:52:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2 02:52:18 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.test_packages.json 02:52:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.crashreporter-symbols.zip 02:52:18 INFO - Running post-action listener: _resource_record_post_action 02:52:18 INFO - [mozharness: 2017-09-14 09:52:18.752066Z] Finished read-buildbot-config step (success) 02:52:18 INFO - [mozharness: 2017-09-14 09:52:18.752378Z] Running download-and-extract step. 02:52:18 INFO - Running pre-action listener: _resource_record_pre_action 02:52:18 INFO - Running main action method: download_and_extract 02:52:18 INFO - mkdir: /builds/slave/test/build/tests 02:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:18 INFO - trying https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.test_packages.json 02:52:18 INFO - Downloading https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:52:19 INFO - Downloaded 989 bytes. 02:52:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:52:19 INFO - Using the following test package requirements: 02:52:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:52:19 INFO - u'common': [u'target.common.tests.zip'], 02:52:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:52:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:52:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:52:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:52:19 INFO - u'mozbase': [u'target.common.tests.zip'], 02:52:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:52:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:52:19 INFO - u'web-platform': [u'target.common.tests.zip', 02:52:19 INFO - u'target.web-platform.tests.tar.gz'], 02:52:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:52:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:52:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.common.tests.zip 02:52:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:52:19 INFO - Fetch https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.common.tests.zip into memory 02:52:21 INFO - Content-Length response header: 54593713 02:52:21 INFO - Bytes received: 54593713 02:52:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.talos.tests.zip 02:52:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:52:32 INFO - Fetch https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.talos.tests.zip into memory 02:52:33 INFO - Content-Length response header: 14500356 02:52:33 INFO - Bytes received: 14500356 02:52: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')]} 02:52:34 INFO - trying https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2 02:52:34 INFO - Downloading https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:52:36 INFO - Downloaded 61364985 bytes. 02:52:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2 02:52:36 INFO - mkdir: /builds/slave/test/properties 02:52:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:36 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:36 INFO - Contents: 02:52:36 INFO - build_url:https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2 02:52:36 INFO - Running post-action listener: _resource_record_post_action 02:52:36 INFO - Running post-action listener: find_tests_for_verification 02:52:36 INFO - Running post-action listener: set_extra_try_arguments 02:52:36 INFO - [mozharness: 2017-09-14 09:52:36.985558Z] Finished download-and-extract step (success) 02:52:36 INFO - [mozharness: 2017-09-14 09:52:36.985674Z] Running populate-webroot step. 02:52:36 INFO - Running pre-action listener: _resource_record_pre_action 02:52:36 INFO - Running main action method: populate_webroot 02:52:36 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:52:36 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:36 INFO - 'tests': ['tresize', 02:52:36 INFO - 'tcanvasmark']}, 02:52:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:52:36 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:36 INFO - 'tests': ['dromaeo_css', 02:52:36 INFO - 'kraken']}, 02:52:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:52:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:36 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:52:36 INFO - 'talos_options': ['--disable-stylo'], 02:52:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:52:36 INFO - 'tests': ['damp', 'tps']}, 02:52:36 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:52:36 INFO - 'talos_options': ['--disable-stylo'], 02:52:36 INFO - 'tests': ['damp', 'tps']}, 02:52:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:36 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:36 INFO - 'tests': ['dromaeo_dom']}, 02:52:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:52:36 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:36 INFO - 'tests': ['basic_compositor_video', 02:52:36 INFO - 'glvideo']}, 02:52:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:52:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:52:36 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:52:36 INFO - 'talos_options': ['--disable-stylo'], 02:52:36 INFO - 'tests': ['ts_paint_webext', 02:52:36 INFO - 'tp5o_webext']}, 02:52:36 INFO - 'other-e10s': {'tests': ['a11yr', 02:52:36 INFO - 'ts_paint', 02:52:36 INFO - 'tpaint', 02:52:36 INFO - 'sessionrestore', 02:52:36 INFO - 'sessionrestore_many_windows', 02:52:36 INFO - 'sessionrestore_no_auto_restore', 02:52:36 INFO - 'tabpaint']}, 02:52:36 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:36 INFO - 'tests': ['a11yr', 02:52:36 INFO - 'ts_paint', 02:52:36 INFO - 'tpaint', 02:52:36 INFO - 'sessionrestore', 02:52:36 INFO - 'sessionrestore_many_windows', 02:52:36 INFO - 'sessionrestore_no_auto_restore', 02:52:36 INFO - 'tabpaint']}, 02:52:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:52:36 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:52:36 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:36 INFO - 'tests': ['bloom_basic_singleton']}, 02:52:36 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:36 INFO - 'tests': ['bloom_basic']}, 02:52:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:52:36 INFO - 'tsvgr_opacity', 02:52:37 INFO - 'tart', 02:52:37 INFO - 'tscrollx', 02:52:37 INFO - 'tsvg_static']}, 02:52:37 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:52:37 INFO - 'tests': ['tsvgx', 02:52:37 INFO - 'tsvgr_opacity', 02:52:37 INFO - 'tart', 02:52:37 INFO - 'tscrollx', 02:52:37 INFO - 'tsvg_static']}, 02:52:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:52:37 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:52:37 INFO - 'talos_options': ['--disable-stylo'], 02:52:37 INFO - 'tests': ['tp5o']}, 02:52:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:37 INFO - 'talos_options': ['--mitmproxy', 02:52:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:37 INFO - '--firstNonBlankPaint'], 02:52:37 INFO - 'tests': ['tp6_google', 02:52:37 INFO - 'tp6_youtube', 02:52:37 INFO - 'tp6_amazon', 02:52:37 INFO - 'tp6_facebook']}, 02:52:37 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:37 INFO - 'talos_options': ['--disable-stylo', 02:52:37 INFO - '--mitmproxy', 02:52:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:37 INFO - '--firstNonBlankPaint'], 02:52:37 INFO - 'tests': ['tp6_google', 02:52:37 INFO - 'tp6_youtube', 02:52:37 INFO - 'tp6_amazon', 02:52:37 INFO - 'tp6_facebook']}, 02:52:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:37 INFO - 'talos_options': ['--stylo-threads=1', 02:52:37 INFO - '--mitmproxy', 02:52:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:37 INFO - '--firstNonBlankPaint'], 02:52:37 INFO - 'tests': ['tp6_google', 02:52:37 INFO - 'tp6_youtube', 02:52:37 INFO - 'tp6_amazon', 02:52:37 INFO - 'tp6_facebook']}, 02:52:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:52:37 INFO - 'talos_options': ['--xperf_path', 02:52:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:37 INFO - 'tests': ['tp5n']}, 02:52:37 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:52:37 INFO - 'talos_options': ['--disable-stylo', 02:52:37 INFO - '--xperf_path', 02:52:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:37 INFO - 'tests': ['tp5n']}}} 02:52:37 INFO - Running post-action listener: _resource_record_post_action 02:52:37 INFO - [mozharness: 2017-09-14 09:52:37.004452Z] Finished populate-webroot step (success) 02:52:37 INFO - [mozharness: 2017-09-14 09:52:37.004560Z] Running create-virtualenv step. 02:52:37 INFO - Running pre-action listener: _resource_record_pre_action 02:52:37 INFO - Running main action method: create_virtualenv 02:52:37 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:37 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:52:37 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:52:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:52:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:52:37 INFO - Installing distribute.............................................................................................................................................................................................done. 02:52:37 INFO - Installing pip...............done. 02:52:37 INFO - Return code: 0 02:52:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:52:38 INFO - Reading from file tmpfile_stdout 02:52:38 INFO - Output received: 02:52:38 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:52:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:52:38 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')]} 02:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:38 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')]} 02:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:38 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1359a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500090>, '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 0x1500d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14faf90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', '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 02:52:38 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 02:52:38 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 02:52:38 INFO - Using env: {'DISPLAY': ':0', 02:52:38 INFO - 'HOME': '/home/cltbld', 02:52:38 INFO - 'LANG': 'en_US.UTF-8', 02:52:38 INFO - 'LANGUAGE': 'en_US:en', 02:52:38 INFO - 'LOGNAME': 'cltbld', 02:52:38 INFO - 'MAIL': '/var/mail/cltbld', 02:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:38 INFO - 'MOZ_NO_REMOTE': '1', 02:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:38 INFO - 'NO_EM_RESTART': '1', 02:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:38 INFO - 'PWD': '/builds/slave/test', 02:52:38 INFO - 'SHELL': '/bin/bash', 02:52:38 INFO - 'SHLVL': '1', 02:52:38 INFO - 'TERM': 'linux', 02:52:38 INFO - 'TMOUT': '86400', 02:52:38 INFO - 'USER': 'cltbld', 02:52:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 02:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:38 INFO - '_': '/tools/buildbot/bin/python'} 02:52:39 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:52:39 INFO - Downloading/unpacking pip>=1.5 02:52:39 INFO - Running setup.py egg_info for package pip 02:52:39 INFO - warning: no files found matching 'pip/cacert.pem' 02:52:39 INFO - warning: no files found matching '*.html' under directory 'docs' 02:52:39 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:52:39 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:52:39 INFO - Installing collected packages: pip 02:52:39 INFO - Found existing installation: pip 1.1 02:52:39 INFO - Uninstalling pip: 02:52:39 INFO - Successfully uninstalled pip 02:52:39 INFO - Running setup.py install for pip 02:52:39 INFO - warning: no files found matching 'pip/cacert.pem' 02:52:39 INFO - warning: no files found matching '*.html' under directory 'docs' 02:52:39 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:52:39 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:52:39 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:52:39 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:52:39 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:52:39 INFO - Successfully installed pip 02:52:39 INFO - Cleaning up... 02:52:39 INFO - Return code: 0 02:52:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52: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')]} 02:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1359a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500090>, '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 0x1500d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14faf90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', '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 02:52:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:52:39 INFO - Using env: {'DISPLAY': ':0', 02:52:39 INFO - 'HOME': '/home/cltbld', 02:52:39 INFO - 'LANG': 'en_US.UTF-8', 02:52:39 INFO - 'LANGUAGE': 'en_US:en', 02:52:39 INFO - 'LOGNAME': 'cltbld', 02:52:39 INFO - 'MAIL': '/var/mail/cltbld', 02:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:39 INFO - 'MOZ_NO_REMOTE': '1', 02:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:39 INFO - 'NO_EM_RESTART': '1', 02:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:39 INFO - 'PWD': '/builds/slave/test', 02:52:39 INFO - 'SHELL': '/bin/bash', 02:52:39 INFO - 'SHLVL': '1', 02:52:39 INFO - 'TERM': 'linux', 02:52:39 INFO - 'TMOUT': '86400', 02:52:39 INFO - 'USER': 'cltbld', 02:52:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 02:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:39 INFO - '_': '/tools/buildbot/bin/python'} 02:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:39 INFO - Downloading/unpacking psutil>=3.1.1 02:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:52:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:40 INFO - Installing collected packages: psutil 02:52:40 INFO - Running setup.py install for psutil 02:52:40 INFO - building 'psutil._psutil_linux' extension 02:52:40 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 02:52:40 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 02:52:40 INFO - building 'psutil._psutil_posix' extension 02:52:40 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 02:52:41 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 02:52:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:41 INFO - Successfully installed psutil 02:52:41 INFO - Cleaning up... 02:52:41 INFO - Return code: 0 02:52:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:52:41 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')]} 02:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:41 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')]} 02:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:41 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1359a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500090>, '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 0x1500d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14faf90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', '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 02:52:41 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 02:52:41 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 02:52:41 INFO - Using env: {'DISPLAY': ':0', 02:52:41 INFO - 'HOME': '/home/cltbld', 02:52:41 INFO - 'LANG': 'en_US.UTF-8', 02:52:41 INFO - 'LANGUAGE': 'en_US:en', 02:52:41 INFO - 'LOGNAME': 'cltbld', 02:52:41 INFO - 'MAIL': '/var/mail/cltbld', 02:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:41 INFO - 'MOZ_NO_REMOTE': '1', 02:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:41 INFO - 'NO_EM_RESTART': '1', 02:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:41 INFO - 'PWD': '/builds/slave/test', 02:52:41 INFO - 'SHELL': '/bin/bash', 02:52:41 INFO - 'SHLVL': '1', 02:52:41 INFO - 'TERM': 'linux', 02:52:41 INFO - 'TMOUT': '86400', 02:52:41 INFO - 'USER': 'cltbld', 02:52:41 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 02:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:41 INFO - '_': '/tools/buildbot/bin/python'} 02:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:52:42 INFO - Installing collected packages: mozsystemmonitor 02:52:42 INFO - Running setup.py install for mozsystemmonitor 02:52:42 INFO - Successfully installed mozsystemmonitor 02:52:42 INFO - Cleaning up... 02:52:43 INFO - Return code: 0 02:52:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:52:43 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')]} 02:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:43 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')]} 02:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:43 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1359a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500090>, '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 0x1500d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14faf90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', '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 02:52:43 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 02:52:43 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 02:52:43 INFO - Using env: {'DISPLAY': ':0', 02:52:43 INFO - 'HOME': '/home/cltbld', 02:52:43 INFO - 'LANG': 'en_US.UTF-8', 02:52:43 INFO - 'LANGUAGE': 'en_US:en', 02:52:43 INFO - 'LOGNAME': 'cltbld', 02:52:43 INFO - 'MAIL': '/var/mail/cltbld', 02:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:43 INFO - 'MOZ_NO_REMOTE': '1', 02:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:43 INFO - 'NO_EM_RESTART': '1', 02:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:43 INFO - 'PWD': '/builds/slave/test', 02:52:43 INFO - 'SHELL': '/bin/bash', 02:52:43 INFO - 'SHLVL': '1', 02:52:43 INFO - 'TERM': 'linux', 02:52:43 INFO - 'TMOUT': '86400', 02:52:43 INFO - 'USER': 'cltbld', 02:52:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 02:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:43 INFO - '_': '/tools/buildbot/bin/python'} 02:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:43 INFO - Downloading/unpacking jsonschema==2.5.1 02:52:43 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 02:52:43 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 02:52:43 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 02:52:43 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 02:52:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:52:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:52:44 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 02:52:44 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 02:52:44 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 02:52:44 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 02:52:45 INFO - Downloading functools32-3.2.3-2.tar.gz 02:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:52:45 INFO - warning: no files found matching '*.txt' 02:52:45 INFO - no previously-included directories found matching 'build' 02:52:45 INFO - no previously-included directories found matching 'dist' 02:52:45 INFO - no previously-included directories found matching '.git*' 02:52:45 INFO - Installing collected packages: jsonschema, functools32 02:52:46 INFO - Running setup.py install for functools32 02:52:46 INFO - warning: no files found matching '*.txt' 02:52:46 INFO - no previously-included directories found matching 'build' 02:52:46 INFO - no previously-included directories found matching 'dist' 02:52:46 INFO - no previously-included directories found matching '.git*' 02:52:46 INFO - Successfully installed jsonschema functools32 02:52:46 INFO - Cleaning up... 02:52:46 INFO - Return code: 0 02:52:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:46 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1359a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500090>, '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 0x1500d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14faf90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', '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 02:52:46 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 02:52:46 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 02:52:46 INFO - Using env: {'DISPLAY': ':0', 02:52:46 INFO - 'HOME': '/home/cltbld', 02:52:46 INFO - 'LANG': 'en_US.UTF-8', 02:52:46 INFO - 'LANGUAGE': 'en_US:en', 02:52:46 INFO - 'LOGNAME': 'cltbld', 02:52:46 INFO - 'MAIL': '/var/mail/cltbld', 02:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:46 INFO - 'MOZ_NO_REMOTE': '1', 02:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:46 INFO - 'NO_EM_RESTART': '1', 02:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:46 INFO - 'PWD': '/builds/slave/test', 02:52:46 INFO - 'SHELL': '/bin/bash', 02:52:46 INFO - 'SHLVL': '1', 02:52:46 INFO - 'TERM': 'linux', 02:52:46 INFO - 'TMOUT': '86400', 02:52:46 INFO - 'USER': 'cltbld', 02:52:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 02:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:46 INFO - '_': '/tools/buildbot/bin/python'} 02:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:52:46 INFO - Cleaning up... 02:52:46 INFO - Return code: 0 02:52:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:46 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1359a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500090>, '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 0x1500d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14faf90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', '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 02:52:46 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 02:52:46 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 02:52:46 INFO - Using env: {'DISPLAY': ':0', 02:52:46 INFO - 'HOME': '/home/cltbld', 02:52:46 INFO - 'LANG': 'en_US.UTF-8', 02:52:46 INFO - 'LANGUAGE': 'en_US:en', 02:52:46 INFO - 'LOGNAME': 'cltbld', 02:52:46 INFO - 'MAIL': '/var/mail/cltbld', 02:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:46 INFO - 'MOZ_NO_REMOTE': '1', 02:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:46 INFO - 'NO_EM_RESTART': '1', 02:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:46 INFO - 'PWD': '/builds/slave/test', 02:52:46 INFO - 'SHELL': '/bin/bash', 02:52:46 INFO - 'SHLVL': '1', 02:52:46 INFO - 'TERM': 'linux', 02:52:46 INFO - 'TMOUT': '86400', 02:52:46 INFO - 'USER': 'cltbld', 02:52:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 02:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:46 INFO - '_': '/tools/buildbot/bin/python'} 02:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:47 INFO - Downloading/unpacking blobuploader==1.2.4 02:52:47 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 02:52:47 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 02:52:47 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 02:52:47 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 02:52:48 INFO - Downloading blobuploader-1.2.4.tar.gz 02:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:52:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:52:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:48 INFO - Downloading docopt-0.6.1.tar.gz 02:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:52:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:52:48 INFO - Running setup.py install for blobuploader 02:52:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:52:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:52:49 INFO - Running setup.py install for requests 02:52:49 INFO - Running setup.py install for docopt 02:52:49 INFO - Successfully installed blobuploader requests docopt 02:52:49 INFO - Cleaning up... 02:52:49 INFO - Return code: 0 02:52:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:49 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')]} 02:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:49 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')]} 02:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:49 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1359a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500090>, '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 0x1500d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14faf90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', '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 02:52:49 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 02:52:49 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 02:52:49 INFO - Using env: {'DISPLAY': ':0', 02:52:49 INFO - 'HOME': '/home/cltbld', 02:52:49 INFO - 'LANG': 'en_US.UTF-8', 02:52:49 INFO - 'LANGUAGE': 'en_US:en', 02:52:49 INFO - 'LOGNAME': 'cltbld', 02:52:49 INFO - 'MAIL': '/var/mail/cltbld', 02:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:49 INFO - 'MOZ_NO_REMOTE': '1', 02:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:49 INFO - 'NO_EM_RESTART': '1', 02:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:49 INFO - 'PWD': '/builds/slave/test', 02:52:49 INFO - 'SHELL': '/bin/bash', 02:52:49 INFO - 'SHLVL': '1', 02:52:49 INFO - 'TERM': 'linux', 02:52:49 INFO - 'TMOUT': '86400', 02:52:49 INFO - 'USER': 'cltbld', 02:52:49 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 02:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:49 INFO - '_': '/tools/buildbot/bin/python'} 02:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:49 INFO - Running setup.py (path:/tmp/pip-gYXy19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:49 INFO - Running setup.py (path:/tmp/pip-T9jaSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:49 INFO - Running setup.py (path:/tmp/pip-kJX13j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:49 INFO - Running setup.py (path:/tmp/pip-CulDzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:50 INFO - Running setup.py (path:/tmp/pip-uOIA8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:50 INFO - Running setup.py (path:/tmp/pip-DHs_h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:50 INFO - Running setup.py (path:/tmp/pip-27A_Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:50 INFO - Running setup.py (path:/tmp/pip-SF73Gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:50 INFO - Running setup.py (path:/tmp/pip-Zhkj0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:50 INFO - Running setup.py (path:/tmp/pip-x4IllH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:50 INFO - Running setup.py (path:/tmp/pip-75C91w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:50 INFO - Running setup.py (path:/tmp/pip-q360rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:50 INFO - Running setup.py (path:/tmp/pip-nCabzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:50 INFO - Running setup.py (path:/tmp/pip-2kplf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:50 INFO - Running setup.py (path:/tmp/pip-7C0Rz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:50 INFO - Running setup.py (path:/tmp/pip-Fxe454-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:50 INFO - Running setup.py (path:/tmp/pip-bYhuB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:52:50 INFO - Running setup.py install for manifestparser 02:52:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Running setup.py install for mozcrash 02:52:51 INFO - Running setup.py install for mozdebug 02:52:51 INFO - Running setup.py install for mozdevice 02:52:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Running setup.py install for mozfile 02:52:51 INFO - Running setup.py install for mozhttpd 02:52:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Running setup.py install for mozinfo 02:52:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Running setup.py install for mozInstall 02:52:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Running setup.py install for mozleak 02:52:51 INFO - Running setup.py install for mozlog 02:52:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Running setup.py install for moznetwork 02:52:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Running setup.py install for mozprocess 02:52:52 INFO - Running setup.py install for mozprofile 02:52:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Running setup.py install for mozrunner 02:52:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Running setup.py install for mozscreenshot 02:52:52 INFO - Running setup.py install for moztest 02:52:52 INFO - Running setup.py install for mozversion 02:52:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:52:52 INFO - Cleaning up... 02:52:52 INFO - Return code: 0 02:52:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:52 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1359a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500090>, '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 0x1500d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14faf90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', '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 02:52:52 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 02:52:52 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 02:52:52 INFO - Using env: {'DISPLAY': ':0', 02:52:52 INFO - 'HOME': '/home/cltbld', 02:52:52 INFO - 'LANG': 'en_US.UTF-8', 02:52:52 INFO - 'LANGUAGE': 'en_US:en', 02:52:52 INFO - 'LOGNAME': 'cltbld', 02:52:52 INFO - 'MAIL': '/var/mail/cltbld', 02:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:52 INFO - 'MOZ_NO_REMOTE': '1', 02:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:52 INFO - 'NO_EM_RESTART': '1', 02:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:52 INFO - 'PWD': '/builds/slave/test', 02:52:52 INFO - 'SHELL': '/bin/bash', 02:52:52 INFO - 'SHLVL': '1', 02:52:52 INFO - 'TERM': 'linux', 02:52:52 INFO - 'TMOUT': '86400', 02:52:52 INFO - 'USER': 'cltbld', 02:52:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 02:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:52 INFO - '_': '/tools/buildbot/bin/python'} 02:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:52 INFO - Running setup.py (path:/tmp/pip-2YA12K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:52 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)) 02:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:52 INFO - Running setup.py (path:/tmp/pip-5_XqBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:53 INFO - Running setup.py (path:/tmp/pip-7wlDs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:53 INFO - Running setup.py (path:/tmp/pip-H0sEff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:53 INFO - Running setup.py (path:/tmp/pip-_Z077x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:53 INFO - Running setup.py (path:/tmp/pip-AJ35qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:53 INFO - Running setup.py (path:/tmp/pip-5XHjVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:53 INFO - Running setup.py (path:/tmp/pip-C1xWx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:53 INFO - Running setup.py (path:/tmp/pip-cK5YCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:53 INFO - Running setup.py (path:/tmp/pip-rUmf_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:53 INFO - Running setup.py (path:/tmp/pip-EqvV9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:53 INFO - Running setup.py (path:/tmp/pip-k_AhPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:53 INFO - Running setup.py (path:/tmp/pip-zo_cnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:53 INFO - Running setup.py (path:/tmp/pip-iVEHRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:53 INFO - Running setup.py (path:/tmp/pip-4pIuOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:53 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)) 02:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:53 INFO - Running setup.py (path:/tmp/pip-z2waVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:54 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)) 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:54 INFO - Running setup.py (path:/tmp/pip-QTjj_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:54 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)) 02:52:54 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)) 02:52:54 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)) 02:52:54 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)) 02:52:54 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)) 02:52:54 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)) 02:52:54 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)) 02:52:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:55 INFO - Downloading blessings-1.6.tar.gz 02:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:52:55 INFO - Installing collected packages: blessings 02:52:55 INFO - Running setup.py install for blessings 02:52:55 INFO - Successfully installed blessings 02:52:55 INFO - Cleaning up... 02:52:55 INFO - Return code: 0 02:52:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:52:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:55 INFO - Reading from file tmpfile_stdout 02:52:55 INFO - Current package versions: 02:52:55 INFO - argparse == 1.2.1 02:52:55 INFO - blessings == 1.6 02:52:55 INFO - blobuploader == 1.2.4 02:52:55 INFO - docopt == 0.6.1 02:52:55 INFO - functools32 == 3.2.3-2 02:52:55 INFO - jsonschema == 2.5.1 02:52:55 INFO - manifestparser == 1.1 02:52:55 INFO - mozInstall == 1.13 02:52:55 INFO - mozcrash == 1.0 02:52:55 INFO - mozdebug == 0.1 02:52:55 INFO - mozdevice == 0.51 02:52:55 INFO - mozfile == 1.2 02:52:55 INFO - mozhttpd == 0.7 02:52:55 INFO - mozinfo == 0.10 02:52:55 INFO - mozleak == 0.1 02:52:55 INFO - mozlog == 3.5 02:52:55 INFO - moznetwork == 0.27 02:52:55 INFO - mozprocess == 0.25 02:52:55 INFO - mozprofile == 0.28 02:52:55 INFO - mozrunner == 6.13 02:52:55 INFO - mozscreenshot == 0.1 02:52:55 INFO - mozsystemmonitor == 0.3 02:52:55 INFO - moztest == 0.8 02:52:55 INFO - mozversion == 1.4 02:52:55 INFO - psutil == 3.1.1 02:52:55 INFO - requests == 1.2.3 02:52:55 INFO - wsgiref == 0.1.2 02:52:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52: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')]} 02:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:55 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1359a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500090>, '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 0x1500d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14faf90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', '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 02:52:55 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 02:52:55 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 02:52:55 INFO - Using env: {'DISPLAY': ':0', 02:52:55 INFO - 'HOME': '/home/cltbld', 02:52:55 INFO - 'LANG': 'en_US.UTF-8', 02:52:55 INFO - 'LANGUAGE': 'en_US:en', 02:52:55 INFO - 'LOGNAME': 'cltbld', 02:52:55 INFO - 'MAIL': '/var/mail/cltbld', 02:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:55 INFO - 'MOZ_NO_REMOTE': '1', 02:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:55 INFO - 'NO_EM_RESTART': '1', 02:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:55 INFO - 'PWD': '/builds/slave/test', 02:52:55 INFO - 'SHELL': '/bin/bash', 02:52:55 INFO - 'SHLVL': '1', 02:52:55 INFO - 'TERM': 'linux', 02:52:55 INFO - 'TMOUT': '86400', 02:52:55 INFO - 'USER': 'cltbld', 02:52:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 02:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:55 INFO - '_': '/tools/buildbot/bin/python'} 02:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:55 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)) 02:52:55 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)) 02:52:55 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)) 02:52:55 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)) 02:52:55 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)) 02:52:55 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)) 02:52:55 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)) 02:52:55 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)) 02:52:55 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)) 02:52:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:52:57 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)) 02:52:57 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)) 02:52:57 INFO - Installing collected packages: simplejson 02:52:57 INFO - Running setup.py install for simplejson 02:52:57 INFO - building 'simplejson._speedups' extension 02:52:57 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 02:52:57 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 02:52:58 INFO - Successfully installed simplejson 02:52:58 INFO - Cleaning up... 02:52:58 INFO - Return code: 0 02:52:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:52:58 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')]} 02:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:58 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')]} 02:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:58 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 0x11901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1359a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1500090>, '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 0x1500d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14faf90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', '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 02:52:58 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 02:52:58 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 02:52:58 INFO - Using env: {'DISPLAY': ':0', 02:52:58 INFO - 'HOME': '/home/cltbld', 02:52:58 INFO - 'LANG': 'en_US.UTF-8', 02:52:58 INFO - 'LANGUAGE': 'en_US:en', 02:52:58 INFO - 'LOGNAME': 'cltbld', 02:52:58 INFO - 'MAIL': '/var/mail/cltbld', 02:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:58 INFO - 'MOZ_NO_REMOTE': '1', 02:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:58 INFO - 'NO_EM_RESTART': '1', 02:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:58 INFO - 'PWD': '/builds/slave/test', 02:52:58 INFO - 'SHELL': '/bin/bash', 02:52:58 INFO - 'SHLVL': '1', 02:52:58 INFO - 'TERM': 'linux', 02:52:58 INFO - 'TMOUT': '86400', 02:52:58 INFO - 'USER': 'cltbld', 02:52:58 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 02:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:58 INFO - '_': '/tools/buildbot/bin/python'} 02:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:52:58 INFO - Cleaning up... 02:52:58 INFO - Return code: 0 02:52:58 INFO - Running post-action listener: _resource_record_post_action 02:52:58 INFO - Running post-action listener: _start_resource_monitoring 02:52:58 INFO - Starting resource monitoring. 02:52:58 INFO - [mozharness: 2017-09-14 09:52:58.406015Z] Finished create-virtualenv step (success) 02:52:58 INFO - [mozharness: 2017-09-14 09:52:58.406597Z] Running install step. 02:52:58 INFO - Running pre-action listener: _resource_record_pre_action 02:52:58 INFO - Running main action method: install 02:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:58 INFO - Reading from file tmpfile_stdout 02:52:58 INFO - Detecting whether we're running mozinstall >=1.0... 02:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:52:58 INFO - Reading from file tmpfile_stdout 02:52:58 INFO - Output received: 02:52:58 INFO - Usage: mozinstall [options] installer 02:52:58 INFO - Options: 02:52:58 INFO - -h, --help show this help message and exit 02:52:58 INFO - -d DEST, --destination=DEST 02:52:58 INFO - Directory to install application into. [default: 02:52:58 INFO - "/builds/slave/test"] 02:52:58 INFO - --app=APP Application being installed. [default: firefox] 02:52:58 INFO - mkdir: /builds/slave/test/build/application 02:52:58 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'] 02:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:53:16 INFO - Reading from file tmpfile_stdout 02:53:16 INFO - Output received: 02:53:16 INFO - /builds/slave/test/build/application/firefox/firefox 02:53:16 INFO - Running post-action listener: _resource_record_post_action 02:53:16 INFO - [mozharness: 2017-09-14 09:53:16.496226Z] Finished install step (success) 02:53:16 INFO - [mozharness: 2017-09-14 09:53:16.496375Z] Running setup-mitmproxy step. 02:53:16 INFO - Running pre-action listener: _resource_record_pre_action 02:53:16 INFO - Running main action method: setup_mitmproxy 02:53:16 INFO - Skipping: mitmproxy is not required 02:53:16 INFO - Running post-action listener: _resource_record_post_action 02:53:16 INFO - [mozharness: 2017-09-14 09:53:16.496899Z] Finished setup-mitmproxy step (success) 02:53:16 INFO - [mozharness: 2017-09-14 09:53:16.496999Z] Running run-tests step. 02:53:16 INFO - Running pre-action listener: _resource_record_pre_action 02:53:16 INFO - Running pre-action listener: _set_gcov_prefix 02:53:16 INFO - Running main action method: run_tests 02:53:16 WARNING - Try message not found. 02:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:53:16 INFO - Python 2.7.3 02:53:16 INFO - Return code: 0 02:53:16 INFO - grabbing minidump binary from tooltool 02:53: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')]} 02:53:16 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 0x1500090>, '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 0x1500d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14faf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:53:16 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 02:53:16 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 02:53:16 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 02:53:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:53:16 INFO - Return code: 0 02:53:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:53:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:53:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:53:16 INFO - ENV: RUST_BACKTRACE is now full 02:53:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:53:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:53:16 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/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 02:53:16 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/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 02:53:16 INFO - Using env: {'DISPLAY': ':0', 02:53:16 INFO - 'HOME': '/home/cltbld', 02:53:16 INFO - 'LANG': 'en_US.UTF-8', 02:53:16 INFO - 'LANGUAGE': 'en_US:en', 02:53:16 INFO - 'LOGNAME': 'cltbld', 02:53:16 INFO - 'MAIL': '/var/mail/cltbld', 02:53:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:53:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:53:16 INFO - 'MOZ_ACCELERATED': '1', 02:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:16 INFO - 'MOZ_NO_REMOTE': '1', 02:53:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:53:16 INFO - 'MOZ_WEBRENDER': '1', 02:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:16 INFO - 'NO_EM_RESTART': '1', 02:53:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:16 INFO - 'PWD': '/builds/slave/test', 02:53:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:53:16 INFO - 'RUST_BACKTRACE': 'full', 02:53:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:53:16 INFO - 'SHELL': '/bin/bash', 02:53:16 INFO - 'SHLVL': '1', 02:53:16 INFO - 'TERM': 'linux', 02:53:16 INFO - 'TMOUT': '86400', 02:53:16 INFO - 'USER': 'cltbld', 02:53:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 02:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:16 INFO - '_': '/tools/buildbot/bin/python'} 02:53:16 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/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 02:53:16 INFO - mozversion application_buildid: 20170914090430 02:53:16 INFO - mozversion application_changeset: dd6b788f149763c4014c27f2fe1a1d13228bda82 02:53:16 INFO - mozversion application_display_name: Nightly 02:53:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:53:16 INFO - mozversion application_name: Firefox 02:53:16 INFO - mozversion application_remotingname: firefox 02:53:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:53:16 INFO - mozversion application_vendor: Mozilla 02:53:16 INFO - mozversion application_version: 57.0a1 02:53:16 INFO - mozversion platform_buildid: 20170914090430 02:53:16 INFO - mozversion platform_changeset: dd6b788f149763c4014c27f2fe1a1d13228bda82 02:53:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:53:16 INFO - mozversion platform_version: 57.0a1 02:53:16 INFO - using testdate: 1505382796 02:53:16 INFO - actual date: 1505382796 02:53:16 INFO - starting webserver on 'localhost:51433' 02:53:16 INFO - SUITE-START | Running 2 tests 02:53:16 INFO - TEST-START | dromaeo_css 02:53:16 INFO - Initialising browser for dromaeo_css test... 02:53:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51433/getInfo.html -profile /tmp/tmphOPeXY/profile 02:53:16 INFO - TEST-INFO | started process 24875 (/builds/slave/test/build/application/firefox/firefox http://localhost:51433/getInfo.html) 02:53:23 INFO - TEST-INFO | 24875: exit 0 02:53:23 INFO - Browser initialized. 02:53:23 INFO - Running cycle 1/1 for dromaeo_css test... 02:53:23 INFO - Using env: {'DISPLAY': ':0', 02:53:23 INFO - 'HOME': '/home/cltbld', 02:53:23 INFO - 'JSGC_DISABLE_POISONING': '1', 02:53:23 INFO - 'LANG': 'en_US.UTF-8', 02:53:23 INFO - 'LANGUAGE': 'en_US:en', 02:53:23 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:53:23 INFO - 'LOGNAME': 'cltbld', 02:53:23 INFO - 'MAIL': '/var/mail/cltbld', 02:53:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:53:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:53:23 INFO - 'MOZ_ACCELERATED': '1', 02:53:23 INFO - 'MOZ_CRASHREPORTER': '1', 02:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:23 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:53:23 INFO - 'MOZ_NO_REMOTE': '1', 02:53:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:53:23 INFO - 'MOZ_WEBRENDER': '1', 02:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:23 INFO - 'NO_EM_RESTART': '1', 02:53:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:23 INFO - 'PWD': '/builds/slave/test', 02:53:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:53:23 INFO - 'RUST_BACKTRACE': 'full', 02:53:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:53:23 INFO - 'SHELL': '/bin/bash', 02:53:23 INFO - 'SHLVL': '1', 02:53:23 INFO - 'TERM': 'linux', 02:53:23 INFO - 'TMOUT': '86400', 02:53:23 INFO - 'USER': 'cltbld', 02:53:23 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 02:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:23 INFO - '_': '/tools/buildbot/bin/python'} 02:53:23 INFO - TEST-INFO | started process 25121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphOPeXY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:24 INFO - PID 25121 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:53:24 INFO - PID 25121 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:53:24 INFO - PID 25121 | 02:53:24 INFO - PID 25121 | (/builds/slave/test/build/application/firefox/firefox:25181): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:53:24 INFO - PID 25121 | 02:53:35 INFO - PID 25121 | RSS: Main: 201478144 02:53:35 INFO - PID 25121 | 02:56:32 INFO - PID 25121 | Cycle 1(1): loaded http://localhost:51433/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51433/tests/dromaeo/cssquery-ext.html) 02:56:34 INFO - PID 25121 | RSS: Main: 211509248 02:56:34 INFO - PID 25121 | 02:59:36 INFO - PID 25121 | Cycle 1(1): loaded http://localhost:51433/tests/dromaeo/cssquery-ext.html (next: http://localhost:51433/tests/dromaeo/cssquery-jquery.html) 02:59:37 INFO - PID 25121 | RSS: Main: 208420864 02:59:37 INFO - PID 25121 | 03:02:39 INFO - PID 25121 | Cycle 1(1): loaded http://localhost:51433/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51433/tests/dromaeo/cssquery-mootools.html) 03:02:39 INFO - PID 25121 | RSS: Main: 213450752 03:02:39 INFO - PID 25121 | 03:05:41 INFO - PID 25121 | Cycle 1(1): loaded http://localhost:51433/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51433/tests/dromaeo/cssquery-prototype.html) 03:05:42 INFO - PID 25121 | RSS: Main: 206331904 03:05:42 INFO - PID 25121 | 03:08:46 INFO - PID 25121 | Cycle 1(1): loaded http://localhost:51433/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51433/tests/dromaeo/cssquery-yui.html) 03:08:46 INFO - PID 25121 | RSS: Main: 211079168 03:08:46 INFO - PID 25121 | 03:11:48 INFO - PID 25121 | Cycle 1(1): loaded http://localhost:51433/tests/dromaeo/cssquery-yui.html (next: http://localhost:51433/tests/dromaeo/cssquery-dojo.html) 03:11:48 INFO - PID 25121 | RSS: Main: 213774336 03:11:48 INFO - PID 25121 | 03:11:49 INFO - PID 25121 | __start_tp_report 03:11:49 INFO - PID 25121 | _x_x_mozilla_page_load 03:11:49 INFO - PID 25121 | _x_x_mozilla_page_load_details 03:11:49 INFO - PID 25121 | |i|pagename|runs| 03:11:49 INFO - PID 25121 | |0;dojo.html;3169.6513383527813;3169.8415079246033;3215.083701145174;3216.5014422764466;3226.0805670383947;6210.130581718563;6452.064450654658;6483.481321494281;6518.83702907427;6557.180352455943;6373.9362606373925;6391.904121438182;6395.392437718409;6399.712012959416;6408.359164083589;5847.912281315773;5885.411458854123;5891.263592050994;6001.819945401645;6020.397960203988;5968.283805943272;5988.2215312009375;5995.040793473046;6011.939880601181;6045.455908968192;1229.8341062444397;5815.127730840365;5875.735591898375;5910.527157827363;6061.818145455643;5837.620554663976;5866.266716660418;5913.970430147865;5920.348761636216;5921.230240068763;5826.475617194473;5835.074425439595;5842.737076831553;5901.4098590141075;5919.5560332974765;6267.2479302484;6343.111964324999;6485.643289619069;6523.967380163116;6534.183227096613;6928.099347084897;6931.514793964425;6933.20268169162;7032.472564557627;7043.6478176091505;6968.372846443794;7035.753748618774;7084.362407383309;7099.07711997437;7114.430845532345;6291.528135389818;6319.5260355473065;6371.490280777573;6454.548181627288;6460.676966151721;7104.289571042855;7159.67781449836;7211.1707153678;7237.927620723831;7243.89134162988;6738.157730283715;6758.83102922421;6804.149481314836;6825.283345248777;6873.450123990069;6908.378245957888;6937.479689023344;6967.7212911482975;6988.6855091521;6996.090508233999;6686.4985126115735;6747.05541224229;6848.7260509580055;6881.483888708367;6928.44572434204;6907.620080895498;6937.514373993873;6979.930200697928;6992.545484543489;7003.2296447390745;5124.205748109049;5257.263983042377;5268.683878967274;5278.762455689503;5303.549198318186;4506.346579745984;4535.705179163344;4609.032103258353;4613.3771940787565;4616.053708989649;5804.564657650693;5838.982925128638;5900.1739756434135;5916.171735956969;5920.289565252111;6760.0535924970545;6912;6914.204866440323;6923.134608173978;6945;5725.055365864669;5814.622049566765;5887.293524777054;5890.9410905891245;5930.406959304035;5635.549156067505;5661.858453538612;5717.113847353584;5739.995500787346;5744.597878148573;6562;6631.30371311015;6655.667216639149;6656.966715166393;6713.395794378529;6790.5925644461495;6913.5506192097355;6921.930780692129;6984.580925144508;7012.053372794608;6415.967920160369;6556.737730490727;6641.435477984425;6708.597484150967;6736.427403670743;6745.831354216184;6778.389944904785;6821.93178068213;6863.725450982104;6888.724451021903;6968.616726080114;7023.33278338557;7024.332688394595;7036.612986285599;7063.399611032914;6750.2237242715755;6750.561213521106;6821.3178682133375;6837.453003759588;6837.692303846239;6584.8353791155605;6718.992151177167;6729.5625784323865;6746.966265168643;6836.589804611739;6471.2234531856475;6569.835754106186;6584.670766461753;6668.633225172662;6716.261211266855;6826.214985276757;6833.487488438288;6835.14560679915;6854.554453960476;6918.757843475655;6513.837154071186;6534.313897040933;6573.835654108686;6596.901046484402;6617.933820661732 03:11:49 INFO - PID 25121 | |1;ext.html;847.9533625650589;866.3545658484426;873.3973558244811;876.3558784293547;882.0473888200742;38477.80761096197;42053.36919946203;42066;42148.15703685928;42180.36729449061;37576.06059848505;37987.810060949654;38024.61975380246;38181.23637527248;38294;6880.518363714542;6932.445404367639;6958.79123626292;7043.542169758949;7050.647467626598;7537.736179233728;7701.537907725527;7763.107242667081;7768.145503994584;7770.650320735552;7682.270184332479;7737.303642672158;7771.922280777177;7793.4934229275195;7793.727219547317;7606.581638009908;7726;7781.727639532589;7787.3770098392;7789.883151752728;7597.582132982684;7599.544027358376;7609.467337286392;7674.8081297968;7689.4232932530285;36950.81524592387;37150.62849371499;37469.81265093657;37514.43728344077;37565.43651845225;3491.493733408667;3522.823858807075;3551.6448355164534;3565.358235517606;3566.4293713005795;30938.69061309403;31094.222644433845;31129;31179;31204.687953120407;5131.640785145041;5136.512031357052;5186.351706036746;5214.843554693365;5242.554382877422;186226;187153;188596;188679;189079;41338.37992430116;47127.76436117797;47407.05185896263;47754.28368574474;47843.28235076477;44367;50486.495135048914;51662.48337516652;51663;51877.48122518802;16016.359345626277;16153.19234038317;16214.594635134215;16247.918760406123;16252.268647910872;13337.799933000819;13346;13359.265240411676;13386.464541418429;13410.664733381549;13944.093633913762;13973.371198296101;14018;14072.155670659793;14344.354504047344;5645.181448689999;5714.714264286769;5810.663547384041;5862.794802181988;5907.734151963172;992.4194346307492;995.1541189988452;1017.801528701896;1032.2670903658336;1045.268312181476;23188.53622927532;23316.88341558281;23333.41666458352;23543;23598.882005590207;1104.4974536585835;1117.6535274064904;1119.8432219489277;1133.5012594458412;1142.1433924556582;12247;12248.693782655504;12323.137380383467;12328.07539434546;12363.134580579454;212362;214070;215788;216358;216611;52920;52923;53057;53261.467385326425;53881.73059134679;1396.8882489400823;1465.0696807527083;1472.749632562467;1474.5944865161953;1476.0995792566741;22949.770502294763;23020.654690179326;23078.653820193045;23225.76774232236;23351.299461016195;37255;37385.065373365884;37418;37483.62516374911;37668;184008;186799;186809;187967;188041;30329.393412132074;32826;34411.65588344084;34654.13364665904;34927;42665.786671066446;42755.14489710251;42828.78585607052;43707.12585748331;43914.56085439105;31715.524267135548;31720.36559268848;31726.36547269088;31953;31993;30848.69151308458;31075;31296.217594559406;31489.21276968094;31684;34465.82767086249;35223.47164792581;35511;35635.82182089177;35664.82167589146;30175.849120754257;30844.383112338077;30887.69112308848;30956;31944;23076.653990115206;23099.19152829643;23172.652410214196;23209.3037208884;23687.644685330077 03:11:49 INFO - PID 25121 | |2;jquery.html;537.7526337884573;546.1643685161704;552.7429745168496;557.4898967444786;573.8192469372148;21012.789872101275;22101.66847497289;22107.557848843015;22162;22189.22337718178;22897;23676.526469470602;24009.519809603797;24012.279631611036;24020.87989560054;6456.128422662939;6611.239707433659;6619.404253617174;6627.37039981201;6635.971424429221;6536.738530458776;6662.633555154464;6667.166604174478;6695.230048544407;6700.631465269408;6623.834404139911;6656.800295991104;6668;6669.466442684574;6685.933140668604;6376.171097757308;6582.045603387506;6644.900326495106;6649.069130321759;6676.232233293161;6118.9694051529905;6167.814965551041;6179.227596550431;6195.163652906845;6195.721192546346;26854.328641784112;27763.305917352027;29165.416691666047;29480.852595736884;29496;2097.549026959211;2129.4356995396233;2148.6239908016037;2148.9247876324253;2152.0638522242716;18415.815841841544;18883.90558047201;18919.527011824677;18987;19045.7143142853;2327.487952650414;2352.682387877649;2396.9213853765873;2400.183937461254;2416.794572461343;122593;128427.35786321101;128545.35727321304;129926;137167.31416342856;14518;14649.168853893263;14673.559793206221;14697.252200688756;14938.551843444715;22783;22808.543829123326;22818.885905570365;22864.885675571848;22991.42521436944;9831.311808173503;9935.516120969758;10385.324953877975;10398.480075996169;10507.159427245802;9699.418034917786;9741.561629726537;9788.853167202498;9816.803663926681;9880.950595246977;8712.91287087121;8897.243734282658;8898.555072246361;8920.910790892009;9120.543972801333;2534.6451496790464;2545.4527276635613;2645.4047839236405;2682.731726827302;2725.550284203084;965.1554889471712;966.5070813884829;979.6081567372966;988.456349008057;992.2260636703382;19315.323963661205;19554.217831286875;19789.505262368268;19803;19904.70142947828;1031.4791030529684;1038.8753349598096;1040.3601784902382;1041.953112109957;1043.0820877627639;10600.787984240273;10932.180086493545;11030.669079927615;11045.558177672963;11047.944760276147;407751;416226;430360;430902.5364619533;431891;99880.00119998852;100766.4961675187;102427;102722.48638756758;103424.48287758513;1054.8048611006989;1147.300146910384;1184.1651635596884;1211.666791632308;1217.6347095871026;20492;20519.17923283052;20649.17403303851;21017.369478915658;21209.257675981884;53868.46131538791;57693;58692.70653646704;59069.704651476466;59120;68193;68778.31221687919;69318.65340673264;69564;71936.28063719296;14146.22195779242;14205.573832785032;14384.712305753617;14424.783628245375;14488.203148826915;23240.4189895254;23419.568955175782;23674.28977130689;23747.40631484227;23952.640710389707;17660;17670.293188272324;18439.90780046091;18555;18574.535636609195;16095.919520402324;17005.91497042507;17064.23210955535;17118.972861628343;17173.141342933053;18366.265349385874;18483.815161848208;18671.81328186701;19261.325853595055;19519.512012199808;14223.07550009246;14231.430742770173;14263.144211346937;14269.785953210918;14280.571582852532;18379.448616541526;18390.1724422404;18571;18676.43970680882;18744.43766686947 03:11:49 INFO - PID 25121 | |3;mootools.html;1298.5844529750482;1346.4816045822356;1353.5127354152503;1359.2320339008463;1363.5977386670932;14997.5500734978;15522.922385388085;15541.378344866205;15645.687086258267;15769.290381932811;15344.923275383635;15485.535433936971;15525.378984840592;15554.45559405421;15575.688486230269;2665.453582015687;2733.6172935789004;2737.274622225112;2759.599858020586;2761.0750398616487;2746.3408781892304;2784.470950519405;2789.609454676347;2793.7904657150693;2796.2170592234206;2657.4153686189006;2680.6917204521533;2684.4228490874457;2688.6101515280275;2700.675918889736;2617.476504699068;2670.412509247962;2679.54447743883;2685.248130523437;2690.0315886280923;2603.635491031257;2612.0727141864745;2618.3585021669624;2627.3037645024083;2634.5784674451997;14791.778123328158;14873.925630371887;14884.181370024644;14993.250337483192;15025.323860426308;7801.609919504002;8080.434369594131;8158.755237342889;8189.71336003243;8194.50832950019;5179.456157103487;5411.945880541183;5421.566274698054;5451.836444906659;5458.61789674723;1912.3306842605116;1927.152053096647;1947.045947485736;1964.4695932098252;1982.821546060847;23912.521749565087;24868.3782905427;25867.870660646575;26622.86688566564;26623.334416639544;6975.267596902354;7031.8945215821805;7052;7075.929240707527;7244.058272424551;20033.899830500755;20158.79841201569;20243.898780506002;20274.087666055064;20357.898210508854;8160.347172226327;8167.224113709188;8269.586520673942;8307.418480706414;8385.958070209732;7136.892946605805;7354.338109570164;7431.29402706742;7436.256374362629;7524.097108347033;5438.45615438453;5625.493705566519;5639.154126880919;5706.4864162225595;5761.337446193741;1687.8396552327508;1759.0589034866284;1767.6818172728774;1768.522498925283;1784.8125946775401;878.3412440669498;879.5426378283257;904.7421484876778;910.3081657940013;921.4517362169498;8049.39629527776;8465.365097617703;8530.957345213234;8574.742757717278;8601.096884827128;677.9423748981293;699.9265077166824;706.7950294414562;713.8072720365473;723.9855202895912;4625.421822272216;4704.3649107370065;4752.334673145762;4782.402199725035;4808.519148085164;20530.38408847737;21743.565128697337;21798.891005544872;21820.34538963802;21830.345089647337;20353.389398317777;21071.894640527007;21115;21174.258900938392;21194.15223391078;9055.27557795388;9240.8613870792;9651.083147101155;10727.892721072845;11005;8890.73327800167;9121.315901307296;9154.40496367734;9163.77090572741;9190.678326258549;17949.641007180046;18366.357177498725;18556.99999999946;18570;18738.25046998105;18328.63342733111;19272.421827345202;19470.12384442675;19719.507012324233;19870.304539341054;12093.879061209274;12160.331181784733;12171.878281217074;12175.208611440228;12265.816012759995;13894.791578126538;13905.51330703461;14010.649733756738;14016.369263382969;14140.717185656024;11044.392558409365;11261.436928153724;11683.766324673628;11735.941320293345;11931.105167112328;10834.729131771768;10926;11012.119030477703;11216.495257713259;11511.76976460483;9681.70954871355;9730.708078757649;9784.706458806248;9801.950990245003;9812.803743925224;7518.774436766906;7560.243975602396;7601.12587052496;7618.695252190072;7731.613419329124;6883.829748942792;6999.300069993164;7014.263502332182;7064.470164737562;7164.068671072727 03:11:49 INFO - PID 25121 | |4;prototype.html;502.4247236913734;504.95707864831496;530.4032962916718;531.2562412622328;534.9728521239225;6286.402791734784;6336.936630633698;6353.491720662348;6394.136791533142;6401.711922963466;6243.687815609224;6258.4680302174365;6266.811995640127;6288.434040936315;6326.873462530747;5174.120399532069;5174.146265866147;5194.142966410556;5216.8695782605355;5219.947800521984;5128.512791284822;5202.297689811884;5205.3233079699585;5207.791688332462;5211.322528071345;4719.4100737407825;4914.1400254955415;4985.40467050544;4991.975040124794;5136.58907287418;4921.163402221631;4940.08608407444;4966.701997880139;4967.677100988424;4998.12532806761;4390.978045109754;4409.677096870926;4410.316400957857;4425.645948324126;4432.357308190294;5950.880982380371;6035.460957455864;6100.877982440371;6127.356627554132;6174.2094792510115;5652.434756524356;5660.264165658438;5684.772609095631;5688.544916406678;5728.42715728428;6399.77600783975;6492.67536623167;6578.881590129641;6581.3747693969;6588.835279118012;4659.464161621423;4779.713217206979;4850.272459131159;4851.320815085891;4887;6724.462043036546;6774.729010839561;6856.691448884812;6918.515703900779;6986.266442023565;4955.529224723646;4985.700857948462;5015.22264049073;5016.899662006739;5019.322391477177;4975.800967961313;5040.521150490697;5049.747512624354;5065.974670126626;5067.1639179535705;5650.85872853182;5668.149777533321;5671.347795003545;5672.631278966854;5697.800576979868;6642.169728783902;6642.335766423319;6649.368310010638;6663.433608143362;6678.799636010927;1746.2840235503384;1751.798543167552;1753.9473815785548;1763.1889330907927;1773.4147731248656;1128.1595211567435;1182.1676401577693;1198.9400529973466;1218.7196944702769;1232.1559731583893;5545.55815487976;5597.80407685729;5644.9435505644415;5674.943250567441;5740;6588.967055164693;6677.933220667731;6691.464682825363;6752.662366881636;6767.221769496571;5586.24585680936;5587.580931430159;5599.888002239933;5653.219235940665;5674.773009079673;3498.6851183393615;3519.859205631797;3529.8411571479346;3550.343186510504;3552.5914519830035;6397.936020639827;6400.263969643457;6469.353064693493;6503.9349606504275;6513.869722605521;6804.965975170093;6843.692033858489;6923.826904327432;6929.861402771916;6929.955663079404;6340.175777149033;6347.238331400262;6366.236051673829;6435.774747883802;6476.708548115346;6123.955102572438;6415.967920160369;6604.867902642017;6632.30360812127;6642.940688386616;6494.967525162344;6509.218893732783;6520.250171230369;6624.370684784938;6632.535722499379;6450.54846160783;6462.736318159299;6468.482521398371;6476.222853257451;6480.8703825922275;4938.48145944685;4945.381827271591;4978.377702787152;4983.950160498349;5009.649324547392;6387.552871298964;6587.924803686823;6603.834904127435;6722.294159113223;6733.2593414725325;6341;6412.326705695835;6441.5490915635455;6519.902201467076;6568.704408301734;6382.393672601095;6414.326495718069;6487.18910136233;6517.641529715911;6518.5111116667385;6314.55798094129;6350.872982540231;6366.140571023038;6375.298717141203;6468.61188328683;6358.809235722936;6408.967955160381;6420.7431702731365;6477.902831457626;6532.771353002622;6326.272478665012;6329.493640508656;6381.138546296191;6397;6415.358464153547 03:11:49 INFO - PID 25121 | |5;yui.html;908.8954770201426;915.6703586708787;927.3693888156059;933.3140141995632;936.0452338614612;19823.702644460307;20109.698354524677;20654.89672551637;20688.689669654967;20707.378778636667;18798.624027519443;18895;19077.80922190781;19103.140358683857;19108.23567057316;958.1855422890523;972.6255391674185;975.3660120921387;976.0824824664828;977.8728765260541;942.1473566422399;964.2237998411276;982.832918403873;985.4924713772413;990.1385794358882;1042.4318746283257;1044.5873879817468;1045.5713157605383;1045.7699306152672;1045.8954104589518;1025.1644909398817;1029.5727273181622;1036.5646428500047;1037.0200160848;1040.3757745352802;716.8100453379858;726.2700985509529;733.0580204437273;733.7761982595306;737.7712908998174;20485.795142048537;20542.589148216954;20573.177072917064;20749.688754668692;20821.37535873926;20636.793632063636;20664.793352066587;22147.224847130274;22164.667529987062;22476.55046899053;17044.829551704574;17228.827711722846;17284;17332.65334693299;17474.388396406066;3770.547534295902;3792.412176112707;3803.410471376941;3821.312163810513;3838.769673819552;136659;138481.3075934614;138888;139812;141045.2947735265;16276.348946042262;16615.169241537875;17038.74441883373;17117.486475405756;17144.742828857576;29755.256118597208;30799.846000769852;30970.690293097232;31239.68760312368;31577.84211078976;8607.61265743043;8610.913890861011;8614.353923455767;8633.093525179891;8691.478511289342;4156.854510092132;4184.769837658897;4234.534201237861;4234.661227101825;4248.34150706641;5480.698561579072;5552.305961754781;5578.860528486739;5625.268715067015;5647.407022262603;1041.5833666533297;1074.7528068544123;1084.9891501084887;1086.2776253791299;1090.0298734126634;696.314130581377;707.992920070803;715.967781449836;717.0463283832595;722.4328901812053;11735.178537502294;11944.522219111139;12038.518459261531;12614.990800735919;13423.597292081253;618.4063299232787;631.1321932343028;638.3297537585516;650.3691419323249;652.5301782716436;5646.124850648156;5756.740946657411;5816.243888294494;5859.970700146472;5918.378570250062;119443.40278298726;125241;125287;125898;128677;106764.46617767017;110197;111067.44466277616;112192.43903780429;112726;89150.55424722836;93055;94169;96014.51992740131;96389.51805240929;10444.738881528023;10561.428564294843;10697.946510267398;10751.301165424222;11182.217244792786;42882.35676464793;44654.10691786211;45716;45745.31382029206;45939.54060459352;55584.72207638936;57222.42777572171;57578.42421575898;58033;58087.70956145192;15803.525894223192;15855.920720396785;15930;16266.837331627006;16276.348946042026;17865.106744662455;17938.461846144637;18109;18218.635627287644;18400.26398944027;16186.190690465193;16487;16689.248983795515;16918.57703557421;16939.915300423418;14095.436182552583;14118.858811411754;14120.43518259258;14267.143971361336;14515.564533064025;15204.543863684106;15265.694686106437;15325.923370383076;15387;15460.304286306919;11434.371109589052;11516.30902145874;11806.350650714294;11806.527738890349;11811.586594469152;11626.418679066182;12013.219140756173;12036.75926481448;12090.879091208975;12156.452959616661 03:11:49 INFO - PID 25121 | __end_tp_report 03:11:49 INFO - PID 25121 | __start_cc_report 03:11:49 INFO - PID 25121 | _x_x_mozilla_cycle_collect,349 03:11:49 INFO - PID 25121 | __end_cc_report 03:11:49 INFO - PID 25121 | __startTimestamp1505383908997__endTimestamp 03:11:49 INFO - PID 25121 | 03:11:49 INFO - PID 25121 | ------- Summary: start ------- 03:11:49 INFO - PID 25121 | Number of tests: 6 03:11:49 INFO - PID 25121 | 03:11:49 INFO - PID 25121 | [#0] dojo.html Cycles:165 Average:6302.75 Median:6573.84 stddev:895.97 (13.6%) stddev-sans-first:864.35 03:11:49 INFO - PID 25121 | Values: 3169.7 3169.8 3215.1 3216.5 3226.1 6210.1 6452.1 6483.5 6518.8 6557.2 6373.9 6391.9 6395.4 6399.7 6408.4 5847.9 5885.4 5891.3 6001.8 6020.4 5968.3 5988.2 5995.0 6011.9 6045.5 1229.8 5815.1 5875.7 5910.5 6061.8 5837.6 5866.3 5914.0 5920.3 5921.2 5826.5 5835.1 5842.7 5901.4 5919.6 6267.2 6343.1 6485.6 6524.0 6534.2 6928.1 6931.5 6933.2 7032.5 7043.6 6968.4 7035.8 7084.4 7099.1 7114.4 6291.5 6319.5 6371.5 6454.5 6460.7 7104.3 7159.7 7211.2 7237.9 7243.9 6738.2 6758.8 6804.1 6825.3 6873.5 6908.4 6937.5 6967.7 6988.7 6996.1 6686.5 6747.1 6848.7 6881.5 6928.4 6907.6 6937.5 6979.9 6992.5 7003.2 5124.2 5257.3 5268.7 5278.8 5303.5 4506.3 4535.7 4609.0 4613.4 4616.1 5804.6 5839.0 5900.2 5916.2 5920.3 6760.1 6912.0 6914.2 6923.1 6945.0 5725.1 5814.6 5887.3 5890.9 5930.4 5635.5 5661.9 5717.1 5740.0 5744.6 6562.0 6631.3 6655.7 6657.0 6713.4 6790.6 6913.6 6921.9 6984.6 7012.1 6416.0 6556.7 6641.4 6708.6 6736.4 6745.8 6778.4 6821.9 6863.7 6888.7 6968.6 7023.3 7024.3 7036.6 7063.4 6750.2 6750.6 6821.3 6837.5 6837.7 6584.8 6719.0 6729.6 6747.0 6836.6 6471.2 6569.8 6584.7 6668.6 6716.3 6826.2 6833.5 6835.1 6854.6 6918.8 6513.8 6534.3 6573.8 6596.9 6617.9 03:11:49 INFO - PID 25121 | 03:11:49 INFO - PID 25121 | [#1] ext.html Cycles:180 Average:36470.62 Median:19373.15 stddev:50947.61 (263.0%) stddev-sans-first:51020.31 03:11:49 INFO - PID 25121 | Values: 848.0 866.4 873.4 876.4 882.0 38477.8 42053.4 42066.0 42148.2 42180.4 37576.1 37987.8 38024.6 38181.2 38294.0 6880.5 6932.4 6958.8 7043.5 7050.6 7537.7 7701.5 7763.1 7768.1 7770.7 7682.3 7737.3 7771.9 7793.5 7793.7 7606.6 7726.0 7781.7 7787.4 7789.9 7597.6 7599.5 7609.5 7674.8 7689.4 36950.8 37150.6 37469.8 37514.4 37565.4 3491.5 3522.8 3551.6 3565.4 3566.4 30938.7 31094.2 31129.0 31179.0 31204.7 5131.6 5136.5 5186.4 5214.8 5242.6 186226.0 187153.0 188596.0 188679.0 189079.0 41338.4 47127.8 47407.1 47754.3 47843.3 44367.0 50486.5 51662.5 51663.0 51877.5 16016.4 16153.2 16214.6 16247.9 16252.3 13337.8 13346.0 13359.3 13386.5 13410.7 13944.1 13973.4 14018.0 14072.2 14344.4 5645.2 5714.7 5810.7 5862.8 5907.7 992.4 995.2 1017.8 1032.3 1045.3 23188.5 23316.9 23333.4 23543.0 23598.9 1104.5 1117.7 1119.8 1133.5 1142.1 12247.0 12248.7 12323.1 12328.1 12363.1 212362.0 214070.0 215788.0 216358.0 216611.0 52920.0 52923.0 53057.0 53261.5 53881.7 1396.9 1465.1 1472.7 1474.6 1476.1 22949.8 23020.7 23078.7 23225.8 23351.3 37255.0 37385.1 37418.0 37483.6 37668.0 184008.0 186799.0 186809.0 187967.0 188041.0 30329.4 32826.0 34411.7 34654.1 34927.0 42665.8 42755.1 42828.8 43707.1 43914.6 31715.5 31720.4 31726.4 31953.0 31993.0 30848.7 31075.0 31296.2 31489.2 31684.0 34465.8 35223.5 35511.0 35635.8 35664.8 30175.8 30844.4 30887.7 30956.0 31944.0 23076.7 23099.2 23172.7 23209.3 23687.6 03:11:49 INFO - PID 25121 | 03:11:49 INFO - PID 25121 | [#2] jquery.html Cycles:180 Average:32248.26 Median:22880.94 stddev:71677.47 (313.3%) stddev-sans-first:71839.00 03:11:49 INFO - PID 25121 | Values: 537.8 546.2 552.7 557.5 573.8 21012.8 22101.7 22107.6 22162.0 22189.2 22897.0 23676.5 24009.5 24012.3 24020.9 6456.1 6611.2 6619.4 6627.4 6636.0 6536.7 6662.6 6667.2 6695.2 6700.6 6623.8 6656.8 6668.0 6669.5 6685.9 6376.2 6582.0 6644.9 6649.1 6676.2 6119.0 6167.8 6179.2 6195.2 6195.7 26854.3 27763.3 29165.4 29480.9 29496.0 2097.5 2129.4 2148.6 2148.9 2152.1 18415.8 18883.9 18919.5 18987.0 19045.7 2327.5 2352.7 2396.9 2400.2 2416.8 122593.0 128427.4 128545.4 129926.0 137167.3 14518.0 14649.2 14673.6 14697.3 14938.6 22783.0 22808.5 22818.9 22864.9 22991.4 9831.3 9935.5 10385.3 10398.5 10507.2 9699.4 9741.6 9788.9 9816.8 9881.0 8712.9 8897.2 8898.6 8920.9 9120.5 2534.6 2545.5 2645.4 2682.7 2725.6 965.2 966.5 979.6 988.5 992.2 19315.3 19554.2 19789.5 19803.0 19904.7 1031.5 1038.9 1040.4 1042.0 1043.1 10600.8 10932.2 11030.7 11045.6 11047.9 407751.0 416226.0 430360.0 430902.5 431891.0 99880.0 100766.5 102427.0 102722.5 103424.5 1054.8 1147.3 1184.2 1211.7 1217.6 20492.0 20519.2 20649.2 21017.4 21209.3 53868.5 57693.0 58692.7 59069.7 59120.0 68193.0 68778.3 69318.7 69564.0 71936.3 14146.2 14205.6 14384.7 14424.8 14488.2 23240.4 23419.6 23674.3 23747.4 23952.6 17660.0 17670.3 18439.9 18555.0 18574.5 16095.9 17005.9 17064.2 17119.0 17173.1 18366.3 18483.8 18671.8 19261.3 19519.5 14223.1 14231.4 14263.1 14269.8 14280.6 18379.4 18390.2 18571.0 18676.4 18744.4 03:11:49 INFO - PID 25121 | 03:11:49 INFO - PID 25121 | [#3] mootools.html Cycles:180 Average:9426.42 Median:2674.98 stddev:6707.79 (250.8%) stddev-sans-first:6698.81 03:11:49 INFO - PID 25121 | Values: 1298.6 1346.5 1353.5 1359.2 1363.6 14997.6 15522.9 15541.4 15645.7 15769.3 15344.9 15485.5 15525.4 15554.5 15575.7 2665.5 2733.6 2737.3 2759.6 2761.1 2746.3 2784.5 2789.6 2793.8 2796.2 2657.4 2680.7 2684.4 2688.6 2700.7 2617.5 2670.4 2679.5 2685.2 2690.0 2603.6 2612.1 2618.4 2627.3 2634.6 14791.8 14873.9 14884.2 14993.3 15025.3 7801.6 8080.4 8158.8 8189.7 8194.5 5179.5 5411.9 5421.6 5451.8 5458.6 1912.3 1927.2 1947.0 1964.5 1982.8 23912.5 24868.4 25867.9 26622.9 26623.3 6975.3 7031.9 7052.0 7075.9 7244.1 20033.9 20158.8 20243.9 20274.1 20357.9 8160.3 8167.2 8269.6 8307.4 8386.0 7136.9 7354.3 7431.3 7436.3 7524.1 5438.5 5625.5 5639.2 5706.5 5761.3 1687.8 1759.1 1767.7 1768.5 1784.8 878.3 879.5 904.7 910.3 921.5 8049.4 8465.4 8531.0 8574.7 8601.1 677.9 699.9 706.8 713.8 724.0 4625.4 4704.4 4752.3 4782.4 4808.5 20530.4 21743.6 21798.9 21820.3 21830.3 20353.4 21071.9 21115.0 21174.3 21194.2 9055.3 9240.9 9651.1 10727.9 11005.0 8890.7 9121.3 9154.4 9163.8 9190.7 17949.6 18366.4 18557.0 18570.0 18738.3 18328.6 19272.4 19470.1 19719.5 19870.3 12093.9 12160.3 12171.9 12175.2 12265.8 13894.8 13905.5 14010.6 14016.4 14140.7 11044.4 11261.4 11683.8 11735.9 11931.1 10834.7 10926.0 11012.1 11216.5 11511.8 9681.7 9730.7 9784.7 9802.0 9812.8 7518.8 7560.2 7601.1 7618.7 7731.6 6883.8 6999.3 7014.3 7064.5 7164.1 03:11:49 INFO - PID 25121 | 03:11:49 INFO - PID 25121 | [#4] prototype.html Cycles:180 Average:5487.18 Median:6208.95 stddev:1532.83 (24.7%) stddev-sans-first:1490.77 03:11:49 INFO - PID 25121 | Values: 502.4 505.0 530.4 531.3 535.0 6286.4 6336.9 6353.5 6394.1 6401.7 6243.7 6258.5 6266.8 6288.4 6326.9 5174.1 5174.1 5194.1 5216.9 5219.9 5128.5 5202.3 5205.3 5207.8 5211.3 4719.4 4914.1 4985.4 4992.0 5136.6 4921.2 4940.1 4966.7 4967.7 4998.1 4391.0 4409.7 4410.3 4425.6 4432.4 5950.9 6035.5 6100.9 6127.4 6174.2 5652.4 5660.3 5684.8 5688.5 5728.4 6399.8 6492.7 6578.9 6581.4 6588.8 4659.5 4779.7 4850.3 4851.3 4887.0 6724.5 6774.7 6856.7 6918.5 6986.3 4955.5 4985.7 5015.2 5016.9 5019.3 4975.8 5040.5 5049.7 5066.0 5067.2 5650.9 5668.1 5671.3 5672.6 5697.8 6642.2 6642.3 6649.4 6663.4 6678.8 1746.3 1751.8 1753.9 1763.2 1773.4 1128.2 1182.2 1198.9 1218.7 1232.2 5545.6 5597.8 5644.9 5674.9 5740.0 6589.0 6677.9 6691.5 6752.7 6767.2 5586.2 5587.6 5599.9 5653.2 5674.8 3498.7 3519.9 3529.8 3550.3 3552.6 6397.9 6400.3 6469.4 6503.9 6513.9 6805.0 6843.7 6923.8 6929.9 6930.0 6340.2 6347.2 6366.2 6435.8 6476.7 6124.0 6416.0 6604.9 6632.3 6642.9 6495.0 6509.2 6520.3 6624.4 6632.5 6450.5 6462.7 6468.5 6476.2 6480.9 4938.5 4945.4 4978.4 4984.0 5009.6 6387.6 6587.9 6603.8 6722.3 6733.3 6341.0 6412.3 6441.5 6519.9 6568.7 6382.4 6414.3 6487.2 6517.6 6518.5 6314.6 6350.9 6366.1 6375.3 6468.6 6358.8 6409.0 6420.7 6477.9 6532.8 6326.3 6329.5 6381.1 6397.0 6415.4 03:11:49 INFO - PID 25121 | 03:11:49 INFO - PID 25121 | [#5] yui.html Cycles:180 Average:24453.95 Median:19966.70 stddev:35443.51 (177.5%) stddev-sans-first:35498.85 03:11:49 INFO - PID 25121 | Values: 908.9 915.7 927.4 933.3 936.0 19823.7 20109.7 20654.9 20688.7 20707.4 18798.6 18895.0 19077.8 19103.1 19108.2 958.2 972.6 975.4 976.1 977.9 942.1 964.2 982.8 985.5 990.1 1042.4 1044.6 1045.6 1045.8 1045.9 1025.2 1029.6 1036.6 1037.0 1040.4 716.8 726.3 733.1 733.8 737.8 20485.8 20542.6 20573.2 20749.7 20821.4 20636.8 20664.8 22147.2 22164.7 22476.6 17044.8 17228.8 17284.0 17332.7 17474.4 3770.5 3792.4 3803.4 3821.3 3838.8 136659.0 138481.3 138888.0 139812.0 141045.3 16276.3 16615.2 17038.7 17117.5 17144.7 29755.3 30799.8 30970.7 31239.7 31577.8 8607.6 8610.9 8614.4 8633.1 8691.5 4156.9 4184.8 4234.5 4234.7 4248.3 5480.7 5552.3 5578.9 5625.3 5647.4 1041.6 1074.8 1085.0 1086.3 1090.0 696.3 708.0 716.0 717.0 722.4 11735.2 11944.5 12038.5 12615.0 13423.6 618.4 631.1 638.3 650.4 652.5 5646.1 5756.7 5816.2 5860.0 5918.4 119443.4 125241.0 125287.0 125898.0 128677.0 106764.5 110197.0 111067.4 112192.4 112726.0 89150.6 93055.0 94169.0 96014.5 96389.5 10444.7 10561.4 10697.9 10751.3 11182.2 42882.4 44654.1 45716.0 45745.3 45939.5 55584.7 57222.4 57578.4 58033.0 58087.7 15803.5 15855.9 15930.0 16266.8 16276.3 17865.1 17938.5 18109.0 18218.6 18400.3 16186.2 16487.0 16689.2 16918.6 16939.9 14095.4 14118.9 14120.4 14267.1 14515.6 15204.5 15265.7 15325.9 15387.0 15460.3 11434.4 11516.3 11806.4 11806.5 11811.6 11626.4 12013.2 12036.8 12090.9 12156.5 03:11:49 INFO - PID 25121 | -------- Summary: end -------- 03:11:49 INFO - PID 25121 | 03:11:50 INFO - TEST-INFO | 25121: exit 0 03:11:50 INFO - TEST-OK | dromaeo_css | took 1113176ms 03:11:50 INFO - TEST-START | kraken 03:11:50 INFO - Initialising browser for kraken test... 03:11:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51433/getInfo.html -profile /tmp/tmp3B4nMC/profile 03:11:50 INFO - TEST-INFO | started process 25507 (/builds/slave/test/build/application/firefox/firefox http://localhost:51433/getInfo.html) 03:11:56 INFO - TEST-INFO | 25507: exit 0 03:11:56 INFO - Browser initialized. 03:11:56 INFO - Running cycle 1/1 for kraken test... 03:11:56 INFO - Using env: {'DISPLAY': ':0', 03:11:56 INFO - 'HOME': '/home/cltbld', 03:11:56 INFO - 'JSGC_DISABLE_POISONING': '1', 03:11:56 INFO - 'LANG': 'en_US.UTF-8', 03:11:56 INFO - 'LANGUAGE': 'en_US:en', 03:11:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:11:56 INFO - 'LOGNAME': 'cltbld', 03:11:56 INFO - 'MAIL': '/var/mail/cltbld', 03:11:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:11:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:11:56 INFO - 'MOZ_ACCELERATED': '1', 03:11:56 INFO - 'MOZ_CRASHREPORTER': '1', 03:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:11:56 INFO - 'MOZ_NO_REMOTE': '1', 03:11:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:11:56 INFO - 'MOZ_WEBRENDER': '1', 03:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:56 INFO - 'NO_EM_RESTART': '1', 03:11:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:56 INFO - 'PWD': '/builds/slave/test', 03:11:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:11:56 INFO - 'RUST_BACKTRACE': 'full', 03:11:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:11:56 INFO - 'SHELL': '/bin/bash', 03:11:56 INFO - 'SHLVL': '1', 03:11:56 INFO - 'TERM': 'linux', 03:11:56 INFO - 'TMOUT': '86400', 03:11:56 INFO - 'USER': 'cltbld', 03:11:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896', 03:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:56 INFO - '_': '/tools/buildbot/bin/python'} 03:11:56 INFO - TEST-INFO | started process 25753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3B4nMC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:57 INFO - PID 25753 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:11:57 INFO - PID 25753 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:11:57 INFO - PID 25753 | 03:11:57 INFO - PID 25753 | (/builds/slave/test/build/application/firefox/firefox:25812): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:11:57 INFO - PID 25753 | 03:12:07 INFO - PID 25753 | RSS: Main: 202317824 03:12:07 INFO - PID 25753 | 03:12:10 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51433/tests/kraken/driver.html?testName=audio-beat-detection) 03:12:11 INFO - PID 25753 | RSS: Main: 208154624 03:12:11 INFO - PID 25753 | 03:12:14 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51433/tests/kraken/driver.html?testName=audio-dft) 03:12:14 INFO - PID 25753 | RSS: Main: 208572416 03:12:14 INFO - PID 25753 | 03:12:18 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51433/tests/kraken/driver.html?testName=audio-fft) 03:12:18 INFO - PID 25753 | RSS: Main: 204632064 03:12:18 INFO - PID 25753 | 03:12:20 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51433/tests/kraken/driver.html?testName=audio-oscillator) 03:12:21 INFO - PID 25753 | RSS: Main: 205762560 03:12:21 INFO - PID 25753 | 03:12:23 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51433/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:12:24 INFO - PID 25753 | RSS: Main: 205303808 03:12:24 INFO - PID 25753 | 03:12:27 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51433/tests/kraken/driver.html?testName=imaging-darkroom) 03:12:28 INFO - PID 25753 | RSS: Main: 208060416 03:12:28 INFO - PID 25753 | 03:12:31 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51433/tests/kraken/driver.html?testName=imaging-desaturate) 03:12:32 INFO - PID 25753 | RSS: Main: 206942208 03:12:32 INFO - PID 25753 | 03:12:35 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51433/tests/kraken/driver.html?testName=json-parse-financial) 03:12:36 INFO - PID 25753 | RSS: Main: 207421440 03:12:36 INFO - PID 25753 | 03:12:37 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51433/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:12:38 INFO - PID 25753 | RSS: Main: 207847424 03:12:38 INFO - PID 25753 | 03:12:40 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:12:40 INFO - PID 25753 | RSS: Main: 204894208 03:12:40 INFO - PID 25753 | 03:12:43 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:12:43 INFO - PID 25753 | RSS: Main: 205193216 03:12:43 INFO - PID 25753 | 03:12:46 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:12:47 INFO - PID 25753 | RSS: Main: 205840384 03:12:47 INFO - PID 25753 | 03:12:50 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:12:50 INFO - PID 25753 | RSS: Main: 205680640 03:12:50 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51433/tests/kraken/driver.html?testName=ai-astar) 03:12:52 INFO - PID 25753 | RSS: Main: 208678912 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | __start_tp_report 03:12:52 INFO - PID 25753 | _x_x_mozilla_page_load 03:12:52 INFO - PID 25753 | _x_x_mozilla_page_load_details 03:12:52 INFO - PID 25753 | |i|pagename|runs| 03:12:52 INFO - PID 25753 | |0;ai-astar;108;117;109;108;115;109;107;113;112;121 03:12:52 INFO - PID 25753 | |1;audio-beat-detection;123;124;118;116;117;129;119;124;124;117 03:12:52 INFO - PID 25753 | |2;audio-dft;163;166;163;164;165;176;162;163;168;169 03:12:52 INFO - PID 25753 | |3;audio-fft;85;79;84;74;76;81;75;74;74;84 03:12:52 INFO - PID 25753 | |4;audio-oscillator;80;80;78;83;79;87;80;82;79;80 03:12:52 INFO - PID 25753 | |5;imaging-gaussian-blur;114;123;116;116;117;119;114;116;115;116 03:12:52 INFO - PID 25753 | |6;imaging-darkroom;147;162;149;152;151;151;149;160;151;154 03:12:52 INFO - PID 25753 | |7;imaging-desaturate;97;94;94;96;97;96;94;98;95;96 03:12:52 INFO - PID 25753 | |8;json-parse-financial;54;54;54;57;56;53;65;53;58;53 03:12:52 INFO - PID 25753 | |9;json-stringify-tinderbox;45;54;38;41;39;39;46;46;44;39 03:12:52 INFO - PID 25753 | |10;stanford-crypto-aes;76;74;78;79;78;74;75;83;74;82 03:12:52 INFO - PID 25753 | |11;stanford-crypto-ccm;120;116;112;125;131;113;111;118;117;118 03:12:52 INFO - PID 25753 | |12;stanford-crypto-pbkdf2;171;169;175;176;173;170;166;179;166;170 03:12:52 INFO - PID 25753 | |13;stanford-crypto-sha256-iterative;68;66;69;65;65;67;64;67;73;66 03:12:52 INFO - PID 25753 | __end_tp_report 03:12:52 INFO - PID 25753 | __start_cc_report 03:12:52 INFO - PID 25753 | _x_x_mozilla_cycle_collect,946 03:12:52 INFO - PID 25753 | __end_cc_report 03:12:52 INFO - PID 25753 | __startTimestamp1505383972868__endTimestamp 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | ------- Summary: start ------- 03:12:52 INFO - PID 25753 | Number of tests: 14 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:4.61 (4.1%) stddev-sans-first:4.66 03:12:52 INFO - PID 25753 | Values: 108.0 117.0 109.0 108.0 115.0 109.0 107.0 113.0 112.0 121.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#1] audio-beat-detection Cycles:10 Average:121.10 Median:123.50 stddev:4.28 (3.5%) stddev-sans-first:4.48 03:12:52 INFO - PID 25753 | Values: 123.0 124.0 118.0 116.0 117.0 129.0 119.0 124.0 124.0 117.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.50 stddev:4.23 (2.6%) stddev-sans-first:4.35 03:12:52 INFO - PID 25753 | Values: 163.0 166.0 163.0 164.0 165.0 176.0 162.0 163.0 168.0 169.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#3] audio-fft Cycles:10 Average:78.60 Median:80.00 stddev:4.58 (5.7%) stddev-sans-first:4.23 03:12:52 INFO - PID 25753 | Values: 85.0 79.0 84.0 74.0 76.0 81.0 75.0 74.0 74.0 84.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#4] audio-oscillator Cycles:10 Average:80.80 Median:80.00 stddev:2.62 (3.3%) stddev-sans-first:2.76 03:12:52 INFO - PID 25753 | Values: 80.0 80.0 78.0 83.0 79.0 87.0 80.0 82.0 79.0 80.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:116.00 stddev:2.67 (2.3%) stddev-sans-first:2.67 03:12:52 INFO - PID 25753 | Values: 114.0 123.0 116.0 116.0 117.0 119.0 114.0 116.0 115.0 116.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#6] imaging-darkroom Cycles:10 Average:152.60 Median:151.50 stddev:4.84 (3.2%) stddev-sans-first:4.68 03:12:52 INFO - PID 25753 | Values: 147.0 162.0 149.0 152.0 151.0 151.0 149.0 160.0 151.0 154.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:1.42 (1.5%) stddev-sans-first:1.42 03:12:52 INFO - PID 25753 | Values: 97.0 94.0 94.0 96.0 97.0 96.0 94.0 98.0 95.0 96.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:3.71 (6.8%) stddev-sans-first:3.89 03:12:52 INFO - PID 25753 | Values: 54.0 54.0 54.0 57.0 56.0 53.0 65.0 53.0 58.0 53.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#9] json-stringify-tinderbox Cycles:10 Average:43.10 Median:44.50 stddev:4.95 (11.1%) stddev-sans-first:5.21 03:12:52 INFO - PID 25753 | Values: 45.0 54.0 38.0 41.0 39.0 39.0 46.0 46.0 44.0 39.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:78.00 stddev:3.30 (4.2%) stddev-sans-first:3.47 03:12:52 INFO - PID 25753 | Values: 76.0 74.0 78.0 79.0 78.0 74.0 75.0 83.0 74.0 82.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:118.00 stddev:6.12 (5.2%) stddev-sans-first:6.45 03:12:52 INFO - PID 25753 | Values: 120.0 116.0 112.0 125.0 131.0 113.0 111.0 118.0 117.0 118.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:172.00 stddev:4.25 (2.5%) stddev-sans-first:4.50 03:12:52 INFO - PID 25753 | Values: 171.0 169.0 175.0 176.0 173.0 170.0 166.0 179.0 166.0 170.0 03:12:52 INFO - PID 25753 | 03:12:52 INFO - PID 25753 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:2.58 (3.9%) stddev-sans-first:2.71 03:12:52 INFO - PID 25753 | Values: 68.0 66.0 69.0 65.0 65.0 67.0 64.0 67.0 73.0 66.0 03:12:52 INFO - PID 25753 | -------- Summary: end -------- 03:12:52 INFO - PID 25753 | 03:12:53 INFO - PID 25753 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:12:53 INFO - TEST-INFO | 25753: exit 0 03:12:53 INFO - TEST-OK | kraken | took 63865ms 03:12:53 INFO - SUITE-END | took 1177s 03:12:54 INFO - Completed test suite (00:19:37) 03:12:54 INFO - javascript benchmark 03:12:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8509.276783217087, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3169.6513383527813, 3169.8415079246033, 3215.083701145174, 3216.5014422764466, 3226.0805670383947, 6210.130581718563, 6452.064450654658, 6483.481321494281, 6518.83702907427, 6557.180352455943, 6373.9362606373925, 6391.904121438182, 6395.392437718409, 6399.712012959416, 6408.359164083589, 5847.912281315773, 5885.411458854123, 5891.263592050994, 6001.819945401645, 6020.397960203988, 5968.283805943272, 5988.2215312009375, 5995.040793473046, 6011.939880601181, 6045.455908968192, 1229.8341062444397, 5815.127730840365, 5875.735591898375, 5910.527157827363, 6061.818145455643, 5837.620554663976, 5866.266716660418, 5913.970430147865, 5920.348761636216, 5921.230240068763, 5826.475617194473, 5835.074425439595, 5842.737076831553, 5901.4098590141075, 5919.5560332974765, 6267.2479302484, 6343.111964324999, 6485.643289619069, 6523.967380163116, 6534.183227096613, 6928.099347084897, 6931.514793964425, 6933.20268169162, 7032.472564557627, 7043.6478176091505, 6968.372846443794, 7035.753748618774, 7084.362407383309, 7099.07711997437, 7114.430845532345, 6291.528135389818, 6319.5260355473065, 6371.490280777573, 6454.548181627288, 6460.676966151721, 7104.289571042855, 7159.67781449836, 7211.1707153678, 7237.927620723831, 7243.89134162988, 6738.157730283715, 6758.83102922421, 6804.149481314836, 6825.283345248777, 6873.450123990069, 6908.378245957888, 6937.479689023344, 6967.7212911482975, 6988.6855091521, 6996.090508233999, 6686.4985126115735, 6747.05541224229, 6848.7260509580055, 6881.483888708367, 6928.44572434204, 6907.620080895498, 6937.514373993873, 6979.930200697928, 6992.545484543489, 7003.2296447390745, 5124.205748109049, 5257.263983042377, 5268.683878967274, 5278.762455689503, 5303.549198318186, 4506.346579745984, 4535.705179163344, 4609.032103258353, 4613.3771940787565, 4616.053708989649, 5804.564657650693, 5838.982925128638, 5900.1739756434135, 5916.171735956969, 5920.289565252111, 6760.0535924970545, 6912.0, 6914.204866440323, 6923.134608173978, 6945.0, 5725.055365864669, 5814.622049566765, 5887.293524777054, 5890.9410905891245, 5930.406959304035, 5635.549156067505, 5661.858453538612, 5717.113847353584, 5739.995500787346, 5744.597878148573, 6562.0, 6631.30371311015, 6655.667216639149, 6656.966715166393, 6713.395794378529, 6790.5925644461495, 6913.5506192097355, 6921.930780692129, 6984.580925144508, 7012.053372794608, 6415.967920160369, 6556.737730490727, 6641.435477984425, 6708.597484150967, 6736.427403670743, 6745.831354216184, 6778.389944904785, 6821.93178068213, 6863.725450982104, 6888.724451021903, 6968.616726080114, 7023.33278338557, 7024.332688394595, 7036.612986285599, 7063.399611032914, 6750.2237242715755, 6750.561213521106, 6821.3178682133375, 6837.453003759588, 6837.692303846239, 6584.8353791155605, 6718.992151177167, 6729.5625784323865, 6746.966265168643, 6836.589804611739, 6471.2234531856475, 6569.835754106186, 6584.670766461753, 6668.633225172662, 6716.261211266855, 6826.214985276757, 6833.487488438288, 6835.14560679915, 6854.554453960476, 6918.757843475655, 6513.837154071186, 6534.313897040933, 6573.835654108686, 6596.901046484402, 6617.933820661732], "value": 6234.303382758747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [847.9533625650589, 866.3545658484426, 873.3973558244811, 876.3558784293547, 882.0473888200742, 38477.80761096197, 42053.36919946203, 42066.0, 42148.15703685928, 42180.36729449061, 37576.06059848505, 37987.810060949654, 38024.61975380246, 38181.23637527248, 38294.0, 6880.518363714542, 6932.445404367639, 6958.79123626292, 7043.542169758949, 7050.647467626598, 7537.736179233728, 7701.537907725527, 7763.107242667081, 7768.145503994584, 7770.650320735552, 7682.270184332479, 7737.303642672158, 7771.922280777177, 7793.4934229275195, 7793.727219547317, 7606.581638009908, 7726.0, 7781.727639532589, 7787.3770098392, 7789.883151752728, 7597.582132982684, 7599.544027358376, 7609.467337286392, 7674.8081297968, 7689.4232932530285, 36950.81524592387, 37150.62849371499, 37469.81265093657, 37514.43728344077, 37565.43651845225, 3491.493733408667, 3522.823858807075, 3551.6448355164534, 3565.358235517606, 3566.4293713005795, 30938.69061309403, 31094.222644433845, 31129.0, 31179.0, 31204.687953120407, 5131.640785145041, 5136.512031357052, 5186.351706036746, 5214.843554693365, 5242.554382877422, 186226.0, 187153.0, 188596.0, 188679.0, 189079.0, 41338.37992430116, 47127.76436117797, 47407.05185896263, 47754.28368574474, 47843.28235076477, 44367.0, 50486.495135048914, 51662.48337516652, 51663.0, 51877.48122518802, 16016.359345626277, 16153.19234038317, 16214.594635134215, 16247.918760406123, 16252.268647910872, 13337.799933000819, 13346.0, 13359.265240411676, 13386.464541418429, 13410.664733381549, 13944.093633913762, 13973.371198296101, 14018.0, 14072.155670659793, 14344.354504047344, 5645.181448689999, 5714.714264286769, 5810.663547384041, 5862.794802181988, 5907.734151963172, 992.4194346307492, 995.1541189988452, 1017.801528701896, 1032.2670903658336, 1045.268312181476, 23188.53622927532, 23316.88341558281, 23333.41666458352, 23543.0, 23598.882005590207, 1104.4974536585835, 1117.6535274064904, 1119.8432219489277, 1133.5012594458412, 1142.1433924556582, 12247.0, 12248.693782655504, 12323.137380383467, 12328.07539434546, 12363.134580579454, 212362.0, 214070.0, 215788.0, 216358.0, 216611.0, 52920.0, 52923.0, 53057.0, 53261.467385326425, 53881.73059134679, 1396.8882489400823, 1465.0696807527083, 1472.749632562467, 1474.5944865161953, 1476.0995792566741, 22949.770502294763, 23020.654690179326, 23078.653820193045, 23225.76774232236, 23351.299461016195, 37255.0, 37385.065373365884, 37418.0, 37483.62516374911, 37668.0, 184008.0, 186799.0, 186809.0, 187967.0, 188041.0, 30329.393412132074, 32826.0, 34411.65588344084, 34654.13364665904, 34927.0, 42665.786671066446, 42755.14489710251, 42828.78585607052, 43707.12585748331, 43914.56085439105, 31715.524267135548, 31720.36559268848, 31726.36547269088, 31953.0, 31993.0, 30848.69151308458, 31075.0, 31296.217594559406, 31489.21276968094, 31684.0, 34465.82767086249, 35223.47164792581, 35511.0, 35635.82182089177, 35664.82167589146, 30175.849120754257, 30844.383112338077, 30887.69112308848, 30956.0, 31944.0, 23076.653990115206, 23099.19152829643, 23172.652410214196, 23209.3037208884, 23687.644685330077], "value": 16951.620732730808, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.7526337884573, 546.1643685161704, 552.7429745168496, 557.4898967444786, 573.8192469372148, 21012.789872101275, 22101.66847497289, 22107.557848843015, 22162.0, 22189.22337718178, 22897.0, 23676.526469470602, 24009.519809603797, 24012.279631611036, 24020.87989560054, 6456.128422662939, 6611.239707433659, 6619.404253617174, 6627.37039981201, 6635.971424429221, 6536.738530458776, 6662.633555154464, 6667.166604174478, 6695.230048544407, 6700.631465269408, 6623.834404139911, 6656.800295991104, 6668.0, 6669.466442684574, 6685.933140668604, 6376.171097757308, 6582.045603387506, 6644.900326495106, 6649.069130321759, 6676.232233293161, 6118.9694051529905, 6167.814965551041, 6179.227596550431, 6195.163652906845, 6195.721192546346, 26854.328641784112, 27763.305917352027, 29165.416691666047, 29480.852595736884, 29496.0, 2097.549026959211, 2129.4356995396233, 2148.6239908016037, 2148.9247876324253, 2152.0638522242716, 18415.815841841544, 18883.90558047201, 18919.527011824677, 18987.0, 19045.7143142853, 2327.487952650414, 2352.682387877649, 2396.9213853765873, 2400.183937461254, 2416.794572461343, 122593.0, 128427.35786321101, 128545.35727321304, 129926.0, 137167.31416342856, 14518.0, 14649.168853893263, 14673.559793206221, 14697.252200688756, 14938.551843444715, 22783.0, 22808.543829123326, 22818.885905570365, 22864.885675571848, 22991.42521436944, 9831.311808173503, 9935.516120969758, 10385.324953877975, 10398.480075996169, 10507.159427245802, 9699.418034917786, 9741.561629726537, 9788.853167202498, 9816.803663926681, 9880.950595246977, 8712.91287087121, 8897.243734282658, 8898.555072246361, 8920.910790892009, 9120.543972801333, 2534.6451496790464, 2545.4527276635613, 2645.4047839236405, 2682.731726827302, 2725.550284203084, 965.1554889471712, 966.5070813884829, 979.6081567372966, 988.456349008057, 992.2260636703382, 19315.323963661205, 19554.217831286875, 19789.505262368268, 19803.0, 19904.70142947828, 1031.4791030529684, 1038.8753349598096, 1040.3601784902382, 1041.953112109957, 1043.0820877627639, 10600.787984240273, 10932.180086493545, 11030.669079927615, 11045.558177672963, 11047.944760276147, 407751.0, 416226.0, 430360.0, 430902.5364619533, 431891.0, 99880.00119998852, 100766.4961675187, 102427.0, 102722.48638756758, 103424.48287758513, 1054.8048611006989, 1147.300146910384, 1184.1651635596884, 1211.666791632308, 1217.6347095871026, 20492.0, 20519.17923283052, 20649.17403303851, 21017.369478915658, 21209.257675981884, 53868.46131538791, 57693.0, 58692.70653646704, 59069.704651476466, 59120.0, 68193.0, 68778.31221687919, 69318.65340673264, 69564.0, 71936.28063719296, 14146.22195779242, 14205.573832785032, 14384.712305753617, 14424.783628245375, 14488.203148826915, 23240.4189895254, 23419.568955175782, 23674.28977130689, 23747.40631484227, 23952.640710389707, 17660.0, 17670.293188272324, 18439.90780046091, 18555.0, 18574.535636609195, 16095.919520402324, 17005.91497042507, 17064.23210955535, 17118.972861628343, 17173.141342933053, 18366.265349385874, 18483.815161848208, 18671.81328186701, 19261.325853595055, 19519.512012199808, 14223.07550009246, 14231.430742770173, 14263.144211346937, 14269.785953210918, 14280.571582852532, 18379.448616541526, 18390.1724422404, 18571.0, 18676.43970680882, 18744.43766686947], "value": 11850.656559153396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.5844529750482, 1346.4816045822356, 1353.5127354152503, 1359.2320339008463, 1363.5977386670932, 14997.5500734978, 15522.922385388085, 15541.378344866205, 15645.687086258267, 15769.290381932811, 15344.923275383635, 15485.535433936971, 15525.378984840592, 15554.45559405421, 15575.688486230269, 2665.453582015687, 2733.6172935789004, 2737.274622225112, 2759.599858020586, 2761.0750398616487, 2746.3408781892304, 2784.470950519405, 2789.609454676347, 2793.7904657150693, 2796.2170592234206, 2657.4153686189006, 2680.6917204521533, 2684.4228490874457, 2688.6101515280275, 2700.675918889736, 2617.476504699068, 2670.412509247962, 2679.54447743883, 2685.248130523437, 2690.0315886280923, 2603.635491031257, 2612.0727141864745, 2618.3585021669624, 2627.3037645024083, 2634.5784674451997, 14791.778123328158, 14873.925630371887, 14884.181370024644, 14993.250337483192, 15025.323860426308, 7801.609919504002, 8080.434369594131, 8158.755237342889, 8189.71336003243, 8194.50832950019, 5179.456157103487, 5411.945880541183, 5421.566274698054, 5451.836444906659, 5458.61789674723, 1912.3306842605116, 1927.152053096647, 1947.045947485736, 1964.4695932098252, 1982.821546060847, 23912.521749565087, 24868.3782905427, 25867.870660646575, 26622.86688566564, 26623.334416639544, 6975.267596902354, 7031.8945215821805, 7052.0, 7075.929240707527, 7244.058272424551, 20033.899830500755, 20158.79841201569, 20243.898780506002, 20274.087666055064, 20357.898210508854, 8160.347172226327, 8167.224113709188, 8269.586520673942, 8307.418480706414, 8385.958070209732, 7136.892946605805, 7354.338109570164, 7431.29402706742, 7436.256374362629, 7524.097108347033, 5438.45615438453, 5625.493705566519, 5639.154126880919, 5706.4864162225595, 5761.337446193741, 1687.8396552327508, 1759.0589034866284, 1767.6818172728774, 1768.522498925283, 1784.8125946775401, 878.3412440669498, 879.5426378283257, 904.7421484876778, 910.3081657940013, 921.4517362169498, 8049.39629527776, 8465.365097617703, 8530.957345213234, 8574.742757717278, 8601.096884827128, 677.9423748981293, 699.9265077166824, 706.7950294414562, 713.8072720365473, 723.9855202895912, 4625.421822272216, 4704.3649107370065, 4752.334673145762, 4782.402199725035, 4808.519148085164, 20530.38408847737, 21743.565128697337, 21798.891005544872, 21820.34538963802, 21830.345089647337, 20353.389398317777, 21071.894640527007, 21115.0, 21174.258900938392, 21194.15223391078, 9055.27557795388, 9240.8613870792, 9651.083147101155, 10727.892721072845, 11005.0, 8890.73327800167, 9121.315901307296, 9154.40496367734, 9163.77090572741, 9190.678326258549, 17949.641007180046, 18366.357177498725, 18556.99999999946, 18570.0, 18738.25046998105, 18328.63342733111, 19272.421827345202, 19470.12384442675, 19719.507012324233, 19870.304539341054, 12093.879061209274, 12160.331181784733, 12171.878281217074, 12175.208611440228, 12265.816012759995, 13894.791578126538, 13905.51330703461, 14010.649733756738, 14016.369263382969, 14140.717185656024, 11044.392558409365, 11261.436928153724, 11683.766324673628, 11735.941320293345, 11931.105167112328, 10834.729131771768, 10926.0, 11012.119030477703, 11216.495257713259, 11511.76976460483, 9681.70954871355, 9730.708078757649, 9784.706458806248, 9801.950990245003, 9812.803743925224, 7518.774436766906, 7560.243975602396, 7601.12587052496, 7618.695252190072, 7731.613419329124, 6883.829748942792, 6999.300069993164, 7014.263502332182, 7064.470164737562, 7164.068671072727], "value": 6696.978646068215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.4247236913734, 504.95707864831496, 530.4032962916718, 531.2562412622328, 534.9728521239225, 6286.402791734784, 6336.936630633698, 6353.491720662348, 6394.136791533142, 6401.711922963466, 6243.687815609224, 6258.4680302174365, 6266.811995640127, 6288.434040936315, 6326.873462530747, 5174.120399532069, 5174.146265866147, 5194.142966410556, 5216.8695782605355, 5219.947800521984, 5128.512791284822, 5202.297689811884, 5205.3233079699585, 5207.791688332462, 5211.322528071345, 4719.4100737407825, 4914.1400254955415, 4985.40467050544, 4991.975040124794, 5136.58907287418, 4921.163402221631, 4940.08608407444, 4966.701997880139, 4967.677100988424, 4998.12532806761, 4390.978045109754, 4409.677096870926, 4410.316400957857, 4425.645948324126, 4432.357308190294, 5950.880982380371, 6035.460957455864, 6100.877982440371, 6127.356627554132, 6174.2094792510115, 5652.434756524356, 5660.264165658438, 5684.772609095631, 5688.544916406678, 5728.42715728428, 6399.77600783975, 6492.67536623167, 6578.881590129641, 6581.3747693969, 6588.835279118012, 4659.464161621423, 4779.713217206979, 4850.272459131159, 4851.320815085891, 4887.0, 6724.462043036546, 6774.729010839561, 6856.691448884812, 6918.515703900779, 6986.266442023565, 4955.529224723646, 4985.700857948462, 5015.22264049073, 5016.899662006739, 5019.322391477177, 4975.800967961313, 5040.521150490697, 5049.747512624354, 5065.974670126626, 5067.1639179535705, 5650.85872853182, 5668.149777533321, 5671.347795003545, 5672.631278966854, 5697.800576979868, 6642.169728783902, 6642.335766423319, 6649.368310010638, 6663.433608143362, 6678.799636010927, 1746.2840235503384, 1751.798543167552, 1753.9473815785548, 1763.1889330907927, 1773.4147731248656, 1128.1595211567435, 1182.1676401577693, 1198.9400529973466, 1218.7196944702769, 1232.1559731583893, 5545.55815487976, 5597.80407685729, 5644.9435505644415, 5674.943250567441, 5740.0, 6588.967055164693, 6677.933220667731, 6691.464682825363, 6752.662366881636, 6767.221769496571, 5586.24585680936, 5587.580931430159, 5599.888002239933, 5653.219235940665, 5674.773009079673, 3498.6851183393615, 3519.859205631797, 3529.8411571479346, 3550.343186510504, 3552.5914519830035, 6397.936020639827, 6400.263969643457, 6469.353064693493, 6503.9349606504275, 6513.869722605521, 6804.965975170093, 6843.692033858489, 6923.826904327432, 6929.861402771916, 6929.955663079404, 6340.175777149033, 6347.238331400262, 6366.236051673829, 6435.774747883802, 6476.708548115346, 6123.955102572438, 6415.967920160369, 6604.867902642017, 6632.30360812127, 6642.940688386616, 6494.967525162344, 6509.218893732783, 6520.250171230369, 6624.370684784938, 6632.535722499379, 6450.54846160783, 6462.736318159299, 6468.482521398371, 6476.222853257451, 6480.8703825922275, 4938.48145944685, 4945.381827271591, 4978.377702787152, 4983.950160498349, 5009.649324547392, 6387.552871298964, 6587.924803686823, 6603.834904127435, 6722.294159113223, 6733.2593414725325, 6341.0, 6412.326705695835, 6441.5490915635455, 6519.902201467076, 6568.704408301734, 6382.393672601095, 6414.326495718069, 6487.18910136233, 6517.641529715911, 6518.5111116667385, 6314.55798094129, 6350.872982540231, 6366.140571023038, 6375.298717141203, 6468.61188328683, 6358.809235722936, 6408.967955160381, 6420.7431702731365, 6477.902831457626, 6532.771353002622, 6326.272478665012, 6329.493640508656, 6381.138546296191, 6397.0, 6415.358464153547], "value": 5036.373153890872, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.8954770201426, 915.6703586708787, 927.3693888156059, 933.3140141995632, 936.0452338614612, 19823.702644460307, 20109.698354524677, 20654.89672551637, 20688.689669654967, 20707.378778636667, 18798.624027519443, 18895.0, 19077.80922190781, 19103.140358683857, 19108.23567057316, 958.1855422890523, 972.6255391674185, 975.3660120921387, 976.0824824664828, 977.8728765260541, 942.1473566422399, 964.2237998411276, 982.832918403873, 985.4924713772413, 990.1385794358882, 1042.4318746283257, 1044.5873879817468, 1045.5713157605383, 1045.7699306152672, 1045.8954104589518, 1025.1644909398817, 1029.5727273181622, 1036.5646428500047, 1037.0200160848, 1040.3757745352802, 716.8100453379858, 726.2700985509529, 733.0580204437273, 733.7761982595306, 737.7712908998174, 20485.795142048537, 20542.589148216954, 20573.177072917064, 20749.688754668692, 20821.37535873926, 20636.793632063636, 20664.793352066587, 22147.224847130274, 22164.667529987062, 22476.55046899053, 17044.829551704574, 17228.827711722846, 17284.0, 17332.65334693299, 17474.388396406066, 3770.547534295902, 3792.412176112707, 3803.410471376941, 3821.312163810513, 3838.769673819552, 136659.0, 138481.3075934614, 138888.0, 139812.0, 141045.2947735265, 16276.348946042262, 16615.169241537875, 17038.74441883373, 17117.486475405756, 17144.742828857576, 29755.256118597208, 30799.846000769852, 30970.690293097232, 31239.68760312368, 31577.84211078976, 8607.61265743043, 8610.913890861011, 8614.353923455767, 8633.093525179891, 8691.478511289342, 4156.854510092132, 4184.769837658897, 4234.534201237861, 4234.661227101825, 4248.34150706641, 5480.698561579072, 5552.305961754781, 5578.860528486739, 5625.268715067015, 5647.407022262603, 1041.5833666533297, 1074.7528068544123, 1084.9891501084887, 1086.2776253791299, 1090.0298734126634, 696.314130581377, 707.992920070803, 715.967781449836, 717.0463283832595, 722.4328901812053, 11735.178537502294, 11944.522219111139, 12038.518459261531, 12614.990800735919, 13423.597292081253, 618.4063299232787, 631.1321932343028, 638.3297537585516, 650.3691419323249, 652.5301782716436, 5646.124850648156, 5756.740946657411, 5816.243888294494, 5859.970700146472, 5918.378570250062, 119443.40278298726, 125241.0, 125287.0, 125898.0, 128677.0, 106764.46617767017, 110197.0, 111067.44466277616, 112192.43903780429, 112726.0, 89150.55424722836, 93055.0, 94169.0, 96014.51992740131, 96389.51805240929, 10444.738881528023, 10561.428564294843, 10697.946510267398, 10751.301165424222, 11182.217244792786, 42882.35676464793, 44654.10691786211, 45716.0, 45745.31382029206, 45939.54060459352, 55584.72207638936, 57222.42777572171, 57578.42421575898, 58033.0, 58087.70956145192, 15803.525894223192, 15855.920720396785, 15930.0, 16266.837331627006, 16276.348946042026, 17865.106744662455, 17938.461846144637, 18109.0, 18218.635627287644, 18400.26398944027, 16186.190690465193, 16487.0, 16689.248983795515, 16918.57703557421, 16939.915300423418, 14095.436182552583, 14118.858811411754, 14120.43518259258, 14267.143971361336, 14515.564533064025, 15204.543863684106, 15265.694686106437, 15325.923370383076, 15387.0, 15460.304286306919, 11434.371109589052, 11516.30902145874, 11806.350650714294, 11806.527738890349, 11811.586594469152, 11626.418679066182, 12013.219140756173, 12036.75926481448, 12090.879091208975, 12156.452959616661], "value": 8986.537909992774, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 109.0, 108.0, 115.0, 109.0, 107.0, 113.0, 112.0, 121.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 118.0, 116.0, 117.0, 129.0, 119.0, 124.0, 124.0, 117.0], "value": 121.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 163.0, 164.0, 165.0, 176.0, 162.0, 163.0, 168.0, 169.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 84.0, 74.0, 76.0, 81.0, 75.0, 74.0, 74.0, 84.0], "value": 78.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 78.0, 83.0, 79.0, 87.0, 80.0, 82.0, 79.0, 80.0], "value": 80.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 123.0, 116.0, 116.0, 117.0, 119.0, 114.0, 116.0, 115.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 162.0, 149.0, 152.0, 151.0, 151.0, 149.0, 160.0, 151.0, 154.0], "value": 152.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 94.0, 96.0, 97.0, 96.0, 94.0, 98.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 57.0, 56.0, 53.0, 65.0, 53.0, 58.0, 53.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 54.0, 38.0, 41.0, 39.0, 39.0, 46.0, 46.0, 44.0, 39.0], "value": 43.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 78.0, 79.0, 78.0, 74.0, 75.0, 83.0, 74.0, 82.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 116.0, 112.0, 125.0, 131.0, 113.0, 111.0, 118.0, 117.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 175.0, 176.0, 173.0, 170.0, 166.0, 179.0, 166.0, 170.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 69.0, 65.0, 65.0, 67.0, 64.0, 67.0, 73.0, 66.0], "value": 67.0, "unit": "score"}]}]} 03:12:54 INFO - Return code: 0 03:12:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:12:54 INFO - # TBPL SUCCESS # 03:12:54 INFO - Running post-action listener: _package_coverage_data 03:12:54 INFO - Running post-action listener: _resource_record_post_action 03:12:54 INFO - [mozharness: 2017-09-14 10:12:54.134610Z] Finished run-tests step (success) 03:12:54 INFO - Running post-run listener: _resource_record_post_run 03:12:54 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 401408; Write bytes: 331849728; Read time: 500; Write time: 318560 03:12:54 INFO - TinderboxPrint: CPU usage
13.3% 03:12:54 INFO - TinderboxPrint: I/O read bytes / time
401,408 / 500 03:12:54 INFO - TinderboxPrint: I/O write bytes / time
331,849,728 / 318,560 03:12:54 INFO - TinderboxPrint: CPU idle
8,255.5 (86.7%) 03:12:54 INFO - TinderboxPrint: CPU user
1,204.5 (12.6%) 03:12:54 INFO - TinderboxPrint: Swap in / out
0 / 0 03:12:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10629120; Read time: 0; Write time: 1732 03:12:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:12:54 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 397312; Write bytes: 321220608; Read time: 488; Write time: 316828 03:12:54 INFO - Running post-run listener: _upload_blobber_files 03:12:54 INFO - Blob upload gear active. 03:12:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:12:54 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 03:12:54 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'] 03:12:54 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 03:12:55 INFO - (blobuploader) - INFO - Open directory for files ... 03:12:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:12:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:12:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:56 INFO - (blobuploader) - INFO - Done attempting. 03:12:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:12:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:12:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:59 INFO - (blobuploader) - INFO - Done attempting. 03:12:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:12:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:13:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:01 INFO - (blobuploader) - INFO - Done attempting. 03:13:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:13:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:13:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:02 INFO - (blobuploader) - INFO - Done attempting. 03:13:02 INFO - (blobuploader) - INFO - Iteration through files over. 03:13:02 INFO - Return code: 0 03:13:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:13:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:13:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8270b619b9712317c08dc6f457bbfae4f1fb2fba9ffa5205a362e3cb2923bc49b8622fcf567cbb80d3c1eed190f233aaa704dc6355b2bc121eaabeccfe8de3fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcb6a72fcbc0094181324c41be1c58019fed6b8c7283fd460808fd1db994a5aa8c778536b61ea314628b3fe2d36fc2f10f9a997d59c9f454ee53720c02d8ad64", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b01000e0e996517298d5fc82f74537a2434cee8c7b2fdb27a457cda714b33e0a6dd9b0b1a7d483ca28ed2137bcf7d251067bee365cc0ab98a6be67c72b54d80", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d62c3443f328024564b4623f0c76b03a355032981d29e59331eb8aa37b64557b76e7cc7b0b4197a5e65f17f032d2f2c2214d58791f0c8ca6c85818c324174348"} 03:13:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:13:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:13:02 INFO - Contents: 03:13:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8270b619b9712317c08dc6f457bbfae4f1fb2fba9ffa5205a362e3cb2923bc49b8622fcf567cbb80d3c1eed190f233aaa704dc6355b2bc121eaabeccfe8de3fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcb6a72fcbc0094181324c41be1c58019fed6b8c7283fd460808fd1db994a5aa8c778536b61ea314628b3fe2d36fc2f10f9a997d59c9f454ee53720c02d8ad64", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b01000e0e996517298d5fc82f74537a2434cee8c7b2fdb27a457cda714b33e0a6dd9b0b1a7d483ca28ed2137bcf7d251067bee365cc0ab98a6be67c72b54d80", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d62c3443f328024564b4623f0c76b03a355032981d29e59331eb8aa37b64557b76e7cc7b0b4197a5e65f17f032d2f2c2214d58791f0c8ca6c85818c324174348"} 03:13:02 INFO - Running post-run listener: copy_logs_to_upload_dir 03:13:02 INFO - Copying logs to upload dir... 03:13:02 INFO - mkdir: /builds/slave/test/build/upload/logs 03:13:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.213970 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-14 03:13:02.418151) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 03:13:02.421731) ========= 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=5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896 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/8270b619b9712317c08dc6f457bbfae4f1fb2fba9ffa5205a362e3cb2923bc49b8622fcf567cbb80d3c1eed190f233aaa704dc6355b2bc121eaabeccfe8de3fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcb6a72fcbc0094181324c41be1c58019fed6b8c7283fd460808fd1db994a5aa8c778536b61ea314628b3fe2d36fc2f10f9a997d59c9f454ee53720c02d8ad64", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b01000e0e996517298d5fc82f74537a2434cee8c7b2fdb27a457cda714b33e0a6dd9b0b1a7d483ca28ed2137bcf7d251067bee365cc0ab98a6be67c72b54d80", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d62c3443f328024564b4623f0c76b03a355032981d29e59331eb8aa37b64557b76e7cc7b0b4197a5e65f17f032d2f2c2214d58791f0c8ca6c85818c324174348"} build_url:https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011986 build_url: 'https://queue.taskcluster.net/v1/task/GD7UpAmZSbaM79RoUDeOdw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8270b619b9712317c08dc6f457bbfae4f1fb2fba9ffa5205a362e3cb2923bc49b8622fcf567cbb80d3c1eed190f233aaa704dc6355b2bc121eaabeccfe8de3fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcb6a72fcbc0094181324c41be1c58019fed6b8c7283fd460808fd1db994a5aa8c778536b61ea314628b3fe2d36fc2f10f9a997d59c9f454ee53720c02d8ad64", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b01000e0e996517298d5fc82f74537a2434cee8c7b2fdb27a457cda714b33e0a6dd9b0b1a7d483ca28ed2137bcf7d251067bee365cc0ab98a6be67c72b54d80", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d62c3443f328024564b4623f0c76b03a355032981d29e59331eb8aa37b64557b76e7cc7b0b4197a5e65f17f032d2f2c2214d58791f0c8ca6c85818c324174348"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 03:13:02.453415) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 03:13:02.453737) ========= 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=5bd038846534b2fdfa68eeae000001e2-1505382345.381756-1063753896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004641 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 03:13:02.504111) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 03:13:02.504427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 03:13:02.504766) ========= ========= Total master_lag: 0.64 =========