builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-011 starttime: 1505645965.45 results: success (0) revision: faa897d7948b7e2439573f39c34366c138913663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:25.446594) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:25.447098) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:25.447369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:25.691790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:25.692157) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-17 03:59:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.8M=0s 2017-09-17 03:59:25 (23.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.210116 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:25.975045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:25.975389) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.109798 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:26.138729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:26.139135) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev faa897d7948b7e2439573f39c34366c138913663 --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 faa897d7948b7e2439573f39c34366c138913663 --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=5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-17 03:59:26,257 truncating revision to first 12 chars 2017-09-17 03:59:26,257 Setting DEBUG logging. 2017-09-17 03:59:26,257 attempt 1/10 2017-09-17 03:59:26,257 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/faa897d7948b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-17 03:59:26,696 unpacking tar archive at: mozilla-central-faa897d7948b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.810978 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:27.005478) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:27.008914) ========= script_repo_revision: faa897d7948b7e2439573f39c34366c138913663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:27.009412) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:27.009689) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 03:59:27.023366) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-17 03:59:27.023721) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:27 INFO - MultiFileLogger online at 20170917 03:59:27 in /builds/slave/test 03:59:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:59:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:59:27 INFO - {'append_to_log': False, 03:59:27 INFO - 'base_work_dir': '/builds/slave/test', 03:59:27 INFO - 'blob_upload_branch': 'Firefox', 03:59:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:59:27 INFO - 'branch': 'Firefox', 03:59:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:27 INFO - 'code_coverage': False, 03:59:27 INFO - 'config_files': ('talos/linux_config.py',), 03:59:27 INFO - 'default_actions': ('clobber', 03:59:27 INFO - 'read-buildbot-config', 03:59:27 INFO - 'download-and-extract', 03:59:27 INFO - 'populate-webroot', 03:59:27 INFO - 'create-virtualenv', 03:59:27 INFO - 'install', 03:59:27 INFO - 'setup-mitmproxy', 03:59:27 INFO - 'run-tests'), 03:59:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:27 INFO - 'disable_ccov_upload': False, 03:59:27 INFO - 'disable_stylo': False, 03:59:27 INFO - 'download_minidump_stackwalk': True, 03:59:27 INFO - 'download_symbols': 'ondemand', 03:59:27 INFO - 'enable_stylo': False, 03:59:27 INFO - 'enable_webrender': False, 03:59:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:59:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:27 INFO - 'gecko_profile': False, 03:59:27 INFO - 'gecko_profile_interval': 0, 03:59:27 INFO - 'installer_path': 'installer.exe', 03:59:27 INFO - 'log_level': 'info', 03:59:27 INFO - 'log_name': 'talos', 03:59:27 INFO - 'log_to_console': True, 03:59:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:27 INFO - 'opt_config_files': (), 03:59:27 INFO - 'pip_index': False, 03:59:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:59:27 INFO - 'system_bits': '32', 03:59:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:27 INFO - 'title': 'talos-linux64-ix-011', 03:59:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:27 INFO - 'use_talos_json': True, 03:59:27 INFO - 'verify': 'False', 03:59:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:59:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:27 INFO - 'work_dir': 'build'} 03:59:27 INFO - [mozharness: 2017-09-17 10:59:27.354948Z] Running clobber step. 03:59:27 INFO - Running pre-action listener: _resource_record_pre_action 03:59:27 INFO - Running main action method: clobber 03:59:27 INFO - rmtree: /builds/slave/test/build 03:59:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:59:28 INFO - Running post-action listener: _resource_record_post_action 03:59:28 INFO - [mozharness: 2017-09-17 10:59:28.308575Z] Finished clobber step (success) 03:59:28 INFO - [mozharness: 2017-09-17 10:59:28.308672Z] Running read-buildbot-config step. 03:59:28 INFO - Running pre-action listener: _resource_record_pre_action 03:59:28 INFO - Running main action method: read_buildbot_config 03:59:28 INFO - Using buildbot properties: 03:59:28 INFO - { 03:59:28 INFO - "project": "", 03:59:28 INFO - "product": "firefox", 03:59:28 INFO - "who": "archaeopteryx@coole-files.de", 03:59:28 INFO - "installer_path": "public/build/target.tar.bz2", 03:59:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:59:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:59:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 03:59:28 INFO - "stage_platform": "linux64-pgo", 03:59:28 INFO - "basedir": "/builds/slave/test", 03:59:28 INFO - "buildnumber": 25, 03:59:28 INFO - "platform": "ubuntu64_hw", 03:59:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:59:28 INFO - "slavebuilddir": "test", 03:59:28 INFO - "taskId": "f_vCxMR8SvyaRbBvlVaTsA", 03:59:28 INFO - "branch": "mozilla-central", 03:59:28 INFO - "script_repo_revision": "production", 03:59:28 INFO - "revision": "faa897d7948b7e2439573f39c34366c138913663", 03:59:28 INFO - "slavename": "talos-linux64-ix-011", 03:59:28 INFO - "repo_path": "mozilla-central" 03:59:28 INFO - } 03:59:28 INFO - Finding installer, test and symbols from parent task. 03:59:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f_vCxMR8SvyaRbBvlVaTsA'}, attempt #1 03:59:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f_vCxMR8SvyaRbBvlVaTsA'}, attempt #1 03:59:29 INFO - Task dependencies: JTdcOmWBQK-wHMxZTbidaA 03:59:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA'}, attempt #1 03:59:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.tar.bz2 03:59:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.test_packages.json 03:59:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.crashreporter-symbols.zip 03:59:29 INFO - Running post-action listener: _resource_record_post_action 03:59:29 INFO - [mozharness: 2017-09-17 10:59:29.657400Z] Finished read-buildbot-config step (success) 03:59:29 INFO - [mozharness: 2017-09-17 10:59:29.657617Z] Running download-and-extract step. 03:59:29 INFO - Running pre-action listener: _resource_record_pre_action 03:59:29 INFO - Running main action method: download_and_extract 03:59:29 INFO - mkdir: /builds/slave/test/build/tests 03:59: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')]} 03:59:29 INFO - trying https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.test_packages.json 03:59:29 INFO - Downloading https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:59:30 INFO - Downloaded 989 bytes. 03:59:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:59:30 INFO - Using the following test package requirements: 03:59:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:59:30 INFO - u'common': [u'target.common.tests.zip'], 03:59:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:59:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:59:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:59:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:59:30 INFO - u'mozbase': [u'target.common.tests.zip'], 03:59:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:59:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:59:30 INFO - u'web-platform': [u'target.common.tests.zip', 03:59:30 INFO - u'target.web-platform.tests.tar.gz'], 03:59:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:59:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:59:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.common.tests.zip 03:59:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:59:30 INFO - Fetch https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.common.tests.zip into memory 03:59:32 INFO - Content-Length response header: 55323415 03:59:32 INFO - Bytes received: 55323415 03:59:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.talos.tests.zip 03:59:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:59:42 INFO - Fetch https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.talos.tests.zip into memory 03:59:44 INFO - Content-Length response header: 14508748 03:59:44 INFO - Bytes received: 14508748 03:59:44 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')]} 03:59:44 INFO - trying https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.tar.bz2 03:59:44 INFO - Downloading https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:59:47 INFO - Downloaded 62228399 bytes. 03:59:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.tar.bz2 03:59:47 INFO - mkdir: /builds/slave/test/properties 03:59:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:59:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:59:47 INFO - Contents: 03:59:47 INFO - build_url:https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.tar.bz2 03:59:47 INFO - Running post-action listener: _resource_record_post_action 03:59:47 INFO - Running post-action listener: find_tests_for_verification 03:59:47 INFO - Running post-action listener: set_extra_try_arguments 03:59:47 INFO - [mozharness: 2017-09-17 10:59:47.455049Z] Finished download-and-extract step (success) 03:59:47 INFO - [mozharness: 2017-09-17 10:59:47.455146Z] Running populate-webroot step. 03:59:47 INFO - Running pre-action listener: _resource_record_pre_action 03:59:47 INFO - Running main action method: populate_webroot 03:59:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:59:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:59:47 INFO - 'tests': ['tresize', 03:59:47 INFO - 'tcanvasmark']}, 03:59:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:59:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:59:47 INFO - 'tests': ['dromaeo_css', 03:59:47 INFO - 'kraken']}, 03:59:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:59:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:59:47 INFO - 'talos_options': ['--disable-stylo'], 03:59:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:59:47 INFO - 'tests': ['damp', 'tps']}, 03:59:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:59:47 INFO - 'talos_options': ['--disable-stylo'], 03:59:47 INFO - 'tests': ['damp', 'tps']}, 03:59:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:59:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:59:47 INFO - 'tests': ['dromaeo_dom']}, 03:59:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:59:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:59:47 INFO - 'tests': ['basic_compositor_video', 03:59:47 INFO - 'glvideo']}, 03:59:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:59:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:59:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:59:47 INFO - 'talos_options': ['--disable-stylo'], 03:59:47 INFO - 'tests': ['ts_paint_webext', 03:59:47 INFO - 'tp5o_webext']}, 03:59:47 INFO - 'other-e10s': {'tests': ['a11yr', 03:59:47 INFO - 'ts_paint', 03:59:47 INFO - 'tpaint', 03:59:47 INFO - 'sessionrestore', 03:59:47 INFO - 'sessionrestore_many_windows', 03:59:47 INFO - 'sessionrestore_no_auto_restore', 03:59:47 INFO - 'tabpaint']}, 03:59:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:59:47 INFO - 'tests': ['a11yr', 03:59:47 INFO - 'ts_paint', 03:59:47 INFO - 'tpaint', 03:59:47 INFO - 'sessionrestore', 03:59:47 INFO - 'sessionrestore_many_windows', 03:59:47 INFO - 'sessionrestore_no_auto_restore', 03:59:47 INFO - 'tabpaint']}, 03:59:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:59:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:59:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:59:47 INFO - 'tests': ['perf_reftest_singletons']}, 03:59:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:59:47 INFO - 'tests': ['bloom_basic']}, 03:59:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:59:47 INFO - 'tsvgr_opacity', 03:59:47 INFO - 'tart', 03:59:47 INFO - 'tscrollx', 03:59:47 INFO - 'tsvg_static']}, 03:59:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:59:47 INFO - 'tests': ['tsvgx', 03:59:47 INFO - 'tsvgr_opacity', 03:59:47 INFO - 'tart', 03:59:47 INFO - 'tscrollx', 03:59:47 INFO - 'tsvg_static']}, 03:59:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:59:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:59:47 INFO - 'talos_options': ['--disable-stylo'], 03:59:47 INFO - 'tests': ['tp5o']}, 03:59:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:59:47 INFO - 'talos_options': ['--mitmproxy', 03:59:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:59:47 INFO - '--firstNonBlankPaint'], 03:59:47 INFO - 'tests': ['tp6_google', 03:59:47 INFO - 'tp6_youtube', 03:59:47 INFO - 'tp6_amazon', 03:59:47 INFO - 'tp6_facebook']}, 03:59:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:59:47 INFO - 'talos_options': ['--disable-stylo', 03:59:47 INFO - '--mitmproxy', 03:59:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:59:47 INFO - '--firstNonBlankPaint'], 03:59:47 INFO - 'tests': ['tp6_google', 03:59:47 INFO - 'tp6_youtube', 03:59:47 INFO - 'tp6_amazon', 03:59:47 INFO - 'tp6_facebook']}, 03:59:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:59:47 INFO - 'talos_options': ['--stylo-threads=1', 03:59:47 INFO - '--mitmproxy', 03:59:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:59:47 INFO - '--firstNonBlankPaint'], 03:59:47 INFO - 'tests': ['tp6_google', 03:59:47 INFO - 'tp6_youtube', 03:59:47 INFO - 'tp6_amazon', 03:59:47 INFO - 'tp6_facebook']}, 03:59:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:59:47 INFO - 'talos_options': ['--xperf_path', 03:59:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:47 INFO - 'tests': ['tp5n']}, 03:59:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:59:47 INFO - 'talos_options': ['--disable-stylo', 03:59:47 INFO - '--xperf_path', 03:59:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:47 INFO - 'tests': ['tp5n']}}} 03:59:47 INFO - Running post-action listener: _resource_record_post_action 03:59:47 INFO - [mozharness: 2017-09-17 10:59:47.473015Z] Finished populate-webroot step (success) 03:59:47 INFO - [mozharness: 2017-09-17 10:59:47.473104Z] Running create-virtualenv step. 03:59:47 INFO - Running pre-action listener: _resource_record_pre_action 03:59:47 INFO - Running main action method: create_virtualenv 03:59:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:59:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:59:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:59:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:59:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:59:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:59:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:59:49 INFO - Installing pip...............done. 03:59:49 INFO - Return code: 0 03:59:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:59:49 INFO - Reading from file tmpfile_stdout 03:59:49 INFO - Output received: 03:59:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:59:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:49 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 0x233b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab090>, '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 0x26abd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', '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 03:59:49 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 03:59:49 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 03:59:49 INFO - Using env: {'DISPLAY': ':0', 03:59:49 INFO - 'HOME': '/home/cltbld', 03:59:49 INFO - 'LANG': 'en_US.UTF-8', 03:59:49 INFO - 'LANGUAGE': 'en_US:en', 03:59:49 INFO - 'LOGNAME': 'cltbld', 03:59:49 INFO - 'MAIL': '/var/mail/cltbld', 03:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:49 INFO - 'MOZ_NO_REMOTE': '1', 03:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:49 INFO - 'NO_EM_RESTART': '1', 03:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:49 INFO - 'PWD': '/builds/slave/test', 03:59:49 INFO - 'SHELL': '/bin/bash', 03:59:49 INFO - 'SHLVL': '1', 03:59:49 INFO - 'TERM': 'linux', 03:59:49 INFO - 'TMOUT': '86400', 03:59:49 INFO - 'USER': 'cltbld', 03:59:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 03:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:49 INFO - '_': '/tools/buildbot/bin/python'} 03:59:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:59:50 INFO - Downloading/unpacking pip>=1.5 03:59:50 INFO - Running setup.py egg_info for package pip 03:59:50 INFO - warning: no files found matching 'pip/cacert.pem' 03:59:50 INFO - warning: no files found matching '*.html' under directory 'docs' 03:59:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:59:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:59:50 INFO - Installing collected packages: pip 03:59:50 INFO - Found existing installation: pip 1.1 03:59:50 INFO - Uninstalling pip: 03:59:50 INFO - Successfully uninstalled pip 03:59:50 INFO - Running setup.py install for pip 03:59:50 INFO - warning: no files found matching 'pip/cacert.pem' 03:59:50 INFO - warning: no files found matching '*.html' under directory 'docs' 03:59:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:59:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:59:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:59:50 INFO - Successfully installed pip 03:59:50 INFO - Cleaning up... 03:59:50 INFO - Return code: 0 03:59:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:59: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')]} 03:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59: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')]} 03:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59: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', '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 0x233b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab090>, '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 0x26abd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', '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 03:59: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:59: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 psutil>=3.1.1 03:59:50 INFO - Using env: {'DISPLAY': ':0', 03:59:50 INFO - 'HOME': '/home/cltbld', 03:59:50 INFO - 'LANG': 'en_US.UTF-8', 03:59:50 INFO - 'LANGUAGE': 'en_US:en', 03:59:50 INFO - 'LOGNAME': 'cltbld', 03:59:50 INFO - 'MAIL': '/var/mail/cltbld', 03:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:50 INFO - 'MOZ_NO_REMOTE': '1', 03:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:50 INFO - 'NO_EM_RESTART': '1', 03:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:50 INFO - 'PWD': '/builds/slave/test', 03:59:50 INFO - 'SHELL': '/bin/bash', 03:59:50 INFO - 'SHLVL': '1', 03:59:50 INFO - 'TERM': 'linux', 03:59:50 INFO - 'TMOUT': '86400', 03:59:50 INFO - 'USER': 'cltbld', 03:59:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 03:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:50 INFO - '_': '/tools/buildbot/bin/python'} 03:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:50 INFO - Downloading/unpacking psutil>=3.1.1 03:59:50 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 03:59:50 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 03:59:50 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 03:59:50 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 03:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:53 INFO - Installing collected packages: psutil 03:59:53 INFO - Running setup.py install for psutil 03:59:53 INFO - building 'psutil._psutil_linux' extension 03:59:53 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 03:59:55 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 03:59:55 INFO - building 'psutil._psutil_posix' extension 03:59:55 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 03:59:55 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 03:59:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:55 INFO - Successfully installed psutil 03:59:55 INFO - Cleaning up... 03:59:55 INFO - Return code: 0 03:59:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab090>, '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 0x26abd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', '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 03:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:59:55 INFO - Using env: {'DISPLAY': ':0', 03:59:55 INFO - 'HOME': '/home/cltbld', 03:59:55 INFO - 'LANG': 'en_US.UTF-8', 03:59:55 INFO - 'LANGUAGE': 'en_US:en', 03:59:55 INFO - 'LOGNAME': 'cltbld', 03:59:55 INFO - 'MAIL': '/var/mail/cltbld', 03:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:55 INFO - 'MOZ_NO_REMOTE': '1', 03:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:55 INFO - 'NO_EM_RESTART': '1', 03:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:55 INFO - 'PWD': '/builds/slave/test', 03:59:55 INFO - 'SHELL': '/bin/bash', 03:59:55 INFO - 'SHLVL': '1', 03:59:55 INFO - 'TERM': 'linux', 03:59:55 INFO - 'TMOUT': '86400', 03:59:55 INFO - 'USER': 'cltbld', 03:59:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 03:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:55 INFO - '_': '/tools/buildbot/bin/python'} 03:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:59:56 INFO - Installing collected packages: mozsystemmonitor 03:59:56 INFO - Running setup.py install for mozsystemmonitor 03:59:56 INFO - Successfully installed mozsystemmonitor 03:59:56 INFO - Cleaning up... 03:59:57 INFO - Return code: 0 03:59:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:59:57 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')]} 03:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:57 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')]} 03:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:57 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 0x233b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab090>, '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 0x26abd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', '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 03:59:57 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 03:59:57 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 03:59:57 INFO - Using env: {'DISPLAY': ':0', 03:59:57 INFO - 'HOME': '/home/cltbld', 03:59:57 INFO - 'LANG': 'en_US.UTF-8', 03:59:57 INFO - 'LANGUAGE': 'en_US:en', 03:59:57 INFO - 'LOGNAME': 'cltbld', 03:59:57 INFO - 'MAIL': '/var/mail/cltbld', 03:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:57 INFO - 'MOZ_NO_REMOTE': '1', 03:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:57 INFO - 'NO_EM_RESTART': '1', 03:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:57 INFO - 'PWD': '/builds/slave/test', 03:59:57 INFO - 'SHELL': '/bin/bash', 03:59:57 INFO - 'SHLVL': '1', 03:59:57 INFO - 'TERM': 'linux', 03:59:57 INFO - 'TMOUT': '86400', 03:59:57 INFO - 'USER': 'cltbld', 03:59:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 03:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:57 INFO - '_': '/tools/buildbot/bin/python'} 03:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:57 INFO - Downloading/unpacking jsonschema==2.5.1 03:59: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 03:59: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 03:59: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 03:59: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 03:59:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:59:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:59:58 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 03:59:58 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 03:59:58 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 03:59:58 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 03:59:58 INFO - Downloading functools32-3.2.3-2.tar.gz 03:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:59:58 INFO - warning: no files found matching '*.txt' 03:59:58 INFO - no previously-included directories found matching 'build' 03:59:58 INFO - no previously-included directories found matching 'dist' 03:59:58 INFO - no previously-included directories found matching '.git*' 03:59:58 INFO - Installing collected packages: jsonschema, functools32 03:59:58 INFO - Running setup.py install for functools32 03:59:58 INFO - warning: no files found matching '*.txt' 03:59:58 INFO - no previously-included directories found matching 'build' 03:59:58 INFO - no previously-included directories found matching 'dist' 03:59:58 INFO - no previously-included directories found matching '.git*' 03:59:58 INFO - Successfully installed jsonschema functools32 03:59:58 INFO - Cleaning up... 03:59:58 INFO - Return code: 0 03:59:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x233b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab090>, '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 0x26abd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', '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 03:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:59:58 INFO - Using env: {'DISPLAY': ':0', 03:59:58 INFO - 'HOME': '/home/cltbld', 03:59:58 INFO - 'LANG': 'en_US.UTF-8', 03:59:58 INFO - 'LANGUAGE': 'en_US:en', 03:59:58 INFO - 'LOGNAME': 'cltbld', 03:59:58 INFO - 'MAIL': '/var/mail/cltbld', 03:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:58 INFO - 'MOZ_NO_REMOTE': '1', 03:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:58 INFO - 'NO_EM_RESTART': '1', 03:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:58 INFO - 'PWD': '/builds/slave/test', 03:59:58 INFO - 'SHELL': '/bin/bash', 03:59:58 INFO - 'SHLVL': '1', 03:59:58 INFO - 'TERM': 'linux', 03:59:58 INFO - 'TMOUT': '86400', 03:59:58 INFO - 'USER': 'cltbld', 03:59:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 03:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:58 INFO - '_': '/tools/buildbot/bin/python'} 03:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:59:58 INFO - Cleaning up... 03:59:58 INFO - Return code: 0 03:59:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x233b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab090>, '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 0x26abd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', '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 03:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:59:58 INFO - Using env: {'DISPLAY': ':0', 03:59:58 INFO - 'HOME': '/home/cltbld', 03:59:58 INFO - 'LANG': 'en_US.UTF-8', 03:59:58 INFO - 'LANGUAGE': 'en_US:en', 03:59:58 INFO - 'LOGNAME': 'cltbld', 03:59:58 INFO - 'MAIL': '/var/mail/cltbld', 03:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:58 INFO - 'MOZ_NO_REMOTE': '1', 03:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:58 INFO - 'NO_EM_RESTART': '1', 03:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:58 INFO - 'PWD': '/builds/slave/test', 03:59:58 INFO - 'SHELL': '/bin/bash', 03:59:58 INFO - 'SHLVL': '1', 03:59:58 INFO - 'TERM': 'linux', 03:59:58 INFO - 'TMOUT': '86400', 03:59:58 INFO - 'USER': 'cltbld', 03:59:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 03:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:58 INFO - '_': '/tools/buildbot/bin/python'} 03:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:59: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 03:59: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 03:59: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 03:59: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 04:00:00 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:00:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:00 INFO - Downloading docopt-0.6.1.tar.gz 04:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:00 INFO - Running setup.py install for blobuploader 04:00:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:00:00 INFO - Running setup.py install for requests 04:00:01 INFO - Running setup.py install for docopt 04:00:01 INFO - Successfully installed blobuploader requests docopt 04:00:01 INFO - Cleaning up... 04:00:01 INFO - Return code: 0 04:00:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:01 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 0x233b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab090>, '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 0x26abd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:00:01 INFO - Using env: {'DISPLAY': ':0', 04:00:01 INFO - 'HOME': '/home/cltbld', 04:00:01 INFO - 'LANG': 'en_US.UTF-8', 04:00:01 INFO - 'LANGUAGE': 'en_US:en', 04:00:01 INFO - 'LOGNAME': 'cltbld', 04:00:01 INFO - 'MAIL': '/var/mail/cltbld', 04:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:01 INFO - 'MOZ_NO_REMOTE': '1', 04:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:01 INFO - 'NO_EM_RESTART': '1', 04:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:01 INFO - 'PWD': '/builds/slave/test', 04:00:01 INFO - 'SHELL': '/bin/bash', 04:00:01 INFO - 'SHLVL': '1', 04:00:01 INFO - 'TERM': 'linux', 04:00:01 INFO - 'TMOUT': '86400', 04:00:01 INFO - 'USER': 'cltbld', 04:00:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 04:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:01 INFO - '_': '/tools/buildbot/bin/python'} 04:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:01 INFO - Running setup.py (path:/tmp/pip-D5zPiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:01 INFO - Running setup.py (path:/tmp/pip-ltLQR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:01 INFO - Running setup.py (path:/tmp/pip-iDUf3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:01 INFO - Running setup.py (path:/tmp/pip-imHRsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:01 INFO - Running setup.py (path:/tmp/pip-dsOCej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:02 INFO - Running setup.py (path:/tmp/pip-5nl2ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:02 INFO - Running setup.py (path:/tmp/pip-8DyWYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:02 INFO - Running setup.py (path:/tmp/pip-aBoTem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:02 INFO - Running setup.py (path:/tmp/pip-2NTKAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:02 INFO - Running setup.py (path:/tmp/pip-Ni9aBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:02 INFO - Running setup.py (path:/tmp/pip-ywTfNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:02 INFO - Running setup.py (path:/tmp/pip-cVmlWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:02 INFO - Running setup.py (path:/tmp/pip-Ke7MmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:02 INFO - Running setup.py (path:/tmp/pip-x3x6eG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:02 INFO - Running setup.py (path:/tmp/pip-rjyrzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:02 INFO - Running setup.py (path:/tmp/pip-muXaaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:02 INFO - Running setup.py (path:/tmp/pip-ZXSzlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:02 INFO - Running setup.py install for manifestparser 04:00:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:00:02 INFO - Running setup.py install for mozcrash 04:00:03 INFO - Running setup.py install for mozdebug 04:00:03 INFO - Running setup.py install for mozdevice 04:00:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:00:03 INFO - Running setup.py install for mozfile 04:00:03 INFO - Running setup.py install for mozhttpd 04:00:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:00:03 INFO - Running setup.py install for mozinfo 04:00:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:00:03 INFO - Running setup.py install for mozInstall 04:00:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:00:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:00:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:00:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:00:03 INFO - Running setup.py install for mozleak 04:00:03 INFO - Running setup.py install for mozlog 04:00:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:00:03 INFO - Running setup.py install for moznetwork 04:00:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:00:03 INFO - Running setup.py install for mozprocess 04:00:04 INFO - Running setup.py install for mozprofile 04:00:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:00:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:00:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:00:04 INFO - Running setup.py install for mozrunner 04:00:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:00:04 INFO - Running setup.py install for mozscreenshot 04:00:04 INFO - Running setup.py install for moztest 04:00:04 INFO - Running setup.py install for mozversion 04:00:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:00:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:00:04 INFO - Cleaning up... 04:00:04 INFO - Return code: 0 04:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:04 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 0x233b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab090>, '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 0x26abd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:00:04 INFO - Using env: {'DISPLAY': ':0', 04:00:04 INFO - 'HOME': '/home/cltbld', 04:00:04 INFO - 'LANG': 'en_US.UTF-8', 04:00:04 INFO - 'LANGUAGE': 'en_US:en', 04:00:04 INFO - 'LOGNAME': 'cltbld', 04:00:04 INFO - 'MAIL': '/var/mail/cltbld', 04:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:04 INFO - 'MOZ_NO_REMOTE': '1', 04:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:04 INFO - 'NO_EM_RESTART': '1', 04:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:04 INFO - 'PWD': '/builds/slave/test', 04:00:04 INFO - 'SHELL': '/bin/bash', 04:00:04 INFO - 'SHLVL': '1', 04:00:04 INFO - 'TERM': 'linux', 04:00:04 INFO - 'TMOUT': '86400', 04:00:04 INFO - 'USER': 'cltbld', 04:00:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 04:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:04 INFO - '_': '/tools/buildbot/bin/python'} 04:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:04 INFO - Running setup.py (path:/tmp/pip-k7EY2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:04 INFO - Running setup.py (path:/tmp/pip-SLGo9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00: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)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:05 INFO - Running setup.py (path:/tmp/pip-z_KSVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00: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)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:05 INFO - Running setup.py (path:/tmp/pip-xPwmlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00: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)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:05 INFO - Running setup.py (path:/tmp/pip-xhu9LC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00: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)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:05 INFO - Running setup.py (path:/tmp/pip-kNesRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00: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)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:05 INFO - Running setup.py (path:/tmp/pip-dK_Tga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00: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)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:05 INFO - Running setup.py (path:/tmp/pip-Onnjvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:05 INFO - Running setup.py (path:/tmp/pip-iU1tkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:05 INFO - Running setup.py (path:/tmp/pip-gEGOIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:05 INFO - Running setup.py (path:/tmp/pip-I3XG_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:05 INFO - Running setup.py (path:/tmp/pip-G27KpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:05 INFO - Running setup.py (path:/tmp/pip-Tq7LYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:05 INFO - Running setup.py (path:/tmp/pip-HmxBbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:05 INFO - Running setup.py (path:/tmp/pip-8bHxXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:05 INFO - Running setup.py (path:/tmp/pip-QdzPDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00: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)) 04:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:06 INFO - Running setup.py (path:/tmp/pip-FCed60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00: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)) 04:00: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)) 04:00: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)) 04:00: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)) 04:00: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)) 04:00: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)) 04:00: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)) 04:00:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:07 INFO - Downloading blessings-1.6.tar.gz 04:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:00:07 INFO - Installing collected packages: blessings 04:00:07 INFO - Running setup.py install for blessings 04:00:07 INFO - Successfully installed blessings 04:00:07 INFO - Cleaning up... 04:00:07 INFO - Return code: 0 04:00:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:07 INFO - Reading from file tmpfile_stdout 04:00:07 INFO - Current package versions: 04:00:07 INFO - argparse == 1.2.1 04:00:07 INFO - blessings == 1.6 04:00:07 INFO - blobuploader == 1.2.4 04:00:07 INFO - docopt == 0.6.1 04:00:07 INFO - functools32 == 3.2.3-2 04:00:07 INFO - jsonschema == 2.5.1 04:00:07 INFO - manifestparser == 1.1 04:00:07 INFO - mozInstall == 1.13 04:00:07 INFO - mozcrash == 1.0 04:00:07 INFO - mozdebug == 0.1 04:00:07 INFO - mozdevice == 0.51 04:00:07 INFO - mozfile == 1.2 04:00:07 INFO - mozhttpd == 0.7 04:00:07 INFO - mozinfo == 0.10 04:00:07 INFO - mozleak == 0.1 04:00:07 INFO - mozlog == 3.5 04:00:07 INFO - moznetwork == 0.27 04:00:07 INFO - mozprocess == 0.25 04:00:07 INFO - mozprofile == 0.28 04:00:07 INFO - mozrunner == 6.13 04:00:07 INFO - mozscreenshot == 0.1 04:00:07 INFO - mozsystemmonitor == 0.3 04:00:07 INFO - moztest == 0.8 04:00:07 INFO - mozversion == 1.4 04:00:07 INFO - psutil == 3.1.1 04:00:07 INFO - requests == 1.2.3 04:00:07 INFO - wsgiref == 0.1.2 04:00:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:07 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 0x233b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab090>, '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 0x26abd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:00:07 INFO - Using env: {'DISPLAY': ':0', 04:00:07 INFO - 'HOME': '/home/cltbld', 04:00:07 INFO - 'LANG': 'en_US.UTF-8', 04:00:07 INFO - 'LANGUAGE': 'en_US:en', 04:00:07 INFO - 'LOGNAME': 'cltbld', 04:00:07 INFO - 'MAIL': '/var/mail/cltbld', 04:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:07 INFO - 'MOZ_NO_REMOTE': '1', 04:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:07 INFO - 'NO_EM_RESTART': '1', 04:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:07 INFO - 'PWD': '/builds/slave/test', 04:00:07 INFO - 'SHELL': '/bin/bash', 04:00:07 INFO - 'SHLVL': '1', 04:00:07 INFO - 'TERM': 'linux', 04:00:07 INFO - 'TMOUT': '86400', 04:00:07 INFO - 'USER': 'cltbld', 04:00:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 04:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:07 INFO - '_': '/tools/buildbot/bin/python'} 04:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00: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)) 04:00: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)) 04:00: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)) 04:00: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)) 04:00: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)) 04:00: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)) 04:00: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)) 04:00: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)) 04:00: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)) 04:00:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:00: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)) 04:00: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)) 04:00:09 INFO - Installing collected packages: simplejson 04:00:09 INFO - Running setup.py install for simplejson 04:00:09 INFO - building 'simplejson._speedups' extension 04:00: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 04:00: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 04:00:10 INFO - Successfully installed simplejson 04:00:10 INFO - Cleaning up... 04:00:10 INFO - Return code: 0 04:00:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00: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 0x233b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab090>, '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 0x26abd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00: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 04:00: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 04:00:10 INFO - Using env: {'DISPLAY': ':0', 04:00:10 INFO - 'HOME': '/home/cltbld', 04:00:10 INFO - 'LANG': 'en_US.UTF-8', 04:00:10 INFO - 'LANGUAGE': 'en_US:en', 04:00:10 INFO - 'LOGNAME': 'cltbld', 04:00:10 INFO - 'MAIL': '/var/mail/cltbld', 04:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:10 INFO - 'MOZ_NO_REMOTE': '1', 04:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:10 INFO - 'NO_EM_RESTART': '1', 04:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:10 INFO - 'PWD': '/builds/slave/test', 04:00:10 INFO - 'SHELL': '/bin/bash', 04:00:10 INFO - 'SHLVL': '1', 04:00:10 INFO - 'TERM': 'linux', 04:00:10 INFO - 'TMOUT': '86400', 04:00:10 INFO - 'USER': 'cltbld', 04:00:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 04:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:10 INFO - '_': '/tools/buildbot/bin/python'} 04:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:00:10 INFO - Cleaning up... 04:00:10 INFO - Return code: 0 04:00:10 INFO - Running post-action listener: _resource_record_post_action 04:00:10 INFO - Running post-action listener: _start_resource_monitoring 04:00:10 INFO - Starting resource monitoring. 04:00:10 INFO - [mozharness: 2017-09-17 11:00:10.594849Z] Finished create-virtualenv step (success) 04:00:10 INFO - [mozharness: 2017-09-17 11:00:10.595846Z] Running install step. 04:00:10 INFO - Running pre-action listener: _resource_record_pre_action 04:00:10 INFO - Running main action method: install 04:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:10 INFO - Reading from file tmpfile_stdout 04:00:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:00:10 INFO - Reading from file tmpfile_stdout 04:00:10 INFO - Output received: 04:00:10 INFO - Usage: mozinstall [options] installer 04:00:10 INFO - Options: 04:00:10 INFO - -h, --help show this help message and exit 04:00:10 INFO - -d DEST, --destination=DEST 04:00:10 INFO - Directory to install application into. [default: 04:00:10 INFO - "/builds/slave/test"] 04:00:10 INFO - --app=APP Application being installed. [default: firefox] 04:00:10 INFO - mkdir: /builds/slave/test/build/application 04:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:00:28 INFO - Reading from file tmpfile_stdout 04:00:28 INFO - Output received: 04:00:28 INFO - /builds/slave/test/build/application/firefox/firefox 04:00:28 INFO - Running post-action listener: _resource_record_post_action 04:00:28 INFO - [mozharness: 2017-09-17 11:00:28.546988Z] Finished install step (success) 04:00:28 INFO - [mozharness: 2017-09-17 11:00:28.547241Z] Running setup-mitmproxy step. 04:00:28 INFO - Running pre-action listener: _resource_record_pre_action 04:00:28 INFO - Running main action method: setup_mitmproxy 04:00:28 INFO - Skipping: mitmproxy is not required 04:00:28 INFO - Running post-action listener: _resource_record_post_action 04:00:28 INFO - [mozharness: 2017-09-17 11:00:28.548368Z] Finished setup-mitmproxy step (success) 04:00:28 INFO - [mozharness: 2017-09-17 11:00:28.548588Z] Running run-tests step. 04:00:28 INFO - Running pre-action listener: _resource_record_pre_action 04:00:28 INFO - Running pre-action listener: _set_gcov_prefix 04:00:28 INFO - Running main action method: run_tests 04:00:28 WARNING - Try message not found. 04:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:00:28 INFO - Python 2.7.3 04:00:28 INFO - Return code: 0 04:00:28 INFO - grabbing minidump binary from tooltool 04:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:28 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 0x26ab090>, '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 0x26abd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a5f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:00:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:00:28 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:00:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:00:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:29 INFO - Return code: 0 04:00:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:00:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:00:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:00:29 INFO - ENV: RUST_BACKTRACE is now full 04:00:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:00:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:00: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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 04:00: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-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 04:00:29 INFO - Using env: {'DISPLAY': ':0', 04:00:29 INFO - 'HOME': '/home/cltbld', 04:00:29 INFO - 'LANG': 'en_US.UTF-8', 04:00:29 INFO - 'LANGUAGE': 'en_US:en', 04:00:29 INFO - 'LOGNAME': 'cltbld', 04:00:29 INFO - 'MAIL': '/var/mail/cltbld', 04:00:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:00:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:29 INFO - 'MOZ_NO_REMOTE': '1', 04:00:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:29 INFO - 'NO_EM_RESTART': '1', 04:00:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:29 INFO - 'PWD': '/builds/slave/test', 04:00:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:00:29 INFO - 'RUST_BACKTRACE': 'full', 04:00:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:00:29 INFO - 'SHELL': '/bin/bash', 04:00:29 INFO - 'SHLVL': '1', 04:00:29 INFO - 'TERM': 'linux', 04:00:29 INFO - 'TMOUT': '86400', 04:00:29 INFO - 'USER': 'cltbld', 04:00:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 04:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:29 INFO - '_': '/tools/buildbot/bin/python'} 04:00:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 04:00:29 INFO - mozversion application_buildid: 20170917094019 04:00:29 INFO - mozversion application_changeset: faa897d7948b7e2439573f39c34366c138913663 04:00:29 INFO - mozversion application_display_name: Nightly 04:00:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:29 INFO - mozversion application_name: Firefox 04:00:29 INFO - mozversion application_remotingname: firefox 04:00:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:00:29 INFO - mozversion application_vendor: Mozilla 04:00:29 INFO - mozversion application_version: 57.0a1 04:00:29 INFO - mozversion platform_buildid: 20170917094019 04:00:29 INFO - mozversion platform_changeset: faa897d7948b7e2439573f39c34366c138913663 04:00:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:00:29 INFO - mozversion platform_version: 57.0a1 04:00:29 INFO - using testdate: 1505646029 04:00:29 INFO - actual date: 1505646029 04:00:29 INFO - starting webserver on 'localhost:42849' 04:00:29 INFO - SUITE-START | Running 2 tests 04:00:29 INFO - TEST-START | dromaeo_css 04:00:29 INFO - Initialising browser for dromaeo_css test... 04:00:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42849/getInfo.html -profile /tmp/tmp0Rri4S/profile 04:00:29 INFO - TEST-INFO | started process 3542 (/builds/slave/test/build/application/firefox/firefox http://localhost:42849/getInfo.html) 04:00:37 INFO - TEST-INFO | 3542: exit 0 04:00:37 INFO - Browser initialized. 04:00:37 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:37 INFO - Using env: {'DISPLAY': ':0', 04:00:37 INFO - 'HOME': '/home/cltbld', 04:00:37 INFO - 'JSGC_DISABLE_POISONING': '1', 04:00:37 INFO - 'LANG': 'en_US.UTF-8', 04:00:37 INFO - 'LANGUAGE': 'en_US:en', 04:00:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:00:37 INFO - 'LOGNAME': 'cltbld', 04:00:37 INFO - 'MAIL': '/var/mail/cltbld', 04:00:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:00:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:00:37 INFO - 'MOZ_CRASHREPORTER': '1', 04:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:00:37 INFO - 'MOZ_NO_REMOTE': '1', 04:00:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:37 INFO - 'NO_EM_RESTART': '1', 04:00:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:37 INFO - 'PWD': '/builds/slave/test', 04:00:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:00:37 INFO - 'RUST_BACKTRACE': 'full', 04:00:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:00:37 INFO - 'SHELL': '/bin/bash', 04:00:37 INFO - 'SHLVL': '1', 04:00:37 INFO - 'STYLO_FORCE_DISABLED': '1', 04:00:37 INFO - 'TERM': 'linux', 04:00:37 INFO - 'TMOUT': '86400', 04:00:37 INFO - 'USER': 'cltbld', 04:00:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 04:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:37 INFO - '_': '/tools/buildbot/bin/python'} 04:00:37 INFO - TEST-INFO | started process 3790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Rri4S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:38 INFO - PID 3790 | 04:00:38 INFO - PID 3790 | (/builds/slave/test/build/application/firefox/firefox:3839): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:00:38 INFO - PID 3790 | 04:00:48 INFO - PID 3790 | RSS: Main: 148926464 04:00:48 INFO - PID 3790 | 04:03:46 INFO - PID 3790 | Cycle 1(1): loaded http://localhost:42849/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42849/tests/dromaeo/cssquery-ext.html) 04:03:47 INFO - PID 3790 | RSS: Main: 148885504 04:03:47 INFO - PID 3790 | 04:06:49 INFO - PID 3790 | Cycle 1(1): loaded http://localhost:42849/tests/dromaeo/cssquery-ext.html (next: http://localhost:42849/tests/dromaeo/cssquery-jquery.html) 04:06:49 INFO - PID 3790 | RSS: Main: 149467136 04:06:49 INFO - PID 3790 | 04:09:51 INFO - PID 3790 | Cycle 1(1): loaded http://localhost:42849/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42849/tests/dromaeo/cssquery-mootools.html) 04:09:51 INFO - PID 3790 | RSS: Main: 151695360 04:09:51 INFO - PID 3790 | 04:12:53 INFO - PID 3790 | Cycle 1(1): loaded http://localhost:42849/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42849/tests/dromaeo/cssquery-prototype.html) 04:12:53 INFO - PID 3790 | RSS: Main: 150118400 04:12:53 INFO - PID 3790 | 04:15:56 INFO - PID 3790 | Cycle 1(1): loaded http://localhost:42849/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42849/tests/dromaeo/cssquery-yui.html) 04:15:57 INFO - PID 3790 | RSS: Main: 151015424 04:15:57 INFO - PID 3790 | 04:18:58 INFO - PID 3790 | Cycle 1(1): loaded http://localhost:42849/tests/dromaeo/cssquery-yui.html (next: http://localhost:42849/tests/dromaeo/cssquery-dojo.html) 04:18:59 INFO - PID 3790 | RSS: Main: 153604096 04:18:59 INFO - PID 3790 | 04:18:59 INFO - PID 3790 | __start_tp_report 04:18:59 INFO - PID 3790 | _x_x_mozilla_page_load 04:18:59 INFO - PID 3790 | _x_x_mozilla_page_load_details 04:18:59 INFO - PID 3790 | |i|pagename|runs| 04:18:59 INFO - PID 3790 | |0;dojo.html;3855.961440385597;3884.223155368926;3944.8816535503943;3948.170884114336;3951.091249012729;6261.248650161987;6347.36526347365;6383.840403989891;6414.134091897592;6418.903716444252;6370.968145159268;6420.422162005419;6433.517486188532;6434.646094464802;6456.128422662939;5699.487046165844;5704.372519022904;5746.051901436268;5762.6254293471;5791.276090488689;5795.15970184323;5797.5651826113;5832;5832.212651292085;5851.79518716845;5730.914036289459;5758.395368486312;5833.4749872511675;5834.883302333951;5842.0652695568715;5557.6109672322955;5640.661560306354;5670.291213598301;5754.338251101135;5779.797707080232;5665.433456654343;5689.886202275931;5751.166080918243;5777.768889244425;5785.6528608283215;6232.470240029603;6320.557560970734;6361.650109243989;6419.35806419359;6459.289478157399;6889.379955803952;6900.689468973908;6905.102336696197;6916.135483064617;6934.653267336613;6915.170179578433;7002.299770023008;7007.404370628503;7019.929800701979;7030.578165310098;6436.645984470852;6465.903011454879;6508.446782023534;6525.836854078639;6547.214334279917;7004.369606735317;7080.468964827659;7088.184858741311;7126;7155.534890232118;6821.658917054127;6877.518573699793;6877.828054298582;6890.483213758988;6902.965485172643;6872.450203983669;6935.965320173367;6961.164660240804;7018.578885266798;7028.683709233097;6738.427233685094;6796.830079248059;6801.557898736566;6856.314368563104;6926.099607051051;6862.862742745117;6862.862742745117;6866.965665171642;6874.243833178446;6925.6190909499455;4935.235038568956;5010.323606313101;5011.899762004739;5014.749262536859;5025.271335656309;4503.279475284005;4504.234280172379;4531.116432295737;4543.54564543543;4588.885277868013;6432.228132624022;6436.195475565554;6436.678166091677;6442;6443.838904027343;6785.1518560179975;6885.586864788129;6896.413804826646;6988;6995.26549712283;6324.146240257598;6327;6360.968195159087;6378.904316435257;6383.71273292703;5547.389787123413;5551;5564.721763911788;5576.079946808731;5610.4670056344585;7167.4266058715175;7252.492325537267;7263.854722905512;7264.455165862476;7268.600226987461;6785.084013658093;6851.760188393382;6874.415674667609;6922.411595014279;6946.5137440378685;7073.787786366417;7160.713571457291;7169.605671687898;7172.390346820579;7266.418686505172;6737.663116844236;6803.081583986099;6817.045613613999;6825.863482730417;6835.213950395768;6927.099477067949;7000.719971201095;7012.7545535906;7022.824429389306;7025.367716905503;6676.532642714963;6740.66296685154;6770.898436523357;6771.966140169267;6781.559198652072;6655.933440665725;6656.167979002625;6664.50016248793;6756.662166891734;6758.42553382968;6391.648459334595;6569.605823650596;6579.934200657932;6580.045893345534;6589.374009469093;6691.799246022627;6702.095217145623;6730.629815360006;6743.52795304324;6781.321867813179;6488.967555162194;6493.837654058498;6573.276939536551;6577.638229897401;6579.046038324321 04:18:59 INFO - PID 3790 | |1;ext.html;885.2128104768234;923.252165745746;941.4398432932405;988.940663560186;992.846108853128;42243.78878105609;43016.56983430165;43065;43087.99999999992;43101;40434;40886.59113408865;40986.38520422196;40992;41021.17957640845;7236.782896513113;7424.25757424256;7426.331630153285;7426.405887528985;7428.628568571577;7118.110236220473;7124.608146551937;7174.282571742836;7174.8565028699395;7175.354218120368;7102.218755936843;7819.843603127934;7952.801179970489;7956;7975.242351976582;7877.330426913691;7940.722074727357;7942.324902383276;7942.960285198595;7948.284654381076;7865.370770338359;7959.562224077674;7997.320227780646;8035.196480351977;8039.35685145187;40127;40383;40476.39285410721;40507.18985620271;40510.59489405098;3668.1746607013474;3715.238376132886;3719.4606782016726;3721.813909304551;3728.142527218755;32770;32783.18042048944;32911.835440822884;32989.6701032989;33097.17257068568;5372;5372.946270537323;5408.702521361323;5418.620696551243;5440.510354068153;212556;213511;215488;216720;259896.9999999981;54070.45929540733;54675.72662136664;54681.45318546764;54768;54782.726086369315;57998.7100064497;58063.70968145132;58156.12765808516;58419.70790146022;58448;16354.264058117174;16437.09595972209;16463.259153338127;16555.6688866222;16954.660906781795;13691.863081369058;13778.586642400744;13796.448142074205;13821.516246931309;13833.861661383458;15736.449224277096;15804.209789510478;15895.364185432685;15919.68160636804;15924.840751592568;6141.815745527641;6179.227596550431;6221.564490485713;6242.812715618538;6387.169667943138;1067.6690226029955;1088.7768007558432;1092.9726756831142;1094.0536435982976;1098.5441041967495;25116.623250651253;25165.62251566228;25276.368090797878;25307.746922530907;25415;1190.773752986947;1199.7600479904054;1207.0283421845322;1207.1670547322494;1211.4790640024698;13331.466741330238;13503.932480337535;13529.932350338382;13614.183149010893;13823.861761382459;280059;281265;281825;282024;282328;57366;57707;57714;57848.42151578431;58017.709911450176;1500.5498350494809;1512.138081293652;1543.7529995200714;1547.752359622455;1551.8448155184617;24701.143515999367;24814.751852481244;24880.751192488566;24917.01991522058;25029.87485062563;40017.79991100026;40289.59710402976;40370.587029453825;40393;40416.79791601023;233607;234729;234791;234985;235333;33547.664523354455;34639.13402164966;37928;41262.79368603138;41837.79081104575;51377.229341560655;51829.7408512955;52131.218031730314;52242.47757522376;52436.73781631068;37506.437403439515;38007.619923800405;38149.427758583086;38229;38326.80836595799;37929;38024.80987595155;38202.617973819906;38423.615763842005;38617.22765544617;44268.55731442644;45276.547234527236;45801.54198457973;45813.77093114513;45869.77065114653;36366.09084772902;36419;37099.62900370962;37550.43674344832;37827.810860945516;27455.588166177124;28001.859990699915;28044.57933130964;28156.43687126287;28518.57222141628 04:18:59 INFO - PID 3790 | |2;jquery.html;567.3702190568468;575.2177039226649;595.5206059122407;602.82819396472;603.381533927724;22936.541269174628;24031.399215019588;24040.87979560102;24066.037358505662;24150.637740433864;23848.165314214006;24955;25362.74637253627;25611.487770244585;25666.358341041483;6560.835979100513;6718.6304753238555;6762.661866906659;6763.830904227384;6767.627780472072;6412.134361861159;6558.475321974231;6635.966820165892;6677.031830384592;6722.294159113296;6571.9014214786575;6581.440577550914;6583.572067815577;6587.275399706028;6593.175853018372;6564.507661925375;6586.341365863424;6589;6625.768098116543;6640.93359066408;6002.96998515009;6239.65681887496;6251.656158911258;6252.843678908018;6255.968720156416;30008.399832003455;30264.8486757567;30291.242718932204;30448.391032179232;30471.69528304711;2252.560750653623;2296.081567373064;2296.1159953417887;2296.2651951375565;2296.81625469962;19815.801841981538;20248.797512024837;20356;20561.794382056287;20654.5869082619;2464.913728019511;2482.91309804156;2531.3671582104475;2550.7194208637034;2565.1278565287894;135339;140004;152337;159763;165855.3414465852;15616.687666246611;15793.526194214191;16162.919185403998;16335.918320408322;16391;25311.493770124493;25398.492030159294;25422.745772542406;25437.10970116037;25438.364040898756;10339.896601034045;10672.413017284123;10841.241113122163;10845.83731244032;10886.237963342648;9645.807083858284;9822.459764712867;9868.555914983843;9871.901280987098;9982.301238913351;9295.209907157832;9487.952560237154;9562.474063926411;9687.564059617334;9700.295356751969;2882.769378449719;2935.406089469973;2963.8962636307624;2980.1506570627703;2985.1790757541416;1010.1767059846202;1029.799189158107;1047.486382177761;1054.7943151085465;1056.963006294776;20370.79629203689;20600;20741.170353186004;20937.79062209389;21116.366509004754;1103.4923934989833;1112.6259070048484;1131.0725205331548;1133.4729350851894;1140.811766058591;11321.603743868925;11454.828177577343;11518.827217591743;11579.710507237387;11598.536058557564;538080;557944;558009;570750;574993;124256;125925;126831;127365;131447;1212.054597414001;1217.592106644284;1225.3689349984766;1246.9127161098636;1254.191046774825;17921.28314867391;18261.90869045646;18393.72409413833;18462.076896155406;18639.534011649816;60007.39992600018;60320;60728.69635651793;64926.67536662475;65729.67135164293;71970.64014679893;72754;76505.61747191228;77140.61429692815;78179.60910195412;14733.55799326022;15007.624809379853;15043.623909402353;15051.548453546411;15077.773833392288;22996.19513317026;23111;23190.3042908713;23398.298051058497;23493.765062349157;18590.628187436447;18897.527561810515;18932.337368192046;19137.90431047836;19230.519237018627;16303.26635301438;16326.428575000293;16958.57603559921;17073.14634268257;17321;18898;19058.237670493025;19156.71264931055;19297.614047718685;19331.806681933;14729.116253024853;14731;14899.180545069692;14944.92527537399;14960.700785984436;18331.633367332845;18352.908235458737;18593.070346482353;18644.254229830654;18669.43991680252 04:18:59 INFO - PID 3790 | |3;mootools.html;1433.3263366217877;1492.3135357735448;1502.7595584706448;1505.8193016837981;1517.2944580769943;16971.321147154114;17645.91177044113;17775.20011599478;17776.11119444029;17826.376076837314;17303.826961730378;17407.564810879736;17440.912795436005;17459.388921387756;17467.82532174678;2781.56885682719;2798.398344355963;2855.657321121468;2857.185702074909;2858.0139851751114;2726.5910113482937;2773.972260277402;2774.6392968914015;2788.0241915329575;2793.916182514528;2812.9578056329174;2843.4881721290158;2845.3597940463437;2846.672632647241;2852.74325310722;2670.332416895776;2698.271466703979;2699.6085567592686;2702.8243164194364;2710.4172602890276;2669.065826960568;2676.5048466033845;2678.9953767337247;2685.892564297426;2689.610006549059;16923.746143807854;17011;17154.485365438934;17159.742603860952;17177.65644687112;8141.715039973632;8383.916160838375;8393.832123357499;8413.789655258606;8426.115257897955;5156.355455568054;5256.421793602701;5407.972960135214;5419.810306639249;5425.186222066682;2048.5595596946578;2107.7786832382685;2130.893455327243;2181.3674034530127;2191.660292654625;29487.262818429495;29756;29773.553396699066;29868.40263194724;29904.102876913727;7061.71753129869;7071.434285257167;7111.168263357503;7201.89197162043;7226.494145409876;19042.33351832679;19472;19573.1192096356;19635.21459141647;19667.803321966596;8096;8326.25063744266;8327.458715183493;8329.916700833035;8336.458130221516;7516.135644400964;7593.202713715091;7616.771496855104;7710.575918324434;7737.92262077372;5278.630495865329;5506.669599824023;5511.448855114537;5547.057000309957;5562.749676264578;1588.8728901687837;1591.0692245036553;1601.9679606407806;1602.9919850400906;1625.7561365795225;966.5408930757974;976.2775546095838;981.9263555233387;1005.2109094361037;1011.691434112588;8539.103394143649;8793.648254069765;9320.766980825398;9658.661946831828;9763.316567840326;753.9283768042137;793.4723408933111;797.44577518624;804.6419343392134;804.7867315161487;4945.9258111128365;5117.948820511747;5701.888131814257;5704.657720536698;5863.208466857005;24672.629910551357;25073;25110.497790044097;25525.106621268165;25906.35234119162;24016.07871370286;25141.748582514305;25249.495010099694;25418.110366137098;25432.364190895005;11819.88180118205;12266.26402415858;12418.627441176779;12425.130240883233;12459.813102803466;9356.204722598655;9366;9406.153446189875;9412.435253884789;9455.527223638928;21023.369298921058;21255;21388.251411200534;21625.783742163007;21933.561328773656;22588.322350329516;22630;22714.318570442912;22967.540649186587;23002.884985574965;12142.150049496451;12374.938125309316;12473.750524989631;12487.750244995232;12498;15050.397984080515;15479.148646824533;15482.380704771684;15661;15668.13825239577;12091.81862272049;12384.442700078338;12467.688307792378;12604.180728252633;12613.87386126127;11546.76906461883;11737.647870563897;11762.70593235176;12010.879891200977;12154.635360939186;10576.15390768752;10848.67453976382;10870.347779133277;10874.23880328401;10884.40135792539;8076.798080048045;8096.149904260204;8150.3072238857985;8293;8337;8030.638621262174;8035.397345199251;8225.341972642054;8240.752777416687;8249.587520623825 04:18:59 INFO - PID 3790 | |4;prototype.html;539.2881396556545;560.8485708858606;570.3896830391482;577.7544543568982;585.3444142560331;6293.622382657044;6302.621842689442;6318.494520438366;6340.904886426707;6350.14273073135;6190.257169139698;6212;6227.9688601557045;6231.40801623845;6237;5131.666441681297;5132;5146.433892271847;5153.536181743642;5169.612279079065;4872.4640289568115;4955.677880937727;5127.256547800566;5133.743312834362;5136.383633963929;4932.161532539477;4938.234573641092;4960.677555958851;4981.5018498150075;4995.975020124894;4957.677750946213;4984.501549845005;5010.348654674905;5021.748912554376;5025.447200807908;4470.485894122153;4507.076049409863;4514.255147900592;4527.162474942146;4532.88667783308;6093.786717464867;6206.875862482771;6222.790909227249;6242.750289988395;6261.87476250477;5835.824925252249;5857.414258574151;5862.472377486004;5872.471477566996;5914.2902851657645;6546.378094081055;6547.705353259114;6563.3108523604815;6575.309592492815;6627;5008.574271186953;5035.571976382012;5039.244113382985;5048.924266136011;5057.519535644108;6703.765368212138;6764.4926630502905;6819.454443644497;6868.347506986778;6875.449964002868;5138.691678499302;5142.202958541432;5147.176451767699;5158.277841102249;5187.844364669066;5186.2479940409185;5204.5576126028955;5224.92162617561;5251.737413129328;5253.50091741284;5756.395578464285;5777.88444231113;5828.970855145782;5841.41585841421;5855.795047173414;6623.172103487064;6627.469802415795;6651.16860392451;6691.197056353269;6695.698693558801;1790.9015004174896;1805.4132406967788;1817.9818201817814;1827.470033690215;1830.2130084063715;1244.0793812578806;1250.1061740855332;1292.4313302147025;1303.0487743946971;1310.2989900403238;6060.121282414113;6060.181875446759;6104.664243466652;6159.538034647419;6166.36591303305;6515.250746164252;6625.271220165778;6634.203895532567;6650.86698266032;6665.867162359368;5994.250718660168;6000.279966404059;6111.877762444727;6115.266168059772;6142.662153581507;3484.581850177995;3528.647135286451;3544.3088597723713;3548.6628770266784;3550.946735798965;6909.619970901648;6981.581105133607;6984.825379365455;6987.371136597731;7021.684024218923;6612.206535215805;6802.14973128359;6887.7244910203035;6890.276520965327;6891.793246202622;6783.592984420852;6803.965980170067;6861.113193871725;6875;6969.54697944632;6674.132362792806;6688.4983626229205;6694.464442844658;6732.192136943598;6743.831404214934;6669.2997235289595;6693.99180245934;6696.899546506709;6708.563943343667;6728.7308507659145;6965.33829286217;7009.2990700929495;7034.366906978396;7058.505904586629;7071.3229120857895;5089.872753181052;5097.362829646294;5108.182690769459;5129.563987061141;5135.589152867687;6597;6622.569532980341;6654.301298363602;6668.633225172468;6758.966205169139;6261.186045814015;6474.741010359533;6486.772962946275;6492.220933488012;6539.247986481425;6455.806325810233;6471.320511346241;6477.643729594729;6490.415862572391;6579.111819904251;6379.330170332234;6390.329015453496;6448.613083215022;6454.354564543508;6480.935190648033;6563.278039415565;6604.952464735948;6605.2734199239;6627.701753421204;6693.531452798452;6397.3282805306635;6408.871822563616;6415.486761059197;6453.225612926479;6521.380468855451 04:18:59 INFO - PID 3790 | |5;yui.html;940.8682784410188;964.9083337082977;970.5292932927529;973.420814615304;987.8419452887537;18389.724154137682;19265.133069011892;19268.13293401797;19275.13261903214;19340.419787406365;17927;18397.54006149847;18495.35266265681;18576.628467430644;18727.625447491042;1019.2050200843336;1040.1003132290552;1040.7086015915556;1040.8230600797883;1042.395410661818;1019.9133073688745;1030.2015937648346;1031.056583226347;1034.7257976636197;1040.6201736366247;1134.4554613785388;1140.1050175612147;1141.9029382502497;1144.5078616195033;1145.1068166829887;1122.6463663945872;1125.06057442036;1129.6441620889393;1130.4347826086957;1130.5534313946027;829.2826704900218;831.575896292895;835.778518692547;835.8871552340418;836.8953880764905;20325.390238292875;20400.897995510077;20459.795402045936;20498.487537811674;20980.265690700904;23142.190023349103;23583.76416235833;23632.527349452914;23659.645105323434;23780.048798048058;18482.2607095716;18547.16537755804;18887.96116213608;18955.905220473946;18973.525661858424;3961.1285517186175;3970.344893092636;3987.900302492461;3988.6011398860173;3989.6608788253034;139001;148928;151050;154281.22859385744;154769;17904.55238619045;18574.814251857308;18687.345942891934;18806.717899231524;18813.717794233096;34117.48823767646;34420.31159376798;35304.823475882455;35425.82287088548;35641.8217908914;10010.54952527138;10014.599416023424;10015.499225038719;10060.597576096874;10086.697399078039;4543.5910768031035;4664.626829853603;4732.384789977281;4762.738049407247;4774.092922344813;5886.352501224862;5941.673207973517;5947.256592925884;5972.552058595623;5992.760289588455;1180.0622321376031;1199.9760004799855;1224.1614494071412;1225.9754804903853;1233.0320698251828;655.1483072006373;687.5221720903924;690.5062880040795;701.2006312803409;704.0811740678362;12703.491860325668;13253.536126235536;13695.726085478434;14244.857551424353;14265.57203283903;673.3535805626653;674.6896427643339;685.8045457044718;704.306258335539;706.9611171385624;6204.286507051656;6279.811605651837;6359.459445947146;6366.427021567988;6384.840378990562;144982.275088626;145118.27440862727;145337.27331363276;146721;146746;123855;124641;125590;129276;129598;105162;106102;107461.92538074676;108797;110796;12004.2197257178;12031.71644580428;12176.147669663038;12222.877771222174;12333.321667308384;54774;54776;55000;55342.72328638331;57058.42941570531;66621;67278.66360668166;68158;68657;69738;16527.256273467483;16645.25096370642;16715.83284167143;16839.66320673604;16855.157242138088;17111.14444277806;17164.39924602633;17294.827051729826;17373.391931282345;17406.651866962842;15242.77135842941;15285.541433757006;15315.846841531442;15346.23268836576;15370.615734606725;15254.237288135771;15320.310586023434;15385.84614153844;15490.148041857807;15524.767128492857;16177.029378236874;16261;16272.186390680656;16389.42637007699;16458.75311870299;10213.948930255301;10323.380597164194;10381.9480902595;10446.68659940203;10745.570177192825;10228.130608898327;10277.229207809294;10307.175425965755;10341.121004714683;10418.73953151147 04:18:59 INFO - PID 3790 | __end_tp_report 04:18:59 INFO - PID 3790 | __start_cc_report 04:18:59 INFO - PID 3790 | _x_x_mozilla_cycle_collect,275 04:18:59 INFO - PID 3790 | __end_cc_report 04:18:59 INFO - PID 3790 | __startTimestamp1505647139196__endTimestamp 04:18:59 INFO - PID 3790 | 04:18:59 INFO - PID 3790 | ------- Summary: start ------- 04:18:59 INFO - PID 3790 | Number of tests: 6 04:18:59 INFO - PID 3790 | 04:18:59 INFO - PID 3790 | [#0] dojo.html Cycles:165 Average:6364.55 Median:6579.93 stddev:763.99 (11.6%) stddev-sans-first:740.55 04:18:59 INFO - PID 3790 | Values: 3856.0 3884.2 3944.9 3948.2 3951.1 6261.2 6347.4 6383.8 6414.1 6418.9 6371.0 6420.4 6433.5 6434.6 6456.1 5699.5 5704.4 5746.1 5762.6 5791.3 5795.2 5797.6 5832.0 5832.2 5851.8 5730.9 5758.4 5833.5 5834.9 5842.1 5557.6 5640.7 5670.3 5754.3 5779.8 5665.4 5689.9 5751.2 5777.8 5785.7 6232.5 6320.6 6361.7 6419.4 6459.3 6889.4 6900.7 6905.1 6916.1 6934.7 6915.2 7002.3 7007.4 7019.9 7030.6 6436.6 6465.9 6508.4 6525.8 6547.2 7004.4 7080.5 7088.2 7126.0 7155.5 6821.7 6877.5 6877.8 6890.5 6903.0 6872.5 6936.0 6961.2 7018.6 7028.7 6738.4 6796.8 6801.6 6856.3 6926.1 6862.9 6862.9 6867.0 6874.2 6925.6 4935.2 5010.3 5011.9 5014.7 5025.3 4503.3 4504.2 4531.1 4543.5 4588.9 6432.2 6436.2 6436.7 6442.0 6443.8 6785.2 6885.6 6896.4 6988.0 6995.3 6324.1 6327.0 6361.0 6378.9 6383.7 5547.4 5551.0 5564.7 5576.1 5610.5 7167.4 7252.5 7263.9 7264.5 7268.6 6785.1 6851.8 6874.4 6922.4 6946.5 7073.8 7160.7 7169.6 7172.4 7266.4 6737.7 6803.1 6817.0 6825.9 6835.2 6927.1 7000.7 7012.8 7022.8 7025.4 6676.5 6740.7 6770.9 6772.0 6781.6 6655.9 6656.2 6664.5 6756.7 6758.4 6391.6 6569.6 6579.9 6580.0 6589.4 6691.8 6702.1 6730.6 6743.5 6781.3 6489.0 6493.8 6573.3 6577.6 6579.0 04:18:59 INFO - PID 3790 | 04:18:59 INFO - PID 3790 | [#1] ext.html Cycles:180 Average:43127.10 Median:38375.21 stddev:64529.98 (168.2%) stddev-sans-first:64633.05 04:18:59 INFO - PID 3790 | Values: 885.2 923.3 941.4 988.9 992.8 42243.8 43016.6 43065.0 43088.0 43101.0 40434.0 40886.6 40986.4 40992.0 41021.2 7236.8 7424.3 7426.3 7426.4 7428.6 7118.1 7124.6 7174.3 7174.9 7175.4 7102.2 7819.8 7952.8 7956.0 7975.2 7877.3 7940.7 7942.3 7943.0 7948.3 7865.4 7959.6 7997.3 8035.2 8039.4 40127.0 40383.0 40476.4 40507.2 40510.6 3668.2 3715.2 3719.5 3721.8 3728.1 32770.0 32783.2 32911.8 32989.7 33097.2 5372.0 5372.9 5408.7 5418.6 5440.5 212556.0 213511.0 215488.0 216720.0 259897.0 54070.5 54675.7 54681.5 54768.0 54782.7 57998.7 58063.7 58156.1 58419.7 58448.0 16354.3 16437.1 16463.3 16555.7 16954.7 13691.9 13778.6 13796.4 13821.5 13833.9 15736.4 15804.2 15895.4 15919.7 15924.8 6141.8 6179.2 6221.6 6242.8 6387.2 1067.7 1088.8 1093.0 1094.1 1098.5 25116.6 25165.6 25276.4 25307.7 25415.0 1190.8 1199.8 1207.0 1207.2 1211.5 13331.5 13503.9 13529.9 13614.2 13823.9 280059.0 281265.0 281825.0 282024.0 282328.0 57366.0 57707.0 57714.0 57848.4 58017.7 1500.5 1512.1 1543.8 1547.8 1551.8 24701.1 24814.8 24880.8 24917.0 25029.9 40017.8 40289.6 40370.6 40393.0 40416.8 233607.0 234729.0 234791.0 234985.0 235333.0 33547.7 34639.1 37928.0 41262.8 41837.8 51377.2 51829.7 52131.2 52242.5 52436.7 37506.4 38007.6 38149.4 38229.0 38326.8 37929.0 38024.8 38202.6 38423.6 38617.2 44268.6 45276.5 45801.5 45813.8 45869.8 36366.1 36419.0 37099.6 37550.4 37827.8 27455.6 28001.9 28044.6 28156.4 28518.6 04:18:59 INFO - PID 3790 | 04:18:59 INFO - PID 3790 | [#2] jquery.html Cycles:180 Average:38002.06 Median:12646.51 stddev:94176.02 (744.7%) stddev-sans-first:94398.26 04:18:59 INFO - PID 3790 | Values: 567.4 575.2 595.5 602.8 603.4 22936.5 24031.4 24040.9 24066.0 24150.6 23848.2 24955.0 25362.7 25611.5 25666.4 6560.8 6718.6 6762.7 6763.8 6767.6 6412.1 6558.5 6636.0 6677.0 6722.3 6571.9 6581.4 6583.6 6587.3 6593.2 6564.5 6586.3 6589.0 6625.8 6640.9 6003.0 6239.7 6251.7 6252.8 6256.0 30008.4 30264.8 30291.2 30448.4 30471.7 2252.6 2296.1 2296.1 2296.3 2296.8 19815.8 20248.8 20356.0 20561.8 20654.6 2464.9 2482.9 2531.4 2550.7 2565.1 135339.0 140004.0 152337.0 159763.0 165855.3 15616.7 15793.5 16162.9 16335.9 16391.0 25311.5 25398.5 25422.7 25437.1 25438.4 10339.9 10672.4 10841.2 10845.8 10886.2 9645.8 9822.5 9868.6 9871.9 9982.3 9295.2 9488.0 9562.5 9687.6 9700.3 2882.8 2935.4 2963.9 2980.2 2985.2 1010.2 1029.8 1047.5 1054.8 1057.0 20370.8 20600.0 20741.2 20937.8 21116.4 1103.5 1112.6 1131.1 1133.5 1140.8 11321.6 11454.8 11518.8 11579.7 11598.5 538080.0 557944.0 558009.0 570750.0 574993.0 124256.0 125925.0 126831.0 127365.0 131447.0 1212.1 1217.6 1225.4 1246.9 1254.2 17921.3 18261.9 18393.7 18462.1 18639.5 60007.4 60320.0 60728.7 64926.7 65729.7 71970.6 72754.0 76505.6 77140.6 78179.6 14733.6 15007.6 15043.6 15051.5 15077.8 22996.2 23111.0 23190.3 23398.3 23493.8 18590.6 18897.5 18932.3 19137.9 19230.5 16303.3 16326.4 16958.6 17073.1 17321.0 18898.0 19058.2 19156.7 19297.6 19331.8 14729.1 14731.0 14899.2 14944.9 14960.7 18331.6 18352.9 18593.1 18644.3 18669.4 04:18:59 INFO - PID 3790 | 04:18:59 INFO - PID 3790 | [#3] mootools.html Cycles:180 Average:10404.64 Median:2682.44 stddev:7777.90 (290.0%) stddev-sans-first:7770.51 04:18:59 INFO - PID 3790 | Values: 1433.3 1492.3 1502.8 1505.8 1517.3 16971.3 17645.9 17775.2 17776.1 17826.4 17303.8 17407.6 17440.9 17459.4 17467.8 2781.6 2798.4 2855.7 2857.2 2858.0 2726.6 2774.0 2774.6 2788.0 2793.9 2813.0 2843.5 2845.4 2846.7 2852.7 2670.3 2698.3 2699.6 2702.8 2710.4 2669.1 2676.5 2679.0 2685.9 2689.6 16923.7 17011.0 17154.5 17159.7 17177.7 8141.7 8383.9 8393.8 8413.8 8426.1 5156.4 5256.4 5408.0 5419.8 5425.2 2048.6 2107.8 2130.9 2181.4 2191.7 29487.3 29756.0 29773.6 29868.4 29904.1 7061.7 7071.4 7111.2 7201.9 7226.5 19042.3 19472.0 19573.1 19635.2 19667.8 8096.0 8326.3 8327.5 8329.9 8336.5 7516.1 7593.2 7616.8 7710.6 7737.9 5278.6 5506.7 5511.4 5547.1 5562.7 1588.9 1591.1 1602.0 1603.0 1625.8 966.5 976.3 981.9 1005.2 1011.7 8539.1 8793.6 9320.8 9658.7 9763.3 753.9 793.5 797.4 804.6 804.8 4945.9 5117.9 5701.9 5704.7 5863.2 24672.6 25073.0 25110.5 25525.1 25906.4 24016.1 25141.7 25249.5 25418.1 25432.4 11819.9 12266.3 12418.6 12425.1 12459.8 9356.2 9366.0 9406.2 9412.4 9455.5 21023.4 21255.0 21388.3 21625.8 21933.6 22588.3 22630.0 22714.3 22967.5 23002.9 12142.2 12374.9 12473.8 12487.8 12498.0 15050.4 15479.1 15482.4 15661.0 15668.1 12091.8 12384.4 12467.7 12604.2 12613.9 11546.8 11737.6 11762.7 12010.9 12154.6 10576.2 10848.7 10870.3 10874.2 10884.4 8076.8 8096.1 8150.3 8293.0 8337.0 8030.6 8035.4 8225.3 8240.8 8249.6 04:18:59 INFO - PID 3790 | 04:18:59 INFO - PID 3790 | [#4] prototype.html Cycles:180 Average:5606.42 Median:6229.69 stddev:1558.78 (25.0%) stddev-sans-first:1516.04 04:18:59 INFO - PID 3790 | Values: 539.3 560.8 570.4 577.8 585.3 6293.6 6302.6 6318.5 6340.9 6350.1 6190.3 6212.0 6228.0 6231.4 6237.0 5131.7 5132.0 5146.4 5153.5 5169.6 4872.5 4955.7 5127.3 5133.7 5136.4 4932.2 4938.2 4960.7 4981.5 4996.0 4957.7 4984.5 5010.3 5021.7 5025.4 4470.5 4507.1 4514.3 4527.2 4532.9 6093.8 6206.9 6222.8 6242.8 6261.9 5835.8 5857.4 5862.5 5872.5 5914.3 6546.4 6547.7 6563.3 6575.3 6627.0 5008.6 5035.6 5039.2 5048.9 5057.5 6703.8 6764.5 6819.5 6868.3 6875.4 5138.7 5142.2 5147.2 5158.3 5187.8 5186.2 5204.6 5224.9 5251.7 5253.5 5756.4 5777.9 5829.0 5841.4 5855.8 6623.2 6627.5 6651.2 6691.2 6695.7 1790.9 1805.4 1818.0 1827.5 1830.2 1244.1 1250.1 1292.4 1303.0 1310.3 6060.1 6060.2 6104.7 6159.5 6166.4 6515.3 6625.3 6634.2 6650.9 6665.9 5994.3 6000.3 6111.9 6115.3 6142.7 3484.6 3528.6 3544.3 3548.7 3550.9 6909.6 6981.6 6984.8 6987.4 7021.7 6612.2 6802.1 6887.7 6890.3 6891.8 6783.6 6804.0 6861.1 6875.0 6969.5 6674.1 6688.5 6694.5 6732.2 6743.8 6669.3 6694.0 6696.9 6708.6 6728.7 6965.3 7009.3 7034.4 7058.5 7071.3 5089.9 5097.4 5108.2 5129.6 5135.6 6597.0 6622.6 6654.3 6668.6 6759.0 6261.2 6474.7 6486.8 6492.2 6539.2 6455.8 6471.3 6477.6 6490.4 6579.1 6379.3 6390.3 6448.6 6454.4 6480.9 6563.3 6605.0 6605.3 6627.7 6693.5 6397.3 6408.9 6415.5 6453.2 6521.4 04:18:59 INFO - PID 3790 | 04:18:59 INFO - PID 3790 | [#5] yui.html Cycles:180 Average:27063.70 Median:17137.77 stddev:40362.12 (235.5%) stddev-sans-first:40427.69 04:18:59 INFO - PID 3790 | Values: 940.9 964.9 970.5 973.4 987.8 18389.7 19265.1 19268.1 19275.1 19340.4 17927.0 18397.5 18495.4 18576.6 18727.6 1019.2 1040.1 1040.7 1040.8 1042.4 1019.9 1030.2 1031.1 1034.7 1040.6 1134.5 1140.1 1141.9 1144.5 1145.1 1122.6 1125.1 1129.6 1130.4 1130.6 829.3 831.6 835.8 835.9 836.9 20325.4 20400.9 20459.8 20498.5 20980.3 23142.2 23583.8 23632.5 23659.6 23780.0 18482.3 18547.2 18888.0 18955.9 18973.5 3961.1 3970.3 3987.9 3988.6 3989.7 139001.0 148928.0 151050.0 154281.2 154769.0 17904.6 18574.8 18687.3 18806.7 18813.7 34117.5 34420.3 35304.8 35425.8 35641.8 10010.5 10014.6 10015.5 10060.6 10086.7 4543.6 4664.6 4732.4 4762.7 4774.1 5886.4 5941.7 5947.3 5972.6 5992.8 1180.1 1200.0 1224.2 1226.0 1233.0 655.1 687.5 690.5 701.2 704.1 12703.5 13253.5 13695.7 14244.9 14265.6 673.4 674.7 685.8 704.3 707.0 6204.3 6279.8 6359.5 6366.4 6384.8 144982.3 145118.3 145337.3 146721.0 146746.0 123855.0 124641.0 125590.0 129276.0 129598.0 105162.0 106102.0 107461.9 108797.0 110796.0 12004.2 12031.7 12176.1 12222.9 12333.3 54774.0 54776.0 55000.0 55342.7 57058.4 66621.0 67278.7 68158.0 68657.0 69738.0 16527.3 16645.3 16715.8 16839.7 16855.2 17111.1 17164.4 17294.8 17373.4 17406.7 15242.8 15285.5 15315.8 15346.2 15370.6 15254.2 15320.3 15385.8 15490.1 15524.8 16177.0 16261.0 16272.2 16389.4 16458.8 10213.9 10323.4 10381.9 10446.7 10745.6 10228.1 10277.2 10307.2 10341.1 10418.7 04:18:59 INFO - PID 3790 | -------- Summary: end -------- 04:18:59 INFO - PID 3790 | 04:18:59 INFO - TEST-INFO | 3790: exit 0 04:18:59 INFO - TEST-OK | dromaeo_css | took 1110450ms 04:18:59 INFO - TEST-START | kraken 04:18:59 INFO - Initialising browser for kraken test... 04:18:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42849/getInfo.html -profile /tmp/tmpU7BnzA/profile 04:18:59 INFO - TEST-INFO | started process 4156 (/builds/slave/test/build/application/firefox/firefox http://localhost:42849/getInfo.html) 04:19:05 INFO - TEST-INFO | 4156: exit 0 04:19:05 INFO - Browser initialized. 04:19:05 INFO - Running cycle 1/1 for kraken test... 04:19:05 INFO - Using env: {'DISPLAY': ':0', 04:19:05 INFO - 'HOME': '/home/cltbld', 04:19:05 INFO - 'JSGC_DISABLE_POISONING': '1', 04:19:05 INFO - 'LANG': 'en_US.UTF-8', 04:19:05 INFO - 'LANGUAGE': 'en_US:en', 04:19:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:19:05 INFO - 'LOGNAME': 'cltbld', 04:19:05 INFO - 'MAIL': '/var/mail/cltbld', 04:19:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:19:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:19:05 INFO - 'MOZ_CRASHREPORTER': '1', 04:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:19:05 INFO - 'MOZ_NO_REMOTE': '1', 04:19:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:05 INFO - 'NO_EM_RESTART': '1', 04:19:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:05 INFO - 'PWD': '/builds/slave/test', 04:19:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:19:05 INFO - 'RUST_BACKTRACE': 'full', 04:19:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:19:05 INFO - 'SHELL': '/bin/bash', 04:19:05 INFO - 'SHLVL': '1', 04:19:05 INFO - 'STYLO_FORCE_DISABLED': '1', 04:19:05 INFO - 'TERM': 'linux', 04:19:05 INFO - 'TMOUT': '86400', 04:19:05 INFO - 'USER': 'cltbld', 04:19:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666', 04:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:05 INFO - '_': '/tools/buildbot/bin/python'} 04:19:05 INFO - TEST-INFO | started process 4389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU7BnzA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:06 INFO - PID 4389 | 04:19:06 INFO - PID 4389 | (/builds/slave/test/build/application/firefox/firefox:4438): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:19:06 INFO - PID 4389 | 04:19:16 INFO - PID 4389 | RSS: Main: 150261760 04:19:16 INFO - PID 4389 | 04:19:18 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42849/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:19 INFO - PID 4389 | RSS: Main: 155475968 04:19:19 INFO - PID 4389 | 04:19:22 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42849/tests/kraken/driver.html?testName=audio-dft) 04:19:22 INFO - PID 4389 | RSS: Main: 155619328 04:19:22 INFO - PID 4389 | 04:19:25 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42849/tests/kraken/driver.html?testName=audio-fft) 04:19:26 INFO - PID 4389 | RSS: Main: 151683072 04:19:26 INFO - PID 4389 | 04:19:28 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42849/tests/kraken/driver.html?testName=audio-oscillator) 04:19:29 INFO - PID 4389 | RSS: Main: 152895488 04:19:29 INFO - PID 4389 | 04:19:31 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42849/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:19:31 INFO - PID 4389 | RSS: Main: 152444928 04:19:31 INFO - PID 4389 | 04:19:34 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42849/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:35 INFO - PID 4389 | RSS: Main: 152141824 04:19:35 INFO - PID 4389 | 04:19:38 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42849/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:39 INFO - PID 4389 | RSS: Main: 153718784 04:19:39 INFO - PID 4389 | 04:19:42 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42849/tests/kraken/driver.html?testName=json-parse-financial) 04:19:43 INFO - PID 4389 | RSS: Main: 155492352 04:19:43 INFO - PID 4389 | 04:19:44 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42849/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:45 INFO - PID 4389 | RSS: Main: 155271168 04:19:45 INFO - PID 4389 | 04:19:46 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42849/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:47 INFO - PID 4389 | RSS: Main: 155615232 04:19:47 INFO - PID 4389 | 04:19:49 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42849/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:19:50 INFO - PID 4389 | RSS: Main: 152391680 04:19:50 INFO - PID 4389 | 04:19:52 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42849/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:19:53 INFO - PID 4389 | RSS: Main: 152154112 04:19:53 INFO - PID 4389 | 04:19:56 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42849/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:19:57 INFO - PID 4389 | RSS: Main: 151339008 04:19:57 INFO - PID 4389 | 04:19:58 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42849/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42849/tests/kraken/driver.html?testName=ai-astar) 04:19:59 INFO - PID 4389 | RSS: Main: 152875008 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | __start_tp_report 04:19:59 INFO - PID 4389 | _x_x_mozilla_page_load 04:19:59 INFO - PID 4389 | _x_x_mozilla_page_load_details 04:19:59 INFO - PID 4389 | |i|pagename|runs| 04:19:59 INFO - PID 4389 | |0;ai-astar;106;106;107;105;105;106;94;106;106;106 04:19:59 INFO - PID 4389 | |1;audio-beat-detection;112;115;113;111;110;111;113;112;111;120 04:19:59 INFO - PID 4389 | |2;audio-dft;162;163;162;161;162;162;162;161;163;165 04:19:59 INFO - PID 4389 | |3;audio-fft;72;73;73;73;73;74;72;75;73;72 04:19:59 INFO - PID 4389 | |4;audio-oscillator;80;78;79;78;77;77;123;78;80;79 04:19:59 INFO - PID 4389 | |5;imaging-gaussian-blur;114;113;113;113;110;114;114;114;114;114 04:19:59 INFO - PID 4389 | |6;imaging-darkroom;149;150;150;149;152;150;151;152;151;150 04:19:59 INFO - PID 4389 | |7;imaging-desaturate;94;94;93;93;94;95;94;93;93;94 04:19:59 INFO - PID 4389 | |8;json-parse-financial;48;51;45;45;49;46;46;48;46;45 04:19:59 INFO - PID 4389 | |9;json-stringify-tinderbox;37;37;36;37;36;36;37;36;37;37 04:19:59 INFO - PID 4389 | |10;stanford-crypto-aes;74;71;74;72;72;72;82;70;69;80 04:19:59 INFO - PID 4389 | |11;stanford-crypto-ccm;103;105;104;105;113;106;105;108;105;105 04:19:59 INFO - PID 4389 | |12;stanford-crypto-pbkdf2;153;150;155;156;150;155;163;146;153;150 04:19:59 INFO - PID 4389 | |13;stanford-crypto-sha256-iterative;59;59;60;61;58;57;61;58;60;63 04:19:59 INFO - PID 4389 | __end_tp_report 04:19:59 INFO - PID 4389 | __start_cc_report 04:19:59 INFO - PID 4389 | _x_x_mozilla_cycle_collect,710 04:19:59 INFO - PID 4389 | __end_cc_report 04:19:59 INFO - PID 4389 | __startTimestamp1505647199218__endTimestamp 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | ------- Summary: start ------- 04:19:59 INFO - PID 4389 | Number of tests: 14 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#0] ai-astar Cycles:10 Average:104.70 Median:106.00 stddev:3.80 (3.6%) stddev-sans-first:4.00 04:19:59 INFO - PID 4389 | Values: 106.0 106.0 107.0 105.0 105.0 106.0 94.0 106.0 106.0 106.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#1] audio-beat-detection Cycles:10 Average:112.80 Median:112.50 stddev:2.90 (2.6%) stddev-sans-first:3.06 04:19:59 INFO - PID 4389 | Values: 112.0 115.0 113.0 111.0 110.0 111.0 113.0 112.0 111.0 120.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 04:19:59 INFO - PID 4389 | Values: 162.0 163.0 162.0 161.0 162.0 162.0 162.0 161.0 163.0 165.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#3] audio-fft Cycles:10 Average:73.00 Median:73.00 stddev:0.94 (1.3%) stddev-sans-first:0.93 04:19:59 INFO - PID 4389 | Values: 72.0 73.0 73.0 73.0 73.0 74.0 72.0 75.0 73.0 72.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:78.50 stddev:14.13 (18.0%) stddev-sans-first:14.95 04:19:59 INFO - PID 4389 | Values: 80.0 78.0 79.0 78.0 77.0 77.0 123.0 78.0 80.0 79.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.25 (1.1%) stddev-sans-first:1.30 04:19:59 INFO - PID 4389 | Values: 114.0 113.0 113.0 113.0 110.0 114.0 114.0 114.0 114.0 114.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 04:19:59 INFO - PID 4389 | Values: 149.0 150.0 150.0 149.0 152.0 150.0 151.0 152.0 151.0 150.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:19:59 INFO - PID 4389 | Values: 94.0 94.0 93.0 93.0 94.0 95.0 94.0 93.0 93.0 94.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#8] json-parse-financial Cycles:10 Average:46.90 Median:47.00 stddev:2.02 (4.3%) stddev-sans-first:2.11 04:19:59 INFO - PID 4389 | Values: 48.0 51.0 45.0 45.0 49.0 46.0 46.0 48.0 46.0 45.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#9] json-stringify-tinderbox Cycles:10 Average:36.60 Median:37.00 stddev:0.52 (1.4%) stddev-sans-first:0.53 04:19:59 INFO - PID 4389 | Values: 37.0 37.0 36.0 37.0 36.0 36.0 37.0 36.0 37.0 37.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.00 stddev:4.22 (5.8%) stddev-sans-first:4.48 04:19:59 INFO - PID 4389 | Values: 74.0 71.0 74.0 72.0 72.0 72.0 82.0 70.0 69.0 80.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#11] stanford-crypto-ccm Cycles:10 Average:105.90 Median:105.00 stddev:2.81 (2.7%) stddev-sans-first:2.77 04:19:59 INFO - PID 4389 | Values: 103.0 105.0 104.0 105.0 113.0 106.0 105.0 108.0 105.0 105.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:154.00 stddev:4.63 (3.0%) stddev-sans-first:4.91 04:19:59 INFO - PID 4389 | Values: 153.0 150.0 155.0 156.0 150.0 155.0 163.0 146.0 153.0 150.0 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:60.00 stddev:1.78 (3.0%) stddev-sans-first:1.87 04:19:59 INFO - PID 4389 | Values: 59.0 59.0 60.0 61.0 58.0 57.0 61.0 58.0 60.0 63.0 04:19:59 INFO - PID 4389 | -------- Summary: end -------- 04:19:59 INFO - PID 4389 | 04:19:59 INFO - PID 4389 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:19:59 INFO - TEST-INFO | 4389: exit 0 04:19:59 INFO - TEST-OK | kraken | took 59957ms 04:19:59 INFO - SUITE-END | took 1170s 04:19:59 INFO - Completed test suite (00:19:30) 04:19:59 INFO - javascript benchmark 04:19:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8990.530493402981, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3855.961440385597, 3884.223155368926, 3944.8816535503943, 3948.170884114336, 3951.091249012729, 6261.248650161987, 6347.36526347365, 6383.840403989891, 6414.134091897592, 6418.903716444252, 6370.968145159268, 6420.422162005419, 6433.517486188532, 6434.646094464802, 6456.128422662939, 5699.487046165844, 5704.372519022904, 5746.051901436268, 5762.6254293471, 5791.276090488689, 5795.15970184323, 5797.5651826113, 5832.0, 5832.212651292085, 5851.79518716845, 5730.914036289459, 5758.395368486312, 5833.4749872511675, 5834.883302333951, 5842.0652695568715, 5557.6109672322955, 5640.661560306354, 5670.291213598301, 5754.338251101135, 5779.797707080232, 5665.433456654343, 5689.886202275931, 5751.166080918243, 5777.768889244425, 5785.6528608283215, 6232.470240029603, 6320.557560970734, 6361.650109243989, 6419.35806419359, 6459.289478157399, 6889.379955803952, 6900.689468973908, 6905.102336696197, 6916.135483064617, 6934.653267336613, 6915.170179578433, 7002.299770023008, 7007.404370628503, 7019.929800701979, 7030.578165310098, 6436.645984470852, 6465.903011454879, 6508.446782023534, 6525.836854078639, 6547.214334279917, 7004.369606735317, 7080.468964827659, 7088.184858741311, 7126.0, 7155.534890232118, 6821.658917054127, 6877.518573699793, 6877.828054298582, 6890.483213758988, 6902.965485172643, 6872.450203983669, 6935.965320173367, 6961.164660240804, 7018.578885266798, 7028.683709233097, 6738.427233685094, 6796.830079248059, 6801.557898736566, 6856.314368563104, 6926.099607051051, 6862.862742745117, 6862.862742745117, 6866.965665171642, 6874.243833178446, 6925.6190909499455, 4935.235038568956, 5010.323606313101, 5011.899762004739, 5014.749262536859, 5025.271335656309, 4503.279475284005, 4504.234280172379, 4531.116432295737, 4543.54564543543, 4588.885277868013, 6432.228132624022, 6436.195475565554, 6436.678166091677, 6442.0, 6443.838904027343, 6785.1518560179975, 6885.586864788129, 6896.413804826646, 6988.0, 6995.26549712283, 6324.146240257598, 6327.0, 6360.968195159087, 6378.904316435257, 6383.71273292703, 5547.389787123413, 5551.0, 5564.721763911788, 5576.079946808731, 5610.4670056344585, 7167.4266058715175, 7252.492325537267, 7263.854722905512, 7264.455165862476, 7268.600226987461, 6785.084013658093, 6851.760188393382, 6874.415674667609, 6922.411595014279, 6946.5137440378685, 7073.787786366417, 7160.713571457291, 7169.605671687898, 7172.390346820579, 7266.418686505172, 6737.663116844236, 6803.081583986099, 6817.045613613999, 6825.863482730417, 6835.213950395768, 6927.099477067949, 7000.719971201095, 7012.7545535906, 7022.824429389306, 7025.367716905503, 6676.532642714963, 6740.66296685154, 6770.898436523357, 6771.966140169267, 6781.559198652072, 6655.933440665725, 6656.167979002625, 6664.50016248793, 6756.662166891734, 6758.42553382968, 6391.648459334595, 6569.605823650596, 6579.934200657932, 6580.045893345534, 6589.374009469093, 6691.799246022627, 6702.095217145623, 6730.629815360006, 6743.52795304324, 6781.321867813179, 6488.967555162194, 6493.837654058498, 6573.276939536551, 6577.638229897401, 6579.046038324321], "value": 6311.795070331711, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.2128104768234, 923.252165745746, 941.4398432932405, 988.940663560186, 992.846108853128, 42243.78878105609, 43016.56983430165, 43065.0, 43087.99999999992, 43101.0, 40434.0, 40886.59113408865, 40986.38520422196, 40992.0, 41021.17957640845, 7236.782896513113, 7424.25757424256, 7426.331630153285, 7426.405887528985, 7428.628568571577, 7118.110236220473, 7124.608146551937, 7174.282571742836, 7174.8565028699395, 7175.354218120368, 7102.218755936843, 7819.843603127934, 7952.801179970489, 7956.0, 7975.242351976582, 7877.330426913691, 7940.722074727357, 7942.324902383276, 7942.960285198595, 7948.284654381076, 7865.370770338359, 7959.562224077674, 7997.320227780646, 8035.196480351977, 8039.35685145187, 40127.0, 40383.0, 40476.39285410721, 40507.18985620271, 40510.59489405098, 3668.1746607013474, 3715.238376132886, 3719.4606782016726, 3721.813909304551, 3728.142527218755, 32770.0, 32783.18042048944, 32911.835440822884, 32989.6701032989, 33097.17257068568, 5372.0, 5372.946270537323, 5408.702521361323, 5418.620696551243, 5440.510354068153, 212556.0, 213511.0, 215488.0, 216720.0, 259896.9999999981, 54070.45929540733, 54675.72662136664, 54681.45318546764, 54768.0, 54782.726086369315, 57998.7100064497, 58063.70968145132, 58156.12765808516, 58419.70790146022, 58448.0, 16354.264058117174, 16437.09595972209, 16463.259153338127, 16555.6688866222, 16954.660906781795, 13691.863081369058, 13778.586642400744, 13796.448142074205, 13821.516246931309, 13833.861661383458, 15736.449224277096, 15804.209789510478, 15895.364185432685, 15919.68160636804, 15924.840751592568, 6141.815745527641, 6179.227596550431, 6221.564490485713, 6242.812715618538, 6387.169667943138, 1067.6690226029955, 1088.7768007558432, 1092.9726756831142, 1094.0536435982976, 1098.5441041967495, 25116.623250651253, 25165.62251566228, 25276.368090797878, 25307.746922530907, 25415.0, 1190.773752986947, 1199.7600479904054, 1207.0283421845322, 1207.1670547322494, 1211.4790640024698, 13331.466741330238, 13503.932480337535, 13529.932350338382, 13614.183149010893, 13823.861761382459, 280059.0, 281265.0, 281825.0, 282024.0, 282328.0, 57366.0, 57707.0, 57714.0, 57848.42151578431, 58017.709911450176, 1500.5498350494809, 1512.138081293652, 1543.7529995200714, 1547.752359622455, 1551.8448155184617, 24701.143515999367, 24814.751852481244, 24880.751192488566, 24917.01991522058, 25029.87485062563, 40017.79991100026, 40289.59710402976, 40370.587029453825, 40393.0, 40416.79791601023, 233607.0, 234729.0, 234791.0, 234985.0, 235333.0, 33547.664523354455, 34639.13402164966, 37928.0, 41262.79368603138, 41837.79081104575, 51377.229341560655, 51829.7408512955, 52131.218031730314, 52242.47757522376, 52436.73781631068, 37506.437403439515, 38007.619923800405, 38149.427758583086, 38229.0, 38326.80836595799, 37929.0, 38024.80987595155, 38202.617973819906, 38423.615763842005, 38617.22765544617, 44268.55731442644, 45276.547234527236, 45801.54198457973, 45813.77093114513, 45869.77065114653, 36366.09084772902, 36419.0, 37099.62900370962, 37550.43674344832, 37827.810860945516, 27455.588166177124, 28001.859990699915, 28044.57933130964, 28156.43687126287, 28518.57222141628], "value": 18735.601697236918, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3702190568468, 575.2177039226649, 595.5206059122407, 602.82819396472, 603.381533927724, 22936.541269174628, 24031.399215019588, 24040.87979560102, 24066.037358505662, 24150.637740433864, 23848.165314214006, 24955.0, 25362.74637253627, 25611.487770244585, 25666.358341041483, 6560.835979100513, 6718.6304753238555, 6762.661866906659, 6763.830904227384, 6767.627780472072, 6412.134361861159, 6558.475321974231, 6635.966820165892, 6677.031830384592, 6722.294159113296, 6571.9014214786575, 6581.440577550914, 6583.572067815577, 6587.275399706028, 6593.175853018372, 6564.507661925375, 6586.341365863424, 6589.0, 6625.768098116543, 6640.93359066408, 6002.96998515009, 6239.65681887496, 6251.656158911258, 6252.843678908018, 6255.968720156416, 30008.399832003455, 30264.8486757567, 30291.242718932204, 30448.391032179232, 30471.69528304711, 2252.560750653623, 2296.081567373064, 2296.1159953417887, 2296.2651951375565, 2296.81625469962, 19815.801841981538, 20248.797512024837, 20356.0, 20561.794382056287, 20654.5869082619, 2464.913728019511, 2482.91309804156, 2531.3671582104475, 2550.7194208637034, 2565.1278565287894, 135339.0, 140004.0, 152337.0, 159763.0, 165855.3414465852, 15616.687666246611, 15793.526194214191, 16162.919185403998, 16335.918320408322, 16391.0, 25311.493770124493, 25398.492030159294, 25422.745772542406, 25437.10970116037, 25438.364040898756, 10339.896601034045, 10672.413017284123, 10841.241113122163, 10845.83731244032, 10886.237963342648, 9645.807083858284, 9822.459764712867, 9868.555914983843, 9871.901280987098, 9982.301238913351, 9295.209907157832, 9487.952560237154, 9562.474063926411, 9687.564059617334, 9700.295356751969, 2882.769378449719, 2935.406089469973, 2963.8962636307624, 2980.1506570627703, 2985.1790757541416, 1010.1767059846202, 1029.799189158107, 1047.486382177761, 1054.7943151085465, 1056.963006294776, 20370.79629203689, 20600.0, 20741.170353186004, 20937.79062209389, 21116.366509004754, 1103.4923934989833, 1112.6259070048484, 1131.0725205331548, 1133.4729350851894, 1140.811766058591, 11321.603743868925, 11454.828177577343, 11518.827217591743, 11579.710507237387, 11598.536058557564, 538080.0, 557944.0, 558009.0, 570750.0, 574993.0, 124256.0, 125925.0, 126831.0, 127365.0, 131447.0, 1212.054597414001, 1217.592106644284, 1225.3689349984766, 1246.9127161098636, 1254.191046774825, 17921.28314867391, 18261.90869045646, 18393.72409413833, 18462.076896155406, 18639.534011649816, 60007.39992600018, 60320.0, 60728.69635651793, 64926.67536662475, 65729.67135164293, 71970.64014679893, 72754.0, 76505.61747191228, 77140.61429692815, 78179.60910195412, 14733.55799326022, 15007.624809379853, 15043.623909402353, 15051.548453546411, 15077.773833392288, 22996.19513317026, 23111.0, 23190.3042908713, 23398.298051058497, 23493.765062349157, 18590.628187436447, 18897.527561810515, 18932.337368192046, 19137.90431047836, 19230.519237018627, 16303.26635301438, 16326.428575000293, 16958.57603559921, 17073.14634268257, 17321.0, 18898.0, 19058.237670493025, 19156.71264931055, 19297.614047718685, 19331.806681933, 14729.116253024853, 14731.0, 14899.180545069692, 14944.92527537399, 14960.700785984436, 18331.633367332845, 18352.908235458737, 18593.070346482353, 18644.254229830654, 18669.43991680252], "value": 12530.545450059217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.3263366217877, 1492.3135357735448, 1502.7595584706448, 1505.8193016837981, 1517.2944580769943, 16971.321147154114, 17645.91177044113, 17775.20011599478, 17776.11119444029, 17826.376076837314, 17303.826961730378, 17407.564810879736, 17440.912795436005, 17459.388921387756, 17467.82532174678, 2781.56885682719, 2798.398344355963, 2855.657321121468, 2857.185702074909, 2858.0139851751114, 2726.5910113482937, 2773.972260277402, 2774.6392968914015, 2788.0241915329575, 2793.916182514528, 2812.9578056329174, 2843.4881721290158, 2845.3597940463437, 2846.672632647241, 2852.74325310722, 2670.332416895776, 2698.271466703979, 2699.6085567592686, 2702.8243164194364, 2710.4172602890276, 2669.065826960568, 2676.5048466033845, 2678.9953767337247, 2685.892564297426, 2689.610006549059, 16923.746143807854, 17011.0, 17154.485365438934, 17159.742603860952, 17177.65644687112, 8141.715039973632, 8383.916160838375, 8393.832123357499, 8413.789655258606, 8426.115257897955, 5156.355455568054, 5256.421793602701, 5407.972960135214, 5419.810306639249, 5425.186222066682, 2048.5595596946578, 2107.7786832382685, 2130.893455327243, 2181.3674034530127, 2191.660292654625, 29487.262818429495, 29756.0, 29773.553396699066, 29868.40263194724, 29904.102876913727, 7061.71753129869, 7071.434285257167, 7111.168263357503, 7201.89197162043, 7226.494145409876, 19042.33351832679, 19472.0, 19573.1192096356, 19635.21459141647, 19667.803321966596, 8096.0, 8326.25063744266, 8327.458715183493, 8329.916700833035, 8336.458130221516, 7516.135644400964, 7593.202713715091, 7616.771496855104, 7710.575918324434, 7737.92262077372, 5278.630495865329, 5506.669599824023, 5511.448855114537, 5547.057000309957, 5562.749676264578, 1588.8728901687837, 1591.0692245036553, 1601.9679606407806, 1602.9919850400906, 1625.7561365795225, 966.5408930757974, 976.2775546095838, 981.9263555233387, 1005.2109094361037, 1011.691434112588, 8539.103394143649, 8793.648254069765, 9320.766980825398, 9658.661946831828, 9763.316567840326, 753.9283768042137, 793.4723408933111, 797.44577518624, 804.6419343392134, 804.7867315161487, 4945.9258111128365, 5117.948820511747, 5701.888131814257, 5704.657720536698, 5863.208466857005, 24672.629910551357, 25073.0, 25110.497790044097, 25525.106621268165, 25906.35234119162, 24016.07871370286, 25141.748582514305, 25249.495010099694, 25418.110366137098, 25432.364190895005, 11819.88180118205, 12266.26402415858, 12418.627441176779, 12425.130240883233, 12459.813102803466, 9356.204722598655, 9366.0, 9406.153446189875, 9412.435253884789, 9455.527223638928, 21023.369298921058, 21255.0, 21388.251411200534, 21625.783742163007, 21933.561328773656, 22588.322350329516, 22630.0, 22714.318570442912, 22967.540649186587, 23002.884985574965, 12142.150049496451, 12374.938125309316, 12473.750524989631, 12487.750244995232, 12498.0, 15050.397984080515, 15479.148646824533, 15482.380704771684, 15661.0, 15668.13825239577, 12091.81862272049, 12384.442700078338, 12467.688307792378, 12604.180728252633, 12613.87386126127, 11546.76906461883, 11737.647870563897, 11762.70593235176, 12010.879891200977, 12154.635360939186, 10576.15390768752, 10848.67453976382, 10870.347779133277, 10874.23880328401, 10884.40135792539, 8076.798080048045, 8096.149904260204, 8150.3072238857985, 8293.0, 8337.0, 8030.638621262174, 8035.397345199251, 8225.341972642054, 8240.752777416687, 8249.587520623825], "value": 7214.8287258507435, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.2881396556545, 560.8485708858606, 570.3896830391482, 577.7544543568982, 585.3444142560331, 6293.622382657044, 6302.621842689442, 6318.494520438366, 6340.904886426707, 6350.14273073135, 6190.257169139698, 6212.0, 6227.9688601557045, 6231.40801623845, 6237.0, 5131.666441681297, 5132.0, 5146.433892271847, 5153.536181743642, 5169.612279079065, 4872.4640289568115, 4955.677880937727, 5127.256547800566, 5133.743312834362, 5136.383633963929, 4932.161532539477, 4938.234573641092, 4960.677555958851, 4981.5018498150075, 4995.975020124894, 4957.677750946213, 4984.501549845005, 5010.348654674905, 5021.748912554376, 5025.447200807908, 4470.485894122153, 4507.076049409863, 4514.255147900592, 4527.162474942146, 4532.88667783308, 6093.786717464867, 6206.875862482771, 6222.790909227249, 6242.750289988395, 6261.87476250477, 5835.824925252249, 5857.414258574151, 5862.472377486004, 5872.471477566996, 5914.2902851657645, 6546.378094081055, 6547.705353259114, 6563.3108523604815, 6575.309592492815, 6627.0, 5008.574271186953, 5035.571976382012, 5039.244113382985, 5048.924266136011, 5057.519535644108, 6703.765368212138, 6764.4926630502905, 6819.454443644497, 6868.347506986778, 6875.449964002868, 5138.691678499302, 5142.202958541432, 5147.176451767699, 5158.277841102249, 5187.844364669066, 5186.2479940409185, 5204.5576126028955, 5224.92162617561, 5251.737413129328, 5253.50091741284, 5756.395578464285, 5777.88444231113, 5828.970855145782, 5841.41585841421, 5855.795047173414, 6623.172103487064, 6627.469802415795, 6651.16860392451, 6691.197056353269, 6695.698693558801, 1790.9015004174896, 1805.4132406967788, 1817.9818201817814, 1827.470033690215, 1830.2130084063715, 1244.0793812578806, 1250.1061740855332, 1292.4313302147025, 1303.0487743946971, 1310.2989900403238, 6060.121282414113, 6060.181875446759, 6104.664243466652, 6159.538034647419, 6166.36591303305, 6515.250746164252, 6625.271220165778, 6634.203895532567, 6650.86698266032, 6665.867162359368, 5994.250718660168, 6000.279966404059, 6111.877762444727, 6115.266168059772, 6142.662153581507, 3484.581850177995, 3528.647135286451, 3544.3088597723713, 3548.6628770266784, 3550.946735798965, 6909.619970901648, 6981.581105133607, 6984.825379365455, 6987.371136597731, 7021.684024218923, 6612.206535215805, 6802.14973128359, 6887.7244910203035, 6890.276520965327, 6891.793246202622, 6783.592984420852, 6803.965980170067, 6861.113193871725, 6875.0, 6969.54697944632, 6674.132362792806, 6688.4983626229205, 6694.464442844658, 6732.192136943598, 6743.831404214934, 6669.2997235289595, 6693.99180245934, 6696.899546506709, 6708.563943343667, 6728.7308507659145, 6965.33829286217, 7009.2990700929495, 7034.366906978396, 7058.505904586629, 7071.3229120857895, 5089.872753181052, 5097.362829646294, 5108.182690769459, 5129.563987061141, 5135.589152867687, 6597.0, 6622.569532980341, 6654.301298363602, 6668.633225172468, 6758.966205169139, 6261.186045814015, 6474.741010359533, 6486.772962946275, 6492.220933488012, 6539.247986481425, 6455.806325810233, 6471.320511346241, 6477.643729594729, 6490.415862572391, 6579.111819904251, 6379.330170332234, 6390.329015453496, 6448.613083215022, 6454.354564543508, 6480.935190648033, 6563.278039415565, 6604.952464735948, 6605.2734199239, 6627.701753421204, 6693.531452798452, 6397.3282805306635, 6408.871822563616, 6415.486761059197, 6453.225612926479, 6521.380468855451], "value": 5159.23403646849, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [940.8682784410188, 964.9083337082977, 970.5292932927529, 973.420814615304, 987.8419452887537, 18389.724154137682, 19265.133069011892, 19268.13293401797, 19275.13261903214, 19340.419787406365, 17927.0, 18397.54006149847, 18495.35266265681, 18576.628467430644, 18727.625447491042, 1019.2050200843336, 1040.1003132290552, 1040.7086015915556, 1040.8230600797883, 1042.395410661818, 1019.9133073688745, 1030.2015937648346, 1031.056583226347, 1034.7257976636197, 1040.6201736366247, 1134.4554613785388, 1140.1050175612147, 1141.9029382502497, 1144.5078616195033, 1145.1068166829887, 1122.6463663945872, 1125.06057442036, 1129.6441620889393, 1130.4347826086957, 1130.5534313946027, 829.2826704900218, 831.575896292895, 835.778518692547, 835.8871552340418, 836.8953880764905, 20325.390238292875, 20400.897995510077, 20459.795402045936, 20498.487537811674, 20980.265690700904, 23142.190023349103, 23583.76416235833, 23632.527349452914, 23659.645105323434, 23780.048798048058, 18482.2607095716, 18547.16537755804, 18887.96116213608, 18955.905220473946, 18973.525661858424, 3961.1285517186175, 3970.344893092636, 3987.900302492461, 3988.6011398860173, 3989.6608788253034, 139001.0, 148928.0, 151050.0, 154281.22859385744, 154769.0, 17904.55238619045, 18574.814251857308, 18687.345942891934, 18806.717899231524, 18813.717794233096, 34117.48823767646, 34420.31159376798, 35304.823475882455, 35425.82287088548, 35641.8217908914, 10010.54952527138, 10014.599416023424, 10015.499225038719, 10060.597576096874, 10086.697399078039, 4543.5910768031035, 4664.626829853603, 4732.384789977281, 4762.738049407247, 4774.092922344813, 5886.352501224862, 5941.673207973517, 5947.256592925884, 5972.552058595623, 5992.760289588455, 1180.0622321376031, 1199.9760004799855, 1224.1614494071412, 1225.9754804903853, 1233.0320698251828, 655.1483072006373, 687.5221720903924, 690.5062880040795, 701.2006312803409, 704.0811740678362, 12703.491860325668, 13253.536126235536, 13695.726085478434, 14244.857551424353, 14265.57203283903, 673.3535805626653, 674.6896427643339, 685.8045457044718, 704.306258335539, 706.9611171385624, 6204.286507051656, 6279.811605651837, 6359.459445947146, 6366.427021567988, 6384.840378990562, 144982.275088626, 145118.27440862727, 145337.27331363276, 146721.0, 146746.0, 123855.0, 124641.0, 125590.0, 129276.0, 129598.0, 105162.0, 106102.0, 107461.92538074676, 108797.0, 110796.0, 12004.2197257178, 12031.71644580428, 12176.147669663038, 12222.877771222174, 12333.321667308384, 54774.0, 54776.0, 55000.0, 55342.72328638331, 57058.42941570531, 66621.0, 67278.66360668166, 68158.0, 68657.0, 69738.0, 16527.256273467483, 16645.25096370642, 16715.83284167143, 16839.66320673604, 16855.157242138088, 17111.14444277806, 17164.39924602633, 17294.827051729826, 17373.391931282345, 17406.651866962842, 15242.77135842941, 15285.541433757006, 15315.846841531442, 15346.23268836576, 15370.615734606725, 15254.237288135771, 15320.310586023434, 15385.84614153844, 15490.148041857807, 15524.767128492857, 16177.029378236874, 16261.0, 16272.186390680656, 16389.42637007699, 16458.75311870299, 10213.948930255301, 10323.380597164194, 10381.9480902595, 10446.68659940203, 10745.570177192825, 10228.130608898327, 10277.229207809294, 10307.175425965755, 10341.121004714683, 10418.73953151147], "value": 9573.783529128641, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1368.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 106.0, 107.0, 105.0, 105.0, 106.0, 94.0, 106.0, 106.0, 106.0], "value": 104.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 113.0, 111.0, 110.0, 111.0, 113.0, 112.0, 111.0, 120.0], "value": 112.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 163.0, 165.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 73.0, 73.0, 74.0, 72.0, 75.0, 73.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 78.0, 77.0, 77.0, 123.0, 78.0, 80.0, 79.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 110.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 149.0, 152.0, 150.0, 151.0, 152.0, 151.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 94.0, 95.0, 94.0, 93.0, 93.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 51.0, 45.0, 45.0, 49.0, 46.0, 46.0, 48.0, 46.0, 45.0], "value": 46.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 36.0, 37.0, 36.0, 36.0, 37.0, 36.0, 37.0, 37.0], "value": 36.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 74.0, 72.0, 72.0, 72.0, 82.0, 70.0, 69.0, 80.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 105.0, 104.0, 105.0, 113.0, 106.0, 105.0, 108.0, 105.0, 105.0], "value": 105.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 155.0, 156.0, 150.0, 155.0, 163.0, 146.0, 153.0, 150.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 61.0, 58.0, 57.0, 61.0, 58.0, 60.0, 63.0], "value": 59.6, "unit": "score"}]}]} 04:19:59 INFO - Return code: 0 04:20:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:20:00 INFO - # TBPL SUCCESS # 04:20:00 INFO - Running post-action listener: _package_coverage_data 04:20:00 INFO - Running post-action listener: _resource_record_post_action 04:20:00 INFO - [mozharness: 2017-09-17 11:20:00.021938Z] Finished run-tests step (success) 04:20:00 INFO - Running post-run listener: _resource_record_post_run 04:20:00 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 9375744; Write bytes: 468754432; Read time: 4288; Write time: 628156 04:20:00 INFO - TinderboxPrint: CPU usage
13.1% 04:20:00 INFO - TinderboxPrint: I/O read bytes / time
9,375,744 / 4,288 04:20:00 INFO - TinderboxPrint: I/O write bytes / time
468,754,432 / 628,156 04:20:00 INFO - TinderboxPrint: CPU idle
8,239.9 (86.9%) 04:20:00 INFO - TinderboxPrint: CPU user
1,186.3 (12.5%) 04:20:00 INFO - TinderboxPrint: Swap in / out
0 / 0 04:20:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 32104448; Read time: 0; Write time: 7672 04:20:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:20:00 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 9375744; Write bytes: 392085504; Read time: 4288; Write time: 552188 04:20:00 INFO - Running post-run listener: _upload_blobber_files 04:20:00 INFO - Blob upload gear active. 04:20:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:20:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:20:01 INFO - (blobuploader) - INFO - Open directory for files ... 04:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:02 INFO - (blobuploader) - INFO - Done attempting. 04:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:03 INFO - (blobuploader) - INFO - Done attempting. 04:20:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:20:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:10 INFO - (blobuploader) - INFO - Done attempting. 04:20:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:20:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:20:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:11 INFO - (blobuploader) - INFO - Done attempting. 04:20:11 INFO - (blobuploader) - INFO - Iteration through files over. 04:20:11 INFO - Return code: 0 04:20:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:20:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:20:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/660a91a91df143afdf1d663a3083eed88dfefd30cf8c3871b0a4101728749e5629c898f5ea95c5bcc28da5c430e3e71cedbf9fbaddaf5780cbfa4e3c2fe2a0a2", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0aa20bda5a99648bdc2a514a990bb3e7b5733a8ac0765e7a14ec5c096bd000a3f7e92c87e4be2869f026fb6e1451e6c90b16cb7d9ef8b67546f1066a626cc760", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d32425d11934f506cda287812535c7aecd0c17cc6a1a81ddb33ec0777e0f90b95ae557eb2652ebb33574312a7528dd80356bd3b1e40ed5a08eca084808d4634", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13312511230275098dfffb552a47a3547b8d4caa619a49726a7390ffa4d7e93ff11b96a3cbf14fc46357c3ce64261892f5b02fc5c385f7fe57a07d5debd5703b"} 04:20:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:20:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:20:11 INFO - Contents: 04:20:11 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/660a91a91df143afdf1d663a3083eed88dfefd30cf8c3871b0a4101728749e5629c898f5ea95c5bcc28da5c430e3e71cedbf9fbaddaf5780cbfa4e3c2fe2a0a2", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0aa20bda5a99648bdc2a514a990bb3e7b5733a8ac0765e7a14ec5c096bd000a3f7e92c87e4be2869f026fb6e1451e6c90b16cb7d9ef8b67546f1066a626cc760", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d32425d11934f506cda287812535c7aecd0c17cc6a1a81ddb33ec0777e0f90b95ae557eb2652ebb33574312a7528dd80356bd3b1e40ed5a08eca084808d4634", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13312511230275098dfffb552a47a3547b8d4caa619a49726a7390ffa4d7e93ff11b96a3cbf14fc46357c3ce64261892f5b02fc5c385f7fe57a07d5debd5703b"} 04:20:11 INFO - Running post-run listener: copy_logs_to_upload_dir 04:20:11 INFO - Copying logs to upload dir... 04:20:11 INFO - mkdir: /builds/slave/test/build/upload/logs 04:20:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.646587 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-17 04:20:11.693421) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 04:20:11.701367) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666 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/660a91a91df143afdf1d663a3083eed88dfefd30cf8c3871b0a4101728749e5629c898f5ea95c5bcc28da5c430e3e71cedbf9fbaddaf5780cbfa4e3c2fe2a0a2", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0aa20bda5a99648bdc2a514a990bb3e7b5733a8ac0765e7a14ec5c096bd000a3f7e92c87e4be2869f026fb6e1451e6c90b16cb7d9ef8b67546f1066a626cc760", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d32425d11934f506cda287812535c7aecd0c17cc6a1a81ddb33ec0777e0f90b95ae557eb2652ebb33574312a7528dd80356bd3b1e40ed5a08eca084808d4634", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13312511230275098dfffb552a47a3547b8d4caa619a49726a7390ffa4d7e93ff11b96a3cbf14fc46357c3ce64261892f5b02fc5c385f7fe57a07d5debd5703b"} build_url:https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/JTdcOmWBQK-wHMxZTbidaA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/660a91a91df143afdf1d663a3083eed88dfefd30cf8c3871b0a4101728749e5629c898f5ea95c5bcc28da5c430e3e71cedbf9fbaddaf5780cbfa4e3c2fe2a0a2", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0aa20bda5a99648bdc2a514a990bb3e7b5733a8ac0765e7a14ec5c096bd000a3f7e92c87e4be2869f026fb6e1451e6c90b16cb7d9ef8b67546f1066a626cc760", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d32425d11934f506cda287812535c7aecd0c17cc6a1a81ddb33ec0777e0f90b95ae557eb2652ebb33574312a7528dd80356bd3b1e40ed5a08eca084808d4634", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13312511230275098dfffb552a47a3547b8d4caa619a49726a7390ffa4d7e93ff11b96a3cbf14fc46357c3ce64261892f5b02fc5c385f7fe57a07d5debd5703b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 04:20:11.737250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 04:20:11.737662) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505644820.905667-1582947666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 04:20:11.822974) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 04:20:11.823412) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 04:20:11.823846) ========= ========= Total master_lag: 0.31 =========