builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1505915069.05 results: success (0) revision: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:29.051497) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:29.051919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:29.052216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:29.100327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:29.100645) ========= 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-1505914314.142008-195556844 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 06:44:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.3M=0s 2017-09-20 06:44:29 (25.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103176 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:29.228080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:29.228362) ========= 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-1505914314.142008-195556844 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019008 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:29.286157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:29.286479) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 --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 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 --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-1505914314.142008-195556844 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 06:44:29,759 truncating revision to first 12 chars 2017-09-20 06:44:29,759 Setting DEBUG logging. 2017-09-20 06:44:29,759 attempt 1/10 2017-09-20 06:44:29,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0c49ebf4195c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 06:44:30,142 unpacking tar archive at: mozilla-central-0c49ebf4195c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.697783 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.003355) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.006665) ========= script_repo_revision: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.007056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.007339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.020450) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-20 06:44:30.020739) ========= /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-1505914314.142008-195556844 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:44:30 INFO - MultiFileLogger online at 20170920 06:44:30 in /builds/slave/test 06:44:30 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 06:44:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:44:30 INFO - {'append_to_log': False, 06:44:30 INFO - 'base_work_dir': '/builds/slave/test', 06:44:30 INFO - 'blob_upload_branch': 'Firefox', 06:44:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:44:30 INFO - 'branch': 'Firefox', 06:44:30 INFO - 'buildbot_json_path': 'buildprops.json', 06:44:30 INFO - 'code_coverage': False, 06:44:30 INFO - 'config_files': ('talos/linux_config.py',), 06:44:30 INFO - 'default_actions': ('clobber', 06:44:30 INFO - 'read-buildbot-config', 06:44:30 INFO - 'download-and-extract', 06:44:30 INFO - 'populate-webroot', 06:44:30 INFO - 'create-virtualenv', 06:44:30 INFO - 'install', 06:44:30 INFO - 'setup-mitmproxy', 06:44:30 INFO - 'run-tests'), 06:44:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:44:30 INFO - 'disable_ccov_upload': False, 06:44:30 INFO - 'disable_stylo': False, 06:44:30 INFO - 'download_minidump_stackwalk': True, 06:44:30 INFO - 'download_symbols': 'ondemand', 06:44:30 INFO - 'enable_stylo': False, 06:44:30 INFO - 'enable_webrender': False, 06:44:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 06:44:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:44:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:44:30 INFO - 'gecko_profile': False, 06:44:30 INFO - 'gecko_profile_interval': 0, 06:44:30 INFO - 'installer_path': 'installer.exe', 06:44:30 INFO - 'log_level': 'info', 06:44:30 INFO - 'log_name': 'talos', 06:44:30 INFO - 'log_to_console': True, 06:44:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:44:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:44:30 INFO - 'opt_config_files': (), 06:44:30 INFO - 'pip_index': False, 06:44:30 INFO - 'suite': 'dromaeojs-e10s', 06:44:30 INFO - 'system_bits': '32', 06:44:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:44:30 INFO - 'title': 'talos-linux64-ix-039', 06:44:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:44:30 INFO - 'use_talos_json': True, 06:44:30 INFO - 'verify': 'False', 06:44:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:44:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:44:30 INFO - 'work_dir': 'build'} 06:44:30 INFO - [mozharness: 2017-09-20 13:44:30.631027Z] Running clobber step. 06:44:30 INFO - Running pre-action listener: _resource_record_pre_action 06:44:30 INFO - Running main action method: clobber 06:44:30 INFO - rmtree: /builds/slave/test/build 06:44:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:44:32 INFO - Running post-action listener: _resource_record_post_action 06:44:32 INFO - [mozharness: 2017-09-20 13:44:32.169944Z] Finished clobber step (success) 06:44:32 INFO - [mozharness: 2017-09-20 13:44:32.170042Z] Running read-buildbot-config step. 06:44:32 INFO - Running pre-action listener: _resource_record_pre_action 06:44:32 INFO - Running main action method: read_buildbot_config 06:44:32 INFO - Using buildbot properties: 06:44:32 INFO - { 06:44:32 INFO - "project": "", 06:44:32 INFO - "product": "firefox", 06:44:32 INFO - "who": "archaeopteryx@coole-files.de", 06:44:32 INFO - "installer_path": "public/build/target.tar.bz2", 06:44:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 06:44:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:44:32 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 06:44:32 INFO - "stage_platform": "linux64-qr", 06:44:32 INFO - "basedir": "/builds/slave/test", 06:44:32 INFO - "buildnumber": 81, 06:44:32 INFO - "platform": "ubuntu64_hw_qr", 06:44:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:44:32 INFO - "slavebuilddir": "test", 06:44:32 INFO - "taskId": "XgWcAcHiSH-nZPL6PR1hRQ", 06:44:32 INFO - "branch": "mozilla-central", 06:44:32 INFO - "script_repo_revision": "production", 06:44:32 INFO - "revision": "0c49ebf4195ce51072b24aacf01eaaffdcff9be6", 06:44:32 INFO - "slavename": "talos-linux64-ix-039", 06:44:32 INFO - "repo_path": "mozilla-central" 06:44:32 INFO - } 06:44:32 INFO - Finding installer, test and symbols from parent task. 06:44:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XgWcAcHiSH-nZPL6PR1hRQ'}, attempt #1 06:44:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XgWcAcHiSH-nZPL6PR1hRQ'}, attempt #1 06:44:33 INFO - Task dependencies: VjX7h9b1Rg6WbANrHaKj3g 06:44:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g'}, attempt #1 06:44:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 06:44:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.test_packages.json 06:44:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.crashreporter-symbols.zip 06:44:33 INFO - Running post-action listener: _resource_record_post_action 06:44:33 INFO - [mozharness: 2017-09-20 13:44:33.511578Z] Finished read-buildbot-config step (success) 06:44:33 INFO - [mozharness: 2017-09-20 13:44:33.511795Z] Running download-and-extract step. 06:44:33 INFO - Running pre-action listener: _resource_record_pre_action 06:44:33 INFO - Running main action method: download_and_extract 06:44:33 INFO - mkdir: /builds/slave/test/build/tests 06:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:33 INFO - trying https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.test_packages.json 06:44:33 INFO - Downloading https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:44:34 INFO - Downloaded 989 bytes. 06:44:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:44:34 INFO - Using the following test package requirements: 06:44:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:44:34 INFO - u'common': [u'target.common.tests.zip'], 06:44:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:44:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:44:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:44:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:44:34 INFO - u'mozbase': [u'target.common.tests.zip'], 06:44:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:44:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:44:34 INFO - u'web-platform': [u'target.common.tests.zip', 06:44:34 INFO - u'target.web-platform.tests.tar.gz'], 06:44:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:44:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 06:44:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.common.tests.zip 06:44:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:44:34 INFO - Fetch https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.common.tests.zip into memory 06:44:35 INFO - Content-Length response header: 54731862 06:44:35 INFO - Bytes received: 54731862 06:44:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.talos.tests.zip 06:44:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:44:45 INFO - Fetch https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.talos.tests.zip into memory 06:44:46 INFO - Content-Length response header: 14508893 06:44:46 INFO - Bytes received: 14508893 06:44: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')]} 06:44:46 INFO - trying https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 06:44:46 INFO - Downloading https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:44:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:44:48 INFO - Downloaded 61637786 bytes. 06:44:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 06:44:49 INFO - mkdir: /builds/slave/test/properties 06:44:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:44:49 INFO - Writing to file /builds/slave/test/properties/build_url 06:44:49 INFO - Contents: 06:44:49 INFO - build_url:https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 06:44:49 INFO - Running post-action listener: _resource_record_post_action 06:44:49 INFO - Running post-action listener: find_tests_for_verification 06:44:49 INFO - Running post-action listener: set_extra_try_arguments 06:44:49 INFO - [mozharness: 2017-09-20 13:44:49.144451Z] Finished download-and-extract step (success) 06:44:49 INFO - [mozharness: 2017-09-20 13:44:49.144683Z] Running populate-webroot step. 06:44:49 INFO - Running pre-action listener: _resource_record_pre_action 06:44:49 INFO - Running main action method: populate_webroot 06:44:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:44:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:49 INFO - 'tests': ['tresize', 06:44:49 INFO - 'tcanvasmark']}, 06:44:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:44:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:49 INFO - 'tests': ['dromaeo_css', 06:44:49 INFO - 'kraken']}, 06:44:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:44:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:49 INFO - 'talos_options': ['--disable-stylo'], 06:44:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:44:49 INFO - 'tests': ['damp', 'tps']}, 06:44:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:49 INFO - 'talos_options': ['--disable-stylo'], 06:44:49 INFO - 'tests': ['damp', 'tps']}, 06:44:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:44:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:49 INFO - 'tests': ['dromaeo_dom']}, 06:44:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:44:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:49 INFO - 'tests': ['basic_compositor_video', 06:44:49 INFO - 'glvideo']}, 06:44:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:44:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:44:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:49 INFO - 'talos_options': ['--disable-stylo'], 06:44:49 INFO - 'tests': ['ts_paint_webext', 06:44:49 INFO - 'tp5o_webext']}, 06:44:49 INFO - 'other-e10s': {'tests': ['a11yr', 06:44:49 INFO - 'ts_paint', 06:44:49 INFO - 'tpaint', 06:44:49 INFO - 'sessionrestore', 06:44:49 INFO - 'sessionrestore_many_windows', 06:44:49 INFO - 'sessionrestore_no_auto_restore', 06:44:49 INFO - 'tabpaint']}, 06:44:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:49 INFO - 'tests': ['a11yr', 06:44:49 INFO - 'ts_paint', 06:44:49 INFO - 'tpaint', 06:44:49 INFO - 'sessionrestore', 06:44:49 INFO - 'sessionrestore_many_windows', 06:44:49 INFO - 'sessionrestore_no_auto_restore', 06:44:49 INFO - 'tabpaint']}, 06:44:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:44:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 06:44:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:49 INFO - 'tests': ['perf_reftest_singletons']}, 06:44:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:49 INFO - 'tests': ['bloom_basic']}, 06:44:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:44:49 INFO - 'tsvgr_opacity', 06:44:49 INFO - 'tart', 06:44:49 INFO - 'tscrollx', 06:44:49 INFO - 'tsvg_static']}, 06:44:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:49 INFO - 'tests': ['tsvgx', 06:44:49 INFO - 'tsvgr_opacity', 06:44:49 INFO - 'tart', 06:44:49 INFO - 'tscrollx', 06:44:49 INFO - 'tsvg_static']}, 06:44:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:44:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:49 INFO - 'talos_options': ['--disable-stylo'], 06:44:49 INFO - 'tests': ['tp5o']}, 06:44:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:44:49 INFO - 'talos_options': ['--mitmproxy', 06:44:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:44:49 INFO - '--firstNonBlankPaint'], 06:44:49 INFO - 'tests': ['tp6_google', 06:44:49 INFO - 'tp6_youtube', 06:44:49 INFO - 'tp6_amazon', 06:44:49 INFO - 'tp6_facebook']}, 06:44:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:44:49 INFO - 'talos_options': ['--disable-stylo', 06:44:49 INFO - '--mitmproxy', 06:44:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:44:49 INFO - '--firstNonBlankPaint'], 06:44:49 INFO - 'tests': ['tp6_google', 06:44:49 INFO - 'tp6_youtube', 06:44:49 INFO - 'tp6_amazon', 06:44:49 INFO - 'tp6_facebook']}, 06:44:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:44:49 INFO - 'talos_options': ['--stylo-threads=1', 06:44:49 INFO - '--mitmproxy', 06:44:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:44:49 INFO - '--firstNonBlankPaint'], 06:44:49 INFO - 'tests': ['tp6_google', 06:44:49 INFO - 'tp6_youtube', 06:44:49 INFO - 'tp6_amazon', 06:44:49 INFO - 'tp6_facebook']}, 06:44:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:44:49 INFO - 'talos_options': ['--xperf_path', 06:44:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:49 INFO - 'tests': ['tp5n']}, 06:44:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:49 INFO - 'talos_options': ['--disable-stylo', 06:44:49 INFO - '--xperf_path', 06:44:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:49 INFO - 'tests': ['tp5n']}}} 06:44:49 INFO - Running post-action listener: _resource_record_post_action 06:44:49 INFO - [mozharness: 2017-09-20 13:44:49.173049Z] Finished populate-webroot step (success) 06:44:49 INFO - [mozharness: 2017-09-20 13:44:49.173138Z] Running create-virtualenv step. 06:44:49 INFO - Running pre-action listener: _resource_record_pre_action 06:44:49 INFO - Running main action method: create_virtualenv 06:44:49 INFO - Creating virtualenv /builds/slave/test/build/venv 06:44:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:44:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 06:44:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:44:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:44:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:44:49 INFO - Installing distribute.............................................................................................................................................................................................done. 06:44:50 INFO - Installing pip...............done. 06:44:50 INFO - Return code: 0 06:44:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:44:50 INFO - Reading from file tmpfile_stdout 06:44:50 INFO - Output received: 06:44:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 06:44:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db090>, '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 0x10dbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f90>, '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-1505914314.142008-195556844', '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 06:44:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:44:50 INFO - Using env: {'DISPLAY': ':0', 06:44:50 INFO - 'HOME': '/home/cltbld', 06:44:50 INFO - 'LANG': 'en_US.UTF-8', 06:44:50 INFO - 'LANGUAGE': 'en_US:en', 06:44:50 INFO - 'LOGNAME': 'cltbld', 06:44:50 INFO - 'MAIL': '/var/mail/cltbld', 06:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:50 INFO - 'MOZ_NO_REMOTE': '1', 06:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:50 INFO - 'NO_EM_RESTART': '1', 06:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:50 INFO - 'PWD': '/builds/slave/test', 06:44:50 INFO - 'SHELL': '/bin/bash', 06:44:50 INFO - 'SHLVL': '1', 06:44:50 INFO - 'TERM': 'linux', 06:44:50 INFO - 'TMOUT': '86400', 06:44:50 INFO - 'USER': 'cltbld', 06:44:50 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 06:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:50 INFO - '_': '/tools/buildbot/bin/python'} 06:44:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:44:51 INFO - Downloading/unpacking pip>=1.5 06:44:51 INFO - Running setup.py egg_info for package pip 06:44:51 INFO - warning: no files found matching 'pip/cacert.pem' 06:44:51 INFO - warning: no files found matching '*.html' under directory 'docs' 06:44:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:44:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:44:51 INFO - Installing collected packages: pip 06:44:51 INFO - Found existing installation: pip 1.1 06:44:51 INFO - Uninstalling pip: 06:44:51 INFO - Successfully uninstalled pip 06:44:51 INFO - Running setup.py install for pip 06:44:51 INFO - warning: no files found matching 'pip/cacert.pem' 06:44:51 INFO - warning: no files found matching '*.html' under directory 'docs' 06:44:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:44:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:44:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Successfully installed pip 06:44:51 INFO - Cleaning up... 06:44:51 INFO - Return code: 0 06:44:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:44:51 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')]} 06:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:51 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')]} 06:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:51 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 0xd6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db090>, '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 0x10dbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f90>, '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-1505914314.142008-195556844', '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 06:44:51 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 06:44:51 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 06:44:51 INFO - Using env: {'DISPLAY': ':0', 06:44:51 INFO - 'HOME': '/home/cltbld', 06:44:51 INFO - 'LANG': 'en_US.UTF-8', 06:44:51 INFO - 'LANGUAGE': 'en_US:en', 06:44:51 INFO - 'LOGNAME': 'cltbld', 06:44:51 INFO - 'MAIL': '/var/mail/cltbld', 06:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:51 INFO - 'MOZ_NO_REMOTE': '1', 06:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:51 INFO - 'NO_EM_RESTART': '1', 06:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:51 INFO - 'PWD': '/builds/slave/test', 06:44:51 INFO - 'SHELL': '/bin/bash', 06:44:51 INFO - 'SHLVL': '1', 06:44:51 INFO - 'TERM': 'linux', 06:44:51 INFO - 'TMOUT': '86400', 06:44:51 INFO - 'USER': 'cltbld', 06:44:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 06:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:51 INFO - '_': '/tools/buildbot/bin/python'} 06:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:51 INFO - Downloading/unpacking psutil>=3.1.1 06:44:51 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 06:44:51 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 06:44:51 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 06:44:51 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 06:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:44:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:52 INFO - Installing collected packages: psutil 06:44:52 INFO - Running setup.py install for psutil 06:44:52 INFO - building 'psutil._psutil_linux' extension 06:44:52 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 06:44:53 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 06:44:53 INFO - building 'psutil._psutil_posix' extension 06:44:53 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 06:44:53 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 06:44:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:53 INFO - Successfully installed psutil 06:44:53 INFO - Cleaning up... 06:44:53 INFO - Return code: 0 06:44:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:44:53 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')]} 06:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:53 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')]} 06:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:53 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 0xd6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db090>, '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 0x10dbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f90>, '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-1505914314.142008-195556844', '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 06:44:53 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 06:44:53 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 06:44:53 INFO - Using env: {'DISPLAY': ':0', 06:44:53 INFO - 'HOME': '/home/cltbld', 06:44:53 INFO - 'LANG': 'en_US.UTF-8', 06:44:53 INFO - 'LANGUAGE': 'en_US:en', 06:44:53 INFO - 'LOGNAME': 'cltbld', 06:44:53 INFO - 'MAIL': '/var/mail/cltbld', 06:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:53 INFO - 'MOZ_NO_REMOTE': '1', 06:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:53 INFO - 'NO_EM_RESTART': '1', 06:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:53 INFO - 'PWD': '/builds/slave/test', 06:44:53 INFO - 'SHELL': '/bin/bash', 06:44:53 INFO - 'SHLVL': '1', 06:44:53 INFO - 'TERM': 'linux', 06:44:53 INFO - 'TMOUT': '86400', 06:44:53 INFO - 'USER': 'cltbld', 06:44:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 06:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:53 INFO - '_': '/tools/buildbot/bin/python'} 06:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:44:53 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 06:44:53 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 06:44:53 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 06:44:53 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 06:44:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:44:54 INFO - Installing collected packages: mozsystemmonitor 06:44:54 INFO - Running setup.py install for mozsystemmonitor 06:44:55 INFO - Successfully installed mozsystemmonitor 06:44:55 INFO - Cleaning up... 06:44:56 INFO - Return code: 0 06:44:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db090>, '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 0x10dbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f90>, '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-1505914314.142008-195556844', '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 06:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:44:56 INFO - Using env: {'DISPLAY': ':0', 06:44:56 INFO - 'HOME': '/home/cltbld', 06:44:56 INFO - 'LANG': 'en_US.UTF-8', 06:44:56 INFO - 'LANGUAGE': 'en_US:en', 06:44:56 INFO - 'LOGNAME': 'cltbld', 06:44:56 INFO - 'MAIL': '/var/mail/cltbld', 06:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:56 INFO - 'MOZ_NO_REMOTE': '1', 06:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:56 INFO - 'NO_EM_RESTART': '1', 06:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:56 INFO - 'PWD': '/builds/slave/test', 06:44:56 INFO - 'SHELL': '/bin/bash', 06:44:56 INFO - 'SHLVL': '1', 06:44:56 INFO - 'TERM': 'linux', 06:44:56 INFO - 'TMOUT': '86400', 06:44:56 INFO - 'USER': 'cltbld', 06:44:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 06:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:56 INFO - '_': '/tools/buildbot/bin/python'} 06:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:56 INFO - Downloading/unpacking jsonschema==2.5.1 06:44:56 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 06:44:56 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 06:44:56 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 06:44:56 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 06:44:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:44:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:58 INFO - Downloading functools32-3.2.3-2.tar.gz 06:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:44:58 INFO - warning: no files found matching '*.txt' 06:44:58 INFO - no previously-included directories found matching 'build' 06:44:58 INFO - no previously-included directories found matching 'dist' 06:44:58 INFO - no previously-included directories found matching '.git*' 06:44:58 INFO - Installing collected packages: jsonschema, functools32 06:44:58 INFO - Running setup.py install for functools32 06:44:59 INFO - warning: no files found matching '*.txt' 06:44:59 INFO - no previously-included directories found matching 'build' 06:44:59 INFO - no previously-included directories found matching 'dist' 06:44:59 INFO - no previously-included directories found matching '.git*' 06:44:59 INFO - Successfully installed jsonschema functools32 06:44:59 INFO - Cleaning up... 06:44:59 INFO - Return code: 0 06:44:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db090>, '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 0x10dbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f90>, '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-1505914314.142008-195556844', '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 06:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:44:59 INFO - Using env: {'DISPLAY': ':0', 06:44:59 INFO - 'HOME': '/home/cltbld', 06:44:59 INFO - 'LANG': 'en_US.UTF-8', 06:44:59 INFO - 'LANGUAGE': 'en_US:en', 06:44:59 INFO - 'LOGNAME': 'cltbld', 06:44:59 INFO - 'MAIL': '/var/mail/cltbld', 06:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:59 INFO - 'MOZ_NO_REMOTE': '1', 06:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:59 INFO - 'NO_EM_RESTART': '1', 06:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:59 INFO - 'PWD': '/builds/slave/test', 06:44:59 INFO - 'SHELL': '/bin/bash', 06:44:59 INFO - 'SHLVL': '1', 06:44:59 INFO - 'TERM': 'linux', 06:44:59 INFO - 'TMOUT': '86400', 06:44:59 INFO - 'USER': 'cltbld', 06:44:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 06:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:59 INFO - '_': '/tools/buildbot/bin/python'} 06:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:44:59 INFO - Cleaning up... 06:44:59 INFO - Return code: 0 06:44:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db090>, '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 0x10dbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f90>, '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-1505914314.142008-195556844', '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 06:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:44:59 INFO - Using env: {'DISPLAY': ':0', 06:44:59 INFO - 'HOME': '/home/cltbld', 06:44:59 INFO - 'LANG': 'en_US.UTF-8', 06:44:59 INFO - 'LANGUAGE': 'en_US:en', 06:44:59 INFO - 'LOGNAME': 'cltbld', 06:44:59 INFO - 'MAIL': '/var/mail/cltbld', 06:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:59 INFO - 'MOZ_NO_REMOTE': '1', 06:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:59 INFO - 'NO_EM_RESTART': '1', 06:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:59 INFO - 'PWD': '/builds/slave/test', 06:44:59 INFO - 'SHELL': '/bin/bash', 06:44:59 INFO - 'SHLVL': '1', 06:44:59 INFO - 'TERM': 'linux', 06:44:59 INFO - 'TMOUT': '86400', 06:44:59 INFO - 'USER': 'cltbld', 06:44:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 06:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:59 INFO - '_': '/tools/buildbot/bin/python'} 06:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:59 INFO - Downloading/unpacking blobuploader==1.2.4 06:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:00 INFO - Downloading blobuploader-1.2.4.tar.gz 06:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:45:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:45:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:01 INFO - Downloading docopt-0.6.1.tar.gz 06:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:45:01 INFO - Installing collected packages: blobuploader, requests, docopt 06:45:01 INFO - Running setup.py install for blobuploader 06:45:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:45:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:45:01 INFO - Running setup.py install for requests 06:45:01 INFO - Running setup.py install for docopt 06:45:02 INFO - Successfully installed blobuploader requests docopt 06:45:02 INFO - Cleaning up... 06:45:02 INFO - Return code: 0 06:45:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:02 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')]} 06:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:02 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')]} 06:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:02 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 0xd6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db090>, '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 0x10dbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f90>, '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-1505914314.142008-195556844', '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 06:45:02 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 06:45:02 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 06:45:02 INFO - Using env: {'DISPLAY': ':0', 06:45:02 INFO - 'HOME': '/home/cltbld', 06:45:02 INFO - 'LANG': 'en_US.UTF-8', 06:45:02 INFO - 'LANGUAGE': 'en_US:en', 06:45:02 INFO - 'LOGNAME': 'cltbld', 06:45:02 INFO - 'MAIL': '/var/mail/cltbld', 06:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:02 INFO - 'MOZ_NO_REMOTE': '1', 06:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:02 INFO - 'NO_EM_RESTART': '1', 06:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:02 INFO - 'PWD': '/builds/slave/test', 06:45:02 INFO - 'SHELL': '/bin/bash', 06:45:02 INFO - 'SHLVL': '1', 06:45:02 INFO - 'TERM': 'linux', 06:45:02 INFO - 'TMOUT': '86400', 06:45:02 INFO - 'USER': 'cltbld', 06:45:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 06:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:02 INFO - '_': '/tools/buildbot/bin/python'} 06:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:02 INFO - Running setup.py (path:/tmp/pip-lrbsoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:02 INFO - Running setup.py (path:/tmp/pip-JdErJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:02 INFO - Running setup.py (path:/tmp/pip-o_K2U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:02 INFO - Running setup.py (path:/tmp/pip-kLNDlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:02 INFO - Running setup.py (path:/tmp/pip-QaxGIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:02 INFO - Running setup.py (path:/tmp/pip-XQWiKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:02 INFO - Running setup.py (path:/tmp/pip-MS73KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:02 INFO - Running setup.py (path:/tmp/pip-ZkANkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:02 INFO - Running setup.py (path:/tmp/pip-HhQxvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:02 INFO - Running setup.py (path:/tmp/pip-ArIST5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:02 INFO - Running setup.py (path:/tmp/pip-GJs7Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:03 INFO - Running setup.py (path:/tmp/pip-VN0MWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:03 INFO - Running setup.py (path:/tmp/pip-dPA3XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:03 INFO - Running setup.py (path:/tmp/pip-QctRyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:03 INFO - Running setup.py (path:/tmp/pip-3lkyZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:03 INFO - Running setup.py (path:/tmp/pip-r2Apel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:03 INFO - Running setup.py (path:/tmp/pip-rNvCsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:45:03 INFO - Running setup.py install for manifestparser 06:45:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for mozcrash 06:45:03 INFO - Running setup.py install for mozdebug 06:45:03 INFO - Running setup.py install for mozdevice 06:45:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for mozfile 06:45:03 INFO - Running setup.py install for mozhttpd 06:45:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for mozinfo 06:45:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for mozInstall 06:45:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for mozleak 06:45:04 INFO - Running setup.py install for mozlog 06:45:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for moznetwork 06:45:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for mozprocess 06:45:04 INFO - Running setup.py install for mozprofile 06:45:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for mozrunner 06:45:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for mozscreenshot 06:45:05 INFO - Running setup.py install for moztest 06:45:05 INFO - Running setup.py install for mozversion 06:45:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:45:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:45:05 INFO - Cleaning up... 06:45:05 INFO - Return code: 0 06:45:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:05 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 0xd6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db090>, '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 0x10dbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f90>, '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-1505914314.142008-195556844', '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 06:45:05 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 06:45:05 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 06:45:05 INFO - Using env: {'DISPLAY': ':0', 06:45:05 INFO - 'HOME': '/home/cltbld', 06:45:05 INFO - 'LANG': 'en_US.UTF-8', 06:45:05 INFO - 'LANGUAGE': 'en_US:en', 06:45:05 INFO - 'LOGNAME': 'cltbld', 06:45:05 INFO - 'MAIL': '/var/mail/cltbld', 06:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:05 INFO - 'MOZ_NO_REMOTE': '1', 06:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:05 INFO - 'NO_EM_RESTART': '1', 06:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:05 INFO - 'PWD': '/builds/slave/test', 06:45:05 INFO - 'SHELL': '/bin/bash', 06:45:05 INFO - 'SHLVL': '1', 06:45:05 INFO - 'TERM': 'linux', 06:45:05 INFO - 'TMOUT': '86400', 06:45:05 INFO - 'USER': 'cltbld', 06:45:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 06:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:05 INFO - '_': '/tools/buildbot/bin/python'} 06:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:05 INFO - Running setup.py (path:/tmp/pip-_qyJbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:05 INFO - Running setup.py (path:/tmp/pip-Z1d_Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:05 INFO - Running setup.py (path:/tmp/pip-1OZf6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:05 INFO - Running setup.py (path:/tmp/pip-FZBvmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:05 INFO - Running setup.py (path:/tmp/pip-_vMT6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:05 INFO - Running setup.py (path:/tmp/pip-LmxEIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:05 INFO - Running setup.py (path:/tmp/pip-7OUg5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:05 INFO - Running setup.py (path:/tmp/pip-xgQRM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:06 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)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:06 INFO - Running setup.py (path:/tmp/pip-Y7hhN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:06 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)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:06 INFO - Running setup.py (path:/tmp/pip-WiUPBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:06 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)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:06 INFO - Running setup.py (path:/tmp/pip-_4n7eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:06 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)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:06 INFO - Running setup.py (path:/tmp/pip-x3C7Q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:06 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)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:06 INFO - Running setup.py (path:/tmp/pip-wiOH7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:06 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)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:06 INFO - Running setup.py (path:/tmp/pip-d9Taq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:06 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)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:06 INFO - Running setup.py (path:/tmp/pip-VfdVem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:06 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)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:06 INFO - Running setup.py (path:/tmp/pip-63fylk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:06 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)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:06 INFO - Running setup.py (path:/tmp/pip-lTxMBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:06 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)) 06:45:06 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)) 06:45:06 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)) 06:45:06 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)) 06:45:06 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)) 06:45:06 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)) 06:45:06 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)) 06:45:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:07 INFO - Downloading blessings-1.6.tar.gz 06:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:45:07 INFO - Installing collected packages: blessings 06:45:07 INFO - Running setup.py install for blessings 06:45:07 INFO - Successfully installed blessings 06:45:07 INFO - Cleaning up... 06:45:08 INFO - Return code: 0 06:45:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:45:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:08 INFO - Reading from file tmpfile_stdout 06:45:08 INFO - Current package versions: 06:45:08 INFO - argparse == 1.2.1 06:45:08 INFO - blessings == 1.6 06:45:08 INFO - blobuploader == 1.2.4 06:45:08 INFO - docopt == 0.6.1 06:45:08 INFO - functools32 == 3.2.3-2 06:45:08 INFO - jsonschema == 2.5.1 06:45:08 INFO - manifestparser == 1.1 06:45:08 INFO - mozInstall == 1.13 06:45:08 INFO - mozcrash == 1.0 06:45:08 INFO - mozdebug == 0.1 06:45:08 INFO - mozdevice == 0.51 06:45:08 INFO - mozfile == 1.2 06:45:08 INFO - mozhttpd == 0.7 06:45:08 INFO - mozinfo == 0.10 06:45:08 INFO - mozleak == 0.1 06:45:08 INFO - mozlog == 3.5 06:45:08 INFO - moznetwork == 0.27 06:45:08 INFO - mozprocess == 0.25 06:45:08 INFO - mozprofile == 0.28 06:45:08 INFO - mozrunner == 6.13 06:45:08 INFO - mozscreenshot == 0.1 06:45:08 INFO - mozsystemmonitor == 0.3 06:45:08 INFO - moztest == 0.8 06:45:08 INFO - mozversion == 1.4 06:45:08 INFO - psutil == 3.1.1 06:45:08 INFO - requests == 1.2.3 06:45:08 INFO - wsgiref == 0.1.2 06:45:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:08 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 0xd6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db090>, '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 0x10dbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f90>, '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-1505914314.142008-195556844', '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 06:45:08 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 06:45:08 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 06:45:08 INFO - Using env: {'DISPLAY': ':0', 06:45:08 INFO - 'HOME': '/home/cltbld', 06:45:08 INFO - 'LANG': 'en_US.UTF-8', 06:45:08 INFO - 'LANGUAGE': 'en_US:en', 06:45:08 INFO - 'LOGNAME': 'cltbld', 06:45:08 INFO - 'MAIL': '/var/mail/cltbld', 06:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:08 INFO - 'MOZ_NO_REMOTE': '1', 06:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:08 INFO - 'NO_EM_RESTART': '1', 06:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:08 INFO - 'PWD': '/builds/slave/test', 06:45:08 INFO - 'SHELL': '/bin/bash', 06:45:08 INFO - 'SHLVL': '1', 06:45:08 INFO - 'TERM': 'linux', 06:45:08 INFO - 'TMOUT': '86400', 06:45:08 INFO - 'USER': 'cltbld', 06:45:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 06:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:08 INFO - '_': '/tools/buildbot/bin/python'} 06:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:08 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)) 06:45:08 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)) 06:45:08 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)) 06:45:08 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)) 06:45:08 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)) 06:45:08 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)) 06:45:08 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)) 06:45:08 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)) 06:45:08 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)) 06:45:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:45:09 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)) 06:45:09 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)) 06:45:09 INFO - Installing collected packages: simplejson 06:45:09 INFO - Running setup.py install for simplejson 06:45:09 INFO - building 'simplejson._speedups' extension 06:45:09 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 06:45:10 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 06:45:10 INFO - Successfully installed simplejson 06:45:10 INFO - Cleaning up... 06:45:10 INFO - Return code: 0 06:45:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:10 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 0xd6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db090>, '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 0x10dbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f90>, '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-1505914314.142008-195556844', '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 06:45:10 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 06:45:10 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 06:45:10 INFO - Using env: {'DISPLAY': ':0', 06:45:10 INFO - 'HOME': '/home/cltbld', 06:45:10 INFO - 'LANG': 'en_US.UTF-8', 06:45:10 INFO - 'LANGUAGE': 'en_US:en', 06:45:10 INFO - 'LOGNAME': 'cltbld', 06:45:10 INFO - 'MAIL': '/var/mail/cltbld', 06:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:10 INFO - 'MOZ_NO_REMOTE': '1', 06:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:10 INFO - 'NO_EM_RESTART': '1', 06:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:10 INFO - 'PWD': '/builds/slave/test', 06:45:10 INFO - 'SHELL': '/bin/bash', 06:45:10 INFO - 'SHLVL': '1', 06:45:10 INFO - 'TERM': 'linux', 06:45:10 INFO - 'TMOUT': '86400', 06:45:10 INFO - 'USER': 'cltbld', 06:45:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 06:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:10 INFO - '_': '/tools/buildbot/bin/python'} 06:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:45:10 INFO - Cleaning up... 06:45:10 INFO - Return code: 0 06:45:10 INFO - Running post-action listener: _resource_record_post_action 06:45:10 INFO - Running post-action listener: _start_resource_monitoring 06:45:10 INFO - Starting resource monitoring. 06:45:10 INFO - [mozharness: 2017-09-20 13:45:10.980299Z] Finished create-virtualenv step (success) 06:45:10 INFO - [mozharness: 2017-09-20 13:45:10.980812Z] Running install step. 06:45:10 INFO - Running pre-action listener: _resource_record_pre_action 06:45:10 INFO - Running main action method: install 06:45:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:11 INFO - Reading from file tmpfile_stdout 06:45:11 INFO - Detecting whether we're running mozinstall >=1.0... 06:45:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:45:11 INFO - Reading from file tmpfile_stdout 06:45:11 INFO - Output received: 06:45:11 INFO - Usage: mozinstall [options] installer 06:45:11 INFO - Options: 06:45:11 INFO - -h, --help show this help message and exit 06:45:11 INFO - -d DEST, --destination=DEST 06:45:11 INFO - Directory to install application into. [default: 06:45:11 INFO - "/builds/slave/test"] 06:45:11 INFO - --app=APP Application being installed. [default: firefox] 06:45:11 INFO - mkdir: /builds/slave/test/build/application 06:45:11 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'] 06:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:45:29 INFO - Reading from file tmpfile_stdout 06:45:29 INFO - Output received: 06:45:29 INFO - /builds/slave/test/build/application/firefox/firefox 06:45:29 INFO - Running post-action listener: _resource_record_post_action 06:45:29 INFO - [mozharness: 2017-09-20 13:45:29.170360Z] Finished install step (success) 06:45:29 INFO - [mozharness: 2017-09-20 13:45:29.170612Z] Running setup-mitmproxy step. 06:45:29 INFO - Running pre-action listener: _resource_record_pre_action 06:45:29 INFO - Running main action method: setup_mitmproxy 06:45:29 INFO - Skipping: mitmproxy is not required 06:45:29 INFO - Running post-action listener: _resource_record_post_action 06:45:29 INFO - [mozharness: 2017-09-20 13:45:29.171728Z] Finished setup-mitmproxy step (success) 06:45:29 INFO - [mozharness: 2017-09-20 13:45:29.171947Z] Running run-tests step. 06:45:29 INFO - Running pre-action listener: _resource_record_pre_action 06:45:29 INFO - Running pre-action listener: _set_gcov_prefix 06:45:29 INFO - Running main action method: run_tests 06:45:29 WARNING - Try message not found. 06:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:45:29 INFO - Python 2.7.3 06:45:29 INFO - Return code: 0 06:45:29 INFO - grabbing minidump binary from tooltool 06:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:29 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 0x10db090>, '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 0x10dbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:45:29 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 06:45:29 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 06:45:29 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 06:45:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:45:29 INFO - Return code: 0 06:45:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:45:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:45:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:45:29 INFO - ENV: RUST_BACKTRACE is now full 06:45:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:45:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:45:29 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/VjX7h9b1Rg6WbANrHaKj3g/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 06:45:29 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/VjX7h9b1Rg6WbANrHaKj3g/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 06:45:29 INFO - Using env: {'DISPLAY': ':0', 06:45:29 INFO - 'HOME': '/home/cltbld', 06:45:29 INFO - 'LANG': 'en_US.UTF-8', 06:45:29 INFO - 'LANGUAGE': 'en_US:en', 06:45:29 INFO - 'LOGNAME': 'cltbld', 06:45:29 INFO - 'MAIL': '/var/mail/cltbld', 06:45:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:45:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:45:29 INFO - 'MOZ_ACCELERATED': '1', 06:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:29 INFO - 'MOZ_NO_REMOTE': '1', 06:45:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:45:29 INFO - 'MOZ_WEBRENDER': '1', 06:45:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:29 INFO - 'NO_EM_RESTART': '1', 06:45:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:29 INFO - 'PWD': '/builds/slave/test', 06:45:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:45:29 INFO - 'RUST_BACKTRACE': 'full', 06:45:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:45:29 INFO - 'SHELL': '/bin/bash', 06:45:29 INFO - 'SHLVL': '1', 06:45:29 INFO - 'TERM': 'linux', 06:45:29 INFO - 'TMOUT': '86400', 06:45:29 INFO - 'USER': 'cltbld', 06:45:29 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 06:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:29 INFO - '_': '/tools/buildbot/bin/python'} 06:45:29 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/VjX7h9b1Rg6WbANrHaKj3g/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 06:45:29 INFO - mozversion application_buildid: 20170920125558 06:45:29 INFO - mozversion application_changeset: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 06:45:29 INFO - mozversion application_display_name: Nightly 06:45:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:45:29 INFO - mozversion application_name: Firefox 06:45:29 INFO - mozversion application_remotingname: firefox 06:45:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:45:29 INFO - mozversion application_vendor: Mozilla 06:45:29 INFO - mozversion application_version: 57.0a1 06:45:29 INFO - mozversion platform_buildid: 20170920125558 06:45:29 INFO - mozversion platform_changeset: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 06:45:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:45:29 INFO - mozversion platform_version: 57.0a1 06:45:29 INFO - using testdate: 1505915129 06:45:29 INFO - actual date: 1505915129 06:45:29 INFO - starting webserver on 'localhost:56831' 06:45:29 INFO - SUITE-START | Running 2 tests 06:45:29 INFO - TEST-START | dromaeo_css 06:45:29 INFO - Initialising browser for dromaeo_css test... 06:45:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56831/getInfo.html -profile /tmp/tmpPioJfn/profile 06:45:29 INFO - TEST-INFO | started process 683 (/builds/slave/test/build/application/firefox/firefox http://localhost:56831/getInfo.html) 06:45:35 INFO - TEST-INFO | 683: exit 0 06:45:35 INFO - Browser initialized. 06:45:35 INFO - Running cycle 1/1 for dromaeo_css test... 06:45:35 INFO - Using env: {'DISPLAY': ':0', 06:45:35 INFO - 'HOME': '/home/cltbld', 06:45:35 INFO - 'JSGC_DISABLE_POISONING': '1', 06:45:35 INFO - 'LANG': 'en_US.UTF-8', 06:45:35 INFO - 'LANGUAGE': 'en_US:en', 06:45:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:45:35 INFO - 'LOGNAME': 'cltbld', 06:45:35 INFO - 'MAIL': '/var/mail/cltbld', 06:45:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:45:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:45:35 INFO - 'MOZ_ACCELERATED': '1', 06:45:35 INFO - 'MOZ_CRASHREPORTER': '1', 06:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:45:35 INFO - 'MOZ_NO_REMOTE': '1', 06:45:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:45:35 INFO - 'MOZ_WEBRENDER': '1', 06:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:35 INFO - 'NO_EM_RESTART': '1', 06:45:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:35 INFO - 'PWD': '/builds/slave/test', 06:45:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:45:35 INFO - 'RUST_BACKTRACE': 'full', 06:45:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:45:35 INFO - 'SHELL': '/bin/bash', 06:45:35 INFO - 'SHLVL': '1', 06:45:35 INFO - 'TERM': 'linux', 06:45:35 INFO - 'TMOUT': '86400', 06:45:35 INFO - 'USER': 'cltbld', 06:45:35 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 06:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:35 INFO - '_': '/tools/buildbot/bin/python'} 06:45:35 INFO - TEST-INFO | started process 939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPioJfn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:45:36 INFO - PID 939 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:45:36 INFO - PID 939 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:45:36 INFO - PID 939 | 06:45:36 INFO - PID 939 | (/builds/slave/test/build/application/firefox/firefox:999): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:45:36 INFO - PID 939 | 06:45:47 INFO - PID 939 | RSS: Main: 194035712 06:45:47 INFO - PID 939 | 06:48:45 INFO - PID 939 | Cycle 1(1): loaded http://localhost:56831/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56831/tests/dromaeo/cssquery-ext.html) 06:48:46 INFO - PID 939 | RSS: Main: 195186688 06:48:46 INFO - PID 939 | 06:51:48 INFO - PID 939 | Cycle 1(1): loaded http://localhost:56831/tests/dromaeo/cssquery-ext.html (next: http://localhost:56831/tests/dromaeo/cssquery-jquery.html) 06:51:49 INFO - PID 939 | RSS: Main: 195416064 06:51:49 INFO - PID 939 | 06:54:51 INFO - PID 939 | Cycle 1(1): loaded http://localhost:56831/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56831/tests/dromaeo/cssquery-mootools.html) 06:54:52 INFO - PID 939 | RSS: Main: 195440640 06:54:52 INFO - PID 939 | 06:57:54 INFO - PID 939 | Cycle 1(1): loaded http://localhost:56831/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56831/tests/dromaeo/cssquery-prototype.html) 06:57:54 INFO - PID 939 | RSS: Main: 193892352 06:57:54 INFO - PID 939 | 07:00:58 INFO - PID 939 | Cycle 1(1): loaded http://localhost:56831/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56831/tests/dromaeo/cssquery-yui.html) 07:00:59 INFO - PID 939 | RSS: Main: 194617344 07:00:59 INFO - PID 939 | 07:04:01 INFO - PID 939 | Cycle 1(1): loaded http://localhost:56831/tests/dromaeo/cssquery-yui.html (next: http://localhost:56831/tests/dromaeo/cssquery-dojo.html) 07:04:01 INFO - PID 939 | RSS: Main: 197320704 07:04:01 INFO - PID 939 | 07:04:01 INFO - PID 939 | __start_tp_report 07:04:01 INFO - PID 939 | _x_x_mozilla_page_load 07:04:01 INFO - PID 939 | _x_x_mozilla_page_load_details 07:04:01 INFO - PID 939 | |i|pagename|runs| 07:04:01 INFO - PID 939 | |0;dojo.html;3120.2979329650825;3154.0853152585764;3155.1796532901444;3157.2422618571522;3173.412918610057;6146.508279337653;6269.49844012479;6350.174477317948;6378.266499352576;6410.455111315544;6222.84442888928;6255.2806427260875;6325.905111423321;6376.489880809536;6412.679366031692;5781.421857814206;5786.189933409316;5786.421357864222;5895.469407753301;5915.053591425372;5718;5862.677552734598;5885.352611212763;5922.2005029321135;5929.644221346712;5714.371419143891;5745;5761.30864296285;5807.39022402648;5816.418358164192;5793.971030144864;5794.420557944214;5813.651180929158;5820.243368362128;5858.033424484955;5714.771409143629;5769.07694768835;5774.566907481913;5780.682062486561;5791.768329266824;6219.378062193789;6232.34560371159;6249.625022498619;6320.968395158041;6363.61818290904;6529.34706529348;6603.14159159311;6641.734330626818;6665.833354166136;6759.864802703918;6798.898016529756;6834.521583489158;6877.140357455318;6919.930800691979;6925.3074692530845;6225.501959843247;6260.530460215502;6284.654344011077;6342.714577843962;6354.491640668735;6894.069300644449;6933.965330173418;6976.232614412411;6986.266442023616;7003.299670033058;6490.967545162244;6581.736730530725;6615.536912416084;6641.66791660415;6715.5299129060495;6712.731490740316;6739;6767.830804229934;6790.0493930849725;6811.352921472452;6701.128853249046;6739.224989126215;6785.253622101565;6830.453563714891;6858.451323894176;6719.857624203897;6811;6812.931870681329;6817.829554261084;6886;5240.895182096337;5279.683219006872;5317.202419637086;5317.8404647860625;5322.042032434121;4607.562281583244;4623.653226008063;4629.976850115728;4666.836660716858;4703.74129422885;5792.768289268382;5848.912266316009;5906.527477801766;5907.616004959664;5909.586328957018;6676.532642714963;6705.664716764142;6778.864422711518;6792.796216113525;6859.965700171567;5667.206591077253;5778.855528611818;5804.303483581997;5816.941830581724;5832.766689332379;5773;5803.187553742479;5836.416358364129;5875.794347197913;5900.144479050514;6444.548881578245;6491.805245842632;6583.177102862142;6597.901031484532;6635.2037755469655;6765.864682706417;6806.965965170241;6866.038754574263;6905.205901321312;6930.7227710891;6309.085182648399;6481.125048118443;6496.252930913006;6538.084668146368;6572.047053177167;6665.866802643465;6697.3637504437;6737.32626737342;6762.8985565217545;6764.763233286812;6804.523683342119;6811.523193376416;6883.139607549057;6897.241303456716;6910.689018994057;6371.49028077762;6493.188351456068;6529.7061632227615;6545.181852268466;6668.599884006975;6507.121538592419;6525.445337146396;6535.3464653534265;6552;6594.076829243813;6516.380943810331;6518.771842985473;6525;6545.443637290884;6549.967250163719;6582.3746744059235;6649.534532582673;6692.297308782508;6707.530472867048;6756.932430675827;6198.504119670325;6351.237851457855;6376.585521941059;6420.486361091195;6465 07:04:01 INFO - PID 939 | |1;ext.html;856.4304737349662;874.1739056591524;876.6493402638944;880.0231742765529;880.8898887639049;37012.814935925315;38126;40946.38580421292;41165.58834411662;41259.381109283386;37402.62597374026;37881.05297367567;37894.62105378945;37895.62104378956;37907.24185516288;7149.892751608717;7233.565986040828;7268.164161121459;7281.381082607984;7743.88384174235;7792.922070779305;7793.727219547317;7860;7874.842503149934;7909.446338756289;7820.843583128334;7905.169957154502;7911.920880791176;7913;7944.682212711485;7791.4935529190425;7881.921180788205;7912.723054693058;7918.930944322558;7931.405144614177;7839.568823714693;7934.484258523177;7938.801529961739;7944.721934732314;7953.204679532058;36105;36359;36412.45381319256;36442;36446.45330320048;3516.331896939573;3563.8574457021687;3565.1265439967374;3569.5181150544604;3570.250247448039;30213.848930755426;30318.393632127234;30362.84818575915;30459.69540304591;30511;4997.225430058346;5012.699238045729;5045.495450454961;5064.645474816764;5067.771950262247;181662;182238;183222;185335;185626;47262.76368618135;47497.28754068692;47611;48560.7571962145;48819.75590122027;51103.48896510987;51538.48461515412;51658;51727.22409163866;51911.74044129755;15421.537353879401;15610.29753661088;15679.216039197994;15706;15893.364265429485;13018.349082545836;13095.738085238241;13097.345132743516;13129.803052954214;13135.474581016651;14378.568642940729;14380.56858294253;14415.42338306477;14491.20298383578;14637;5637.746301416446;5642.6614403135945;5700.6009579329875;5716.828495145152;5725.141228815628;1004.7839714461426;1011.7521207304258;1022.5602990713916;1025.3489034463169;1028.8456731490337;22905.656415153786;23030.193943211907;23177.3046808596;23335.066597336256;23548.175813846778;1107.5625128074366;1114.804909140897;1116.393221827043;1128.210252823027;1138.1861968692424;12001.459934302977;12189.817152742717;12237.510499579917;12330.260184388966;12409.193402428813;241032;242312;243488;244747;244820;51654.22518662223;52101.47898521042;52105.2184217237;52194;52464.73767631137;1285.5886116442834;1407.3877863129571;1450.8766754825747;1456.7013762178728;1465.077001489055;24523;26548.867255663597;27100.864495677397;27233.86383068072;27721.30696732517;48725;48846;48904.75547622239;48908.266376003674;49030;202635;203325;203411;205284;205298;32608.34783304368;34141.48787768235;34186.316273674885;34296;34415.31169376648;42329.5767042338;42344.5765542353;42412;42935.355969661105;43572.78213608912;30643.54034689437;30779.230519237197;31138.688613114486;31175.688243117278;31224.843875780476;30875.382492350476;31183.688163118077;31266;31593.36813263676;31596.526052109697;34017.14957126092;35100.824495878376;35110.47334290039;35206;35295.47056794099;29811.403771924008;30370.240743981576;30605.693943060283;30672.386552268385;31279.218019549695;22539.211127610455;23002.424939376648;23057.423564411023;23291.650625240298;23366.883165584062 07:04:01 INFO - PID 939 | |2;jquery.html;557.79516244911;566.28082335434;573.6873403994825;579.2180556249062;581.5986968991396;21556.56886862264;22514.324570262877;22611.773882261172;22727.886360568173;22764.20325288613;22743.31770046901;23587.76412235877;23752.524949501;23970.640440393407;24536.509269814593;6484.902726459107;6666.566673166253;6678.66606669667;6687.598744075347;6741.797746067601;6561;6688.799336019927;6690.6654667266685;6727.66361681914;6730.091437655928;6403.231612206541;6627.801165965029;6641.6015039097565;6692.9330706693045;6712.395884370406;6644.601323920556;6689.799306020778;6692.63190524521;6701.028350889118;6704.5306828522025;6214.285357183891;6217.87564248717;6231.283402408736;6254.280757712876;6257.5932564383165;29949.550756738667;30959.535606965914;31013;31108.688913110804;31264.37471250585;2005.8796472211714;2050.1286953044896;2066.628006958747;2067.452125186827;2068.307117115768;20471.795282047136;20944.16223351064;21104.577908441897;21514.784852151435;21626;2449.4856080223176;2463.6674049003514;2560.9871950640127;2564.6794150731157;2599.4281258123374;123793.38103309515;130163;133320;139666.301668491;139669;21102.261420850504;21205.575888482144;21483.78516214849;21841.126354945944;22044.448888777588;42202;42556.36165457521;42732.78633606812;42744.3588346175;43063.784681076395;11415.885841141482;11651.650450486499;11658.76682466363;11771;11894.405279735978;9643.662471813454;9784.951075244579;9837.671914291623;9865.914749377564;9927.305088643725;11621.593244236412;11757;11801.173917825841;11846.822297665542;11875.406229688653;3647.3981793004386;3694.8802085674815;4013.4983127109113;4253.2769429197115;4411.8014689338415;957.1481381570408;962.5187406296851;968.0803236924809;976.2092704909046;985.0691096913491;19521.511962201057;19664.508387290432;19863.900680496507;19993.100310486065;20428.693569596468;1033.204432586904;1039.4542864995938;1045.5869931377063;1049.0977759127145;1054.5149231353664;11069.50187241576;11109.222354435113;11110.55557777696;11131.276467029616;11200.383978881076;481850;489111;504522;506320;525297;111334;113377;113594;114112;115006.42496787463;1150.9654710358702;1167.9299242045336;1197.6826141072622;1212.2423485321674;1229.9877001230052;20683.68974465354;20896.477588059814;20901.37295881126;20924.267650632155;21155.576888462452;55903.81666425217;56883;59864.70067649634;60515.39484605274;60632.69683651553;75252.62373688097;75437;75747.62126189334;75830.62084689763;77404.61297693476;14152.150870947777;14276.785848212492;14334.21161836109;14516.34676439584;14575.271236437924;22100.66848997234;22340.553188935806;22483.887580561994;22523.43691407728;22807.885960570093;17794.822051779316;18140;18148.546286342946;18230.544236394195;18325.816741832943;15825.920870395574;15859.444919428226;16312.755308670143;16330.918345408198;16754.99470031802;18363.347298743178;18374.540636484195;18506.259749609864;18534.351297704514;18943.242270309034;14126.50557230492;14219.928900355431;14309.785353219502;14322.713545729235;14375.28123593837;17266.395676151275;17343.739843902098;17436.651266974844;17859.46421607354;18677.719834202228 07:04:01 INFO - PID 939 | |3;mootools.html;1331.773598488257;1368.2201145347155;1370.3011464153278;1375.174895062962;1379.675776192595;14664;14923.403063877446;15743.134127622976;15917.681646367066;15968.760468592965;15693.215339233022;15953.680926381494;15981.84018159818;16014.519564413056;16029.438969636065;2806.9438611227765;2862.5133727266416;2870.856457177143;2871.6266885304985;2876.8130071545283;2653.7876969842464;2758.255271076808;2768.3632764464187;2772.348498102944;2777.9027734029314;2804.78964077694;2808.101407549585;2851.1304052264154;2856.2573730829927;2864.298246929495;2766.8616569171663;2779.8610069496444;2827.6182715333475;2840.6449193850767;2843.8151520151227;2660.8802603882873;2681.3564744461382;2688.8924443022256;2689.784817214618;2693.205504376214;14658.780118298235;14951.700965980728;14956.177410242432;14962;14962.47631332909;8099.878501822477;8340.165983401672;8385.95807020967;8400.159984001551;8435.072142064368;5541.390447050821;5590.720463976825;5597.7201139943245;5669.433056694339;5697.145428185805;1904.238304678126;1907.818757218062;1957.314939771083;1974.7432833731523;1982.9702554461694;25842.87078564595;26093.08674196394;26219.868900655565;26294;26331.341716457242;6695.1965764107645;6751.324867513307;6894.103766510422;6939.514234003672;7048.083749112582;17177.914110429367;17316.567085822957;17347.65304693899;17349.392771252944;17388.47834564965;7958.243966823143;8035.357171426272;8063.838723225503;8132.512049277062;8142.51144931306;7324.157721862054;7389.371903388164;7417.9244009618305;7446;7493.025906632103;4994.22589498621;5244.5279924806955;5267.0256002639635;5278.9208161877605;5312.814051508256;1443.1918125849559;1455.2650911289732;1464.3337281536876;1477.231839443505;1482.5478229140215;881.7927786970057;893.1827377949104;911.8632205169145;913.7532866126109;919.793046564531;7564.243575642392;7710.575918324546;7718.652660630285;7771.106322772954;7885.093214280317;701.113091938698;709.7795616409198;719.4783781758288;723.280336065618;733.3729661139755;4764.237721964469;4764.547368000034;5249.737513124329;5432.809851655173;5507.586930980113;21011.47471313199;21106.47233819136;21697.67453488199;22064.779352206595;22302.665460018114;21218.469538261357;21618.56762864734;21752;21875.12499500034;21994.89002554977;10568.260221784401;10661.73345666349;10754.677359679223;10792.136629069655;10958.726031849268;8242.216989386;8285.088640249689;8356.87464688018;8356.874646880424;8376.204260595234;18030.639387212446;18471.53821154482;18509.167087480826;18697.81302187015;19042.714359284346;19320.130594123017;19463.61072778565;19491.805081948998;19557.21771129139;19694.212231511152;10688.62589809384;11008.39453830047;11141.944290278496;11151.275167114112;11175.994160525266;13969.30153492301;14129;14193.716125677634;14198.574042778733;14203.289835507976;11254.21220514556;11643.825342620037;11694.532218711156;11751.941240293743;12009.759804804029;11192.440377980905;11194.440277985905;11273.661790146309;11408.771824563297;11528.135389845627;9968.750781230527;9987;9995.70012899614;10013;10076;7291.781246562611;7342.669579869025;7343.485955983244;7395.926040739524;7412.332890039922;7551;7689.115751688628;7689.577073260801;7699.692012319444;7776.88334674969 07:04:01 INFO - PID 939 | |4;prototype.html;494.57960733376655;505.97792459232363;518.945510721374;526.2921370756331;534.0627199265289;6373.426391624753;6374.171357723495;6382.4255816976465;6388.968055159724;6392;6228.007037747922;6276.874462510747;6306.621602703841;6319.494440444765;6332.810015699525;5221.5822734181365;5238.7118708470925;5268.4994925482015;5273.657212281209;5292.259083728281;5242.659227150223;5253.4221235664045;5258.44786297439;5293.100172970585;5295.549878260353;4843.927341089887;4953.777080031407;4995.725235112068;4998.5501304882555;5132;4936.284238785374;4953;4970.155073637454;5000.224965130411;5009.699418034929;4364.585364390377;4407.779611019436;4439.75581343026;4460.219461594208;4467.7542735149555;6006.909896351558;6096.969515152396;6110.755569777203;6170.81487555374;6191.4118158774845;5640.464155905223;5679.602427830054;5737.77048918047;5747.425257474261;5760.395158508338;6537.41163295301;6599.241087274929;6639.970804525258;6643.900341494881;6691.230508491537;4669.229577119771;4797.808087676523;4883.7778810641075;4893.412790465167;4894.437139728905;6702.458434560079;6715.9328406715795;6777.186737591521;6787.796366109024;6947.756828510978;4985;5000.574951129195;5009.624278179078;5019.146745053276;5077.746112694351;5014.548690617862;5025.145725226647;5110.97444512775;5114.232865070269;5116.283720279164;5715.971420142872;5717.485426311652;5734.853029394138;5736.282964629421;5748.5688573357165;6678.49911256648;6689.561744224918;6701.257673005054;6726.428253598499;6742.42689371409;1748.5715999580184;1762.4888782253004;1767.1605987156;1770.8229177082446;1771.8759686822057;1128.424503503203;1200.8619008813923;1213.4114954247184;1220.6704189868685;1234.740704452075;5637.830865074055;5640.407757185519;5670.262865827416;5692.37383887772;5704.942950570524;6731.730730770714;6735.932640673531;6750.1562304711915;6822.931770682229;6852.862942741117;5666.17840413146;5685.914711279334;5715.257016587817;5760.884782304414;5800.39095894925;3501.982490087584;3503.9299214015577;3506.333796578642;3529.8058606776362;3544.6632569906333;6331.493480521547;6384.904226436607;6392.4886009119155;6456.257530383972;6490.707918143695;6711.798646040626;6915.792526224222;6965.850634645227;6976.197737260179;6980.546264492893;5839.912401314069;6342.270638876588;6366.840828979312;6390.411883187317;6479.352064793483;6530.640814755044;6569.967150164219;6630.635315057718;6641.734330626721;6762.830929226809;6479.857269224328;6659.267480577036;6669.032635372674;6739.224989126314;6831.555948863308;6373.139626150411;6397.904031439439;6403.623221007506;6456.451201647913;6464.547481676425;4920;4954.77703503336;4965.45380008206;5000.524950129732;5016.8610896010205;6389.456896163878;6619.139511863427;6631.678912380628;6698.56459330142;6757.189137303555;6261.96869015652;6560.475161986934;6582.473402127723;6590.8352291193105;6638.535302528777;6339.651319177489;6364.268109167319;6551.574147680385;6558.934410655832;6589.550298934419;6419.261784894797;6449.838754030999;6489.4691070483495;6489.837754056186;6510.381513756186;6521.923882559325;6548.869022619616;6561.573497722633;6594.208694956636;6619.536632435684;6329.367063293634;6344.365563443619;6347.650879201688;6420.871582568229;6490.188726409199 07:04:01 INFO - PID 939 | |5;yui.html;894.0880302091863;908.9954550227247;922.8154369126177;922.8615707643856;944.617429940874;19378.612427751435;20026.799732002677;20150.899245503788;20178.899105504453;20260.290889818858;17991.280348786066;18120.456386308433;18647.06764661765;18693.53266168343;18720.251189952385;964.8215080210166;978.921686265097;982.5382070426924;982.7936133411993;986.4180133721103;1000.8748906386702;1000.9149222316112;1001.5092604623718;1001.8948010458906;1006.8087063457956;1008.9646862359818;1041.1462600667455;1042.681981995491;1044.0655613226158;1057.8836328003913;1022.42233138277;1027.2809033676456;1028.8662473878423;1030.2324768047852;1038.5586125896502;724.2431658916445;742.8142964258935;743.4201322968094;744.6128013432984;744.6128013433039;19932.501687457785;20023.1990720371;20153.294634687714;20232.39302820918;20386;21074.15703371863;21628;22151.224707135174;22321.107155713915;22635.547289054128;17060.402885899057;17423.12884355777;17466.301347946068;17567.47297581062;17672.469825905115;3743.2326373093724;3765.8493660253557;3781.3949768037255;3785.1861849702445;3789.6020917803507;129830.3508482461;132988.33505832506;133045;134270;134916.65083349138;15671.370435493058;16559.42042028523;16586;16712.997220166584;17114.914425427793;30365.69634303629;30847.2288192797;30876.53685194724;31023.84488077545;31105.8444707775;8951.597178127;9083.591238394289;9107.08929107084;9110.81778364429;9181.311401644904;4140.792960352031;4149.107941792529;4153.3769934510065;4180.414741936132;4200.810963506649;5249.186376111708;5551.694656793834;5584.636998595079;5588.050031494656;5593.552515798727;953.7806304549993;988.1995583577325;989.3322007644811;992.8560358747941;999.3654029691198;682.3517658224706;695.5652717051742;700.989485157723;709.3792931185213;712.8146681862753;10916.56333746657;11120.443977801078;11387.14596405273;11443.713907152387;11557.364344961108;680.7072958627739;684.698732557673;695.6313154028373;696.3036963036963;702.9121359830021;5462.945370546244;5505.513511351913;5575.191597218381;5583.609147359646;5709.714514274269;116071.41964290294;125703;126234;126953.3652331751;126963.36518317349;110255.44872275747;110427;111658;113213;113438.43280783543;86205;88617.55691221502;89566.55216723874;89712;90140.54929725309;10303;10396.376217426978;10605;10623.787524249627;10720.249582529148;43495;44205;44295.77852110719;45033.774831126946;45838;57837.4216257832;58471;58658.12012819726;58668.70665646644;58826.705866470395;14425.63935901569;14498.85501144975;14650.70698586001;14799.778003329744;14845.92577037108;15240.695186096438;15245.542633721006;15300.693986119993;15445.22773861325;15489.30298136609;13962.441502339792;14371;14387.208703521406;14435.639109022359;14530.927345363205;14232.857671423568;14555.05392149507;14571.417143314573;14573.562793116223;14647.70704585881;14039.50861719835;14296.142231466145;14381.712365752417;14462.27688615544;14491.492797752027;9419.481928493999;9494.335396522178;9692.466914319499;9885.06091921295;9930.900690993287;9135.497547634945;9174.26605871542;9340.486273255035;9428.717138485583;9506.762330941781 07:04:01 INFO - PID 939 | __end_tp_report 07:04:01 INFO - PID 939 | __start_cc_report 07:04:01 INFO - PID 939 | _x_x_mozilla_cycle_collect,277 07:04:01 INFO - PID 939 | __end_cc_report 07:04:01 INFO - PID 939 | __startTimestamp1505916241339__endTimestamp 07:04:01 INFO - PID 939 | 07:04:01 INFO - PID 939 | ------- Summary: start ------- 07:04:01 INFO - PID 939 | Number of tests: 6 07:04:01 INFO - PID 939 | 07:04:01 INFO - PID 939 | [#0] dojo.html Cycles:165 Average:6216.32 Median:6465.00 stddev:751.25 (11.6%) stddev-sans-first:713.21 07:04:01 INFO - PID 939 | Values: 3120.3 3154.1 3155.2 3157.2 3173.4 6146.5 6269.5 6350.2 6378.3 6410.5 6222.8 6255.3 6325.9 6376.5 6412.7 5781.4 5786.2 5786.4 5895.5 5915.1 5718.0 5862.7 5885.4 5922.2 5929.6 5714.4 5745.0 5761.3 5807.4 5816.4 5794.0 5794.4 5813.7 5820.2 5858.0 5714.8 5769.1 5774.6 5780.7 5791.8 6219.4 6232.3 6249.6 6321.0 6363.6 6529.3 6603.1 6641.7 6665.8 6759.9 6798.9 6834.5 6877.1 6919.9 6925.3 6225.5 6260.5 6284.7 6342.7 6354.5 6894.1 6934.0 6976.2 6986.3 7003.3 6491.0 6581.7 6615.5 6641.7 6715.5 6712.7 6739.0 6767.8 6790.0 6811.4 6701.1 6739.2 6785.3 6830.5 6858.5 6719.9 6811.0 6812.9 6817.8 6886.0 5240.9 5279.7 5317.2 5317.8 5322.0 4607.6 4623.7 4630.0 4666.8 4703.7 5792.8 5848.9 5906.5 5907.6 5909.6 6676.5 6705.7 6778.9 6792.8 6860.0 5667.2 5778.9 5804.3 5816.9 5832.8 5773.0 5803.2 5836.4 5875.8 5900.1 6444.5 6491.8 6583.2 6597.9 6635.2 6765.9 6807.0 6866.0 6905.2 6930.7 6309.1 6481.1 6496.3 6538.1 6572.0 6665.9 6697.4 6737.3 6762.9 6764.8 6804.5 6811.5 6883.1 6897.2 6910.7 6371.5 6493.2 6529.7 6545.2 6668.6 6507.1 6525.4 6535.3 6552.0 6594.1 6516.4 6518.8 6525.0 6545.4 6550.0 6582.4 6649.5 6692.3 6707.5 6756.9 6198.5 6351.2 6376.6 6420.5 6465.0 07:04:01 INFO - PID 939 | 07:04:01 INFO - PID 939 | [#1] ext.html Cycles:180 Average:37944.38 Median:34758.07 stddev:54927.48 (158.0%) stddev-sans-first:55010.97 07:04:01 INFO - PID 939 | Values: 856.4 874.2 876.6 880.0 880.9 37012.8 38126.0 40946.4 41165.6 41259.4 37402.6 37881.1 37894.6 37895.6 37907.2 7149.9 7233.6 7268.2 7281.4 7743.9 7792.9 7793.7 7860.0 7874.8 7909.4 7820.8 7905.2 7911.9 7913.0 7944.7 7791.5 7881.9 7912.7 7918.9 7931.4 7839.6 7934.5 7938.8 7944.7 7953.2 36105.0 36359.0 36412.5 36442.0 36446.5 3516.3 3563.9 3565.1 3569.5 3570.3 30213.8 30318.4 30362.8 30459.7 30511.0 4997.2 5012.7 5045.5 5064.6 5067.8 181662.0 182238.0 183222.0 185335.0 185626.0 47262.8 47497.3 47611.0 48560.8 48819.8 51103.5 51538.5 51658.0 51727.2 51911.7 15421.5 15610.3 15679.2 15706.0 15893.4 13018.3 13095.7 13097.3 13129.8 13135.5 14378.6 14380.6 14415.4 14491.2 14637.0 5637.7 5642.7 5700.6 5716.8 5725.1 1004.8 1011.8 1022.6 1025.3 1028.8 22905.7 23030.2 23177.3 23335.1 23548.2 1107.6 1114.8 1116.4 1128.2 1138.2 12001.5 12189.8 12237.5 12330.3 12409.2 241032.0 242312.0 243488.0 244747.0 244820.0 51654.2 52101.5 52105.2 52194.0 52464.7 1285.6 1407.4 1450.9 1456.7 1465.1 24523.0 26548.9 27100.9 27233.9 27721.3 48725.0 48846.0 48904.8 48908.3 49030.0 202635.0 203325.0 203411.0 205284.0 205298.0 32608.3 34141.5 34186.3 34296.0 34415.3 42329.6 42344.6 42412.0 42935.4 43572.8 30643.5 30779.2 31138.7 31175.7 31224.8 30875.4 31183.7 31266.0 31593.4 31596.5 34017.1 35100.8 35110.5 35206.0 35295.5 29811.4 30370.2 30605.7 30672.4 31279.2 22539.2 23002.4 23057.4 23291.7 23366.9 07:04:01 INFO - PID 939 | 07:04:01 INFO - PID 939 | [#2] jquery.html Cycles:180 Average:36038.65 Median:22072.56 stddev:84115.00 (381.1%) stddev-sans-first:84308.78 07:04:01 INFO - PID 939 | Values: 557.8 566.3 573.7 579.2 581.6 21556.6 22514.3 22611.8 22727.9 22764.2 22743.3 23587.8 23752.5 23970.6 24536.5 6484.9 6666.6 6678.7 6687.6 6741.8 6561.0 6688.8 6690.7 6727.7 6730.1 6403.2 6627.8 6641.6 6692.9 6712.4 6644.6 6689.8 6692.6 6701.0 6704.5 6214.3 6217.9 6231.3 6254.3 6257.6 29949.6 30959.5 31013.0 31108.7 31264.4 2005.9 2050.1 2066.6 2067.5 2068.3 20471.8 20944.2 21104.6 21514.8 21626.0 2449.5 2463.7 2561.0 2564.7 2599.4 123793.4 130163.0 133320.0 139666.3 139669.0 21102.3 21205.6 21483.8 21841.1 22044.4 42202.0 42556.4 42732.8 42744.4 43063.8 11415.9 11651.7 11658.8 11771.0 11894.4 9643.7 9785.0 9837.7 9865.9 9927.3 11621.6 11757.0 11801.2 11846.8 11875.4 3647.4 3694.9 4013.5 4253.3 4411.8 957.1 962.5 968.1 976.2 985.1 19521.5 19664.5 19863.9 19993.1 20428.7 1033.2 1039.5 1045.6 1049.1 1054.5 11069.5 11109.2 11110.6 11131.3 11200.4 481850.0 489111.0 504522.0 506320.0 525297.0 111334.0 113377.0 113594.0 114112.0 115006.4 1151.0 1167.9 1197.7 1212.2 1230.0 20683.7 20896.5 20901.4 20924.3 21155.6 55903.8 56883.0 59864.7 60515.4 60632.7 75252.6 75437.0 75747.6 75830.6 77404.6 14152.2 14276.8 14334.2 14516.3 14575.3 22100.7 22340.6 22483.9 22523.4 22807.9 17794.8 18140.0 18148.5 18230.5 18325.8 15825.9 15859.4 16312.8 16330.9 16755.0 18363.3 18374.5 18506.3 18534.4 18943.2 14126.5 14219.9 14309.8 14322.7 14375.3 17266.4 17343.7 17436.7 17859.5 18677.7 07:04:01 INFO - PID 939 | 07:04:01 INFO - PID 939 | [#3] mootools.html Cycles:180 Average:9392.64 Median:2689.34 stddev:6686.17 (248.6%) stddev-sans-first:6677.50 07:04:01 INFO - PID 939 | Values: 1331.8 1368.2 1370.3 1375.2 1379.7 14664.0 14923.4 15743.1 15917.7 15968.8 15693.2 15953.7 15981.8 16014.5 16029.4 2806.9 2862.5 2870.9 2871.6 2876.8 2653.8 2758.3 2768.4 2772.3 2777.9 2804.8 2808.1 2851.1 2856.3 2864.3 2766.9 2779.9 2827.6 2840.6 2843.8 2660.9 2681.4 2688.9 2689.8 2693.2 14658.8 14951.7 14956.2 14962.0 14962.5 8099.9 8340.2 8386.0 8400.2 8435.1 5541.4 5590.7 5597.7 5669.4 5697.1 1904.2 1907.8 1957.3 1974.7 1983.0 25842.9 26093.1 26219.9 26294.0 26331.3 6695.2 6751.3 6894.1 6939.5 7048.1 17177.9 17316.6 17347.7 17349.4 17388.5 7958.2 8035.4 8063.8 8132.5 8142.5 7324.2 7389.4 7417.9 7446.0 7493.0 4994.2 5244.5 5267.0 5278.9 5312.8 1443.2 1455.3 1464.3 1477.2 1482.5 881.8 893.2 911.9 913.8 919.8 7564.2 7710.6 7718.7 7771.1 7885.1 701.1 709.8 719.5 723.3 733.4 4764.2 4764.5 5249.7 5432.8 5507.6 21011.5 21106.5 21697.7 22064.8 22302.7 21218.5 21618.6 21752.0 21875.1 21994.9 10568.3 10661.7 10754.7 10792.1 10958.7 8242.2 8285.1 8356.9 8356.9 8376.2 18030.6 18471.5 18509.2 18697.8 19042.7 19320.1 19463.6 19491.8 19557.2 19694.2 10688.6 11008.4 11141.9 11151.3 11176.0 13969.3 14129.0 14193.7 14198.6 14203.3 11254.2 11643.8 11694.5 11751.9 12009.8 11192.4 11194.4 11273.7 11408.8 11528.1 9968.8 9987.0 9995.7 10013.0 10076.0 7291.8 7342.7 7343.5 7395.9 7412.3 7551.0 7689.1 7689.6 7699.7 7776.9 07:04:01 INFO - PID 939 | 07:04:01 INFO - PID 939 | [#4] prototype.html Cycles:180 Average:5519.74 Median:6209.71 stddev:1544.35 (24.9%) stddev-sans-first:1501.92 07:04:01 INFO - PID 939 | Values: 494.6 506.0 518.9 526.3 534.1 6373.4 6374.2 6382.4 6389.0 6392.0 6228.0 6276.9 6306.6 6319.5 6332.8 5221.6 5238.7 5268.5 5273.7 5292.3 5242.7 5253.4 5258.4 5293.1 5295.5 4843.9 4953.8 4995.7 4998.6 5132.0 4936.3 4953.0 4970.2 5000.2 5009.7 4364.6 4407.8 4439.8 4460.2 4467.8 6006.9 6097.0 6110.8 6170.8 6191.4 5640.5 5679.6 5737.8 5747.4 5760.4 6537.4 6599.2 6640.0 6643.9 6691.2 4669.2 4797.8 4883.8 4893.4 4894.4 6702.5 6715.9 6777.2 6787.8 6947.8 4985.0 5000.6 5009.6 5019.1 5077.7 5014.5 5025.1 5111.0 5114.2 5116.3 5716.0 5717.5 5734.9 5736.3 5748.6 6678.5 6689.6 6701.3 6726.4 6742.4 1748.6 1762.5 1767.2 1770.8 1771.9 1128.4 1200.9 1213.4 1220.7 1234.7 5637.8 5640.4 5670.3 5692.4 5704.9 6731.7 6735.9 6750.2 6822.9 6852.9 5666.2 5685.9 5715.3 5760.9 5800.4 3502.0 3503.9 3506.3 3529.8 3544.7 6331.5 6384.9 6392.5 6456.3 6490.7 6711.8 6915.8 6965.9 6976.2 6980.5 5839.9 6342.3 6366.8 6390.4 6479.4 6530.6 6570.0 6630.6 6641.7 6762.8 6479.9 6659.3 6669.0 6739.2 6831.6 6373.1 6397.9 6403.6 6456.5 6464.5 4920.0 4954.8 4965.5 5000.5 5016.9 6389.5 6619.1 6631.7 6698.6 6757.2 6262.0 6560.5 6582.5 6590.8 6638.5 6339.7 6364.3 6551.6 6558.9 6589.6 6419.3 6449.8 6489.5 6489.8 6510.4 6521.9 6548.9 6561.6 6594.2 6619.5 6329.4 6344.4 6347.7 6420.9 6490.2 07:04:01 INFO - PID 939 | 07:04:01 INFO - PID 939 | [#5] yui.html Cycles:180 Average:23795.65 Median:21351.08 stddev:34832.53 (163.1%) stddev-sans-first:34887.80 07:04:01 INFO - PID 939 | Values: 894.1 909.0 922.8 922.9 944.6 19378.6 20026.8 20150.9 20178.9 20260.3 17991.3 18120.5 18647.1 18693.5 18720.3 964.8 978.9 982.5 982.8 986.4 1000.9 1000.9 1001.5 1001.9 1006.8 1009.0 1041.1 1042.7 1044.1 1057.9 1022.4 1027.3 1028.9 1030.2 1038.6 724.2 742.8 743.4 744.6 744.6 19932.5 20023.2 20153.3 20232.4 20386.0 21074.2 21628.0 22151.2 22321.1 22635.5 17060.4 17423.1 17466.3 17567.5 17672.5 3743.2 3765.8 3781.4 3785.2 3789.6 129830.4 132988.3 133045.0 134270.0 134916.7 15671.4 16559.4 16586.0 16713.0 17114.9 30365.7 30847.2 30876.5 31023.8 31105.8 8951.6 9083.6 9107.1 9110.8 9181.3 4140.8 4149.1 4153.4 4180.4 4200.8 5249.2 5551.7 5584.6 5588.1 5593.6 953.8 988.2 989.3 992.9 999.4 682.4 695.6 701.0 709.4 712.8 10916.6 11120.4 11387.1 11443.7 11557.4 680.7 684.7 695.6 696.3 702.9 5462.9 5505.5 5575.2 5583.6 5709.7 116071.4 125703.0 126234.0 126953.4 126963.4 110255.4 110427.0 111658.0 113213.0 113438.4 86205.0 88617.6 89566.6 89712.0 90140.5 10303.0 10396.4 10605.0 10623.8 10720.2 43495.0 44205.0 44295.8 45033.8 45838.0 57837.4 58471.0 58658.1 58668.7 58826.7 14425.6 14498.9 14650.7 14799.8 14845.9 15240.7 15245.5 15300.7 15445.2 15489.3 13962.4 14371.0 14387.2 14435.6 14530.9 14232.9 14555.1 14571.4 14573.6 14647.7 14039.5 14296.1 14381.7 14462.3 14491.5 9419.5 9494.3 9692.5 9885.1 9930.9 9135.5 9174.3 9340.5 9428.7 9506.8 07:04:01 INFO - PID 939 | -------- Summary: end -------- 07:04:01 INFO - PID 939 | 07:04:02 INFO - TEST-INFO | 939: exit 0 07:04:02 INFO - TEST-OK | dromaeo_css | took 1112746ms 07:04:02 INFO - TEST-START | kraken 07:04:02 INFO - Initialising browser for kraken test... 07:04:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56831/getInfo.html -profile /tmp/tmpPLJ_tj/profile 07:04:02 INFO - TEST-INFO | started process 1404 (/builds/slave/test/build/application/firefox/firefox http://localhost:56831/getInfo.html) 07:04:08 INFO - TEST-INFO | 1404: exit 0 07:04:08 INFO - Browser initialized. 07:04:08 INFO - Running cycle 1/1 for kraken test... 07:04:08 INFO - Using env: {'DISPLAY': ':0', 07:04:08 INFO - 'HOME': '/home/cltbld', 07:04:08 INFO - 'JSGC_DISABLE_POISONING': '1', 07:04:08 INFO - 'LANG': 'en_US.UTF-8', 07:04:08 INFO - 'LANGUAGE': 'en_US:en', 07:04:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:04:08 INFO - 'LOGNAME': 'cltbld', 07:04:08 INFO - 'MAIL': '/var/mail/cltbld', 07:04:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:04:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:04:08 INFO - 'MOZ_ACCELERATED': '1', 07:04:08 INFO - 'MOZ_CRASHREPORTER': '1', 07:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:04:08 INFO - 'MOZ_NO_REMOTE': '1', 07:04:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:04:08 INFO - 'MOZ_WEBRENDER': '1', 07:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:08 INFO - 'NO_EM_RESTART': '1', 07:04:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:08 INFO - 'PWD': '/builds/slave/test', 07:04:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:04:08 INFO - 'RUST_BACKTRACE': 'full', 07:04:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:04:08 INFO - 'SHELL': '/bin/bash', 07:04:08 INFO - 'SHLVL': '1', 07:04:08 INFO - 'TERM': 'linux', 07:04:08 INFO - 'TMOUT': '86400', 07:04:08 INFO - 'USER': 'cltbld', 07:04:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505914314.142008-195556844', 07:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:08 INFO - '_': '/tools/buildbot/bin/python'} 07:04:08 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPLJ_tj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:09 INFO - PID 1648 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 07:04:09 INFO - PID 1648 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 07:04:09 INFO - PID 1648 | 07:04:09 INFO - PID 1648 | (/builds/slave/test/build/application/firefox/firefox:1708): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:04:09 INFO - PID 1648 | 07:04:19 INFO - PID 1648 | RSS: Main: 193806336 07:04:19 INFO - PID 1648 | 07:04:22 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56831/tests/kraken/driver.html?testName=audio-beat-detection) 07:04:23 INFO - PID 1648 | RSS: Main: 192978944 07:04:23 INFO - PID 1648 | 07:04:26 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56831/tests/kraken/driver.html?testName=audio-dft) 07:04:26 INFO - PID 1648 | RSS: Main: 192741376 07:04:26 INFO - PID 1648 | 07:04:29 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56831/tests/kraken/driver.html?testName=audio-fft) 07:04:30 INFO - PID 1648 | RSS: Main: 189493248 07:04:30 INFO - PID 1648 | 07:04:32 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56831/tests/kraken/driver.html?testName=audio-oscillator) 07:04:33 INFO - PID 1648 | RSS: Main: 190431232 07:04:33 INFO - PID 1648 | 07:04:35 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56831/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:04:36 INFO - PID 1648 | RSS: Main: 190582784 07:04:36 INFO - PID 1648 | 07:04:39 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56831/tests/kraken/driver.html?testName=imaging-darkroom) 07:04:39 INFO - PID 1648 | RSS: Main: 191954944 07:04:39 INFO - PID 1648 | 07:04:43 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56831/tests/kraken/driver.html?testName=imaging-desaturate) 07:04:44 INFO - PID 1648 | RSS: Main: 191934464 07:04:44 INFO - PID 1648 | 07:04:47 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56831/tests/kraken/driver.html?testName=json-parse-financial) 07:04:47 INFO - PID 1648 | RSS: Main: 192876544 07:04:47 INFO - PID 1648 | 07:04:49 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56831/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:04:50 INFO - PID 1648 | RSS: Main: 193077248 07:04:50 INFO - PID 1648 | 07:04:51 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56831/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:04:52 INFO - PID 1648 | RSS: Main: 190300160 07:04:52 INFO - PID 1648 | 07:04:54 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56831/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:04:55 INFO - PID 1648 | RSS: Main: 190087168 07:04:55 INFO - PID 1648 | 07:04:57 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:04:58 INFO - PID 1648 | RSS: Main: 189181952 07:04:58 INFO - PID 1648 | 07:05:01 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:05:02 INFO - PID 1648 | RSS: Main: 190451712 07:05:02 INFO - PID 1648 | 07:05:03 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:56831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56831/tests/kraken/driver.html?testName=ai-astar) 07:05:04 INFO - PID 1648 | RSS: Main: 192835584 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | __start_tp_report 07:05:04 INFO - PID 1648 | _x_x_mozilla_page_load 07:05:04 INFO - PID 1648 | _x_x_mozilla_page_load_details 07:05:04 INFO - PID 1648 | |i|pagename|runs| 07:05:04 INFO - PID 1648 | |0;ai-astar;109;108;107;110;115;116;117;113;108;112 07:05:04 INFO - PID 1648 | |1;audio-beat-detection;120;121;124;118;118;126;118;122;124;118 07:05:04 INFO - PID 1648 | |2;audio-dft;166;175;164;164;169;174;171;170;170;164 07:05:04 INFO - PID 1648 | |3;audio-fft;82;77;74;74;77;75;81;75;81;78 07:05:04 INFO - PID 1648 | |4;audio-oscillator;83;80;85;87;79;79;79;78;81;79 07:05:04 INFO - PID 1648 | |5;imaging-gaussian-blur;117;116;118;113;115;116;117;122;116;114 07:05:04 INFO - PID 1648 | |6;imaging-darkroom;148;149;150;147;149;147;150;153;150;152 07:05:04 INFO - PID 1648 | |7;imaging-desaturate;97;98;94;94;94;94;95;95;95;97 07:05:04 INFO - PID 1648 | |8;json-parse-financial;65;56;55;54;54;54;53;54;55;55 07:05:04 INFO - PID 1648 | |9;json-stringify-tinderbox;47;46;46;46;39;49;41;39;46;39 07:05:04 INFO - PID 1648 | |10;stanford-crypto-aes;78;79;74;86;81;80;92;78;77;77 07:05:04 INFO - PID 1648 | |11;stanford-crypto-ccm;115;114;112;134;123;119;115;120;118;117 07:05:04 INFO - PID 1648 | |12;stanford-crypto-pbkdf2;169;171;175;179;172;171;178;185;179;168 07:05:04 INFO - PID 1648 | |13;stanford-crypto-sha256-iterative;67;75;66;68;66;68;68;68;64;69 07:05:04 INFO - PID 1648 | __end_tp_report 07:05:04 INFO - PID 1648 | __start_cc_report 07:05:04 INFO - PID 1648 | _x_x_mozilla_cycle_collect,720 07:05:04 INFO - PID 1648 | __end_cc_report 07:05:04 INFO - PID 1648 | __startTimestamp1505916304183__endTimestamp 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | ------- Summary: start ------- 07:05:04 INFO - PID 1648 | Number of tests: 14 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:3.63 (3.2%) stddev-sans-first:3.73 07:05:04 INFO - PID 1648 | Values: 109.0 108.0 107.0 110.0 115.0 116.0 117.0 113.0 108.0 112.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#1] audio-beat-detection Cycles:10 Average:120.90 Median:121.50 stddev:3.00 (2.5%) stddev-sans-first:3.16 07:05:04 INFO - PID 1648 | Values: 120.0 121.0 124.0 118.0 118.0 126.0 118.0 122.0 124.0 118.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#2] audio-dft Cycles:10 Average:168.70 Median:170.00 stddev:4.08 (2.4%) stddev-sans-first:4.21 07:05:04 INFO - PID 1648 | Values: 166.0 175.0 164.0 164.0 169.0 174.0 171.0 170.0 170.0 164.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#3] audio-fft Cycles:10 Average:77.40 Median:77.50 stddev:3.03 (3.9%) stddev-sans-first:2.71 07:05:04 INFO - PID 1648 | Values: 82.0 77.0 74.0 74.0 77.0 75.0 81.0 75.0 81.0 78.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#4] audio-oscillator Cycles:10 Average:81.00 Median:80.50 stddev:3.02 (3.7%) stddev-sans-first:3.11 07:05:04 INFO - PID 1648 | Values: 83.0 80.0 85.0 87.0 79.0 79.0 79.0 78.0 81.0 79.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:2.46 (2.1%) stddev-sans-first:2.60 07:05:04 INFO - PID 1648 | Values: 117.0 116.0 118.0 113.0 115.0 116.0 117.0 122.0 116.0 114.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:150.00 stddev:1.96 (1.3%) stddev-sans-first:2.00 07:05:04 INFO - PID 1648 | Values: 148.0 149.0 150.0 147.0 149.0 147.0 150.0 153.0 150.0 152.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.49 (1.6%) stddev-sans-first:1.45 07:05:04 INFO - PID 1648 | Values: 97.0 98.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 97.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:3.44 (6.3%) stddev-sans-first:0.88 07:05:04 INFO - PID 1648 | Values: 65.0 56.0 55.0 54.0 54.0 54.0 53.0 54.0 55.0 55.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:43.80 Median:46.00 stddev:3.85 (8.4%) stddev-sans-first:3.91 07:05:04 INFO - PID 1648 | Values: 47.0 46.0 46.0 46.0 39.0 49.0 41.0 39.0 46.0 39.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:5.20 (6.5%) stddev-sans-first:5.46 07:05:04 INFO - PID 1648 | Values: 78.0 79.0 74.0 86.0 81.0 80.0 92.0 78.0 77.0 77.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:118.50 stddev:6.25 (5.3%) stddev-sans-first:6.49 07:05:04 INFO - PID 1648 | Values: 115.0 114.0 112.0 134.0 123.0 119.0 115.0 120.0 118.0 117.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:176.50 stddev:5.44 (3.1%) stddev-sans-first:5.36 07:05:04 INFO - PID 1648 | Values: 169.0 171.0 175.0 179.0 172.0 171.0 178.0 185.0 179.0 168.0 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.88 (4.2%) stddev-sans-first:3.04 07:05:04 INFO - PID 1648 | Values: 67.0 75.0 66.0 68.0 66.0 68.0 68.0 68.0 64.0 69.0 07:05:04 INFO - PID 1648 | -------- Summary: end -------- 07:05:04 INFO - PID 1648 | 07:05:04 INFO - PID 1648 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:05:05 INFO - TEST-INFO | 1648: exit 0 07:05:05 INFO - TEST-OK | kraken | took 62785ms 07:05:05 INFO - SUITE-END | took 1175s 07:05:05 INFO - Completed test suite (00:19:35) 07:05:05 INFO - javascript benchmark 07:05:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8568.88095413125, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3120.2979329650825, 3154.0853152585764, 3155.1796532901444, 3157.2422618571522, 3173.412918610057, 6146.508279337653, 6269.49844012479, 6350.174477317948, 6378.266499352576, 6410.455111315544, 6222.84442888928, 6255.2806427260875, 6325.905111423321, 6376.489880809536, 6412.679366031692, 5781.421857814206, 5786.189933409316, 5786.421357864222, 5895.469407753301, 5915.053591425372, 5718.0, 5862.677552734598, 5885.352611212763, 5922.2005029321135, 5929.644221346712, 5714.371419143891, 5745.0, 5761.30864296285, 5807.39022402648, 5816.418358164192, 5793.971030144864, 5794.420557944214, 5813.651180929158, 5820.243368362128, 5858.033424484955, 5714.771409143629, 5769.07694768835, 5774.566907481913, 5780.682062486561, 5791.768329266824, 6219.378062193789, 6232.34560371159, 6249.625022498619, 6320.968395158041, 6363.61818290904, 6529.34706529348, 6603.14159159311, 6641.734330626818, 6665.833354166136, 6759.864802703918, 6798.898016529756, 6834.521583489158, 6877.140357455318, 6919.930800691979, 6925.3074692530845, 6225.501959843247, 6260.530460215502, 6284.654344011077, 6342.714577843962, 6354.491640668735, 6894.069300644449, 6933.965330173418, 6976.232614412411, 6986.266442023616, 7003.299670033058, 6490.967545162244, 6581.736730530725, 6615.536912416084, 6641.66791660415, 6715.5299129060495, 6712.731490740316, 6739.0, 6767.830804229934, 6790.0493930849725, 6811.352921472452, 6701.128853249046, 6739.224989126215, 6785.253622101565, 6830.453563714891, 6858.451323894176, 6719.857624203897, 6811.0, 6812.931870681329, 6817.829554261084, 6886.0, 5240.895182096337, 5279.683219006872, 5317.202419637086, 5317.8404647860625, 5322.042032434121, 4607.562281583244, 4623.653226008063, 4629.976850115728, 4666.836660716858, 4703.74129422885, 5792.768289268382, 5848.912266316009, 5906.527477801766, 5907.616004959664, 5909.586328957018, 6676.532642714963, 6705.664716764142, 6778.864422711518, 6792.796216113525, 6859.965700171567, 5667.206591077253, 5778.855528611818, 5804.303483581997, 5816.941830581724, 5832.766689332379, 5773.0, 5803.187553742479, 5836.416358364129, 5875.794347197913, 5900.144479050514, 6444.548881578245, 6491.805245842632, 6583.177102862142, 6597.901031484532, 6635.2037755469655, 6765.864682706417, 6806.965965170241, 6866.038754574263, 6905.205901321312, 6930.7227710891, 6309.085182648399, 6481.125048118443, 6496.252930913006, 6538.084668146368, 6572.047053177167, 6665.866802643465, 6697.3637504437, 6737.32626737342, 6762.8985565217545, 6764.763233286812, 6804.523683342119, 6811.523193376416, 6883.139607549057, 6897.241303456716, 6910.689018994057, 6371.49028077762, 6493.188351456068, 6529.7061632227615, 6545.181852268466, 6668.599884006975, 6507.121538592419, 6525.445337146396, 6535.3464653534265, 6552.0, 6594.076829243813, 6516.380943810331, 6518.771842985473, 6525.0, 6545.443637290884, 6549.967250163719, 6582.3746744059235, 6649.534532582673, 6692.297308782508, 6707.530472867048, 6756.932430675827, 6198.504119670325, 6351.237851457855, 6376.585521941059, 6420.486361091195, 6465.0], "value": 6158.545196900825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.4304737349662, 874.1739056591524, 876.6493402638944, 880.0231742765529, 880.8898887639049, 37012.814935925315, 38126.0, 40946.38580421292, 41165.58834411662, 41259.381109283386, 37402.62597374026, 37881.05297367567, 37894.62105378945, 37895.62104378956, 37907.24185516288, 7149.892751608717, 7233.565986040828, 7268.164161121459, 7281.381082607984, 7743.88384174235, 7792.922070779305, 7793.727219547317, 7860.0, 7874.842503149934, 7909.446338756289, 7820.843583128334, 7905.169957154502, 7911.920880791176, 7913.0, 7944.682212711485, 7791.4935529190425, 7881.921180788205, 7912.723054693058, 7918.930944322558, 7931.405144614177, 7839.568823714693, 7934.484258523177, 7938.801529961739, 7944.721934732314, 7953.204679532058, 36105.0, 36359.0, 36412.45381319256, 36442.0, 36446.45330320048, 3516.331896939573, 3563.8574457021687, 3565.1265439967374, 3569.5181150544604, 3570.250247448039, 30213.848930755426, 30318.393632127234, 30362.84818575915, 30459.69540304591, 30511.0, 4997.225430058346, 5012.699238045729, 5045.495450454961, 5064.645474816764, 5067.771950262247, 181662.0, 182238.0, 183222.0, 185335.0, 185626.0, 47262.76368618135, 47497.28754068692, 47611.0, 48560.7571962145, 48819.75590122027, 51103.48896510987, 51538.48461515412, 51658.0, 51727.22409163866, 51911.74044129755, 15421.537353879401, 15610.29753661088, 15679.216039197994, 15706.0, 15893.364265429485, 13018.349082545836, 13095.738085238241, 13097.345132743516, 13129.803052954214, 13135.474581016651, 14378.568642940729, 14380.56858294253, 14415.42338306477, 14491.20298383578, 14637.0, 5637.746301416446, 5642.6614403135945, 5700.6009579329875, 5716.828495145152, 5725.141228815628, 1004.7839714461426, 1011.7521207304258, 1022.5602990713916, 1025.3489034463169, 1028.8456731490337, 22905.656415153786, 23030.193943211907, 23177.3046808596, 23335.066597336256, 23548.175813846778, 1107.5625128074366, 1114.804909140897, 1116.393221827043, 1128.210252823027, 1138.1861968692424, 12001.459934302977, 12189.817152742717, 12237.510499579917, 12330.260184388966, 12409.193402428813, 241032.0, 242312.0, 243488.0, 244747.0, 244820.0, 51654.22518662223, 52101.47898521042, 52105.2184217237, 52194.0, 52464.73767631137, 1285.5886116442834, 1407.3877863129571, 1450.8766754825747, 1456.7013762178728, 1465.077001489055, 24523.0, 26548.867255663597, 27100.864495677397, 27233.86383068072, 27721.30696732517, 48725.0, 48846.0, 48904.75547622239, 48908.266376003674, 49030.0, 202635.0, 203325.0, 203411.0, 205284.0, 205298.0, 32608.34783304368, 34141.48787768235, 34186.316273674885, 34296.0, 34415.31169376648, 42329.5767042338, 42344.5765542353, 42412.0, 42935.355969661105, 43572.78213608912, 30643.54034689437, 30779.230519237197, 31138.688613114486, 31175.688243117278, 31224.843875780476, 30875.382492350476, 31183.688163118077, 31266.0, 31593.36813263676, 31596.526052109697, 34017.14957126092, 35100.824495878376, 35110.47334290039, 35206.0, 35295.47056794099, 29811.403771924008, 30370.240743981576, 30605.693943060283, 30672.386552268385, 31279.218019549695, 22539.211127610455, 23002.424939376648, 23057.423564411023, 23291.650625240298, 23366.883165584062], "value": 17201.177307541107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.79516244911, 566.28082335434, 573.6873403994825, 579.2180556249062, 581.5986968991396, 21556.56886862264, 22514.324570262877, 22611.773882261172, 22727.886360568173, 22764.20325288613, 22743.31770046901, 23587.76412235877, 23752.524949501, 23970.640440393407, 24536.509269814593, 6484.902726459107, 6666.566673166253, 6678.66606669667, 6687.598744075347, 6741.797746067601, 6561.0, 6688.799336019927, 6690.6654667266685, 6727.66361681914, 6730.091437655928, 6403.231612206541, 6627.801165965029, 6641.6015039097565, 6692.9330706693045, 6712.395884370406, 6644.601323920556, 6689.799306020778, 6692.63190524521, 6701.028350889118, 6704.5306828522025, 6214.285357183891, 6217.87564248717, 6231.283402408736, 6254.280757712876, 6257.5932564383165, 29949.550756738667, 30959.535606965914, 31013.0, 31108.688913110804, 31264.37471250585, 2005.8796472211714, 2050.1286953044896, 2066.628006958747, 2067.452125186827, 2068.307117115768, 20471.795282047136, 20944.16223351064, 21104.577908441897, 21514.784852151435, 21626.0, 2449.4856080223176, 2463.6674049003514, 2560.9871950640127, 2564.6794150731157, 2599.4281258123374, 123793.38103309515, 130163.0, 133320.0, 139666.301668491, 139669.0, 21102.261420850504, 21205.575888482144, 21483.78516214849, 21841.126354945944, 22044.448888777588, 42202.0, 42556.36165457521, 42732.78633606812, 42744.3588346175, 43063.784681076395, 11415.885841141482, 11651.650450486499, 11658.76682466363, 11771.0, 11894.405279735978, 9643.662471813454, 9784.951075244579, 9837.671914291623, 9865.914749377564, 9927.305088643725, 11621.593244236412, 11757.0, 11801.173917825841, 11846.822297665542, 11875.406229688653, 3647.3981793004386, 3694.8802085674815, 4013.4983127109113, 4253.2769429197115, 4411.8014689338415, 957.1481381570408, 962.5187406296851, 968.0803236924809, 976.2092704909046, 985.0691096913491, 19521.511962201057, 19664.508387290432, 19863.900680496507, 19993.100310486065, 20428.693569596468, 1033.204432586904, 1039.4542864995938, 1045.5869931377063, 1049.0977759127145, 1054.5149231353664, 11069.50187241576, 11109.222354435113, 11110.55557777696, 11131.276467029616, 11200.383978881076, 481850.0, 489111.0, 504522.0, 506320.0, 525297.0, 111334.0, 113377.0, 113594.0, 114112.0, 115006.42496787463, 1150.9654710358702, 1167.9299242045336, 1197.6826141072622, 1212.2423485321674, 1229.9877001230052, 20683.68974465354, 20896.477588059814, 20901.37295881126, 20924.267650632155, 21155.576888462452, 55903.81666425217, 56883.0, 59864.70067649634, 60515.39484605274, 60632.69683651553, 75252.62373688097, 75437.0, 75747.62126189334, 75830.62084689763, 77404.61297693476, 14152.150870947777, 14276.785848212492, 14334.21161836109, 14516.34676439584, 14575.271236437924, 22100.66848997234, 22340.553188935806, 22483.887580561994, 22523.43691407728, 22807.885960570093, 17794.822051779316, 18140.0, 18148.546286342946, 18230.544236394195, 18325.816741832943, 15825.920870395574, 15859.444919428226, 16312.755308670143, 16330.918345408198, 16754.99470031802, 18363.347298743178, 18374.540636484195, 18506.259749609864, 18534.351297704514, 18943.242270309034, 14126.50557230492, 14219.928900355431, 14309.785353219502, 14322.713545729235, 14375.28123593837, 17266.395676151275, 17343.739843902098, 17436.651266974844, 17859.46421607354, 18677.719834202228], "value": 12689.081455471882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.773598488257, 1368.2201145347155, 1370.3011464153278, 1375.174895062962, 1379.675776192595, 14664.0, 14923.403063877446, 15743.134127622976, 15917.681646367066, 15968.760468592965, 15693.215339233022, 15953.680926381494, 15981.84018159818, 16014.519564413056, 16029.438969636065, 2806.9438611227765, 2862.5133727266416, 2870.856457177143, 2871.6266885304985, 2876.8130071545283, 2653.7876969842464, 2758.255271076808, 2768.3632764464187, 2772.348498102944, 2777.9027734029314, 2804.78964077694, 2808.101407549585, 2851.1304052264154, 2856.2573730829927, 2864.298246929495, 2766.8616569171663, 2779.8610069496444, 2827.6182715333475, 2840.6449193850767, 2843.8151520151227, 2660.8802603882873, 2681.3564744461382, 2688.8924443022256, 2689.784817214618, 2693.205504376214, 14658.780118298235, 14951.700965980728, 14956.177410242432, 14962.0, 14962.47631332909, 8099.878501822477, 8340.165983401672, 8385.95807020967, 8400.159984001551, 8435.072142064368, 5541.390447050821, 5590.720463976825, 5597.7201139943245, 5669.433056694339, 5697.145428185805, 1904.238304678126, 1907.818757218062, 1957.314939771083, 1974.7432833731523, 1982.9702554461694, 25842.87078564595, 26093.08674196394, 26219.868900655565, 26294.0, 26331.341716457242, 6695.1965764107645, 6751.324867513307, 6894.103766510422, 6939.514234003672, 7048.083749112582, 17177.914110429367, 17316.567085822957, 17347.65304693899, 17349.392771252944, 17388.47834564965, 7958.243966823143, 8035.357171426272, 8063.838723225503, 8132.512049277062, 8142.51144931306, 7324.157721862054, 7389.371903388164, 7417.9244009618305, 7446.0, 7493.025906632103, 4994.22589498621, 5244.5279924806955, 5267.0256002639635, 5278.9208161877605, 5312.814051508256, 1443.1918125849559, 1455.2650911289732, 1464.3337281536876, 1477.231839443505, 1482.5478229140215, 881.7927786970057, 893.1827377949104, 911.8632205169145, 913.7532866126109, 919.793046564531, 7564.243575642392, 7710.575918324546, 7718.652660630285, 7771.106322772954, 7885.093214280317, 701.113091938698, 709.7795616409198, 719.4783781758288, 723.280336065618, 733.3729661139755, 4764.237721964469, 4764.547368000034, 5249.737513124329, 5432.809851655173, 5507.586930980113, 21011.47471313199, 21106.47233819136, 21697.67453488199, 22064.779352206595, 22302.665460018114, 21218.469538261357, 21618.56762864734, 21752.0, 21875.12499500034, 21994.89002554977, 10568.260221784401, 10661.73345666349, 10754.677359679223, 10792.136629069655, 10958.726031849268, 8242.216989386, 8285.088640249689, 8356.87464688018, 8356.874646880424, 8376.204260595234, 18030.639387212446, 18471.53821154482, 18509.167087480826, 18697.81302187015, 19042.714359284346, 19320.130594123017, 19463.61072778565, 19491.805081948998, 19557.21771129139, 19694.212231511152, 10688.62589809384, 11008.39453830047, 11141.944290278496, 11151.275167114112, 11175.994160525266, 13969.30153492301, 14129.0, 14193.716125677634, 14198.574042778733, 14203.289835507976, 11254.21220514556, 11643.825342620037, 11694.532218711156, 11751.941240293743, 12009.759804804029, 11192.440377980905, 11194.440277985905, 11273.661790146309, 11408.771824563297, 11528.135389845627, 9968.750781230527, 9987.0, 9995.70012899614, 10013.0, 10076.0, 7291.781246562611, 7342.669579869025, 7343.485955983244, 7395.926040739524, 7412.332890039922, 7551.0, 7689.115751688628, 7689.577073260801, 7699.692012319444, 7776.88334674969], "value": 6682.5014008600365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.57960733376655, 505.97792459232363, 518.945510721374, 526.2921370756331, 534.0627199265289, 6373.426391624753, 6374.171357723495, 6382.4255816976465, 6388.968055159724, 6392.0, 6228.007037747922, 6276.874462510747, 6306.621602703841, 6319.494440444765, 6332.810015699525, 5221.5822734181365, 5238.7118708470925, 5268.4994925482015, 5273.657212281209, 5292.259083728281, 5242.659227150223, 5253.4221235664045, 5258.44786297439, 5293.100172970585, 5295.549878260353, 4843.927341089887, 4953.777080031407, 4995.725235112068, 4998.5501304882555, 5132.0, 4936.284238785374, 4953.0, 4970.155073637454, 5000.224965130411, 5009.699418034929, 4364.585364390377, 4407.779611019436, 4439.75581343026, 4460.219461594208, 4467.7542735149555, 6006.909896351558, 6096.969515152396, 6110.755569777203, 6170.81487555374, 6191.4118158774845, 5640.464155905223, 5679.602427830054, 5737.77048918047, 5747.425257474261, 5760.395158508338, 6537.41163295301, 6599.241087274929, 6639.970804525258, 6643.900341494881, 6691.230508491537, 4669.229577119771, 4797.808087676523, 4883.7778810641075, 4893.412790465167, 4894.437139728905, 6702.458434560079, 6715.9328406715795, 6777.186737591521, 6787.796366109024, 6947.756828510978, 4985.0, 5000.574951129195, 5009.624278179078, 5019.146745053276, 5077.746112694351, 5014.548690617862, 5025.145725226647, 5110.97444512775, 5114.232865070269, 5116.283720279164, 5715.971420142872, 5717.485426311652, 5734.853029394138, 5736.282964629421, 5748.5688573357165, 6678.49911256648, 6689.561744224918, 6701.257673005054, 6726.428253598499, 6742.42689371409, 1748.5715999580184, 1762.4888782253004, 1767.1605987156, 1770.8229177082446, 1771.8759686822057, 1128.424503503203, 1200.8619008813923, 1213.4114954247184, 1220.6704189868685, 1234.740704452075, 5637.830865074055, 5640.407757185519, 5670.262865827416, 5692.37383887772, 5704.942950570524, 6731.730730770714, 6735.932640673531, 6750.1562304711915, 6822.931770682229, 6852.862942741117, 5666.17840413146, 5685.914711279334, 5715.257016587817, 5760.884782304414, 5800.39095894925, 3501.982490087584, 3503.9299214015577, 3506.333796578642, 3529.8058606776362, 3544.6632569906333, 6331.493480521547, 6384.904226436607, 6392.4886009119155, 6456.257530383972, 6490.707918143695, 6711.798646040626, 6915.792526224222, 6965.850634645227, 6976.197737260179, 6980.546264492893, 5839.912401314069, 6342.270638876588, 6366.840828979312, 6390.411883187317, 6479.352064793483, 6530.640814755044, 6569.967150164219, 6630.635315057718, 6641.734330626721, 6762.830929226809, 6479.857269224328, 6659.267480577036, 6669.032635372674, 6739.224989126314, 6831.555948863308, 6373.139626150411, 6397.904031439439, 6403.623221007506, 6456.451201647913, 6464.547481676425, 4920.0, 4954.77703503336, 4965.45380008206, 5000.524950129732, 5016.8610896010205, 6389.456896163878, 6619.139511863427, 6631.678912380628, 6698.56459330142, 6757.189137303555, 6261.96869015652, 6560.475161986934, 6582.473402127723, 6590.8352291193105, 6638.535302528777, 6339.651319177489, 6364.268109167319, 6551.574147680385, 6558.934410655832, 6589.550298934419, 6419.261784894797, 6449.838754030999, 6489.4691070483495, 6489.837754056186, 6510.381513756186, 6521.923882559325, 6548.869022619616, 6561.573497722633, 6594.208694956636, 6619.536632435684, 6329.367063293634, 6344.365563443619, 6347.650879201688, 6420.871582568229, 6490.188726409199], "value": 5063.638824992697, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [894.0880302091863, 908.9954550227247, 922.8154369126177, 922.8615707643856, 944.617429940874, 19378.612427751435, 20026.799732002677, 20150.899245503788, 20178.899105504453, 20260.290889818858, 17991.280348786066, 18120.456386308433, 18647.06764661765, 18693.53266168343, 18720.251189952385, 964.8215080210166, 978.921686265097, 982.5382070426924, 982.7936133411993, 986.4180133721103, 1000.8748906386702, 1000.9149222316112, 1001.5092604623718, 1001.8948010458906, 1006.8087063457956, 1008.9646862359818, 1041.1462600667455, 1042.681981995491, 1044.0655613226158, 1057.8836328003913, 1022.42233138277, 1027.2809033676456, 1028.8662473878423, 1030.2324768047852, 1038.5586125896502, 724.2431658916445, 742.8142964258935, 743.4201322968094, 744.6128013432984, 744.6128013433039, 19932.501687457785, 20023.1990720371, 20153.294634687714, 20232.39302820918, 20386.0, 21074.15703371863, 21628.0, 22151.224707135174, 22321.107155713915, 22635.547289054128, 17060.402885899057, 17423.12884355777, 17466.301347946068, 17567.47297581062, 17672.469825905115, 3743.2326373093724, 3765.8493660253557, 3781.3949768037255, 3785.1861849702445, 3789.6020917803507, 129830.3508482461, 132988.33505832506, 133045.0, 134270.0, 134916.65083349138, 15671.370435493058, 16559.42042028523, 16586.0, 16712.997220166584, 17114.914425427793, 30365.69634303629, 30847.2288192797, 30876.53685194724, 31023.84488077545, 31105.8444707775, 8951.597178127, 9083.591238394289, 9107.08929107084, 9110.81778364429, 9181.311401644904, 4140.792960352031, 4149.107941792529, 4153.3769934510065, 4180.414741936132, 4200.810963506649, 5249.186376111708, 5551.694656793834, 5584.636998595079, 5588.050031494656, 5593.552515798727, 953.7806304549993, 988.1995583577325, 989.3322007644811, 992.8560358747941, 999.3654029691198, 682.3517658224706, 695.5652717051742, 700.989485157723, 709.3792931185213, 712.8146681862753, 10916.56333746657, 11120.443977801078, 11387.14596405273, 11443.713907152387, 11557.364344961108, 680.7072958627739, 684.698732557673, 695.6313154028373, 696.3036963036963, 702.9121359830021, 5462.945370546244, 5505.513511351913, 5575.191597218381, 5583.609147359646, 5709.714514274269, 116071.41964290294, 125703.0, 126234.0, 126953.3652331751, 126963.36518317349, 110255.44872275747, 110427.0, 111658.0, 113213.0, 113438.43280783543, 86205.0, 88617.55691221502, 89566.55216723874, 89712.0, 90140.54929725309, 10303.0, 10396.376217426978, 10605.0, 10623.787524249627, 10720.249582529148, 43495.0, 44205.0, 44295.77852110719, 45033.774831126946, 45838.0, 57837.4216257832, 58471.0, 58658.12012819726, 58668.70665646644, 58826.705866470395, 14425.63935901569, 14498.85501144975, 14650.70698586001, 14799.778003329744, 14845.92577037108, 15240.695186096438, 15245.542633721006, 15300.693986119993, 15445.22773861325, 15489.30298136609, 13962.441502339792, 14371.0, 14387.208703521406, 14435.639109022359, 14530.927345363205, 14232.857671423568, 14555.05392149507, 14571.417143314573, 14573.562793116223, 14647.70704585881, 14039.50861719835, 14296.142231466145, 14381.712365752417, 14462.27688615544, 14491.492797752027, 9419.481928493999, 9494.335396522178, 9692.466914319499, 9885.06091921295, 9930.900690993287, 9135.497547634945, 9174.26605871542, 9340.486273255035, 9428.717138485583, 9506.762330941781], "value": 8702.616271701183, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 107.0, 110.0, 115.0, 116.0, 117.0, 113.0, 108.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 124.0, 118.0, 118.0, 126.0, 118.0, 122.0, 124.0, 118.0], "value": 120.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 175.0, 164.0, 164.0, 169.0, 174.0, 171.0, 170.0, 170.0, 164.0], "value": 168.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 74.0, 74.0, 77.0, 75.0, 81.0, 75.0, 81.0, 78.0], "value": 77.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 85.0, 87.0, 79.0, 79.0, 79.0, 78.0, 81.0, 79.0], "value": 81.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 113.0, 115.0, 116.0, 117.0, 122.0, 116.0, 114.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 147.0, 149.0, 147.0, 150.0, 153.0, 150.0, 152.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 97.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 56.0, 55.0, 54.0, 54.0, 54.0, 53.0, 54.0, 55.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 46.0, 46.0, 46.0, 39.0, 49.0, 41.0, 39.0, 46.0, 39.0], "value": 43.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 74.0, 86.0, 81.0, 80.0, 92.0, 78.0, 77.0, 77.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 112.0, 134.0, 123.0, 119.0, 115.0, 120.0, 118.0, 117.0], "value": 118.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 175.0, 179.0, 172.0, 171.0, 178.0, 185.0, 179.0, 168.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 66.0, 68.0, 66.0, 68.0, 68.0, 68.0, 64.0, 69.0], "value": 67.9, "unit": "score"}]}]} 07:05:05 INFO - Return code: 0 07:05:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:05:05 INFO - # TBPL SUCCESS # 07:05:05 INFO - Running post-action listener: _package_coverage_data 07:05:05 INFO - Running post-action listener: _resource_record_post_action 07:05:05 INFO - [mozharness: 2017-09-20 14:05:05.460057Z] Finished run-tests step (success) 07:05:05 INFO - Running post-run listener: _resource_record_post_run 07:05:05 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 24576; Write bytes: 341450752; Read time: 28; Write time: 348332 07:05:05 INFO - TinderboxPrint: CPU usage
13.3% 07:05:05 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 28 07:05:05 INFO - TinderboxPrint: I/O write bytes / time
341,450,752 / 348,332 07:05:05 INFO - TinderboxPrint: CPU idle
8,248.0 (86.7%) 07:05:05 INFO - TinderboxPrint: CPU user
1,202.0 (12.6%) 07:05:05 INFO - TinderboxPrint: Swap in / out
0 / 0 07:05:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12812288; Read time: 0; Write time: 3216 07:05:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:05:05 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 20480; Write bytes: 327856128; Read time: 12; Write time: 345024 07:05:06 INFO - Running post-run listener: _upload_blobber_files 07:05:06 INFO - Blob upload gear active. 07:05:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:05:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:05:06 INFO - (blobuploader) - INFO - Open directory for files ... 07:05:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:05:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:05:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:07 INFO - (blobuploader) - INFO - Done attempting. 07:05:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:05:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:05:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:14 INFO - (blobuploader) - INFO - Done attempting. 07:05:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:05:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:05:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:15 INFO - (blobuploader) - INFO - Done attempting. 07:05:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:05:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:05:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:16 INFO - (blobuploader) - INFO - Done attempting. 07:05:16 INFO - (blobuploader) - INFO - Iteration through files over. 07:05:16 INFO - Return code: 0 07:05:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:05:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:05:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e19735e8f84c3a5a1a3b65d0edeac99b09c057fd8799d37a7f7e31829e77e70151dd6a4fdaa94227c00dcfafd3dfe6d149f9a5ed3920b4c580eff4cb54f307b6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a971cf3d1bd1f1ec154cc9ee58d4704b504a5451d70f28d8dc8fb1dde79fb8ffbfcc2dc17aae2f8cf3a97112d4a8600ff21aa1abc67d76b1c37888860f89c8c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/184d853706362e607f63a94b4cd2cb19b0ab9e9d9dd7311abefa93613f2db4b4619a55d233a76eec1b3a037e15ea632f25d0ab26ed2d3b834ef52d1fcb4a52c8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1a68da18bcc8ae20abcb383f2cb774deaa2e880a89985711e6a8ccd4ff5f24baa6df0f2652ba47d1fa9479c9014886cc2111b1cd4d88400fa5413c3ca810c61"} 07:05:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:05:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:05:16 INFO - Contents: 07:05:16 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e19735e8f84c3a5a1a3b65d0edeac99b09c057fd8799d37a7f7e31829e77e70151dd6a4fdaa94227c00dcfafd3dfe6d149f9a5ed3920b4c580eff4cb54f307b6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a971cf3d1bd1f1ec154cc9ee58d4704b504a5451d70f28d8dc8fb1dde79fb8ffbfcc2dc17aae2f8cf3a97112d4a8600ff21aa1abc67d76b1c37888860f89c8c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/184d853706362e607f63a94b4cd2cb19b0ab9e9d9dd7311abefa93613f2db4b4619a55d233a76eec1b3a037e15ea632f25d0ab26ed2d3b834ef52d1fcb4a52c8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1a68da18bcc8ae20abcb383f2cb774deaa2e880a89985711e6a8ccd4ff5f24baa6df0f2652ba47d1fa9479c9014886cc2111b1cd4d88400fa5413c3ca810c61"} 07:05:16 INFO - Running post-run listener: copy_logs_to_upload_dir 07:05:16 INFO - Copying logs to upload dir... 07:05:16 INFO - mkdir: /builds/slave/test/build/upload/logs 07:05:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.788182 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-20 07:05:15.875402) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 07:05:15.882892) ========= 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-1505914314.142008-195556844 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/e19735e8f84c3a5a1a3b65d0edeac99b09c057fd8799d37a7f7e31829e77e70151dd6a4fdaa94227c00dcfafd3dfe6d149f9a5ed3920b4c580eff4cb54f307b6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a971cf3d1bd1f1ec154cc9ee58d4704b504a5451d70f28d8dc8fb1dde79fb8ffbfcc2dc17aae2f8cf3a97112d4a8600ff21aa1abc67d76b1c37888860f89c8c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/184d853706362e607f63a94b4cd2cb19b0ab9e9d9dd7311abefa93613f2db4b4619a55d233a76eec1b3a037e15ea632f25d0ab26ed2d3b834ef52d1fcb4a52c8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1a68da18bcc8ae20abcb383f2cb774deaa2e880a89985711e6a8ccd4ff5f24baa6df0f2652ba47d1fa9479c9014886cc2111b1cd4d88400fa5413c3ca810c61"} build_url:https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e19735e8f84c3a5a1a3b65d0edeac99b09c057fd8799d37a7f7e31829e77e70151dd6a4fdaa94227c00dcfafd3dfe6d149f9a5ed3920b4c580eff4cb54f307b6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a971cf3d1bd1f1ec154cc9ee58d4704b504a5451d70f28d8dc8fb1dde79fb8ffbfcc2dc17aae2f8cf3a97112d4a8600ff21aa1abc67d76b1c37888860f89c8c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/184d853706362e607f63a94b4cd2cb19b0ab9e9d9dd7311abefa93613f2db4b4619a55d233a76eec1b3a037e15ea632f25d0ab26ed2d3b834ef52d1fcb4a52c8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1a68da18bcc8ae20abcb383f2cb774deaa2e880a89985711e6a8ccd4ff5f24baa6df0f2652ba47d1fa9479c9014886cc2111b1cd4d88400fa5413c3ca810c61"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 07:05:15.913234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 07:05:15.916629) ========= 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-1505914314.142008-195556844 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 07:05:16.001824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 07:05:16.002144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 07:05:16.002537) ========= ========= Total master_lag: 0.25 =========