builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-081 starttime: 1505964912.07 results: success (0) revision: 47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:12.067851) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:12.068268) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:12.068545) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:12.086793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:12.087139) ========= 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=483e410453545d07cca6935c000001ab-1505959915.772173-166902363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 20:35:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 105M=0s 2017-09-20 20:35:12 (105 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.178028 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:12.282520) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:12.282945) ========= 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=483e410453545d07cca6935c000001ab-1505959915.772173-166902363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021208 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:12.351080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:12.351431) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf --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 47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf --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=483e410453545d07cca6935c000001ab-1505959915.772173-166902363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 20:35:12,408 truncating revision to first 12 chars 2017-09-20 20:35:12,408 Setting DEBUG logging. 2017-09-20 20:35:12,408 attempt 1/10 2017-09-20 20:35:12,408 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/47f7b6c64265?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 20:35:12,825 unpacking tar archive at: mozilla-central-47f7b6c64265/testing/mozharness/ program finished with exit code 0 elapsedTime=0.710217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:13.084907) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:13.085209) ========= script_repo_revision: 47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:13.085604) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:13.085920) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 20:35:13.100409) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-20 20:35:13.101039) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=483e410453545d07cca6935c000001ab-1505959915.772173-166902363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:35:13 INFO - MultiFileLogger online at 20170920 20:35:13 in /builds/slave/test 20:35:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:35:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:35:13 INFO - {'append_to_log': False, 20:35:13 INFO - 'base_work_dir': '/builds/slave/test', 20:35:13 INFO - 'blob_upload_branch': 'Firefox', 20:35:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:35:13 INFO - 'branch': 'Firefox', 20:35:13 INFO - 'buildbot_json_path': 'buildprops.json', 20:35:13 INFO - 'code_coverage': False, 20:35:13 INFO - 'config_files': ('talos/linux_config.py',), 20:35:13 INFO - 'default_actions': ('clobber', 20:35:13 INFO - 'read-buildbot-config', 20:35:13 INFO - 'download-and-extract', 20:35:13 INFO - 'populate-webroot', 20:35:13 INFO - 'create-virtualenv', 20:35:13 INFO - 'install', 20:35:13 INFO - 'setup-mitmproxy', 20:35:13 INFO - 'run-tests'), 20:35:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:35:13 INFO - 'disable_ccov_upload': False, 20:35:13 INFO - 'disable_stylo': False, 20:35:13 INFO - 'download_minidump_stackwalk': True, 20:35:13 INFO - 'download_symbols': 'ondemand', 20:35:13 INFO - 'enable_stylo': False, 20:35:13 INFO - 'enable_webrender': False, 20:35:13 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 20:35:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:35:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:35:13 INFO - 'gecko_profile': False, 20:35:13 INFO - 'gecko_profile_interval': 0, 20:35:13 INFO - 'installer_path': 'installer.exe', 20:35:13 INFO - 'log_level': 'info', 20:35:13 INFO - 'log_name': 'talos', 20:35:13 INFO - 'log_to_console': True, 20:35:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:35:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:35:13 INFO - 'opt_config_files': (), 20:35:13 INFO - 'pip_index': False, 20:35:13 INFO - 'suite': 'dromaeojs-e10s', 20:35:13 INFO - 'system_bits': '32', 20:35:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:35:13 INFO - 'title': 'talos-linux64-ix-081', 20:35:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:35:13 INFO - 'use_talos_json': True, 20:35:13 INFO - 'verify': 'False', 20:35:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:35:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:35:13 INFO - 'work_dir': 'build'} 20:35:13 INFO - [mozharness: 2017-09-21 03:35:13.303214Z] Running clobber step. 20:35:13 INFO - Running pre-action listener: _resource_record_pre_action 20:35:13 INFO - Running main action method: clobber 20:35:13 INFO - rmtree: /builds/slave/test/build 20:35:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:35:14 INFO - Running post-action listener: _resource_record_post_action 20:35:14 INFO - [mozharness: 2017-09-21 03:35:14.827521Z] Finished clobber step (success) 20:35:14 INFO - [mozharness: 2017-09-21 03:35:14.827617Z] Running read-buildbot-config step. 20:35:14 INFO - Running pre-action listener: _resource_record_pre_action 20:35:14 INFO - Running main action method: read_buildbot_config 20:35:14 INFO - Using buildbot properties: 20:35:14 INFO - { 20:35:14 INFO - "project": "", 20:35:14 INFO - "product": "firefox", 20:35:14 INFO - "who": "ryanvm@gmail.com", 20:35:14 INFO - "installer_path": "public/build/target.tar.bz2", 20:35:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 20:35:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:35:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 20:35:14 INFO - "stage_platform": "linux64-pgo", 20:35:14 INFO - "basedir": "/builds/slave/test", 20:35:14 INFO - "buildnumber": 197, 20:35:14 INFO - "platform": "ubuntu64_hw", 20:35:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:35:14 INFO - "slavebuilddir": "test", 20:35:14 INFO - "taskId": "einjHKTARMm-AX_r2VKFmw", 20:35:14 INFO - "branch": "mozilla-central", 20:35:14 INFO - "script_repo_revision": "production", 20:35:14 INFO - "revision": "47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf", 20:35:14 INFO - "slavename": "talos-linux64-ix-081", 20:35:14 INFO - "repo_path": "mozilla-central" 20:35:14 INFO - } 20:35:14 INFO - Finding installer, test and symbols from parent task. 20:35:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/einjHKTARMm-AX_r2VKFmw'}, attempt #1 20:35:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/einjHKTARMm-AX_r2VKFmw'}, attempt #1 20:35:15 INFO - Task dependencies: CsEgb139SD6oyZsaoMKOhw 20:35:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw'}, attempt #1 20:35:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.tar.bz2 20:35:16 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.test_packages.json 20:35:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.crashreporter-symbols.zip 20:35:16 INFO - Running post-action listener: _resource_record_post_action 20:35:16 INFO - [mozharness: 2017-09-21 03:35:16.159823Z] Finished read-buildbot-config step (success) 20:35:16 INFO - [mozharness: 2017-09-21 03:35:16.160039Z] Running download-and-extract step. 20:35:16 INFO - Running pre-action listener: _resource_record_pre_action 20:35:16 INFO - Running main action method: download_and_extract 20:35:16 INFO - mkdir: /builds/slave/test/build/tests 20:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:16 INFO - trying https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.test_packages.json 20:35:16 INFO - Downloading https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:35:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:35:16 INFO - Downloaded 989 bytes. 20:35:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:35:16 INFO - Using the following test package requirements: 20:35:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:35:16 INFO - u'common': [u'target.common.tests.zip'], 20:35:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:35:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:35:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:35:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:35:16 INFO - u'mozbase': [u'target.common.tests.zip'], 20:35:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:35:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:35:16 INFO - u'web-platform': [u'target.common.tests.zip', 20:35:16 INFO - u'target.web-platform.tests.tar.gz'], 20:35:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:35:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 20:35:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.common.tests.zip 20:35:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:35:16 INFO - Fetch https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.common.tests.zip into memory 20:35:20 INFO - Content-Length response header: 55325497 20:35:20 INFO - Bytes received: 55325497 20:35:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.talos.tests.zip 20:35:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:35:31 INFO - Fetch https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.talos.tests.zip into memory 20:35:32 INFO - Content-Length response header: 14509184 20:35:32 INFO - Bytes received: 14509184 20:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:33 INFO - trying https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.tar.bz2 20:35:33 INFO - Downloading https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:35:36 INFO - Downloaded 62299981 bytes. 20:35:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.tar.bz2 20:35:36 INFO - mkdir: /builds/slave/test/properties 20:35:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:35:36 INFO - Writing to file /builds/slave/test/properties/build_url 20:35:36 INFO - Contents: 20:35:36 INFO - build_url:https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.tar.bz2 20:35:36 INFO - Running post-action listener: _resource_record_post_action 20:35:36 INFO - Running post-action listener: find_tests_for_verification 20:35:36 INFO - Running post-action listener: set_extra_try_arguments 20:35:36 INFO - [mozharness: 2017-09-21 03:35:36.610279Z] Finished download-and-extract step (success) 20:35:36 INFO - [mozharness: 2017-09-21 03:35:36.610483Z] Running populate-webroot step. 20:35:36 INFO - Running pre-action listener: _resource_record_pre_action 20:35:36 INFO - Running main action method: populate_webroot 20:35:36 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:35:36 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:35:36 INFO - 'tests': ['tresize', 20:35:36 INFO - 'tcanvasmark']}, 20:35:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:35:36 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:35:36 INFO - 'tests': ['dromaeo_css', 20:35:36 INFO - 'kraken']}, 20:35:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:35:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:35:36 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:35:36 INFO - 'talos_options': ['--disable-stylo'], 20:35:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:35:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:35:36 INFO - 'tests': ['damp', 'tps']}, 20:35:36 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:35:36 INFO - 'talos_options': ['--disable-stylo'], 20:35:36 INFO - 'tests': ['damp', 'tps']}, 20:35:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:35:36 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:35:36 INFO - 'tests': ['dromaeo_dom']}, 20:35:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:35:36 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:35:36 INFO - 'tests': ['basic_compositor_video', 20:35:36 INFO - 'glvideo']}, 20:35:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:35:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:35:36 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:35:36 INFO - 'talos_options': ['--disable-stylo'], 20:35:36 INFO - 'tests': ['ts_paint_webext', 20:35:36 INFO - 'tp5o_webext']}, 20:35:36 INFO - 'other-e10s': {'tests': ['a11yr', 20:35:36 INFO - 'ts_paint', 20:35:36 INFO - 'tpaint', 20:35:36 INFO - 'sessionrestore', 20:35:36 INFO - 'sessionrestore_many_windows', 20:35:36 INFO - 'sessionrestore_no_auto_restore', 20:35:36 INFO - 'tabpaint']}, 20:35:36 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:35:36 INFO - 'tests': ['a11yr', 20:35:36 INFO - 'ts_paint', 20:35:36 INFO - 'tpaint', 20:35:36 INFO - 'sessionrestore', 20:35:36 INFO - 'sessionrestore_many_windows', 20:35:36 INFO - 'sessionrestore_no_auto_restore', 20:35:36 INFO - 'tabpaint']}, 20:35:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 20:35:36 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 20:35:36 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:35:36 INFO - 'tests': ['perf_reftest_singletons']}, 20:35:36 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:35:36 INFO - 'tests': ['bloom_basic']}, 20:35:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:35:36 INFO - 'tsvgr_opacity', 20:35:36 INFO - 'tart', 20:35:36 INFO - 'tscrollx', 20:35:36 INFO - 'tsvg_static']}, 20:35:36 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:35:36 INFO - 'tests': ['tsvgx', 20:35:36 INFO - 'tsvgr_opacity', 20:35:36 INFO - 'tart', 20:35:36 INFO - 'tscrollx', 20:35:36 INFO - 'tsvg_static']}, 20:35:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:35:36 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:35:36 INFO - 'talos_options': ['--disable-stylo'], 20:35:36 INFO - 'tests': ['tp5o']}, 20:35:36 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:35:36 INFO - 'talos_options': ['--mitmproxy', 20:35:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:35:36 INFO - '--firstNonBlankPaint'], 20:35:36 INFO - 'tests': ['tp6_google', 20:35:36 INFO - 'tp6_youtube', 20:35:36 INFO - 'tp6_amazon', 20:35:36 INFO - 'tp6_facebook']}, 20:35:36 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:35:36 INFO - 'talos_options': ['--disable-stylo', 20:35:36 INFO - '--mitmproxy', 20:35:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:35:36 INFO - '--firstNonBlankPaint'], 20:35:36 INFO - 'tests': ['tp6_google', 20:35:36 INFO - 'tp6_youtube', 20:35:36 INFO - 'tp6_amazon', 20:35:36 INFO - 'tp6_facebook']}, 20:35:36 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:35:36 INFO - 'talos_options': ['--stylo-threads=1', 20:35:36 INFO - '--mitmproxy', 20:35:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:35:36 INFO - '--firstNonBlankPaint'], 20:35:36 INFO - 'tests': ['tp6_google', 20:35:36 INFO - 'tp6_youtube', 20:35:36 INFO - 'tp6_amazon', 20:35:36 INFO - 'tp6_facebook']}, 20:35:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:35:36 INFO - 'talos_options': ['--xperf_path', 20:35:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:35:36 INFO - 'tests': ['tp5n']}, 20:35:36 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:35:36 INFO - 'talos_options': ['--disable-stylo', 20:35:36 INFO - '--xperf_path', 20:35:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:35:36 INFO - 'tests': ['tp5n']}}} 20:35:36 INFO - Running post-action listener: _resource_record_post_action 20:35:36 INFO - [mozharness: 2017-09-21 03:35:36.627425Z] Finished populate-webroot step (success) 20:35:36 INFO - [mozharness: 2017-09-21 03:35:36.627531Z] Running create-virtualenv step. 20:35:36 INFO - Running pre-action listener: _resource_record_pre_action 20:35:36 INFO - Running main action method: create_virtualenv 20:35:36 INFO - Creating virtualenv /builds/slave/test/build/venv 20:35:36 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:35:36 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 20:35:36 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:35:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:35:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:35:37 INFO - Installing distribute.............................................................................................................................................................................................done. 20:35:37 INFO - Installing pip...............done. 20:35:37 INFO - Return code: 0 20:35:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:35:37 INFO - Reading from file tmpfile_stdout 20:35:37 INFO - Output received: 20:35:37 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 20:35:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:35:37 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')]} 20:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:37 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')]} 20:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:37 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 0x209f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240f090>, '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 0x240fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409f90>, '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': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', '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 20:35:37 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 20:35:37 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 20:35:37 INFO - Using env: {'DISPLAY': ':0', 20:35:37 INFO - 'HOME': '/home/cltbld', 20:35:37 INFO - 'LANG': 'en_US.UTF-8', 20:35:37 INFO - 'LANGUAGE': 'en_US:en', 20:35:37 INFO - 'LOGNAME': 'cltbld', 20:35:37 INFO - 'MAIL': '/var/mail/cltbld', 20:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:37 INFO - 'MOZ_NO_REMOTE': '1', 20:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:37 INFO - 'NO_EM_RESTART': '1', 20:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:37 INFO - 'PWD': '/builds/slave/test', 20:35:37 INFO - 'SHELL': '/bin/bash', 20:35:37 INFO - 'SHLVL': '1', 20:35:37 INFO - 'TERM': 'linux', 20:35:37 INFO - 'TMOUT': '86400', 20:35:37 INFO - 'USER': 'cltbld', 20:35:37 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:37 INFO - '_': '/tools/buildbot/bin/python'} 20:35:38 INFO - Ignoring indexes: http://pypi.python.org/simple/ 20:35:38 INFO - Downloading/unpacking pip>=1.5 20:35:38 INFO - Running setup.py egg_info for package pip 20:35:38 INFO - warning: no files found matching 'pip/cacert.pem' 20:35:38 INFO - warning: no files found matching '*.html' under directory 'docs' 20:35:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:35:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:35:38 INFO - Installing collected packages: pip 20:35:38 INFO - Found existing installation: pip 1.1 20:35:38 INFO - Uninstalling pip: 20:35:38 INFO - Successfully uninstalled pip 20:35:38 INFO - Running setup.py install for pip 20:35:38 INFO - warning: no files found matching 'pip/cacert.pem' 20:35:38 INFO - warning: no files found matching '*.html' under directory 'docs' 20:35:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:35:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:35:38 INFO - Installing pip script to /builds/slave/test/build/venv/bin 20:35:38 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 20:35:38 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 20:35:38 INFO - Successfully installed pip 20:35:38 INFO - Cleaning up... 20:35:38 INFO - Return code: 0 20:35:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x209f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240f090>, '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 0x240fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409f90>, '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': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', '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 20:35:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:35:38 INFO - Using env: {'DISPLAY': ':0', 20:35:38 INFO - 'HOME': '/home/cltbld', 20:35:38 INFO - 'LANG': 'en_US.UTF-8', 20:35:38 INFO - 'LANGUAGE': 'en_US:en', 20:35:38 INFO - 'LOGNAME': 'cltbld', 20:35:38 INFO - 'MAIL': '/var/mail/cltbld', 20:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:38 INFO - 'MOZ_NO_REMOTE': '1', 20:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:38 INFO - 'NO_EM_RESTART': '1', 20:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:38 INFO - 'PWD': '/builds/slave/test', 20:35:38 INFO - 'SHELL': '/bin/bash', 20:35:38 INFO - 'SHLVL': '1', 20:35:38 INFO - 'TERM': 'linux', 20:35:38 INFO - 'TMOUT': '86400', 20:35:38 INFO - 'USER': 'cltbld', 20:35:38 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:38 INFO - '_': '/tools/buildbot/bin/python'} 20:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:39 INFO - Downloading/unpacking psutil>=3.1.1 20:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:35:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:35:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:35:40 INFO - Installing collected packages: psutil 20:35:40 INFO - Running setup.py install for psutil 20:35:40 INFO - building 'psutil._psutil_linux' extension 20:35:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:35:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:35:40 INFO - building 'psutil._psutil_posix' extension 20:35:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:35:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:35:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:35:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:35:40 INFO - Successfully installed psutil 20:35:40 INFO - Cleaning up... 20:35:40 INFO - Return code: 0 20:35:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:35:40 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')]} 20:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:40 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')]} 20:35:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:40 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 0x209f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240f090>, '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 0x240fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409f90>, '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': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', '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 20:35:40 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 20:35:40 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 20:35:40 INFO - Using env: {'DISPLAY': ':0', 20:35:40 INFO - 'HOME': '/home/cltbld', 20:35:40 INFO - 'LANG': 'en_US.UTF-8', 20:35:40 INFO - 'LANGUAGE': 'en_US:en', 20:35:40 INFO - 'LOGNAME': 'cltbld', 20:35:40 INFO - 'MAIL': '/var/mail/cltbld', 20:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:40 INFO - 'MOZ_NO_REMOTE': '1', 20:35:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:40 INFO - 'NO_EM_RESTART': '1', 20:35:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:40 INFO - 'PWD': '/builds/slave/test', 20:35:40 INFO - 'SHELL': '/bin/bash', 20:35:40 INFO - 'SHLVL': '1', 20:35:40 INFO - 'TERM': 'linux', 20:35:40 INFO - 'TMOUT': '86400', 20:35:40 INFO - 'USER': 'cltbld', 20:35:40 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:40 INFO - '_': '/tools/buildbot/bin/python'} 20:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:35:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:35:42 INFO - Installing collected packages: mozsystemmonitor 20:35:42 INFO - Running setup.py install for mozsystemmonitor 20:35:42 INFO - Successfully installed mozsystemmonitor 20:35:42 INFO - Cleaning up... 20:35:42 INFO - Return code: 0 20:35:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:35:42 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')]} 20:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:42 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')]} 20:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:42 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 0x209f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240f090>, '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 0x240fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409f90>, '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': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', '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 20:35:42 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 20:35:42 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 20:35:42 INFO - Using env: {'DISPLAY': ':0', 20:35:42 INFO - 'HOME': '/home/cltbld', 20:35:42 INFO - 'LANG': 'en_US.UTF-8', 20:35:42 INFO - 'LANGUAGE': 'en_US:en', 20:35:42 INFO - 'LOGNAME': 'cltbld', 20:35:42 INFO - 'MAIL': '/var/mail/cltbld', 20:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:42 INFO - 'MOZ_NO_REMOTE': '1', 20:35:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:42 INFO - 'NO_EM_RESTART': '1', 20:35:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:42 INFO - 'PWD': '/builds/slave/test', 20:35:42 INFO - 'SHELL': '/bin/bash', 20:35:42 INFO - 'SHLVL': '1', 20:35:42 INFO - 'TERM': 'linux', 20:35:42 INFO - 'TMOUT': '86400', 20:35:42 INFO - 'USER': 'cltbld', 20:35:42 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:42 INFO - '_': '/tools/buildbot/bin/python'} 20:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:43 INFO - Downloading/unpacking jsonschema==2.5.1 20:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:35:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:44 INFO - Downloading functools32-3.2.3-2.tar.gz 20:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:35:44 INFO - warning: no files found matching '*.txt' 20:35:44 INFO - no previously-included directories found matching 'build' 20:35:44 INFO - no previously-included directories found matching 'dist' 20:35:44 INFO - no previously-included directories found matching '.git*' 20:35:44 INFO - Installing collected packages: jsonschema, functools32 20:35:44 INFO - Running setup.py install for functools32 20:35:44 INFO - warning: no files found matching '*.txt' 20:35:44 INFO - no previously-included directories found matching 'build' 20:35:44 INFO - no previously-included directories found matching 'dist' 20:35:44 INFO - no previously-included directories found matching '.git*' 20:35:44 INFO - Successfully installed jsonschema functools32 20:35:44 INFO - Cleaning up... 20:35:44 INFO - Return code: 0 20:35:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:35: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')]} 20:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35: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')]} 20:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:44 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 0x209f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240f090>, '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 0x240fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409f90>, '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': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', '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 20:35:44 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 20:35:44 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 20:35:44 INFO - Using env: {'DISPLAY': ':0', 20:35:44 INFO - 'HOME': '/home/cltbld', 20:35:44 INFO - 'LANG': 'en_US.UTF-8', 20:35:44 INFO - 'LANGUAGE': 'en_US:en', 20:35:44 INFO - 'LOGNAME': 'cltbld', 20:35:44 INFO - 'MAIL': '/var/mail/cltbld', 20:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:44 INFO - 'MOZ_NO_REMOTE': '1', 20:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:44 INFO - 'NO_EM_RESTART': '1', 20:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:44 INFO - 'PWD': '/builds/slave/test', 20:35:44 INFO - 'SHELL': '/bin/bash', 20:35:44 INFO - 'SHLVL': '1', 20:35:44 INFO - 'TERM': 'linux', 20:35:44 INFO - 'TMOUT': '86400', 20:35:44 INFO - 'USER': 'cltbld', 20:35:44 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:44 INFO - '_': '/tools/buildbot/bin/python'} 20:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:35:44 INFO - Cleaning up... 20:35:44 INFO - Return code: 0 20:35:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:35: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')]} 20:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35: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')]} 20:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:44 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 0x209f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240f090>, '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 0x240fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409f90>, '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': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', '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 20:35:44 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 20:35:44 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 20:35:44 INFO - Using env: {'DISPLAY': ':0', 20:35:44 INFO - 'HOME': '/home/cltbld', 20:35:44 INFO - 'LANG': 'en_US.UTF-8', 20:35:44 INFO - 'LANGUAGE': 'en_US:en', 20:35:44 INFO - 'LOGNAME': 'cltbld', 20:35:44 INFO - 'MAIL': '/var/mail/cltbld', 20:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:44 INFO - 'MOZ_NO_REMOTE': '1', 20:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:44 INFO - 'NO_EM_RESTART': '1', 20:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:44 INFO - 'PWD': '/builds/slave/test', 20:35:44 INFO - 'SHELL': '/bin/bash', 20:35:44 INFO - 'SHLVL': '1', 20:35:44 INFO - 'TERM': 'linux', 20:35:44 INFO - 'TMOUT': '86400', 20:35:44 INFO - 'USER': 'cltbld', 20:35:44 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:44 INFO - '_': '/tools/buildbot/bin/python'} 20:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:45 INFO - Downloading/unpacking blobuploader==1.2.4 20:35:45 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 20:35:45 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 20:35:45 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 20:35:45 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 20:35:46 INFO - Downloading blobuploader-1.2.4.tar.gz 20:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:35:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:35:46 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 20:35:46 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 20:35:46 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 20:35:46 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 20:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:35:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:35:46 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 20:35:46 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 20:35:46 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 20:35:46 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 20:35:46 INFO - Downloading docopt-0.6.1.tar.gz 20:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:35:46 INFO - Installing collected packages: blobuploader, requests, docopt 20:35:46 INFO - Running setup.py install for blobuploader 20:35:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:35:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:35:46 INFO - Running setup.py install for requests 20:35:47 INFO - Running setup.py install for docopt 20:35:47 INFO - Successfully installed blobuploader requests docopt 20:35:47 INFO - Cleaning up... 20:35:47 INFO - Return code: 0 20:35:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35:47 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')]} 20:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:47 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')]} 20:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:47 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 0x209f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240f090>, '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 0x240fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409f90>, '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': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', '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 20:35:47 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 20:35:47 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 20:35:47 INFO - Using env: {'DISPLAY': ':0', 20:35:47 INFO - 'HOME': '/home/cltbld', 20:35:47 INFO - 'LANG': 'en_US.UTF-8', 20:35:47 INFO - 'LANGUAGE': 'en_US:en', 20:35:47 INFO - 'LOGNAME': 'cltbld', 20:35:47 INFO - 'MAIL': '/var/mail/cltbld', 20:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:47 INFO - 'MOZ_NO_REMOTE': '1', 20:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:47 INFO - 'NO_EM_RESTART': '1', 20:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:47 INFO - 'PWD': '/builds/slave/test', 20:35:47 INFO - 'SHELL': '/bin/bash', 20:35:47 INFO - 'SHLVL': '1', 20:35:47 INFO - 'TERM': 'linux', 20:35:47 INFO - 'TMOUT': '86400', 20:35:47 INFO - 'USER': 'cltbld', 20:35:47 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:47 INFO - '_': '/tools/buildbot/bin/python'} 20:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:35:47 INFO - Running setup.py (path:/tmp/pip-His6ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:35:47 INFO - Running setup.py (path:/tmp/pip-87NBVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:35:47 INFO - Running setup.py (path:/tmp/pip-ELoFFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:35:47 INFO - Running setup.py (path:/tmp/pip-lOt2qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:35:47 INFO - Running setup.py (path:/tmp/pip-MDGMqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:35:47 INFO - Running setup.py (path:/tmp/pip-d8eGqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:35:47 INFO - Running setup.py (path:/tmp/pip-e2LDzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:35:48 INFO - Running setup.py (path:/tmp/pip-tDTePb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:35:48 INFO - Running setup.py (path:/tmp/pip-ep48RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:35:48 INFO - Running setup.py (path:/tmp/pip-eo6rsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:35:48 INFO - Running setup.py (path:/tmp/pip-ippueM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:35:48 INFO - Running setup.py (path:/tmp/pip-M_mS5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:35:48 INFO - Running setup.py (path:/tmp/pip-15_bJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:35:48 INFO - Running setup.py (path:/tmp/pip-hOJzqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:48 INFO - Running setup.py (path:/tmp/pip-w_oJnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:35:48 INFO - Running setup.py (path:/tmp/pip-g3djRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:35:48 INFO - Running setup.py (path:/tmp/pip-QsuVo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:35:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:35:48 INFO - Running setup.py install for manifestparser 20:35:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:35:48 INFO - Running setup.py install for mozcrash 20:35:48 INFO - Running setup.py install for mozdebug 20:35:49 INFO - Running setup.py install for mozdevice 20:35:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:35:49 INFO - Running setup.py install for mozfile 20:35:49 INFO - Running setup.py install for mozhttpd 20:35:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:35:49 INFO - Running setup.py install for mozinfo 20:35:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:35:49 INFO - Running setup.py install for mozInstall 20:35:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:35:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:35:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:35:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:35:49 INFO - Running setup.py install for mozleak 20:35:49 INFO - Running setup.py install for mozlog 20:35:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:35:49 INFO - Running setup.py install for moznetwork 20:35:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:35:49 INFO - Running setup.py install for mozprocess 20:35:49 INFO - Running setup.py install for mozprofile 20:35:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:35:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:35:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:35:50 INFO - Running setup.py install for mozrunner 20:35:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:35:50 INFO - Running setup.py install for mozscreenshot 20:35:50 INFO - Running setup.py install for moztest 20:35:50 INFO - Running setup.py install for mozversion 20:35:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:35:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:35:50 INFO - Cleaning up... 20:35:50 INFO - Return code: 0 20:35:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35: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')]} 20:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35: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')]} 20:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:50 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 0x209f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240f090>, '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 0x240fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409f90>, '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': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', '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 20:35:50 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 20:35:50 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 20:35:50 INFO - Using env: {'DISPLAY': ':0', 20:35:50 INFO - 'HOME': '/home/cltbld', 20:35:50 INFO - 'LANG': 'en_US.UTF-8', 20:35:50 INFO - 'LANGUAGE': 'en_US:en', 20:35:50 INFO - 'LOGNAME': 'cltbld', 20:35:50 INFO - 'MAIL': '/var/mail/cltbld', 20:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:50 INFO - 'MOZ_NO_REMOTE': '1', 20:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:50 INFO - 'NO_EM_RESTART': '1', 20:35:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:50 INFO - 'PWD': '/builds/slave/test', 20:35:50 INFO - 'SHELL': '/bin/bash', 20:35:50 INFO - 'SHLVL': '1', 20:35:50 INFO - 'TERM': 'linux', 20:35:50 INFO - 'TMOUT': '86400', 20:35:50 INFO - 'USER': 'cltbld', 20:35:50 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:50 INFO - '_': '/tools/buildbot/bin/python'} 20:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:35:50 INFO - Running setup.py (path:/tmp/pip-9SnMDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:35:50 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)) 20:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:35:50 INFO - Running setup.py (path:/tmp/pip-0Xdh8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:35:50 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)) 20:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:35:50 INFO - Running setup.py (path:/tmp/pip-92s3cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:35:50 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)) 20:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:35:50 INFO - Running setup.py (path:/tmp/pip-dq_WhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:35:51 INFO - Running setup.py (path:/tmp/pip-Vk8MU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:35:51 INFO - Running setup.py (path:/tmp/pip-iMPh0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:35:51 INFO - Running setup.py (path:/tmp/pip-pGVEYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:35:51 INFO - Running setup.py (path:/tmp/pip-txBiQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:35:51 INFO - Running setup.py (path:/tmp/pip-XFElyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:35:51 INFO - Running setup.py (path:/tmp/pip-l6G_Q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:35:51 INFO - Running setup.py (path:/tmp/pip-qqAQ82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:35:51 INFO - Running setup.py (path:/tmp/pip-nd5_qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:35:51 INFO - Running setup.py (path:/tmp/pip-slqPAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:35:51 INFO - Running setup.py (path:/tmp/pip-Z4V3o7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:51 INFO - Running setup.py (path:/tmp/pip-69Vi0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:35:51 INFO - Running setup.py (path:/tmp/pip-iGdlI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:35:51 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)) 20:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:35:51 INFO - Running setup.py (path:/tmp/pip-v1jBZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:35:51 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)) 20:35:51 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)) 20:35:51 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)) 20:35:51 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)) 20:35:51 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)) 20:35:51 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)) 20:35:51 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)) 20:35:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:53 INFO - Downloading blessings-1.6.tar.gz 20:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:35:53 INFO - Installing collected packages: blessings 20:35:53 INFO - Running setup.py install for blessings 20:35:53 INFO - Successfully installed blessings 20:35:53 INFO - Cleaning up... 20:35:53 INFO - Return code: 0 20:35:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:35:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:35:53 INFO - Reading from file tmpfile_stdout 20:35:53 INFO - Current package versions: 20:35:53 INFO - argparse == 1.2.1 20:35:53 INFO - blessings == 1.6 20:35:53 INFO - blobuploader == 1.2.4 20:35:53 INFO - docopt == 0.6.1 20:35:53 INFO - functools32 == 3.2.3-2 20:35:53 INFO - jsonschema == 2.5.1 20:35:53 INFO - manifestparser == 1.1 20:35:53 INFO - mozInstall == 1.13 20:35:53 INFO - mozcrash == 1.0 20:35:53 INFO - mozdebug == 0.1 20:35:53 INFO - mozdevice == 0.51 20:35:53 INFO - mozfile == 1.2 20:35:53 INFO - mozhttpd == 0.7 20:35:53 INFO - mozinfo == 0.10 20:35:53 INFO - mozleak == 0.1 20:35:53 INFO - mozlog == 3.5 20:35:53 INFO - moznetwork == 0.27 20:35:53 INFO - mozprocess == 0.25 20:35:53 INFO - mozprofile == 0.28 20:35:53 INFO - mozrunner == 6.13 20:35:53 INFO - mozscreenshot == 0.1 20:35:53 INFO - mozsystemmonitor == 0.3 20:35:53 INFO - moztest == 0.8 20:35:53 INFO - mozversion == 1.4 20:35:53 INFO - psutil == 3.1.1 20:35:53 INFO - requests == 1.2.3 20:35:53 INFO - wsgiref == 0.1.2 20:35:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:53 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 0x209f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240f090>, '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 0x240fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409f90>, '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': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', '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 20:35:53 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 20:35:53 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 20:35:53 INFO - Using env: {'DISPLAY': ':0', 20:35:53 INFO - 'HOME': '/home/cltbld', 20:35:53 INFO - 'LANG': 'en_US.UTF-8', 20:35:53 INFO - 'LANGUAGE': 'en_US:en', 20:35:53 INFO - 'LOGNAME': 'cltbld', 20:35:53 INFO - 'MAIL': '/var/mail/cltbld', 20:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:53 INFO - 'MOZ_NO_REMOTE': '1', 20:35:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:53 INFO - 'NO_EM_RESTART': '1', 20:35:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:53 INFO - 'PWD': '/builds/slave/test', 20:35:53 INFO - 'SHELL': '/bin/bash', 20:35:53 INFO - 'SHLVL': '1', 20:35:53 INFO - 'TERM': 'linux', 20:35:53 INFO - 'TMOUT': '86400', 20:35:53 INFO - 'USER': 'cltbld', 20:35:53 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:53 INFO - '_': '/tools/buildbot/bin/python'} 20:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:53 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)) 20:35:53 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)) 20:35:53 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)) 20:35:53 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)) 20:35:53 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)) 20:35:53 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)) 20:35:53 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)) 20:35:53 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)) 20:35:53 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)) 20:35:53 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20:35:54 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)) 20:35:54 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)) 20:35:54 INFO - Installing collected packages: simplejson 20:35:54 INFO - Running setup.py install for simplejson 20:35:55 INFO - building 'simplejson._speedups' extension 20:35:55 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 20:35:55 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 20:35:55 INFO - Successfully installed simplejson 20:35:55 INFO - Cleaning up... 20:35:55 INFO - Return code: 0 20:35:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:35: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')]} 20:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35: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')]} 20:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2268a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240f090>, '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 0x240fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409f90>, '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': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', '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 20:35: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', 'jsonschema'] in /builds/slave/test/build 20:35: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 jsonschema 20:35:55 INFO - Using env: {'DISPLAY': ':0', 20:35:55 INFO - 'HOME': '/home/cltbld', 20:35:55 INFO - 'LANG': 'en_US.UTF-8', 20:35:55 INFO - 'LANGUAGE': 'en_US:en', 20:35:55 INFO - 'LOGNAME': 'cltbld', 20:35:55 INFO - 'MAIL': '/var/mail/cltbld', 20:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:55 INFO - 'MOZ_NO_REMOTE': '1', 20:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:55 INFO - 'NO_EM_RESTART': '1', 20:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:55 INFO - 'PWD': '/builds/slave/test', 20:35:55 INFO - 'SHELL': '/bin/bash', 20:35:55 INFO - 'SHLVL': '1', 20:35:55 INFO - 'TERM': 'linux', 20:35:55 INFO - 'TMOUT': '86400', 20:35:55 INFO - 'USER': 'cltbld', 20:35:55 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:55 INFO - '_': '/tools/buildbot/bin/python'} 20:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:35:56 INFO - Cleaning up... 20:35:56 INFO - Return code: 0 20:35:56 INFO - Running post-action listener: _resource_record_post_action 20:35:56 INFO - Running post-action listener: _start_resource_monitoring 20:35:56 INFO - Starting resource monitoring. 20:35:56 INFO - [mozharness: 2017-09-21 03:35:56.249592Z] Finished create-virtualenv step (success) 20:35:56 INFO - [mozharness: 2017-09-21 03:35:56.250110Z] Running install step. 20:35:56 INFO - Running pre-action listener: _resource_record_pre_action 20:35:56 INFO - Running main action method: install 20:35:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:35:56 INFO - Reading from file tmpfile_stdout 20:35:56 INFO - Detecting whether we're running mozinstall >=1.0... 20:35:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:35:56 INFO - Reading from file tmpfile_stdout 20:35:56 INFO - Output received: 20:35:56 INFO - Usage: mozinstall [options] installer 20:35:56 INFO - Options: 20:35:56 INFO - -h, --help show this help message and exit 20:35:56 INFO - -d DEST, --destination=DEST 20:35:56 INFO - Directory to install application into. [default: 20:35:56 INFO - "/builds/slave/test"] 20:35:56 INFO - --app=APP Application being installed. [default: firefox] 20:35:56 INFO - mkdir: /builds/slave/test/build/application 20:35:56 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'] 20:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:36:14 INFO - Reading from file tmpfile_stdout 20:36:14 INFO - Output received: 20:36:14 INFO - /builds/slave/test/build/application/firefox/firefox 20:36:14 INFO - Running post-action listener: _resource_record_post_action 20:36:14 INFO - [mozharness: 2017-09-21 03:36:14.255184Z] Finished install step (success) 20:36:14 INFO - [mozharness: 2017-09-21 03:36:14.255434Z] Running setup-mitmproxy step. 20:36:14 INFO - Running pre-action listener: _resource_record_pre_action 20:36:14 INFO - Running main action method: setup_mitmproxy 20:36:14 INFO - Skipping: mitmproxy is not required 20:36:14 INFO - Running post-action listener: _resource_record_post_action 20:36:14 INFO - [mozharness: 2017-09-21 03:36:14.256564Z] Finished setup-mitmproxy step (success) 20:36:14 INFO - [mozharness: 2017-09-21 03:36:14.256783Z] Running run-tests step. 20:36:14 INFO - Running pre-action listener: _resource_record_pre_action 20:36:14 INFO - Running pre-action listener: _set_gcov_prefix 20:36:14 INFO - Running main action method: run_tests 20:36:14 WARNING - Try message not found. 20:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:36:14 INFO - Python 2.7.3 20:36:14 INFO - Return code: 0 20:36:14 INFO - grabbing minidump binary from tooltool 20:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:14 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 0x240f090>, '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 0x240fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2409f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:36:14 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 20:36:14 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 20:36:14 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 20:36:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:36:14 INFO - Return code: 0 20:36:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:36:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:36:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:36:14 INFO - ENV: RUST_BACKTRACE is now full 20:36:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:36:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-081 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:36:14 INFO - Using env: {'DISPLAY': ':0', 20:36:14 INFO - 'HOME': '/home/cltbld', 20:36:14 INFO - 'LANG': 'en_US.UTF-8', 20:36:14 INFO - 'LANGUAGE': 'en_US:en', 20:36:14 INFO - 'LOGNAME': 'cltbld', 20:36:14 INFO - 'MAIL': '/var/mail/cltbld', 20:36:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:36:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:14 INFO - 'MOZ_NO_REMOTE': '1', 20:36:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:14 INFO - 'NO_EM_RESTART': '1', 20:36:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:14 INFO - 'PWD': '/builds/slave/test', 20:36:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:36:14 INFO - 'RUST_BACKTRACE': 'full', 20:36:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:36:14 INFO - 'SHELL': '/bin/bash', 20:36:14 INFO - 'SHLVL': '1', 20:36:14 INFO - 'TERM': 'linux', 20:36:14 INFO - 'TMOUT': '86400', 20:36:14 INFO - 'USER': 'cltbld', 20:36:14 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:14 INFO - '_': '/tools/buildbot/bin/python'} 20:36:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:36:14 INFO - mozversion application_buildid: 20170921022004 20:36:14 INFO - mozversion application_changeset: 47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf 20:36:14 INFO - mozversion application_display_name: Nightly 20:36:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:36:14 INFO - mozversion application_name: Firefox 20:36:14 INFO - mozversion application_remotingname: firefox 20:36:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:36:14 INFO - mozversion application_vendor: Mozilla 20:36:14 INFO - mozversion application_version: 57.0a1 20:36:14 INFO - mozversion platform_buildid: 20170921022004 20:36:14 INFO - mozversion platform_changeset: 47f7b6c64265bc7bdd22eef7ab71abc97cf3f8bf 20:36:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:36:14 INFO - mozversion platform_version: 57.0a1 20:36:14 INFO - using testdate: 1505964974 20:36:14 INFO - actual date: 1505964974 20:36:14 INFO - starting webserver on 'localhost:40558' 20:36:14 INFO - SUITE-START | Running 2 tests 20:36:14 INFO - TEST-START | dromaeo_css 20:36:14 INFO - Initialising browser for dromaeo_css test... 20:36:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40558/getInfo.html -profile /tmp/tmprQAYNc/profile 20:36:14 INFO - TEST-INFO | started process 29776 (/builds/slave/test/build/application/firefox/firefox http://localhost:40558/getInfo.html) 20:36:20 INFO - TEST-INFO | 29776: exit 0 20:36:20 INFO - Browser initialized. 20:36:20 INFO - Running cycle 1/1 for dromaeo_css test... 20:36:20 INFO - Using env: {'DISPLAY': ':0', 20:36:20 INFO - 'HOME': '/home/cltbld', 20:36:20 INFO - 'JSGC_DISABLE_POISONING': '1', 20:36:20 INFO - 'LANG': 'en_US.UTF-8', 20:36:20 INFO - 'LANGUAGE': 'en_US:en', 20:36:20 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:36:20 INFO - 'LOGNAME': 'cltbld', 20:36:20 INFO - 'MAIL': '/var/mail/cltbld', 20:36:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:36:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:36:20 INFO - 'MOZ_CRASHREPORTER': '1', 20:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:20 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:36:20 INFO - 'MOZ_NO_REMOTE': '1', 20:36:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:20 INFO - 'NO_EM_RESTART': '1', 20:36:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:20 INFO - 'PWD': '/builds/slave/test', 20:36:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:36:20 INFO - 'RUST_BACKTRACE': 'full', 20:36:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:36:20 INFO - 'SHELL': '/bin/bash', 20:36:20 INFO - 'SHLVL': '1', 20:36:20 INFO - 'TERM': 'linux', 20:36:20 INFO - 'TMOUT': '86400', 20:36:20 INFO - 'USER': 'cltbld', 20:36:20 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:20 INFO - '_': '/tools/buildbot/bin/python'} 20:36:20 INFO - TEST-INFO | started process 30009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprQAYNc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:36:21 INFO - PID 30009 | 20:36:21 INFO - PID 30009 | (/builds/slave/test/build/application/firefox/firefox:30061): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:36:21 INFO - PID 30009 | 20:36:31 INFO - PID 30009 | RSS: Main: 147464192 20:36:31 INFO - PID 30009 | 20:39:28 INFO - PID 30009 | Cycle 1(1): loaded http://localhost:40558/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40558/tests/dromaeo/cssquery-ext.html) 20:39:30 INFO - PID 30009 | RSS: Main: 148590592 20:39:30 INFO - PID 30009 | 20:42:31 INFO - PID 30009 | Cycle 1(1): loaded http://localhost:40558/tests/dromaeo/cssquery-ext.html (next: http://localhost:40558/tests/dromaeo/cssquery-jquery.html) 20:42:32 INFO - PID 30009 | RSS: Main: 148959232 20:42:32 INFO - PID 30009 | 20:45:34 INFO - PID 30009 | Cycle 1(1): loaded http://localhost:40558/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40558/tests/dromaeo/cssquery-mootools.html) 20:45:34 INFO - PID 30009 | RSS: Main: 150593536 20:45:34 INFO - PID 30009 | 20:48:36 INFO - PID 30009 | Cycle 1(1): loaded http://localhost:40558/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40558/tests/dromaeo/cssquery-prototype.html) 20:48:36 INFO - PID 30009 | RSS: Main: 148578304 20:48:36 INFO - PID 30009 | 20:51:39 INFO - PID 30009 | Cycle 1(1): loaded http://localhost:40558/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40558/tests/dromaeo/cssquery-yui.html) 20:51:40 INFO - PID 30009 | RSS: Main: 150568960 20:51:40 INFO - PID 30009 | 20:54:42 INFO - PID 30009 | Cycle 1(1): loaded http://localhost:40558/tests/dromaeo/cssquery-yui.html (next: http://localhost:40558/tests/dromaeo/cssquery-dojo.html) 20:54:42 INFO - PID 30009 | RSS: Main: 152936448 20:54:42 INFO - PID 30009 | 20:54:42 INFO - PID 30009 | __start_tp_report 20:54:42 INFO - PID 30009 | _x_x_mozilla_page_load 20:54:42 INFO - PID 30009 | _x_x_mozilla_page_load_details 20:54:42 INFO - PID 30009 | |i|pagename|runs| 20:54:42 INFO - PID 30009 | |0;dojo.html;3903.199844031973;3917.0599056226497;3921;3935.488386509755;3961.1681546875157;6269.738110182515;6307.243130824308;6335.809925702236;6404.359564043593;6459.935400645993;6397.58415702979;6397.744090236385;6422.486201103912;6423.486121110312;6425.100485931974;5607.327120745516;5641.464060914217;5672.971635141818;5743.626664266831;5766.855828604276;5739.3399759027825;5741.253637027202;5786.479216870481;5825.359210486843;5841.8831623367505;747.0518393828099;5666.943330566724;5721.771129154849;5824.563157763185;5831.387704291052;5612.579056570733;5633.690147041911;5638.2670252866865;5652.660840349592;5772.624779389368;5562.554995600382;5648.096304591246;5697.886042279172;5727.799527016535;5734.741936612821;6264.655443950581;6328.841778955517;6337.04944258365;6358.745650173987;6384.808455746335;6842.589444633338;6857.27998560154;6944.4444444444825;6944.965275173592;6948;6828.897566536506;6889.862202755967;6908.274631163706;6993.580385176906;6997.1253593300835;6261.812145635638;6275.152854364694;6276.686165691697;6277.529185311074;6287.685615719196;6977.546459480118;7162.283771622796;7162.570245785269;7183.96408017967;7191.7842464726145;6819.659017049128;6820.249772525019;6896.896546551806;6914.688839002257;6933.618650974245;6819;6933.237343892168;6963.059986901703;7038;7068.5758854468895;6868;6868.690908909111;6907.447404207652;6907.965460172667;6936.861262774716;6887.2079710832895;6926.168859736763;6961.895571566431;6986.161660600659;7004.92995070053;4928.827491037797;4952.479989601112;4995.9500404996215;5005.399352077774;5015.247712843103;4456.398386217884;4467.776611169428;4490.730556166641;4577.1074640444795;4577.542245775396;6346.2384513857705;6388.712507937061;6396;6398.392152745481;6404.519661025442;6860.3139686031;6863.210730766026;6958.826029349206;6963.721451141999;6963.82590435233;6291.779787707408;6306.054091886253;6317.557770955989;6390.808275751735;6414.711337989708;5416.133418652997;5501.229827824108;5502.504774570228;5539.473749993744;5562.888742225133;7202.675879585431;7206.531575447579;7213.783586492414;7232.529885557422;7246.130464344313;6765.391114799691;6774.187097548326;6830.21452532965;6916.273791251846;6975.232724400211;7135;7252.311030452099;7261.164966028974;7262.092238470192;7279.4540409470565;6795.422389096784;6803.183617965876;6842.213145488333;6894.689738961659;6924;6791.966040169767;6872.725090996504;6894.482913781587;6924.272951340036;6952.826179345557;6692.966535167293;6701.698423570853;6702.162229721285;6773.898391524032;6788;6664.366885145903;6665.933450647873;6667.633280169637;6748.865022699617;6762.323767623395;6531.804045878631;6626.27111017778;6628.436582890508;6688.297728738413;6695.330466953265;6603.537752357289;6661.367170118831;6703.966480167568;6715.3620406061345;6743.15710536183;6455.9677201613695;6509.674516274073;6526.477881769352;6560.507961902972;6571.704273307617 20:54:42 INFO - PID 30009 | |1;ext.html;922.6217250927119;945.3382632157492;955.2405837359299;999.7950420163867;999.8000399920018;43445;44256.3361549577;44299;44371;44451.1109777805;42025.78987105068;42280.78859605706;44016.45942392017;44596.554034459645;44839.327410088874;8498.490090594583;8621.870671939925;8624;8624.094470080614;8626.3098952084;8425.83148337033;8516.403851730382;8554.61504232311;8579.485230886135;8580;8537.146285371444;8540.145985401472;8554.61504232308;8575.785605359884;8613.913860861405;8440;8540.145985401441;8558.400911936167;8563;8576.656933722643;8388.622511986976;8427.70503032397;8471.025832029272;8477.703280385218;8492.575371231476;41243.7937810312;41515.377269340985;41559;41652.37521437181;41668.79165604183;3719.8326075326404;3742.5883152853166;3753.5120434343635;3754.455603937414;3756.417755247941;33045.17387065318;33099.66900331014;33152;33251.5012274816;33287.6671233287;5340.385855626614;5492.780288788484;5496.422875598045;5511.366192887789;5514.696691681956;210120;215529;219068.9046554773;226024;226142;53239.733801330745;53501;53660.73169634127;53747.73126134344;53749.462505375224;56358;56393.43606563964;56588;56593.71703141458;56783.71608141933;15156;15158.545243642708;15291.770623440658;15294.770578441332;15340.92329538345;12328;12342.197757145757;12425.502979880885;12432.12975091735;12439.253644781342;14003.859961400256;14141.505047323295;14201.715965680629;14260.857391425952;14353.569392918229;5481.725913704299;5559.388467268597;5594.482482882638;5629.54963602919;5679.176519404746;1092.7650555130685;1094.7372630568607;1105.5135740274254;1109.046220250584;1117.0951529261324;24523;24805.5038899221;24810.131645392325;24924.875375623367;24983.62524562133;1200.1299058182922;1208.7763763703567;1209.9455524501418;1214.738831151289;1224.4673566998383;13408.865911340958;13434.126781759154;13440.596782096552;13483.460661573623;13497.797533037012;246491;276322;285441;287117;287685;57028;57731.42268577345;57839.71080144656;57974.7101264491;58003;1507.5628067860416;1543.6218126559065;1549.4886687393134;1551.6974190032836;1554.9378024879104;24673.100096600923;24702.011919523018;24736.304017155537;24749.33405165923;24957.625635615845;39745;41325.586744132175;41435.585644143175;41497.585024149375;41560.376594351714;234278;234566;234841;234959;235336;33328;33716.83141584374;34019.14952126217;34258;36402.635973639924;46771;47047;47099;47408.62956852213;47614;34497.65502344944;34843.477347839296;34897.30205395827;35082.298354033286;35621.82189089038;33440;33971.320573587895;34778.82610587032;34827.30345393129;34870.825645872625;39425.40861887131;39780.60219397769;40310;40329.39505907355;40393.39409908913;32627;32989.67010329866;33029.17427064246;33106.50340244947;33573.83213083919;24742.134025309748;25120.11599130036;25386.74613253844;25408.491830162922;25420.364490887874 20:54:42 INFO - PID 30009 | |2;jquery.html;619.845038740315;624.6814124796352;624.7251209467834;636.8503401700602;645.4642646603319;22485.21301754435;23218.88390558049;23989.040438382464;23998.76001239987;24047.75952240477;24493.510129797392;25637.87181064092;25695.743042569615;25774.097906573275;25776;6522.641254731;6629.6685165741765;6654.567453115532;6713.328667133296;6715.294894036129;6913.101296831405;6948.5830850148905;6950.652467376636;6955.826104347381;6958;6900.171979362483;6913.585184888898;6917.688704008307;6924.446044316468;6931.480138989571;6636.668166591675;6880.311968803129;6888.793336199922;6891.483138764563;6917.9308206917785;6398.392152745481;6417.518686098515;6419.967900160469;6433.453156481658;6438.839029024265;28937.710622893923;29356.119316420543;29375.97184098546;29390.85304573485;29412.558811617844;2306.884655767222;2334.7665233476687;2336.4158960259933;2339.017612602711;2340.0990618611786;19466.513337166543;20367.388978330673;20572.897135514377;20601.278955236645;20643.17427302906;2528.898844046236;2543.186180422266;2588.3399733067945;2596.1302963507246;2601.7008044074983;140738.29630851882;145923;161537;166663;167342.99999999878;15726.842731572766;15849;15920.601984950237;15953.122578258308;16677.24952377146;26010.479790404086;26060.478790424084;26065.218043458728;26094.217173484827;26184.476310473685;10403.375797452178;10614.681559553226;10656.413897235727;10660.520276587573;10711.410872402093;9383.859242111374;9482.478463684563;9535.809283814424;9562.187214086742;9630.518474076269;9604.51977401141;9726.756831079138;9873.75315617101;9907.653232136985;10020.599176032876;2772.2930652683435;2829.8160619559662;2841.289677580605;2867.7132286771157;2928.8974885878893;1022.2384323678758;1048.2400259811575;1053.3837704942694;1069.4438891776233;1072.1690689715533;21536.78463215379;21714.674279885814;21834.454138646663;22045.889770551046;22055.11779528801;1109.6227282723912;1116.4473585575192;1117.3128525956479;1121.7588218533056;1122.1191364778772;11650.475728592064;11955.282683039046;11977.760444791056;12028.097892658086;12037.217580857216;559893;583468;604274;605846;608111;127463;133077;133910.33044834714;134549.3272533631;135098.32450837683;1120.7758448310371;1218.7501562179732;1242.8322176506238;1254.8494180698192;1279.8592154862959;22354.552908942056;22388.88805555962;22547.549049019257;22588;22618.43453913665;63169.36830631635;63425.68287158535;64141.35858641541;65235.67382163059;65509.672451639344;75865.6206718963;76275;76747;77068;79619;15475.845241547891;15569.610759730644;15639.68720625604;15803.920980395025;15879.444219452263;24460.87769561141;24486.26541203767;24600.753992459846;24681.136160234306;24731.134410296272;19692;19937.302194423126;20116.497087572927;20119.39641810748;20372.490687732927;17409.912950435166;17558.29766809313;17682.115894205497;18019.008954507626;18056.90971545134;20281.79718202799;20391.4902127448;20463.181472740922;20612;20614.58770824605;14530.782038269223;15278.77081843751;15305.387784488941;15336.309866055832;15474.458393956607;19786.307479238156;20015.499612509804;20027.098780554617;20030;20048.298309559097 20:54:42 INFO - PID 30009 | |3;mootools.html;1437.8058962040125;1470.8747807926945;1476.379920433418;1492.1643879427525;1502.9624259393513;17238.655226895455;17891.73162402565;17899.910500447513;17910.194041268143;17935.64128717425;17191.484255472325;17366.82633173668;17372.913135434304;17392.652146957054;17410.564735881577;2960.4523163214767;2973.524236122221;3017.803842750225;3019.411214813112;3020.6526249481262;2913.3736246706953;2950.247686839853;2956.896508622199;2957;2965.303153758865;2789.888404463819;2934.7065293470696;3001.4897467430587;3013.6383633963956;3015.8190508569555;2936.2512559297456;2951.070412819955;2951.7343439090587;2957.053742802304;2974.5686875403053;2843.473957317882;2844.3884564818454;2876.7698584113223;2878.0358579875765;2883.3656595549155;16378.754318685229;16748.330066797313;16804.32782688703;16876.915615421967;16883.324667013305;8741.475511469269;9035.32235082365;9058.365914385995;9066.818663626691;9068.8639670405;5399.544291653306;5683.971580142114;5690.089585666274;5745.138229265602;5787.1608616750755;2020.1818263603263;2024.8582599218062;2040.1329434990218;2040.7245021922;2069.2343832781967;31542.369152617048;31794.04617861491;31842.84078579592;31847.36305273905;31860.522092168638;7461.104667439833;7547.849043019109;7576.772696819105;7699.884501732478;7754.224577542201;19451.3192038278;19482.902585487267;19520.60958780845;19557.804421955883;19560.8043919559;8695.08701586337;8835.69075082369;8855.911440885637;8911.287097032222;8911.821763564822;7914.722984695623;7954.164812694699;7992;8032.3172530334405;8161.469504482189;5805.332386775491;5848.912266316009;5866;5923.4076592340425;6075.878482430327;1551.3019141386421;1593.2272847668871;1641.5896025993502;1676.7568702538063;1688.375301138562;925.6112432778249;937.6202637931649;942.641796117471;945.163530275711;956.7512446763892;9391.483468409304;9658.661946831828;9694.660686875926;9794.216462682969;9799.363041402286;1028.1928685981468;1054.1830081686753;1056.0812093478723;1073.4900922061959;1076.230495195923;6129.754809807647;6212.534059945522;6365.713542890581;6371.490280777527;6438.517111216677;25187;25755.22734317936;25899.223023308954;26356.209313720618;26385.604215936775;24341.51316973686;25519.87240063788;25625;25633.61549576758;25835.870820645778;12305.323207223688;12476.18904771187;12659.936700316439;12740.617781466572;12897.613071607866;9947.900520994697;9952.10431061208;10006.69979900604;10039.949800250952;10066.44634545107;21578.784212157676;21679.241226556995;21731.456713582287;21868.781312186675;22265.44336391603;22507.887460562593;22637.320880373616;22840.543189136457;22929.31212063641;23145.65281520745;13158.80261796093;13350.399232034388;13360.265185414895;13496.5276215332;13514.72970540564;15676.764848527053;15796.60508487251;15934.442294519637;15945.282462289457;15953;12496.375181240719;12693.555725549562;12740.235585864877;12825.679358016125;13026.869731302566;12198.451069702061;12315.568955086528;12374.13381063317;12768.553100641433;12828.29444380568;10665.093467055387;10756.408397538211;10886.891131088905;10960.123190144928;10974.780504389708;8006.59967001636;8087.353011759163;8158.755237342889;8178.223068808692;8306;8178.877316840371;8211.260986511243;8244.175582441947;8333.6666533338;8387.412881098264 20:54:42 INFO - PID 30009 | |4;prototype.html;548.2516365161556;565.8585353661584;572.1332181744657;583.9007368747313;591.742591972492;6161.661108639023;6243.46930510906;6266.248050233972;6272.466840318572;6315.526335524831;6147.508199344053;6158.907616385746;6167.506599472043;6171.197744293247;6180.814575562729;5131.230315452674;5132.923006154911;5137.691738495683;5169.991851588923;5175.508326708957;4818.710877347353;4997.325361076245;5043.167877300241;5147.1764517677175;5166.276721259027;4952.727599981999;4968.701877887338;5011.699298042111;5013.674111182761;5036.194208926572;4996.925046124311;5000.299958005882;5006;5022.171341728647;5038.823641172541;4424.159409712144;4539.455265368177;4550.8862278442975;4557.134144512532;4576.199165146119;6163.691815409256;6192.783252586138;6201.224846894138;6210.906836397413;6221.346758590328;5916.792912248094;5940.227770389822;5945.910811337833;5952.73212705425;5960.1357803118735;6666.933330666729;6703.296153903819;6742.49431292655;6747.460203183734;6747.763828266036;4712.764361781898;4985.700857948498;4991.850244492671;4998.450170481244;5036.194208926554;6793.150856142982;6813.148356455443;6835.035679305991;6857.628474305109;6946.93053069473;5169.81905633301;5214.139666954986;5220.634555581149;5290.576753859682;5294.205869119586;5230.529252367305;5320.627556071038;5330.773921997962;5369.838904832861;5385.649932754437;5844.590878638454;5846;5879.176915231871;5892.234009578813;5953.618552579003;6720.966395167993;6730.596164230064;6733.42765864907;6741.1910570731825;6777.81388257053;1811.3750755989163;1812.0248928667552;1840.1351364858494;1847.1528471528472;1849.3817909329337;1263.4819723913151;1288.8775566321185;1312.7702652036046;1316.3813007886279;1329.6171981139507;6063.848403789941;6196.566240363221;6197.101420294032;6266.905996410058;6302.684865756693;6780.864382712318;6794.558353706993;6808.523403361717;6810.727570897108;6823;6271.43557079865;6273.780417685359;6283.120363149163;6286.371362863769;6291.591046581958;3595.94606080909;3602.4416215486117;3619.262753878153;3633.927321453609;3634.727395445352;6905.620190889449;6929.411000065051;7028.367446929801;7045.260247674023;7088.751893683696;6957.79126626202;6966.164060312795;6998.06081445794;6998.440124790106;7015.263397343308;6968.686409111703;6984.939442864367;7025.962470883591;7072.328128827753;7096.716131354688;6747.156605424322;6758.898616520658;6814.693338799865;6833.487488438486;6858.588484690935;6697.966510167418;6736.528443009139;6737.797866064026;6765.221999470124;6772.255051944184;6836.760713375008;6903.861922761416;6934.757283495053;6951.721931122698;6996.545224560387;5144.0997825381155;5175.585953123817;5193.506616871542;5202.73986300691;5210.036143313499;6632.635205063768;6740.427063699641;6778.3221677831825;6787.253402125861;6857.177138743184;6302.613425046482;6420.6789660517725;6440.774572890114;6632.436242919406;6642.634655093823;6526.184226971629;6526.804195874131;6557.639329836714;6581.60308547006;6585.5719378240265;6479.639275751956;6538.215414150142;6552.3775241352;6561.179852518435;6590.604563726191;6549.4760419167305;6566.737330506726;6626.53614246998;6701.597904125768;6748.561343512656;6372.426481616677;6437.388448097423;6494;6494.512911531559;6563.835904102436 20:54:42 INFO - PID 30009 | |5;yui.html;972.1105188752297;978.7846673731779;982.7395740128862;989.2877128467501;1002.0880998291553;18209.18058687359;18500.537486562844;18521.629567408643;18566.350177743763;18598.163082661278;19022.524436889085;19142.71285930712;19197.712034319495;19216.42350729477;19302.903485482588;1028.4600584693057;1051.6950084475493;1052.4001319248032;1053.0680347892094;1053.0838170791385;1076.6554702495205;1079.7408621930758;1081.3511892864258;1082.4154956323616;1084.9403282819442;1096.627146770098;1123.9325640461557;1124.9943750281236;1125.3754166437625;1125.5497800879673;1114.2645853736535;1118.848955391024;1119.289251325406;1121.43928035982;1124.876263611002;816.8652172391548;818.6193420059701;818.6684392820918;820.0815087102484;826.8594338962391;18901.243950241973;18952.90523547387;21708.674369884466;22132.66800997986;22242.443938901655;22702.77297227023;23247.070117195293;23696.76303236963;23896.641550376757;24105.276841694777;18589.256429742793;18970.336038238594;19247.903760481247;19316.517087072796;19369.22523099074;3966.841326346943;3976.5426975897853;3985.442038114666;3990.501187351581;3998.300297447964;115962.42018789936;158896;160048;161072;163230.18384908236;18522.536936576424;18679;18905.14926828296;18916.527086822938;19346.903265483863;34644.826775866466;34741.131471712906;34747.82626086853;34767.65232347695;34860.82569587136;9963.80072398548;9989.450580218012;10039.548220330104;10048.949755251177;10069.295149339476;4434.157510073076;4466.486354069259;4531.56950089741;4536.410266665378;4540.659450541222;6149;6298.464630506367;6331.841703957346;6348;6358.1416508771645;1249.1068885746554;1268.0869773762877;1271.841019872516;1280.8270883430805;1282.6280378690262;705.8905869590221;731.2322061835052;739.0318682525908;740.3373980287612;753.1940823318996;13634.727305453835;13764.518241861688;14043.859561404255;14609.415623375158;14700.779488307684;709.9183593886665;719.7552832037028;720.3804727933973;721.6103304215769;727.9672414741349;6287.874242515124;6296.118543403835;6304.747810087637;6348.746050158034;6474.287828338879;146127;146410;148431;150272;153663;111440;121758.3912080434;125431.3728431352;133251;137588.31205843907;112796.43601781939;112930.43534782274;114744;115802;118065.40967295281;14271;14335.283235838375;14629.561113166623;14744.48394306237;14776.261186940395;52473;52840.73579632231;53620.1956970638;53757;54739.45260547344;70873.29126708666;70988.64505677439;71573.64213179109;73557;73572.63213683898;19087.42737717871;19245.13396897115;19340.4197874064;19344.8065519343;19418.514537136685;21862.23482178116;22820.88589557108;23009.424764381023;23010.19464318741;23078.307650770505;19365.225390984768;19562.510937226114;19568.510787230432;19829.702554461404;19912.303069392503;19018.334358297394;19262.518437039187;19388.903055484632;19407.3207437739;19424.931628759987;20641.58716825685;20682.482937926674;20974.475638108557;21037;21315;14573.781393279321;14654.120752754869;14701.191434470778;14706.926465367605;14843.554693359216;14573;14709;14774.48289309869;14809.185494797459;14829.92585037111 20:54:42 INFO - PID 30009 | __end_tp_report 20:54:42 INFO - PID 30009 | __start_cc_report 20:54:42 INFO - PID 30009 | _x_x_mozilla_cycle_collect,269 20:54:42 INFO - PID 30009 | __end_cc_report 20:54:42 INFO - PID 30009 | __startTimestamp1505966082277__endTimestamp 20:54:42 INFO - PID 30009 | 20:54:42 INFO - PID 30009 | ------- Summary: start ------- 20:54:42 INFO - PID 30009 | Number of tests: 6 20:54:42 INFO - PID 30009 | 20:54:42 INFO - PID 30009 | [#0] dojo.html Cycles:165 Average:6318.56 Median:6628.44 stddev:888.21 (13.4%) stddev-sans-first:870.49 20:54:42 INFO - PID 30009 | Values: 3903.2 3917.1 3921.0 3935.5 3961.2 6269.7 6307.2 6335.8 6404.4 6459.9 6397.6 6397.7 6422.5 6423.5 6425.1 5607.3 5641.5 5673.0 5743.6 5766.9 5739.3 5741.3 5786.5 5825.4 5841.9 747.1 5666.9 5721.8 5824.6 5831.4 5612.6 5633.7 5638.3 5652.7 5772.6 5562.6 5648.1 5697.9 5727.8 5734.7 6264.7 6328.8 6337.0 6358.7 6384.8 6842.6 6857.3 6944.4 6945.0 6948.0 6828.9 6889.9 6908.3 6993.6 6997.1 6261.8 6275.2 6276.7 6277.5 6287.7 6977.5 7162.3 7162.6 7184.0 7191.8 6819.7 6820.2 6896.9 6914.7 6933.6 6819.0 6933.2 6963.1 7038.0 7068.6 6868.0 6868.7 6907.4 6908.0 6936.9 6887.2 6926.2 6961.9 6986.2 7004.9 4928.8 4952.5 4996.0 5005.4 5015.2 4456.4 4467.8 4490.7 4577.1 4577.5 6346.2 6388.7 6396.0 6398.4 6404.5 6860.3 6863.2 6958.8 6963.7 6963.8 6291.8 6306.1 6317.6 6390.8 6414.7 5416.1 5501.2 5502.5 5539.5 5562.9 7202.7 7206.5 7213.8 7232.5 7246.1 6765.4 6774.2 6830.2 6916.3 6975.2 7135.0 7252.3 7261.2 7262.1 7279.5 6795.4 6803.2 6842.2 6894.7 6924.0 6792.0 6872.7 6894.5 6924.3 6952.8 6693.0 6701.7 6702.2 6773.9 6788.0 6664.4 6665.9 6667.6 6748.9 6762.3 6531.8 6626.3 6628.4 6688.3 6695.3 6603.5 6661.4 6704.0 6715.4 6743.2 6456.0 6509.7 6526.5 6560.5 6571.7 20:54:42 INFO - PID 30009 | 20:54:42 INFO - PID 30009 | [#1] ext.html Cycles:180 Average:42181.75 Median:3731.21 stddev:63718.50 (1707.7%) stddev-sans-first:63821.94 20:54:42 INFO - PID 30009 | Values: 922.6 945.3 955.2 999.8 999.8 43445.0 44256.3 44299.0 44371.0 44451.1 42025.8 42280.8 44016.5 44596.6 44839.3 8498.5 8621.9 8624.0 8624.1 8626.3 8425.8 8516.4 8554.6 8579.5 8580.0 8537.1 8540.1 8554.6 8575.8 8613.9 8440.0 8540.1 8558.4 8563.0 8576.7 8388.6 8427.7 8471.0 8477.7 8492.6 41243.8 41515.4 41559.0 41652.4 41668.8 3719.8 3742.6 3753.5 3754.5 3756.4 33045.2 33099.7 33152.0 33251.5 33287.7 5340.4 5492.8 5496.4 5511.4 5514.7 210120.0 215529.0 219068.9 226024.0 226142.0 53239.7 53501.0 53660.7 53747.7 53749.5 56358.0 56393.4 56588.0 56593.7 56783.7 15156.0 15158.5 15291.8 15294.8 15340.9 12328.0 12342.2 12425.5 12432.1 12439.3 14003.9 14141.5 14201.7 14260.9 14353.6 5481.7 5559.4 5594.5 5629.5 5679.2 1092.8 1094.7 1105.5 1109.0 1117.1 24523.0 24805.5 24810.1 24924.9 24983.6 1200.1 1208.8 1209.9 1214.7 1224.5 13408.9 13434.1 13440.6 13483.5 13497.8 246491.0 276322.0 285441.0 287117.0 287685.0 57028.0 57731.4 57839.7 57974.7 58003.0 1507.6 1543.6 1549.5 1551.7 1554.9 24673.1 24702.0 24736.3 24749.3 24957.6 39745.0 41325.6 41435.6 41497.6 41560.4 234278.0 234566.0 234841.0 234959.0 235336.0 33328.0 33716.8 34019.1 34258.0 36402.6 46771.0 47047.0 47099.0 47408.6 47614.0 34497.7 34843.5 34897.3 35082.3 35621.8 33440.0 33971.3 34778.8 34827.3 34870.8 39425.4 39780.6 40310.0 40329.4 40393.4 32627.0 32989.7 33029.2 33106.5 33573.8 24742.1 25120.1 25386.7 25408.5 25420.4 20:54:42 INFO - PID 30009 | 20:54:42 INFO - PID 30009 | [#2] jquery.html Cycles:180 Average:39700.44 Median:2337.72 stddev:99506.64 (4256.6%) stddev-sans-first:99742.52 20:54:42 INFO - PID 30009 | Values: 619.8 624.7 624.7 636.9 645.5 22485.2 23218.9 23989.0 23998.8 24047.8 24493.5 25637.9 25695.7 25774.1 25776.0 6522.6 6629.7 6654.6 6713.3 6715.3 6913.1 6948.6 6950.7 6955.8 6958.0 6900.2 6913.6 6917.7 6924.4 6931.5 6636.7 6880.3 6888.8 6891.5 6917.9 6398.4 6417.5 6420.0 6433.5 6438.8 28937.7 29356.1 29376.0 29390.9 29412.6 2306.9 2334.8 2336.4 2339.0 2340.1 19466.5 20367.4 20572.9 20601.3 20643.2 2528.9 2543.2 2588.3 2596.1 2601.7 140738.3 145923.0 161537.0 166663.0 167343.0 15726.8 15849.0 15920.6 15953.1 16677.2 26010.5 26060.5 26065.2 26094.2 26184.5 10403.4 10614.7 10656.4 10660.5 10711.4 9383.9 9482.5 9535.8 9562.2 9630.5 9604.5 9726.8 9873.8 9907.7 10020.6 2772.3 2829.8 2841.3 2867.7 2928.9 1022.2 1048.2 1053.4 1069.4 1072.2 21536.8 21714.7 21834.5 22045.9 22055.1 1109.6 1116.4 1117.3 1121.8 1122.1 11650.5 11955.3 11977.8 12028.1 12037.2 559893.0 583468.0 604274.0 605846.0 608111.0 127463.0 133077.0 133910.3 134549.3 135098.3 1120.8 1218.8 1242.8 1254.8 1279.9 22354.6 22388.9 22547.5 22588.0 22618.4 63169.4 63425.7 64141.4 65235.7 65509.7 75865.6 76275.0 76747.0 77068.0 79619.0 15475.8 15569.6 15639.7 15803.9 15879.4 24460.9 24486.3 24600.8 24681.1 24731.1 19692.0 19937.3 20116.5 20119.4 20372.5 17409.9 17558.3 17682.1 18019.0 18056.9 20281.8 20391.5 20463.2 20612.0 20614.6 14530.8 15278.8 15305.4 15336.3 15474.5 19786.3 20015.5 20027.1 20030.0 20048.3 20:54:42 INFO - PID 30009 | 20:54:42 INFO - PID 30009 | [#3] mootools.html Cycles:180 Average:10731.31 Median:26127.72 stddev:7932.45 (30.4%) stddev-sans-first:7923.97 20:54:42 INFO - PID 30009 | Values: 1437.8 1470.9 1476.4 1492.2 1503.0 17238.7 17891.7 17899.9 17910.2 17935.6 17191.5 17366.8 17372.9 17392.7 17410.6 2960.5 2973.5 3017.8 3019.4 3020.7 2913.4 2950.2 2956.9 2957.0 2965.3 2789.9 2934.7 3001.5 3013.6 3015.8 2936.3 2951.1 2951.7 2957.1 2974.6 2843.5 2844.4 2876.8 2878.0 2883.4 16378.8 16748.3 16804.3 16876.9 16883.3 8741.5 9035.3 9058.4 9066.8 9068.9 5399.5 5684.0 5690.1 5745.1 5787.2 2020.2 2024.9 2040.1 2040.7 2069.2 31542.4 31794.0 31842.8 31847.4 31860.5 7461.1 7547.8 7576.8 7699.9 7754.2 19451.3 19482.9 19520.6 19557.8 19560.8 8695.1 8835.7 8855.9 8911.3 8911.8 7914.7 7954.2 7992.0 8032.3 8161.5 5805.3 5848.9 5866.0 5923.4 6075.9 1551.3 1593.2 1641.6 1676.8 1688.4 925.6 937.6 942.6 945.2 956.8 9391.5 9658.7 9694.7 9794.2 9799.4 1028.2 1054.2 1056.1 1073.5 1076.2 6129.8 6212.5 6365.7 6371.5 6438.5 25187.0 25755.2 25899.2 26356.2 26385.6 24341.5 25519.9 25625.0 25633.6 25835.9 12305.3 12476.2 12659.9 12740.6 12897.6 9947.9 9952.1 10006.7 10039.9 10066.4 21578.8 21679.2 21731.5 21868.8 22265.4 22507.9 22637.3 22840.5 22929.3 23145.7 13158.8 13350.4 13360.3 13496.5 13514.7 15676.8 15796.6 15934.4 15945.3 15953.0 12496.4 12693.6 12740.2 12825.7 13026.9 12198.5 12315.6 12374.1 12768.6 12828.3 10665.1 10756.4 10886.9 10960.1 10974.8 8006.6 8087.4 8158.8 8178.2 8306.0 8178.9 8211.3 8244.2 8333.7 8387.4 20:54:42 INFO - PID 30009 | 20:54:42 INFO - PID 30009 | [#4] prototype.html Cycles:180 Average:5659.14 Median:6266.58 stddev:1576.25 (25.2%) stddev-sans-first:1533.28 20:54:42 INFO - PID 30009 | Values: 548.3 565.9 572.1 583.9 591.7 6161.7 6243.5 6266.2 6272.5 6315.5 6147.5 6158.9 6167.5 6171.2 6180.8 5131.2 5132.9 5137.7 5170.0 5175.5 4818.7 4997.3 5043.2 5147.2 5166.3 4952.7 4968.7 5011.7 5013.7 5036.2 4996.9 5000.3 5006.0 5022.2 5038.8 4424.2 4539.5 4550.9 4557.1 4576.2 6163.7 6192.8 6201.2 6210.9 6221.3 5916.8 5940.2 5945.9 5952.7 5960.1 6666.9 6703.3 6742.5 6747.5 6747.8 4712.8 4985.7 4991.9 4998.5 5036.2 6793.2 6813.1 6835.0 6857.6 6946.9 5169.8 5214.1 5220.6 5290.6 5294.2 5230.5 5320.6 5330.8 5369.8 5385.6 5844.6 5846.0 5879.2 5892.2 5953.6 6721.0 6730.6 6733.4 6741.2 6777.8 1811.4 1812.0 1840.1 1847.2 1849.4 1263.5 1288.9 1312.8 1316.4 1329.6 6063.8 6196.6 6197.1 6266.9 6302.7 6780.9 6794.6 6808.5 6810.7 6823.0 6271.4 6273.8 6283.1 6286.4 6291.6 3595.9 3602.4 3619.3 3633.9 3634.7 6905.6 6929.4 7028.4 7045.3 7088.8 6957.8 6966.2 6998.1 6998.4 7015.3 6968.7 6984.9 7026.0 7072.3 7096.7 6747.2 6758.9 6814.7 6833.5 6858.6 6698.0 6736.5 6737.8 6765.2 6772.3 6836.8 6903.9 6934.8 6951.7 6996.5 5144.1 5175.6 5193.5 5202.7 5210.0 6632.6 6740.4 6778.3 6787.3 6857.2 6302.6 6420.7 6440.8 6632.4 6642.6 6526.2 6526.8 6557.6 6581.6 6585.6 6479.6 6538.2 6552.4 6561.2 6590.6 6549.5 6566.7 6626.5 6701.6 6748.6 6372.4 6437.4 6494.0 6494.5 6563.8 20:54:42 INFO - PID 30009 | 20:54:42 INFO - PID 30009 | [#5] yui.html Cycles:180 Average:28388.44 Median:19282.71 stddev:41125.47 (213.3%) stddev-sans-first:41189.31 20:54:42 INFO - PID 30009 | Values: 972.1 978.8 982.7 989.3 1002.1 18209.2 18500.5 18521.6 18566.4 18598.2 19022.5 19142.7 19197.7 19216.4 19302.9 1028.5 1051.7 1052.4 1053.1 1053.1 1076.7 1079.7 1081.4 1082.4 1084.9 1096.6 1123.9 1125.0 1125.4 1125.5 1114.3 1118.8 1119.3 1121.4 1124.9 816.9 818.6 818.7 820.1 826.9 18901.2 18952.9 21708.7 22132.7 22242.4 22702.8 23247.1 23696.8 23896.6 24105.3 18589.3 18970.3 19247.9 19316.5 19369.2 3966.8 3976.5 3985.4 3990.5 3998.3 115962.4 158896.0 160048.0 161072.0 163230.2 18522.5 18679.0 18905.1 18916.5 19346.9 34644.8 34741.1 34747.8 34767.7 34860.8 9963.8 9989.5 10039.5 10048.9 10069.3 4434.2 4466.5 4531.6 4536.4 4540.7 6149.0 6298.5 6331.8 6348.0 6358.1 1249.1 1268.1 1271.8 1280.8 1282.6 705.9 731.2 739.0 740.3 753.2 13634.7 13764.5 14043.9 14609.4 14700.8 709.9 719.8 720.4 721.6 728.0 6287.9 6296.1 6304.7 6348.7 6474.3 146127.0 146410.0 148431.0 150272.0 153663.0 111440.0 121758.4 125431.4 133251.0 137588.3 112796.4 112930.4 114744.0 115802.0 118065.4 14271.0 14335.3 14629.6 14744.5 14776.3 52473.0 52840.7 53620.2 53757.0 54739.5 70873.3 70988.6 71573.6 73557.0 73572.6 19087.4 19245.1 19340.4 19344.8 19418.5 21862.2 22820.9 23009.4 23010.2 23078.3 19365.2 19562.5 19568.5 19829.7 19912.3 19018.3 19262.5 19388.9 19407.3 19424.9 20641.6 20682.5 20974.5 21037.0 21315.0 14573.8 14654.1 14701.2 14706.9 14843.6 14573.0 14709.0 14774.5 14809.2 14829.9 20:54:42 INFO - PID 30009 | -------- Summary: end -------- 20:54:42 INFO - PID 30009 | 20:54:42 INFO - TEST-INFO | 30009: exit 0 20:54:42 INFO - TEST-OK | dromaeo_css | took 1108296ms 20:54:42 INFO - TEST-START | kraken 20:54:42 INFO - Initialising browser for kraken test... 20:54:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40558/getInfo.html -profile /tmp/tmpG1IR1v/profile 20:54:42 INFO - TEST-INFO | started process 30390 (/builds/slave/test/build/application/firefox/firefox http://localhost:40558/getInfo.html) 20:54:48 INFO - TEST-INFO | 30390: exit 0 20:54:48 INFO - Browser initialized. 20:54:48 INFO - Running cycle 1/1 for kraken test... 20:54:48 INFO - Using env: {'DISPLAY': ':0', 20:54:48 INFO - 'HOME': '/home/cltbld', 20:54:48 INFO - 'JSGC_DISABLE_POISONING': '1', 20:54:48 INFO - 'LANG': 'en_US.UTF-8', 20:54:48 INFO - 'LANGUAGE': 'en_US:en', 20:54:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:54:48 INFO - 'LOGNAME': 'cltbld', 20:54:48 INFO - 'MAIL': '/var/mail/cltbld', 20:54:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:54:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:54:48 INFO - 'MOZ_CRASHREPORTER': '1', 20:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:54:48 INFO - 'MOZ_NO_REMOTE': '1', 20:54:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:54:48 INFO - 'NO_EM_RESTART': '1', 20:54:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:48 INFO - 'PWD': '/builds/slave/test', 20:54:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:54:48 INFO - 'RUST_BACKTRACE': 'full', 20:54:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:54:48 INFO - 'SHELL': '/bin/bash', 20:54:48 INFO - 'SHLVL': '1', 20:54:48 INFO - 'TERM': 'linux', 20:54:48 INFO - 'TMOUT': '86400', 20:54:48 INFO - 'USER': 'cltbld', 20:54:48 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505959915.772173-166902363', 20:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:48 INFO - '_': '/tools/buildbot/bin/python'} 20:54:48 INFO - TEST-INFO | started process 30629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG1IR1v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:54:49 INFO - PID 30629 | 20:54:49 INFO - PID 30629 | (/builds/slave/test/build/application/firefox/firefox:30679): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:54:49 INFO - PID 30629 | 20:54:59 INFO - PID 30629 | RSS: Main: 147955712 20:54:59 INFO - PID 30629 | 20:55:02 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40558/tests/kraken/driver.html?testName=audio-beat-detection) 20:55:03 INFO - PID 30629 | RSS: Main: 153190400 20:55:03 INFO - PID 30629 | 20:55:05 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40558/tests/kraken/driver.html?testName=audio-dft) 20:55:06 INFO - PID 30629 | RSS: Main: 153468928 20:55:06 INFO - PID 30629 | 20:55:09 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40558/tests/kraken/driver.html?testName=audio-fft) 20:55:09 INFO - PID 30629 | RSS: Main: 149688320 20:55:09 INFO - PID 30629 | 20:55:11 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40558/tests/kraken/driver.html?testName=audio-oscillator) 20:55:12 INFO - PID 30629 | RSS: Main: 150974464 20:55:12 INFO - PID 30629 | 20:55:14 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40558/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:55:15 INFO - PID 30629 | RSS: Main: 150974464 20:55:15 INFO - PID 30629 | 20:55:18 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40558/tests/kraken/driver.html?testName=imaging-darkroom) 20:55:18 INFO - PID 30629 | RSS: Main: 151052288 20:55:18 INFO - PID 30629 | 20:55:22 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40558/tests/kraken/driver.html?testName=imaging-desaturate) 20:55:22 INFO - PID 30629 | RSS: Main: 152604672 20:55:22 INFO - PID 30629 | 20:55:25 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40558/tests/kraken/driver.html?testName=json-parse-financial) 20:55:26 INFO - PID 30629 | RSS: Main: 153550848 20:55:26 INFO - PID 30629 | 20:55:27 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40558/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:55:28 INFO - PID 30629 | RSS: Main: 153690112 20:55:28 INFO - PID 30629 | 20:55:30 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40558/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:55:30 INFO - PID 30629 | RSS: Main: 153870336 20:55:30 INFO - PID 30629 | 20:55:32 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40558/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:55:33 INFO - PID 30629 | RSS: Main: 151048192 20:55:33 INFO - PID 30629 | 20:55:35 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40558/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:55:36 INFO - PID 30629 | RSS: Main: 151146496 20:55:36 INFO - PID 30629 | 20:55:39 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40558/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:55:39 INFO - PID 30629 | RSS: Main: 151695360 20:55:39 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | Cycle 1(1): loaded http://localhost:40558/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40558/tests/kraken/driver.html?testName=ai-astar) 20:55:41 INFO - PID 30629 | RSS: Main: 153423872 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | __start_tp_report 20:55:41 INFO - PID 30629 | _x_x_mozilla_page_load 20:55:41 INFO - PID 30629 | _x_x_mozilla_page_load_details 20:55:41 INFO - PID 30629 | |i|pagename|runs| 20:55:41 INFO - PID 30629 | |0;ai-astar;103;108;104;106;106;107;106;105;104;105 20:55:41 INFO - PID 30629 | |1;audio-beat-detection;110;112;113;112;115;116;139;115;115;114 20:55:41 INFO - PID 30629 | |2;audio-dft;162;163;161;162;162;161;163;162;162;169 20:55:41 INFO - PID 30629 | |3;audio-fft;74;80;78;73;73;72;75;73;73;78 20:55:41 INFO - PID 30629 | |4;audio-oscillator;77;78;81;77;77;80;78;78;78;84 20:55:41 INFO - PID 30629 | |5;imaging-gaussian-blur;113;114;114;110;113;113;113;113;113;114 20:55:41 INFO - PID 30629 | |6;imaging-darkroom;150;149;151;150;150;149;151;149;151;149 20:55:41 INFO - PID 30629 | |7;imaging-desaturate;94;94;98;93;94;93;93;94;94;94 20:55:41 INFO - PID 30629 | |8;json-parse-financial;43;45;45;47;48;45;45;46;46;46 20:55:41 INFO - PID 30629 | |9;json-stringify-tinderbox;38;37;37;38;37;38;37;37;37;39 20:55:41 INFO - PID 30629 | |10;stanford-crypto-aes;72;73;70;70;69;70;71;71;70;72 20:55:41 INFO - PID 30629 | |11;stanford-crypto-ccm;111;108;111;103;107;108;109;112;113;104 20:55:41 INFO - PID 30629 | |12;stanford-crypto-pbkdf2;149;156;158;147;153;158;156;149;160;163 20:55:41 INFO - PID 30629 | |13;stanford-crypto-sha256-iterative;64;61;59;59;58;58;61;58;61;59 20:55:41 INFO - PID 30629 | __end_tp_report 20:55:41 INFO - PID 30629 | __start_cc_report 20:55:41 INFO - PID 30629 | _x_x_mozilla_cycle_collect,740 20:55:41 INFO - PID 30629 | __end_cc_report 20:55:41 INFO - PID 30629 | __startTimestamp1505966141708__endTimestamp 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | ------- Summary: start ------- 20:55:41 INFO - PID 30629 | Number of tests: 14 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#0] ai-astar Cycles:10 Average:105.40 Median:106.00 stddev:1.51 (1.4%) stddev-sans-first:1.32 20:55:41 INFO - PID 30629 | Values: 103.0 108.0 104.0 106.0 106.0 107.0 106.0 105.0 104.0 105.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#1] audio-beat-detection Cycles:10 Average:116.10 Median:115.00 stddev:8.25 (7.2%) stddev-sans-first:8.45 20:55:41 INFO - PID 30629 | Values: 110.0 112.0 113.0 112.0 115.0 116.0 139.0 115.0 115.0 114.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.31 (1.4%) stddev-sans-first:2.44 20:55:41 INFO - PID 30629 | Values: 162.0 163.0 161.0 162.0 162.0 161.0 163.0 162.0 162.0 169.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#3] audio-fft Cycles:10 Average:74.90 Median:74.50 stddev:2.77 (3.7%) stddev-sans-first:2.92 20:55:41 INFO - PID 30629 | Values: 74.0 80.0 78.0 73.0 73.0 72.0 75.0 73.0 73.0 78.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:78.00 stddev:2.25 (2.9%) stddev-sans-first:2.29 20:55:41 INFO - PID 30629 | Values: 77.0 78.0 81.0 77.0 77.0 80.0 78.0 78.0 78.0 84.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:1.15 (1.0%) stddev-sans-first:1.22 20:55:41 INFO - PID 30629 | Values: 113.0 114.0 114.0 110.0 113.0 113.0 113.0 113.0 113.0 114.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 20:55:41 INFO - PID 30629 | Values: 150.0 149.0 151.0 150.0 150.0 149.0 151.0 149.0 151.0 149.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:1.45 (1.5%) stddev-sans-first:1.54 20:55:41 INFO - PID 30629 | Values: 94.0 94.0 98.0 93.0 94.0 93.0 93.0 94.0 94.0 94.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#8] json-parse-financial Cycles:10 Average:45.60 Median:46.00 stddev:1.35 (2.9%) stddev-sans-first:1.05 20:55:41 INFO - PID 30629 | Values: 43.0 45.0 45.0 47.0 48.0 45.0 45.0 46.0 46.0 46.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#9] json-stringify-tinderbox Cycles:10 Average:37.50 Median:37.50 stddev:0.71 (1.9%) stddev-sans-first:0.73 20:55:41 INFO - PID 30629 | Values: 38.0 37.0 37.0 38.0 37.0 38.0 37.0 37.0 37.0 39.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#10] stanford-crypto-aes Cycles:10 Average:70.80 Median:71.00 stddev:1.23 (1.7%) stddev-sans-first:1.22 20:55:41 INFO - PID 30629 | Values: 72.0 73.0 70.0 70.0 69.0 70.0 71.0 71.0 70.0 72.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#11] stanford-crypto-ccm Cycles:10 Average:108.60 Median:110.00 stddev:3.31 (3.0%) stddev-sans-first:3.39 20:55:41 INFO - PID 30629 | Values: 111.0 108.0 111.0 103.0 107.0 108.0 109.0 112.0 113.0 104.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:157.00 stddev:5.26 (3.3%) stddev-sans-first:5.13 20:55:41 INFO - PID 30629 | Values: 149.0 156.0 158.0 147.0 153.0 158.0 156.0 149.0 160.0 163.0 20:55:41 INFO - PID 30629 | 20:55:41 INFO - PID 30629 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.80 Median:60.00 stddev:1.93 (3.2%) stddev-sans-first:1.32 20:55:41 INFO - PID 30629 | Values: 64.0 61.0 59.0 59.0 58.0 58.0 61.0 58.0 61.0 59.0 20:55:41 INFO - PID 30629 | -------- Summary: end -------- 20:55:41 INFO - PID 30629 | 20:55:42 INFO - PID 30629 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:55:42 INFO - TEST-INFO | 30629: exit 0 20:55:42 INFO - TEST-OK | kraken | took 59432ms 20:55:42 INFO - SUITE-END | took 1167s 20:55:42 INFO - Completed test suite (00:19:27) 20:55:42 INFO - javascript benchmark 20:55:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9182.057283975215, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3903.199844031973, 3917.0599056226497, 3921.0, 3935.488386509755, 3961.1681546875157, 6269.738110182515, 6307.243130824308, 6335.809925702236, 6404.359564043593, 6459.935400645993, 6397.58415702979, 6397.744090236385, 6422.486201103912, 6423.486121110312, 6425.100485931974, 5607.327120745516, 5641.464060914217, 5672.971635141818, 5743.626664266831, 5766.855828604276, 5739.3399759027825, 5741.253637027202, 5786.479216870481, 5825.359210486843, 5841.8831623367505, 747.0518393828099, 5666.943330566724, 5721.771129154849, 5824.563157763185, 5831.387704291052, 5612.579056570733, 5633.690147041911, 5638.2670252866865, 5652.660840349592, 5772.624779389368, 5562.554995600382, 5648.096304591246, 5697.886042279172, 5727.799527016535, 5734.741936612821, 6264.655443950581, 6328.841778955517, 6337.04944258365, 6358.745650173987, 6384.808455746335, 6842.589444633338, 6857.27998560154, 6944.4444444444825, 6944.965275173592, 6948.0, 6828.897566536506, 6889.862202755967, 6908.274631163706, 6993.580385176906, 6997.1253593300835, 6261.812145635638, 6275.152854364694, 6276.686165691697, 6277.529185311074, 6287.685615719196, 6977.546459480118, 7162.283771622796, 7162.570245785269, 7183.96408017967, 7191.7842464726145, 6819.659017049128, 6820.249772525019, 6896.896546551806, 6914.688839002257, 6933.618650974245, 6819.0, 6933.237343892168, 6963.059986901703, 7038.0, 7068.5758854468895, 6868.0, 6868.690908909111, 6907.447404207652, 6907.965460172667, 6936.861262774716, 6887.2079710832895, 6926.168859736763, 6961.895571566431, 6986.161660600659, 7004.92995070053, 4928.827491037797, 4952.479989601112, 4995.9500404996215, 5005.399352077774, 5015.247712843103, 4456.398386217884, 4467.776611169428, 4490.730556166641, 4577.1074640444795, 4577.542245775396, 6346.2384513857705, 6388.712507937061, 6396.0, 6398.392152745481, 6404.519661025442, 6860.3139686031, 6863.210730766026, 6958.826029349206, 6963.721451141999, 6963.82590435233, 6291.779787707408, 6306.054091886253, 6317.557770955989, 6390.808275751735, 6414.711337989708, 5416.133418652997, 5501.229827824108, 5502.504774570228, 5539.473749993744, 5562.888742225133, 7202.675879585431, 7206.531575447579, 7213.783586492414, 7232.529885557422, 7246.130464344313, 6765.391114799691, 6774.187097548326, 6830.21452532965, 6916.273791251846, 6975.232724400211, 7135.0, 7252.311030452099, 7261.164966028974, 7262.092238470192, 7279.4540409470565, 6795.422389096784, 6803.183617965876, 6842.213145488333, 6894.689738961659, 6924.0, 6791.966040169767, 6872.725090996504, 6894.482913781587, 6924.272951340036, 6952.826179345557, 6692.966535167293, 6701.698423570853, 6702.162229721285, 6773.898391524032, 6788.0, 6664.366885145903, 6665.933450647873, 6667.633280169637, 6748.865022699617, 6762.323767623395, 6531.804045878631, 6626.27111017778, 6628.436582890508, 6688.297728738413, 6695.330466953265, 6603.537752357289, 6661.367170118831, 6703.966480167568, 6715.3620406061345, 6743.15710536183, 6455.9677201613695, 6509.674516274073, 6526.477881769352, 6560.507961902972, 6571.704273307617], "value": 6258.564853686411, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [922.6217250927119, 945.3382632157492, 955.2405837359299, 999.7950420163867, 999.8000399920018, 43445.0, 44256.3361549577, 44299.0, 44371.0, 44451.1109777805, 42025.78987105068, 42280.78859605706, 44016.45942392017, 44596.554034459645, 44839.327410088874, 8498.490090594583, 8621.870671939925, 8624.0, 8624.094470080614, 8626.3098952084, 8425.83148337033, 8516.403851730382, 8554.61504232311, 8579.485230886135, 8580.0, 8537.146285371444, 8540.145985401472, 8554.61504232308, 8575.785605359884, 8613.913860861405, 8440.0, 8540.145985401441, 8558.400911936167, 8563.0, 8576.656933722643, 8388.622511986976, 8427.70503032397, 8471.025832029272, 8477.703280385218, 8492.575371231476, 41243.7937810312, 41515.377269340985, 41559.0, 41652.37521437181, 41668.79165604183, 3719.8326075326404, 3742.5883152853166, 3753.5120434343635, 3754.455603937414, 3756.417755247941, 33045.17387065318, 33099.66900331014, 33152.0, 33251.5012274816, 33287.6671233287, 5340.385855626614, 5492.780288788484, 5496.422875598045, 5511.366192887789, 5514.696691681956, 210120.0, 215529.0, 219068.9046554773, 226024.0, 226142.0, 53239.733801330745, 53501.0, 53660.73169634127, 53747.73126134344, 53749.462505375224, 56358.0, 56393.43606563964, 56588.0, 56593.71703141458, 56783.71608141933, 15156.0, 15158.545243642708, 15291.770623440658, 15294.770578441332, 15340.92329538345, 12328.0, 12342.197757145757, 12425.502979880885, 12432.12975091735, 12439.253644781342, 14003.859961400256, 14141.505047323295, 14201.715965680629, 14260.857391425952, 14353.569392918229, 5481.725913704299, 5559.388467268597, 5594.482482882638, 5629.54963602919, 5679.176519404746, 1092.7650555130685, 1094.7372630568607, 1105.5135740274254, 1109.046220250584, 1117.0951529261324, 24523.0, 24805.5038899221, 24810.131645392325, 24924.875375623367, 24983.62524562133, 1200.1299058182922, 1208.7763763703567, 1209.9455524501418, 1214.738831151289, 1224.4673566998383, 13408.865911340958, 13434.126781759154, 13440.596782096552, 13483.460661573623, 13497.797533037012, 246491.0, 276322.0, 285441.0, 287117.0, 287685.0, 57028.0, 57731.42268577345, 57839.71080144656, 57974.7101264491, 58003.0, 1507.5628067860416, 1543.6218126559065, 1549.4886687393134, 1551.6974190032836, 1554.9378024879104, 24673.100096600923, 24702.011919523018, 24736.304017155537, 24749.33405165923, 24957.625635615845, 39745.0, 41325.586744132175, 41435.585644143175, 41497.585024149375, 41560.376594351714, 234278.0, 234566.0, 234841.0, 234959.0, 235336.0, 33328.0, 33716.83141584374, 34019.14952126217, 34258.0, 36402.635973639924, 46771.0, 47047.0, 47099.0, 47408.62956852213, 47614.0, 34497.65502344944, 34843.477347839296, 34897.30205395827, 35082.298354033286, 35621.82189089038, 33440.0, 33971.320573587895, 34778.82610587032, 34827.30345393129, 34870.825645872625, 39425.40861887131, 39780.60219397769, 40310.0, 40329.39505907355, 40393.39409908913, 32627.0, 32989.67010329866, 33029.17427064246, 33106.50340244947, 33573.83213083919, 24742.134025309748, 25120.11599130036, 25386.74613253844, 25408.491830162922, 25420.364490887874], "value": 18487.960874742177, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.845038740315, 624.6814124796352, 624.7251209467834, 636.8503401700602, 645.4642646603319, 22485.21301754435, 23218.88390558049, 23989.040438382464, 23998.76001239987, 24047.75952240477, 24493.510129797392, 25637.87181064092, 25695.743042569615, 25774.097906573275, 25776.0, 6522.641254731, 6629.6685165741765, 6654.567453115532, 6713.328667133296, 6715.294894036129, 6913.101296831405, 6948.5830850148905, 6950.652467376636, 6955.826104347381, 6958.0, 6900.171979362483, 6913.585184888898, 6917.688704008307, 6924.446044316468, 6931.480138989571, 6636.668166591675, 6880.311968803129, 6888.793336199922, 6891.483138764563, 6917.9308206917785, 6398.392152745481, 6417.518686098515, 6419.967900160469, 6433.453156481658, 6438.839029024265, 28937.710622893923, 29356.119316420543, 29375.97184098546, 29390.85304573485, 29412.558811617844, 2306.884655767222, 2334.7665233476687, 2336.4158960259933, 2339.017612602711, 2340.0990618611786, 19466.513337166543, 20367.388978330673, 20572.897135514377, 20601.278955236645, 20643.17427302906, 2528.898844046236, 2543.186180422266, 2588.3399733067945, 2596.1302963507246, 2601.7008044074983, 140738.29630851882, 145923.0, 161537.0, 166663.0, 167342.99999999878, 15726.842731572766, 15849.0, 15920.601984950237, 15953.122578258308, 16677.24952377146, 26010.479790404086, 26060.478790424084, 26065.218043458728, 26094.217173484827, 26184.476310473685, 10403.375797452178, 10614.681559553226, 10656.413897235727, 10660.520276587573, 10711.410872402093, 9383.859242111374, 9482.478463684563, 9535.809283814424, 9562.187214086742, 9630.518474076269, 9604.51977401141, 9726.756831079138, 9873.75315617101, 9907.653232136985, 10020.599176032876, 2772.2930652683435, 2829.8160619559662, 2841.289677580605, 2867.7132286771157, 2928.8974885878893, 1022.2384323678758, 1048.2400259811575, 1053.3837704942694, 1069.4438891776233, 1072.1690689715533, 21536.78463215379, 21714.674279885814, 21834.454138646663, 22045.889770551046, 22055.11779528801, 1109.6227282723912, 1116.4473585575192, 1117.3128525956479, 1121.7588218533056, 1122.1191364778772, 11650.475728592064, 11955.282683039046, 11977.760444791056, 12028.097892658086, 12037.217580857216, 559893.0, 583468.0, 604274.0, 605846.0, 608111.0, 127463.0, 133077.0, 133910.33044834714, 134549.3272533631, 135098.32450837683, 1120.7758448310371, 1218.7501562179732, 1242.8322176506238, 1254.8494180698192, 1279.8592154862959, 22354.552908942056, 22388.88805555962, 22547.549049019257, 22588.0, 22618.43453913665, 63169.36830631635, 63425.68287158535, 64141.35858641541, 65235.67382163059, 65509.672451639344, 75865.6206718963, 76275.0, 76747.0, 77068.0, 79619.0, 15475.845241547891, 15569.610759730644, 15639.68720625604, 15803.920980395025, 15879.444219452263, 24460.87769561141, 24486.26541203767, 24600.753992459846, 24681.136160234306, 24731.134410296272, 19692.0, 19937.302194423126, 20116.497087572927, 20119.39641810748, 20372.490687732927, 17409.912950435166, 17558.29766809313, 17682.115894205497, 18019.008954507626, 18056.90971545134, 20281.79718202799, 20391.4902127448, 20463.181472740922, 20612.0, 20614.58770824605, 14530.782038269223, 15278.77081843751, 15305.387784488941, 15336.309866055832, 15474.458393956607, 19786.307479238156, 20015.499612509804, 20027.098780554617, 20030.0, 20048.298309559097], "value": 12910.547008762447, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.8058962040125, 1470.8747807926945, 1476.379920433418, 1492.1643879427525, 1502.9624259393513, 17238.655226895455, 17891.73162402565, 17899.910500447513, 17910.194041268143, 17935.64128717425, 17191.484255472325, 17366.82633173668, 17372.913135434304, 17392.652146957054, 17410.564735881577, 2960.4523163214767, 2973.524236122221, 3017.803842750225, 3019.411214813112, 3020.6526249481262, 2913.3736246706953, 2950.247686839853, 2956.896508622199, 2957.0, 2965.303153758865, 2789.888404463819, 2934.7065293470696, 3001.4897467430587, 3013.6383633963956, 3015.8190508569555, 2936.2512559297456, 2951.070412819955, 2951.7343439090587, 2957.053742802304, 2974.5686875403053, 2843.473957317882, 2844.3884564818454, 2876.7698584113223, 2878.0358579875765, 2883.3656595549155, 16378.754318685229, 16748.330066797313, 16804.32782688703, 16876.915615421967, 16883.324667013305, 8741.475511469269, 9035.32235082365, 9058.365914385995, 9066.818663626691, 9068.8639670405, 5399.544291653306, 5683.971580142114, 5690.089585666274, 5745.138229265602, 5787.1608616750755, 2020.1818263603263, 2024.8582599218062, 2040.1329434990218, 2040.7245021922, 2069.2343832781967, 31542.369152617048, 31794.04617861491, 31842.84078579592, 31847.36305273905, 31860.522092168638, 7461.104667439833, 7547.849043019109, 7576.772696819105, 7699.884501732478, 7754.224577542201, 19451.3192038278, 19482.902585487267, 19520.60958780845, 19557.804421955883, 19560.8043919559, 8695.08701586337, 8835.69075082369, 8855.911440885637, 8911.287097032222, 8911.821763564822, 7914.722984695623, 7954.164812694699, 7992.0, 8032.3172530334405, 8161.469504482189, 5805.332386775491, 5848.912266316009, 5866.0, 5923.4076592340425, 6075.878482430327, 1551.3019141386421, 1593.2272847668871, 1641.5896025993502, 1676.7568702538063, 1688.375301138562, 925.6112432778249, 937.6202637931649, 942.641796117471, 945.163530275711, 956.7512446763892, 9391.483468409304, 9658.661946831828, 9694.660686875926, 9794.216462682969, 9799.363041402286, 1028.1928685981468, 1054.1830081686753, 1056.0812093478723, 1073.4900922061959, 1076.230495195923, 6129.754809807647, 6212.534059945522, 6365.713542890581, 6371.490280777527, 6438.517111216677, 25187.0, 25755.22734317936, 25899.223023308954, 26356.209313720618, 26385.604215936775, 24341.51316973686, 25519.87240063788, 25625.0, 25633.61549576758, 25835.870820645778, 12305.323207223688, 12476.18904771187, 12659.936700316439, 12740.617781466572, 12897.613071607866, 9947.900520994697, 9952.10431061208, 10006.69979900604, 10039.949800250952, 10066.44634545107, 21578.784212157676, 21679.241226556995, 21731.456713582287, 21868.781312186675, 22265.44336391603, 22507.887460562593, 22637.320880373616, 22840.543189136457, 22929.31212063641, 23145.65281520745, 13158.80261796093, 13350.399232034388, 13360.265185414895, 13496.5276215332, 13514.72970540564, 15676.764848527053, 15796.60508487251, 15934.442294519637, 15945.282462289457, 15953.0, 12496.375181240719, 12693.555725549562, 12740.235585864877, 12825.679358016125, 13026.869731302566, 12198.451069702061, 12315.568955086528, 12374.13381063317, 12768.553100641433, 12828.29444380568, 10665.093467055387, 10756.408397538211, 10886.891131088905, 10960.123190144928, 10974.780504389708, 8006.59967001636, 8087.353011759163, 8158.755237342889, 8178.223068808692, 8306.0, 8178.877316840371, 8211.260986511243, 8244.175582441947, 8333.6666533338, 8387.412881098264], "value": 7519.863504769573, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.2516365161556, 565.8585353661584, 572.1332181744657, 583.9007368747313, 591.742591972492, 6161.661108639023, 6243.46930510906, 6266.248050233972, 6272.466840318572, 6315.526335524831, 6147.508199344053, 6158.907616385746, 6167.506599472043, 6171.197744293247, 6180.814575562729, 5131.230315452674, 5132.923006154911, 5137.691738495683, 5169.991851588923, 5175.508326708957, 4818.710877347353, 4997.325361076245, 5043.167877300241, 5147.1764517677175, 5166.276721259027, 4952.727599981999, 4968.701877887338, 5011.699298042111, 5013.674111182761, 5036.194208926572, 4996.925046124311, 5000.299958005882, 5006.0, 5022.171341728647, 5038.823641172541, 4424.159409712144, 4539.455265368177, 4550.8862278442975, 4557.134144512532, 4576.199165146119, 6163.691815409256, 6192.783252586138, 6201.224846894138, 6210.906836397413, 6221.346758590328, 5916.792912248094, 5940.227770389822, 5945.910811337833, 5952.73212705425, 5960.1357803118735, 6666.933330666729, 6703.296153903819, 6742.49431292655, 6747.460203183734, 6747.763828266036, 4712.764361781898, 4985.700857948498, 4991.850244492671, 4998.450170481244, 5036.194208926554, 6793.150856142982, 6813.148356455443, 6835.035679305991, 6857.628474305109, 6946.93053069473, 5169.81905633301, 5214.139666954986, 5220.634555581149, 5290.576753859682, 5294.205869119586, 5230.529252367305, 5320.627556071038, 5330.773921997962, 5369.838904832861, 5385.649932754437, 5844.590878638454, 5846.0, 5879.176915231871, 5892.234009578813, 5953.618552579003, 6720.966395167993, 6730.596164230064, 6733.42765864907, 6741.1910570731825, 6777.81388257053, 1811.3750755989163, 1812.0248928667552, 1840.1351364858494, 1847.1528471528472, 1849.3817909329337, 1263.4819723913151, 1288.8775566321185, 1312.7702652036046, 1316.3813007886279, 1329.6171981139507, 6063.848403789941, 6196.566240363221, 6197.101420294032, 6266.905996410058, 6302.684865756693, 6780.864382712318, 6794.558353706993, 6808.523403361717, 6810.727570897108, 6823.0, 6271.43557079865, 6273.780417685359, 6283.120363149163, 6286.371362863769, 6291.591046581958, 3595.94606080909, 3602.4416215486117, 3619.262753878153, 3633.927321453609, 3634.727395445352, 6905.620190889449, 6929.411000065051, 7028.367446929801, 7045.260247674023, 7088.751893683696, 6957.79126626202, 6966.164060312795, 6998.06081445794, 6998.440124790106, 7015.263397343308, 6968.686409111703, 6984.939442864367, 7025.962470883591, 7072.328128827753, 7096.716131354688, 6747.156605424322, 6758.898616520658, 6814.693338799865, 6833.487488438486, 6858.588484690935, 6697.966510167418, 6736.528443009139, 6737.797866064026, 6765.221999470124, 6772.255051944184, 6836.760713375008, 6903.861922761416, 6934.757283495053, 6951.721931122698, 6996.545224560387, 5144.0997825381155, 5175.585953123817, 5193.506616871542, 5202.73986300691, 5210.036143313499, 6632.635205063768, 6740.427063699641, 6778.3221677831825, 6787.253402125861, 6857.177138743184, 6302.613425046482, 6420.6789660517725, 6440.774572890114, 6632.436242919406, 6642.634655093823, 6526.184226971629, 6526.804195874131, 6557.639329836714, 6581.60308547006, 6585.5719378240265, 6479.639275751956, 6538.215414150142, 6552.3775241352, 6561.179852518435, 6590.604563726191, 6549.4760419167305, 6566.737330506726, 6626.53614246998, 6701.597904125768, 6748.561343512656, 6372.426481616677, 6437.388448097423, 6494.0, 6494.512911531559, 6563.835904102436], "value": 5208.134189289354, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [972.1105188752297, 978.7846673731779, 982.7395740128862, 989.2877128467501, 1002.0880998291553, 18209.18058687359, 18500.537486562844, 18521.629567408643, 18566.350177743763, 18598.163082661278, 19022.524436889085, 19142.71285930712, 19197.712034319495, 19216.42350729477, 19302.903485482588, 1028.4600584693057, 1051.6950084475493, 1052.4001319248032, 1053.0680347892094, 1053.0838170791385, 1076.6554702495205, 1079.7408621930758, 1081.3511892864258, 1082.4154956323616, 1084.9403282819442, 1096.627146770098, 1123.9325640461557, 1124.9943750281236, 1125.3754166437625, 1125.5497800879673, 1114.2645853736535, 1118.848955391024, 1119.289251325406, 1121.43928035982, 1124.876263611002, 816.8652172391548, 818.6193420059701, 818.6684392820918, 820.0815087102484, 826.8594338962391, 18901.243950241973, 18952.90523547387, 21708.674369884466, 22132.66800997986, 22242.443938901655, 22702.77297227023, 23247.070117195293, 23696.76303236963, 23896.641550376757, 24105.276841694777, 18589.256429742793, 18970.336038238594, 19247.903760481247, 19316.517087072796, 19369.22523099074, 3966.841326346943, 3976.5426975897853, 3985.442038114666, 3990.501187351581, 3998.300297447964, 115962.42018789936, 158896.0, 160048.0, 161072.0, 163230.18384908236, 18522.536936576424, 18679.0, 18905.14926828296, 18916.527086822938, 19346.903265483863, 34644.826775866466, 34741.131471712906, 34747.82626086853, 34767.65232347695, 34860.82569587136, 9963.80072398548, 9989.450580218012, 10039.548220330104, 10048.949755251177, 10069.295149339476, 4434.157510073076, 4466.486354069259, 4531.56950089741, 4536.410266665378, 4540.659450541222, 6149.0, 6298.464630506367, 6331.841703957346, 6348.0, 6358.1416508771645, 1249.1068885746554, 1268.0869773762877, 1271.841019872516, 1280.8270883430805, 1282.6280378690262, 705.8905869590221, 731.2322061835052, 739.0318682525908, 740.3373980287612, 753.1940823318996, 13634.727305453835, 13764.518241861688, 14043.859561404255, 14609.415623375158, 14700.779488307684, 709.9183593886665, 719.7552832037028, 720.3804727933973, 721.6103304215769, 727.9672414741349, 6287.874242515124, 6296.118543403835, 6304.747810087637, 6348.746050158034, 6474.287828338879, 146127.0, 146410.0, 148431.0, 150272.0, 153663.0, 111440.0, 121758.3912080434, 125431.3728431352, 133251.0, 137588.31205843907, 112796.43601781939, 112930.43534782274, 114744.0, 115802.0, 118065.40967295281, 14271.0, 14335.283235838375, 14629.561113166623, 14744.48394306237, 14776.261186940395, 52473.0, 52840.73579632231, 53620.1956970638, 53757.0, 54739.45260547344, 70873.29126708666, 70988.64505677439, 71573.64213179109, 73557.0, 73572.63213683898, 19087.42737717871, 19245.13396897115, 19340.4197874064, 19344.8065519343, 19418.514537136685, 21862.23482178116, 22820.88589557108, 23009.424764381023, 23010.19464318741, 23078.307650770505, 19365.225390984768, 19562.510937226114, 19568.510787230432, 19829.702554461404, 19912.303069392503, 19018.334358297394, 19262.518437039187, 19388.903055484632, 19407.3207437739, 19424.931628759987, 20641.58716825685, 20682.482937926674, 20974.475638108557, 21037.0, 21315.0, 14573.781393279321, 14654.120752754869, 14701.191434470778, 14706.926465367605, 14843.554693359216, 14573.0, 14709.0, 14774.48289309869, 14809.185494797459, 14829.92585037111], "value": 10242.670046471401, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1372.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 108.0, 104.0, 106.0, 106.0, 107.0, 106.0, 105.0, 104.0, 105.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 113.0, 112.0, 115.0, 116.0, 139.0, 115.0, 115.0, 114.0], "value": 116.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 162.0, 161.0, 163.0, 162.0, 162.0, 169.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 78.0, 73.0, 73.0, 72.0, 75.0, 73.0, 73.0, 78.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 81.0, 77.0, 77.0, 80.0, 78.0, 78.0, 78.0, 84.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 110.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 151.0, 150.0, 150.0, 149.0, 151.0, 149.0, 151.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 98.0, 93.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 45.0, 45.0, 47.0, 48.0, 45.0, 45.0, 46.0, 46.0, 46.0], "value": 45.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 37.0, 38.0, 37.0, 38.0, 37.0, 37.0, 37.0, 39.0], "value": 37.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 70.0, 70.0, 69.0, 70.0, 71.0, 71.0, 70.0, 72.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 111.0, 103.0, 107.0, 108.0, 109.0, 112.0, 113.0, 104.0], "value": 108.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 156.0, 158.0, 147.0, 153.0, 158.0, 156.0, 149.0, 160.0, 163.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 59.0, 59.0, 58.0, 58.0, 61.0, 58.0, 61.0, 59.0], "value": 59.8, "unit": "score"}]}]} 20:55:42 INFO - Return code: 0 20:55:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:55:42 INFO - # TBPL SUCCESS # 20:55:42 INFO - Running post-action listener: _package_coverage_data 20:55:42 INFO - Running post-action listener: _resource_record_post_action 20:55:42 INFO - [mozharness: 2017-09-21 03:55:42.492678Z] Finished run-tests step (success) 20:55:42 INFO - Running post-run listener: _resource_record_post_run 20:55:42 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 12288; Write bytes: 339922944; Read time: 168; Write time: 211276 20:55:42 INFO - TinderboxPrint: CPU usage
13.1% 20:55:42 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 168 20:55:42 INFO - TinderboxPrint: I/O write bytes / time
339,922,944 / 211,276 20:55:42 INFO - TinderboxPrint: CPU idle
8,221.5 (86.9%) 20:55:42 INFO - TinderboxPrint: CPU user
1,187.4 (12.6%) 20:55:42 INFO - TinderboxPrint: Swap in / out
0 / 0 20:55:42 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12488704; Read time: 0; Write time: 1948 20:55:42 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:55:42 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 12288; Write bytes: 326799360; Read time: 168; Write time: 209320 20:55:43 INFO - Running post-run listener: _upload_blobber_files 20:55:43 INFO - Blob upload gear active. 20:55:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:55:43 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 20:55:43 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'] 20:55:43 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 20:55:43 INFO - (blobuploader) - INFO - Open directory for files ... 20:55:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:55:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:55:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:44 INFO - (blobuploader) - INFO - Done attempting. 20:55:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:55:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:55:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:45 INFO - (blobuploader) - INFO - Done attempting. 20:55:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:55:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:55:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:52 INFO - (blobuploader) - INFO - Done attempting. 20:55:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:55:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:55:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:53 INFO - (blobuploader) - INFO - Done attempting. 20:55:53 INFO - (blobuploader) - INFO - Iteration through files over. 20:55:53 INFO - Return code: 0 20:55:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:55:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:55:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4a2faaac4d72a4bcf26f5023dde3c4afb5451e5099dbc218c74426cb283005a063b8947bea3729d4dc9043fb19874dbf4c986ac98503c45bf57dce3a63e522", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a17f8f48fbf4cb81606a8b96c163531ea8d3825274bb06d0f8f948f18e0251ec3a6a25428b3fbbe778955cbbd35bb38ff03365aa6e9ff77c82fb0df402c26d5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/899cd6af2b387450287a3be5860129886f9f3d208be185e073e3b3563424bf97af9ddedcebee986f6d21d8ed5082d526755458be89bdfb69c8a71ce7ce049a3a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98fcc1f3ecf212ab0b882f8a21ab0cf81ac1aaf55d84a6541a352983e0d62dc3a07c0223d3be7565667a06d5e491b2e994b19fd6082580f0b2456432fb3e589d"} 20:55:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:55:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:55:53 INFO - Contents: 20:55:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4a2faaac4d72a4bcf26f5023dde3c4afb5451e5099dbc218c74426cb283005a063b8947bea3729d4dc9043fb19874dbf4c986ac98503c45bf57dce3a63e522", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a17f8f48fbf4cb81606a8b96c163531ea8d3825274bb06d0f8f948f18e0251ec3a6a25428b3fbbe778955cbbd35bb38ff03365aa6e9ff77c82fb0df402c26d5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/899cd6af2b387450287a3be5860129886f9f3d208be185e073e3b3563424bf97af9ddedcebee986f6d21d8ed5082d526755458be89bdfb69c8a71ce7ce049a3a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98fcc1f3ecf212ab0b882f8a21ab0cf81ac1aaf55d84a6541a352983e0d62dc3a07c0223d3be7565667a06d5e491b2e994b19fd6082580f0b2456432fb3e589d"} 20:55:53 INFO - Running post-run listener: copy_logs_to_upload_dir 20:55:53 INFO - Copying logs to upload dir... 20:55:53 INFO - mkdir: /builds/slave/test/build/upload/logs 20:55:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.303377 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-20 20:55:53.439412) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 20:55:53.443239) ========= 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=483e410453545d07cca6935c000001ab-1505959915.772173-166902363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4a2faaac4d72a4bcf26f5023dde3c4afb5451e5099dbc218c74426cb283005a063b8947bea3729d4dc9043fb19874dbf4c986ac98503c45bf57dce3a63e522", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a17f8f48fbf4cb81606a8b96c163531ea8d3825274bb06d0f8f948f18e0251ec3a6a25428b3fbbe778955cbbd35bb38ff03365aa6e9ff77c82fb0df402c26d5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/899cd6af2b387450287a3be5860129886f9f3d208be185e073e3b3563424bf97af9ddedcebee986f6d21d8ed5082d526755458be89bdfb69c8a71ce7ce049a3a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98fcc1f3ecf212ab0b882f8a21ab0cf81ac1aaf55d84a6541a352983e0d62dc3a07c0223d3be7565667a06d5e491b2e994b19fd6082580f0b2456432fb3e589d"} build_url:https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/CsEgb139SD6oyZsaoMKOhw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4a2faaac4d72a4bcf26f5023dde3c4afb5451e5099dbc218c74426cb283005a063b8947bea3729d4dc9043fb19874dbf4c986ac98503c45bf57dce3a63e522", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a17f8f48fbf4cb81606a8b96c163531ea8d3825274bb06d0f8f948f18e0251ec3a6a25428b3fbbe778955cbbd35bb38ff03365aa6e9ff77c82fb0df402c26d5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/899cd6af2b387450287a3be5860129886f9f3d208be185e073e3b3563424bf97af9ddedcebee986f6d21d8ed5082d526755458be89bdfb69c8a71ce7ce049a3a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98fcc1f3ecf212ab0b882f8a21ab0cf81ac1aaf55d84a6541a352983e0d62dc3a07c0223d3be7565667a06d5e491b2e994b19fd6082580f0b2456432fb3e589d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 20:55:53.471493) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:55:53.471892) ========= 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=483e410453545d07cca6935c000001ab-1505959915.772173-166902363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 20:55:53.555511) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 20:55:53.555926) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 20:55:53.556253) ========= ========= Total master_lag: 0.22 =========