builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-010 starttime: 1505687057.58 results: success (0) revision: ae39864562c6048fdc2950c5dfedb48e247c3300 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:17.579653) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:17.580109) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:17.580385) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:17.598080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:17.598470) ========= 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=eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-17 15:24:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2017-09-17 15:24:17 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124838 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:17.740133) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:17.743128) ========= 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=eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021138 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:17.793449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:17.793782) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ae39864562c6048fdc2950c5dfedb48e247c3300 --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 ae39864562c6048fdc2950c5dfedb48e247c3300 --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=eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-17 15:24:17,986 truncating revision to first 12 chars 2017-09-17 15:24:17,986 Setting DEBUG logging. 2017-09-17 15:24:17,986 attempt 1/10 2017-09-17 15:24:17,986 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ae39864562c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-17 15:24:18,239 unpacking tar archive at: mozilla-central-ae39864562c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547795 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:18.355367) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:18.357528) ========= script_repo_revision: ae39864562c6048fdc2950c5dfedb48e247c3300 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:18.357912) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:18.358174) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:18.372838) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-17 15:24:18.373222) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:24:18 INFO - MultiFileLogger online at 20170917 15:24:18 in /builds/slave/test 15:24:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:24:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:24:18 INFO - {'append_to_log': False, 15:24:18 INFO - 'base_work_dir': '/builds/slave/test', 15:24:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:24:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:24:18 INFO - 'branch': 'Firefox-Non-PGO', 15:24:18 INFO - 'buildbot_json_path': 'buildprops.json', 15:24:18 INFO - 'code_coverage': False, 15:24:18 INFO - 'config_files': ('talos/linux_config.py',), 15:24:18 INFO - 'default_actions': ('clobber', 15:24:18 INFO - 'read-buildbot-config', 15:24:18 INFO - 'download-and-extract', 15:24:18 INFO - 'populate-webroot', 15:24:18 INFO - 'create-virtualenv', 15:24:18 INFO - 'install', 15:24:18 INFO - 'setup-mitmproxy', 15:24:18 INFO - 'run-tests'), 15:24:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:24:18 INFO - 'disable_ccov_upload': False, 15:24:18 INFO - 'disable_stylo': False, 15:24:18 INFO - 'download_minidump_stackwalk': True, 15:24:18 INFO - 'download_symbols': 'ondemand', 15:24:18 INFO - 'enable_stylo': False, 15:24:18 INFO - 'enable_webrender': False, 15:24:18 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:24:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:24:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:24:18 INFO - 'gecko_profile': False, 15:24:18 INFO - 'gecko_profile_interval': 0, 15:24:18 INFO - 'installer_path': 'installer.exe', 15:24:18 INFO - 'log_level': 'info', 15:24:18 INFO - 'log_name': 'talos', 15:24:18 INFO - 'log_to_console': True, 15:24:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:24:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:24:18 INFO - 'opt_config_files': (), 15:24:18 INFO - 'pip_index': False, 15:24:18 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:24:18 INFO - 'system_bits': '32', 15:24:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:24:18 INFO - 'title': 'talos-linux64-ix-010', 15:24:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:24:18 INFO - 'use_talos_json': True, 15:24:18 INFO - 'verify': 'False', 15:24:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:24:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:24:18 INFO - 'work_dir': 'build'} 15:24:18 INFO - [mozharness: 2017-09-17 22:24:18.706161Z] Running clobber step. 15:24:18 INFO - Running pre-action listener: _resource_record_pre_action 15:24:18 INFO - Running main action method: clobber 15:24:18 INFO - rmtree: /builds/slave/test/build 15:24:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:24:19 INFO - Running post-action listener: _resource_record_post_action 15:24:19 INFO - [mozharness: 2017-09-17 22:24:19.715154Z] Finished clobber step (success) 15:24:19 INFO - [mozharness: 2017-09-17 22:24:19.715250Z] Running read-buildbot-config step. 15:24:19 INFO - Running pre-action listener: _resource_record_pre_action 15:24:19 INFO - Running main action method: read_buildbot_config 15:24:19 INFO - Using buildbot properties: 15:24:19 INFO - { 15:24:19 INFO - "project": "", 15:24:19 INFO - "product": "firefox", 15:24:19 INFO - "who": "archaeopteryx@coole-files.de", 15:24:19 INFO - "installer_path": "public/build/target.tar.bz2", 15:24:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:24:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:24:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:24:19 INFO - "stage_platform": "linux64", 15:24:19 INFO - "basedir": "/builds/slave/test", 15:24:19 INFO - "buildnumber": 36, 15:24:19 INFO - "platform": "ubuntu64_hw", 15:24:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:24:19 INFO - "slavebuilddir": "test", 15:24:19 INFO - "taskId": "SYGb6dxqSHiWLl-QMuRIOg", 15:24:19 INFO - "branch": "mozilla-central", 15:24:19 INFO - "script_repo_revision": "production", 15:24:19 INFO - "revision": "ae39864562c6048fdc2950c5dfedb48e247c3300", 15:24:19 INFO - "slavename": "talos-linux64-ix-010", 15:24:19 INFO - "repo_path": "mozilla-central" 15:24:19 INFO - } 15:24:19 INFO - Finding installer, test and symbols from parent task. 15:24:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SYGb6dxqSHiWLl-QMuRIOg'}, attempt #1 15:24:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SYGb6dxqSHiWLl-QMuRIOg'}, attempt #1 15:24:20 INFO - Task dependencies: b2Y79Ct6TZem2FvxMKycGw 15:24:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw'}, attempt #1 15:24:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 15:24:21 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.test_packages.json 15:24:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.crashreporter-symbols.zip 15:24:21 INFO - Running post-action listener: _resource_record_post_action 15:24:21 INFO - [mozharness: 2017-09-17 22:24:21.108500Z] Finished read-buildbot-config step (success) 15:24:21 INFO - [mozharness: 2017-09-17 22:24:21.108714Z] Running download-and-extract step. 15:24:21 INFO - Running pre-action listener: _resource_record_pre_action 15:24:21 INFO - Running main action method: download_and_extract 15:24:21 INFO - mkdir: /builds/slave/test/build/tests 15:24:21 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')]} 15:24:21 INFO - trying https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.test_packages.json 15:24:21 INFO - Downloading https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:24:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:24:21 INFO - Downloaded 989 bytes. 15:24:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:24:21 INFO - Using the following test package requirements: 15:24:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:24:21 INFO - u'common': [u'target.common.tests.zip'], 15:24:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:24:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:24:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:24:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:24:21 INFO - u'mozbase': [u'target.common.tests.zip'], 15:24:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:24:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:24:21 INFO - u'web-platform': [u'target.common.tests.zip', 15:24:21 INFO - u'target.web-platform.tests.tar.gz'], 15:24:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:24:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:24:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.common.tests.zip 15:24:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:24:21 INFO - Fetch https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.common.tests.zip into memory 15:24:22 INFO - Content-Length response header: 54731154 15:24:22 INFO - Bytes received: 54731154 15:24:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.talos.tests.zip 15:24:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:24:33 INFO - Fetch https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.talos.tests.zip into memory 15:24:34 INFO - Content-Length response header: 14508748 15:24:34 INFO - Bytes received: 14508748 15:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:34 INFO - trying https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 15:24:34 INFO - Downloading https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:24:35 INFO - Downloaded 61436042 bytes. 15:24:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 15:24:35 INFO - mkdir: /builds/slave/test/properties 15:24:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:24:35 INFO - Writing to file /builds/slave/test/properties/build_url 15:24:35 INFO - Contents: 15:24:35 INFO - build_url:https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 15:24:35 INFO - Running post-action listener: _resource_record_post_action 15:24:35 INFO - Running post-action listener: find_tests_for_verification 15:24:35 INFO - Running post-action listener: set_extra_try_arguments 15:24:35 INFO - [mozharness: 2017-09-17 22:24:35.466833Z] Finished download-and-extract step (success) 15:24:35 INFO - [mozharness: 2017-09-17 22:24:35.466930Z] Running populate-webroot step. 15:24:35 INFO - Running pre-action listener: _resource_record_pre_action 15:24:35 INFO - Running main action method: populate_webroot 15:24:35 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:24:35 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:35 INFO - 'tests': ['tresize', 15:24:35 INFO - 'tcanvasmark']}, 15:24:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:24:35 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:35 INFO - 'tests': ['dromaeo_css', 15:24:35 INFO - 'kraken']}, 15:24:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:24:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:35 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:35 INFO - 'talos_options': ['--disable-stylo'], 15:24:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:24:35 INFO - 'tests': ['damp', 'tps']}, 15:24:35 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:35 INFO - 'talos_options': ['--disable-stylo'], 15:24:35 INFO - 'tests': ['damp', 'tps']}, 15:24:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:24:35 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:35 INFO - 'tests': ['dromaeo_dom']}, 15:24:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:24:35 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:35 INFO - 'tests': ['basic_compositor_video', 15:24:35 INFO - 'glvideo']}, 15:24:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:24:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:24:35 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:35 INFO - 'talos_options': ['--disable-stylo'], 15:24:35 INFO - 'tests': ['ts_paint_webext', 15:24:35 INFO - 'tp5o_webext']}, 15:24:35 INFO - 'other-e10s': {'tests': ['a11yr', 15:24:35 INFO - 'ts_paint', 15:24:35 INFO - 'tpaint', 15:24:35 INFO - 'sessionrestore', 15:24:35 INFO - 'sessionrestore_many_windows', 15:24:35 INFO - 'sessionrestore_no_auto_restore', 15:24:35 INFO - 'tabpaint']}, 15:24:35 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:35 INFO - 'tests': ['a11yr', 15:24:35 INFO - 'ts_paint', 15:24:35 INFO - 'tpaint', 15:24:35 INFO - 'sessionrestore', 15:24:35 INFO - 'sessionrestore_many_windows', 15:24:35 INFO - 'sessionrestore_no_auto_restore', 15:24:35 INFO - 'tabpaint']}, 15:24:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:24:35 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:24:35 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:35 INFO - 'tests': ['perf_reftest_singletons']}, 15:24:35 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:35 INFO - 'tests': ['bloom_basic']}, 15:24:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:24:35 INFO - 'tsvgr_opacity', 15:24:35 INFO - 'tart', 15:24:35 INFO - 'tscrollx', 15:24:35 INFO - 'tsvg_static']}, 15:24:35 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:35 INFO - 'tests': ['tsvgx', 15:24:35 INFO - 'tsvgr_opacity', 15:24:35 INFO - 'tart', 15:24:35 INFO - 'tscrollx', 15:24:35 INFO - 'tsvg_static']}, 15:24:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:24:35 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:35 INFO - 'talos_options': ['--disable-stylo'], 15:24:35 INFO - 'tests': ['tp5o']}, 15:24:35 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:24:35 INFO - 'talos_options': ['--mitmproxy', 15:24:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:24:35 INFO - '--firstNonBlankPaint'], 15:24:35 INFO - 'tests': ['tp6_google', 15:24:35 INFO - 'tp6_youtube', 15:24:35 INFO - 'tp6_amazon', 15:24:35 INFO - 'tp6_facebook']}, 15:24:35 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:24:35 INFO - 'talos_options': ['--disable-stylo', 15:24:35 INFO - '--mitmproxy', 15:24:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:24:35 INFO - '--firstNonBlankPaint'], 15:24:35 INFO - 'tests': ['tp6_google', 15:24:35 INFO - 'tp6_youtube', 15:24:35 INFO - 'tp6_amazon', 15:24:35 INFO - 'tp6_facebook']}, 15:24:35 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:24:35 INFO - 'talos_options': ['--stylo-threads=1', 15:24:35 INFO - '--mitmproxy', 15:24:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:24:35 INFO - '--firstNonBlankPaint'], 15:24:35 INFO - 'tests': ['tp6_google', 15:24:35 INFO - 'tp6_youtube', 15:24:35 INFO - 'tp6_amazon', 15:24:35 INFO - 'tp6_facebook']}, 15:24:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:24:35 INFO - 'talos_options': ['--xperf_path', 15:24:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:35 INFO - 'tests': ['tp5n']}, 15:24:35 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:35 INFO - 'talos_options': ['--disable-stylo', 15:24:35 INFO - '--xperf_path', 15:24:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:35 INFO - 'tests': ['tp5n']}}} 15:24:35 INFO - Running post-action listener: _resource_record_post_action 15:24:35 INFO - [mozharness: 2017-09-17 22:24:35.481833Z] Finished populate-webroot step (success) 15:24:35 INFO - [mozharness: 2017-09-17 22:24:35.481923Z] Running create-virtualenv step. 15:24:35 INFO - Running pre-action listener: _resource_record_pre_action 15:24:35 INFO - Running main action method: create_virtualenv 15:24:35 INFO - Creating virtualenv /builds/slave/test/build/venv 15:24:35 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:24:35 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:24:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:24:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:24:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:24:36 INFO - Installing distribute.............................................................................................................................................................................................done. 15:24:36 INFO - Installing pip...............done. 15:24:36 INFO - Return code: 0 15:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:24:36 INFO - Reading from file tmpfile_stdout 15:24:36 INFO - Output received: 15:24:36 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:24:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:24:36 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')]} 15:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:36 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')]} 15:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:36 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 0x1f701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2139a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22dca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e0090>, '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 0x22e0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22daf90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', '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 15:24:36 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 15:24:36 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 15:24:36 INFO - Using env: {'DISPLAY': ':0', 15:24:36 INFO - 'HOME': '/home/cltbld', 15:24:36 INFO - 'LANG': 'en_US.UTF-8', 15:24:36 INFO - 'LANGUAGE': 'en_US:en', 15:24:36 INFO - 'LOGNAME': 'cltbld', 15:24:36 INFO - 'MAIL': '/var/mail/cltbld', 15:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:36 INFO - 'MOZ_NO_REMOTE': '1', 15:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:36 INFO - 'NO_EM_RESTART': '1', 15:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:36 INFO - 'PWD': '/builds/slave/test', 15:24:36 INFO - 'SHELL': '/bin/bash', 15:24:36 INFO - 'SHLVL': '1', 15:24:36 INFO - 'TERM': 'linux', 15:24:36 INFO - 'TMOUT': '86400', 15:24:36 INFO - 'USER': 'cltbld', 15:24:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:36 INFO - '_': '/tools/buildbot/bin/python'} 15:24:37 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:24:37 INFO - Downloading/unpacking pip>=1.5 15:24:37 INFO - Running setup.py egg_info for package pip 15:24:37 INFO - warning: no files found matching 'pip/cacert.pem' 15:24:37 INFO - warning: no files found matching '*.html' under directory 'docs' 15:24:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:24:37 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:24:37 INFO - Installing collected packages: pip 15:24:37 INFO - Found existing installation: pip 1.1 15:24:37 INFO - Uninstalling pip: 15:24:37 INFO - Successfully uninstalled pip 15:24:37 INFO - Running setup.py install for pip 15:24:37 INFO - warning: no files found matching 'pip/cacert.pem' 15:24:37 INFO - warning: no files found matching '*.html' under directory 'docs' 15:24:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:24:37 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:24:37 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:24:37 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:24:37 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:24:37 INFO - Successfully installed pip 15:24:37 INFO - Cleaning up... 15:24:37 INFO - Return code: 0 15:24:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24: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')]} 15:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24: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', '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 0x1f701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2139a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22dca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e0090>, '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 0x22e0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22daf90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', '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 15:24: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:24: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 psutil>=3.1.1 15:24:37 INFO - Using env: {'DISPLAY': ':0', 15:24:37 INFO - 'HOME': '/home/cltbld', 15:24:37 INFO - 'LANG': 'en_US.UTF-8', 15:24:37 INFO - 'LANGUAGE': 'en_US:en', 15:24:37 INFO - 'LOGNAME': 'cltbld', 15:24:37 INFO - 'MAIL': '/var/mail/cltbld', 15:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:37 INFO - 'MOZ_NO_REMOTE': '1', 15:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:37 INFO - 'NO_EM_RESTART': '1', 15:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:37 INFO - 'PWD': '/builds/slave/test', 15:24:37 INFO - 'SHELL': '/bin/bash', 15:24:37 INFO - 'SHLVL': '1', 15:24:37 INFO - 'TERM': 'linux', 15:24:37 INFO - 'TMOUT': '86400', 15:24:37 INFO - 'USER': 'cltbld', 15:24:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:37 INFO - '_': '/tools/buildbot/bin/python'} 15:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:38 INFO - Downloading/unpacking psutil>=3.1.1 15:24:38 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 15:24:38 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 15:24:38 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 15:24:38 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 15:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:24:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:39 INFO - Installing collected packages: psutil 15:24:39 INFO - Running setup.py install for psutil 15:24:39 INFO - building 'psutil._psutil_linux' extension 15:24:39 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 15:24:39 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 15:24:39 INFO - building 'psutil._psutil_posix' extension 15:24:39 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 15:24:39 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 15:24:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:39 INFO - Successfully installed psutil 15:24:39 INFO - Cleaning up... 15:24:39 INFO - Return code: 0 15:24:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2139a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22dca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e0090>, '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 0x22e0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22daf90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', '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 15:24:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:24:39 INFO - Using env: {'DISPLAY': ':0', 15:24:39 INFO - 'HOME': '/home/cltbld', 15:24:39 INFO - 'LANG': 'en_US.UTF-8', 15:24:39 INFO - 'LANGUAGE': 'en_US:en', 15:24:39 INFO - 'LOGNAME': 'cltbld', 15:24:39 INFO - 'MAIL': '/var/mail/cltbld', 15:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:39 INFO - 'MOZ_NO_REMOTE': '1', 15:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:39 INFO - 'NO_EM_RESTART': '1', 15:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:39 INFO - 'PWD': '/builds/slave/test', 15:24:39 INFO - 'SHELL': '/bin/bash', 15:24:39 INFO - 'SHLVL': '1', 15:24:39 INFO - 'TERM': 'linux', 15:24:39 INFO - 'TMOUT': '86400', 15:24:39 INFO - 'USER': 'cltbld', 15:24:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:39 INFO - '_': '/tools/buildbot/bin/python'} 15:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:24:40 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 15:24:40 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 15:24:40 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 15:24:40 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 15:24:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:24:41 INFO - Installing collected packages: mozsystemmonitor 15:24:41 INFO - Running setup.py install for mozsystemmonitor 15:24:41 INFO - Successfully installed mozsystemmonitor 15:24:41 INFO - Cleaning up... 15:24:42 INFO - Return code: 0 15:24:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24: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')]} 15:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24: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 0x1f701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2139a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22dca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e0090>, '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 0x22e0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22daf90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', '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 15:24: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 15:24: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 15:24:42 INFO - Using env: {'DISPLAY': ':0', 15:24:42 INFO - 'HOME': '/home/cltbld', 15:24:42 INFO - 'LANG': 'en_US.UTF-8', 15:24:42 INFO - 'LANGUAGE': 'en_US:en', 15:24:42 INFO - 'LOGNAME': 'cltbld', 15:24:42 INFO - 'MAIL': '/var/mail/cltbld', 15:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:42 INFO - 'MOZ_NO_REMOTE': '1', 15:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:42 INFO - 'NO_EM_RESTART': '1', 15:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:42 INFO - 'PWD': '/builds/slave/test', 15:24:42 INFO - 'SHELL': '/bin/bash', 15:24:42 INFO - 'SHLVL': '1', 15:24:42 INFO - 'TERM': 'linux', 15:24:42 INFO - 'TMOUT': '86400', 15:24:42 INFO - 'USER': 'cltbld', 15:24:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:42 INFO - '_': '/tools/buildbot/bin/python'} 15:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:42 INFO - Downloading/unpacking jsonschema==2.5.1 15:24:42 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 15:24:42 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 15:24:42 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 15:24:42 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 15:24:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:24:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:24: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 15:24: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 15:24: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 15:24: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 15:24:43 INFO - Downloading functools32-3.2.3-2.tar.gz 15:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:24:44 INFO - warning: no files found matching '*.txt' 15:24:44 INFO - no previously-included directories found matching 'build' 15:24:44 INFO - no previously-included directories found matching 'dist' 15:24:44 INFO - no previously-included directories found matching '.git*' 15:24:44 INFO - Installing collected packages: jsonschema, functools32 15:24:44 INFO - Running setup.py install for functools32 15:24:44 INFO - warning: no files found matching '*.txt' 15:24:44 INFO - no previously-included directories found matching 'build' 15:24:44 INFO - no previously-included directories found matching 'dist' 15:24:44 INFO - no previously-included directories found matching '.git*' 15:24:44 INFO - Successfully installed jsonschema functools32 15:24:44 INFO - Cleaning up... 15:24:45 INFO - Return code: 0 15:24:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:24:45 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')]} 15:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:45 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')]} 15:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:45 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 0x1f701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2139a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22dca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e0090>, '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 0x22e0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22daf90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', '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 15:24:45 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 15:24:45 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 15:24:45 INFO - Using env: {'DISPLAY': ':0', 15:24:45 INFO - 'HOME': '/home/cltbld', 15:24:45 INFO - 'LANG': 'en_US.UTF-8', 15:24:45 INFO - 'LANGUAGE': 'en_US:en', 15:24:45 INFO - 'LOGNAME': 'cltbld', 15:24:45 INFO - 'MAIL': '/var/mail/cltbld', 15:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:45 INFO - 'MOZ_NO_REMOTE': '1', 15:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:45 INFO - 'NO_EM_RESTART': '1', 15:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:45 INFO - 'PWD': '/builds/slave/test', 15:24:45 INFO - 'SHELL': '/bin/bash', 15:24:45 INFO - 'SHLVL': '1', 15:24:45 INFO - 'TERM': 'linux', 15:24:45 INFO - 'TMOUT': '86400', 15:24:45 INFO - 'USER': 'cltbld', 15:24:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:45 INFO - '_': '/tools/buildbot/bin/python'} 15:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:24:45 INFO - Cleaning up... 15:24:45 INFO - Return code: 0 15:24:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:24:45 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')]} 15:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:45 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')]} 15:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:45 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 0x1f701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2139a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22dca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e0090>, '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 0x22e0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22daf90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', '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 15:24:45 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 15:24:45 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 15:24:45 INFO - Using env: {'DISPLAY': ':0', 15:24:45 INFO - 'HOME': '/home/cltbld', 15:24:45 INFO - 'LANG': 'en_US.UTF-8', 15:24:45 INFO - 'LANGUAGE': 'en_US:en', 15:24:45 INFO - 'LOGNAME': 'cltbld', 15:24:45 INFO - 'MAIL': '/var/mail/cltbld', 15:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:45 INFO - 'MOZ_NO_REMOTE': '1', 15:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:45 INFO - 'NO_EM_RESTART': '1', 15:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:45 INFO - 'PWD': '/builds/slave/test', 15:24:45 INFO - 'SHELL': '/bin/bash', 15:24:45 INFO - 'SHLVL': '1', 15:24:45 INFO - 'TERM': 'linux', 15:24:45 INFO - 'TMOUT': '86400', 15:24:45 INFO - 'USER': 'cltbld', 15:24:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:45 INFO - '_': '/tools/buildbot/bin/python'} 15:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:45 INFO - Downloading/unpacking blobuploader==1.2.4 15:24: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 15:24: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 15:24: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 15:24: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 15:24:47 INFO - Downloading blobuploader-1.2.4.tar.gz 15:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:24:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:24:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:47 INFO - Downloading docopt-0.6.1.tar.gz 15:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:24:47 INFO - Installing collected packages: blobuploader, requests, docopt 15:24:47 INFO - Running setup.py install for blobuploader 15:24:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:24:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:24:47 INFO - Running setup.py install for requests 15:24:48 INFO - Running setup.py install for docopt 15:24:48 INFO - Successfully installed blobuploader requests docopt 15:24:48 INFO - Cleaning up... 15:24:48 INFO - Return code: 0 15:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:48 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')]} 15:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:48 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')]} 15:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:48 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 0x1f701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2139a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22dca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e0090>, '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 0x22e0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22daf90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', '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 15:24:48 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 15:24:48 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 15:24:48 INFO - Using env: {'DISPLAY': ':0', 15:24:48 INFO - 'HOME': '/home/cltbld', 15:24:48 INFO - 'LANG': 'en_US.UTF-8', 15:24:48 INFO - 'LANGUAGE': 'en_US:en', 15:24:48 INFO - 'LOGNAME': 'cltbld', 15:24:48 INFO - 'MAIL': '/var/mail/cltbld', 15:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:48 INFO - 'MOZ_NO_REMOTE': '1', 15:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:48 INFO - 'NO_EM_RESTART': '1', 15:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:48 INFO - 'PWD': '/builds/slave/test', 15:24:48 INFO - 'SHELL': '/bin/bash', 15:24:48 INFO - 'SHLVL': '1', 15:24:48 INFO - 'TERM': 'linux', 15:24:48 INFO - 'TMOUT': '86400', 15:24:48 INFO - 'USER': 'cltbld', 15:24:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:48 INFO - '_': '/tools/buildbot/bin/python'} 15:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:48 INFO - Running setup.py (path:/tmp/pip-HEOSyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:48 INFO - Running setup.py (path:/tmp/pip-Wxkqcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:48 INFO - Running setup.py (path:/tmp/pip-uEEdoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:48 INFO - Running setup.py (path:/tmp/pip-bzmSCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:48 INFO - Running setup.py (path:/tmp/pip-Ds0fcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:48 INFO - Running setup.py (path:/tmp/pip-pNySLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:48 INFO - Running setup.py (path:/tmp/pip-5AKGQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:48 INFO - Running setup.py (path:/tmp/pip-R7cr2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:49 INFO - Running setup.py (path:/tmp/pip-fa9idc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:49 INFO - Running setup.py (path:/tmp/pip-4PQvoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:49 INFO - Running setup.py (path:/tmp/pip-zVmPVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:49 INFO - Running setup.py (path:/tmp/pip-surt1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:49 INFO - Running setup.py (path:/tmp/pip-3z3Uto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:49 INFO - Running setup.py (path:/tmp/pip-HkyBKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:49 INFO - Running setup.py (path:/tmp/pip-HSPN3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:49 INFO - Running setup.py (path:/tmp/pip-UjYvcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:49 INFO - Running setup.py (path:/tmp/pip-bDCGco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:24:49 INFO - Running setup.py install for manifestparser 15:24:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:24:49 INFO - Running setup.py install for mozcrash 15:24:49 INFO - Running setup.py install for mozdebug 15:24:49 INFO - Running setup.py install for mozdevice 15:24:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:24:50 INFO - Running setup.py install for mozfile 15:24:50 INFO - Running setup.py install for mozhttpd 15:24:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:24:50 INFO - Running setup.py install for mozinfo 15:24:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:24:50 INFO - Running setup.py install for mozInstall 15:24:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:24:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:24:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:24:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:24:50 INFO - Running setup.py install for mozleak 15:24:50 INFO - Running setup.py install for mozlog 15:24:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:24:50 INFO - Running setup.py install for moznetwork 15:24:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:24:50 INFO - Running setup.py install for mozprocess 15:24:50 INFO - Running setup.py install for mozprofile 15:24:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:24:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:24:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:24:51 INFO - Running setup.py install for mozrunner 15:24:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:24:51 INFO - Running setup.py install for mozscreenshot 15:24:51 INFO - Running setup.py install for moztest 15:24:51 INFO - Running setup.py install for mozversion 15:24:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:24:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:24:51 INFO - Cleaning up... 15:24:51 INFO - Return code: 0 15:24:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:51 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 0x1f701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2139a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22dca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e0090>, '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 0x22e0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22daf90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', '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 15:24:51 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 15:24:51 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 15:24:51 INFO - Using env: {'DISPLAY': ':0', 15:24:51 INFO - 'HOME': '/home/cltbld', 15:24:51 INFO - 'LANG': 'en_US.UTF-8', 15:24:51 INFO - 'LANGUAGE': 'en_US:en', 15:24:51 INFO - 'LOGNAME': 'cltbld', 15:24:51 INFO - 'MAIL': '/var/mail/cltbld', 15:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:51 INFO - 'MOZ_NO_REMOTE': '1', 15:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:51 INFO - 'NO_EM_RESTART': '1', 15:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:51 INFO - 'PWD': '/builds/slave/test', 15:24:51 INFO - 'SHELL': '/bin/bash', 15:24:51 INFO - 'SHLVL': '1', 15:24:51 INFO - 'TERM': 'linux', 15:24:51 INFO - 'TMOUT': '86400', 15:24:51 INFO - 'USER': 'cltbld', 15:24:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:51 INFO - '_': '/tools/buildbot/bin/python'} 15:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:51 INFO - Running setup.py (path:/tmp/pip-mlTAbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:51 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)) 15:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:51 INFO - Running setup.py (path:/tmp/pip-S6tbPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:51 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)) 15:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:51 INFO - Running setup.py (path:/tmp/pip-8htUhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:51 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)) 15:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:51 INFO - Running setup.py (path:/tmp/pip-eMfASZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24: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)) 15:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:51 INFO - Running setup.py (path:/tmp/pip-6XMUl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:52 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)) 15:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:52 INFO - Running setup.py (path:/tmp/pip-FMb1jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:52 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)) 15:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:52 INFO - Running setup.py (path:/tmp/pip-_52mc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:52 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)) 15:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:52 INFO - Running setup.py (path:/tmp/pip-nUScgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:52 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)) 15:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:52 INFO - Running setup.py (path:/tmp/pip-LF7w0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:52 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)) 15:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:52 INFO - Running setup.py (path:/tmp/pip-shR93A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:52 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)) 15:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:52 INFO - Running setup.py (path:/tmp/pip-j2darT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:52 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)) 15:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:52 INFO - Running setup.py (path:/tmp/pip-dM2TJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:52 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)) 15:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:52 INFO - Running setup.py (path:/tmp/pip-CKU7KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:52 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)) 15:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:52 INFO - Running setup.py (path:/tmp/pip-O9TvVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:52 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)) 15:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:52 INFO - Running setup.py (path:/tmp/pip-04IQMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:52 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)) 15:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:52 INFO - Running setup.py (path:/tmp/pip-g4ep1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:52 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)) 15:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:52 INFO - Running setup.py (path:/tmp/pip-sdR68a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:52 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)) 15:24:52 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)) 15:24:52 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)) 15:24:52 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)) 15:24:52 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)) 15:24:52 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)) 15:24:52 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)) 15:24:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:24:52 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 15:24:52 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 15:24:52 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 15:24:52 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 15:24:53 INFO - Downloading blessings-1.6.tar.gz 15:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:24:54 INFO - Installing collected packages: blessings 15:24:54 INFO - Running setup.py install for blessings 15:24:54 INFO - Successfully installed blessings 15:24:54 INFO - Cleaning up... 15:24:54 INFO - Return code: 0 15:24:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:24:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:54 INFO - Reading from file tmpfile_stdout 15:24:54 INFO - Current package versions: 15:24:54 INFO - argparse == 1.2.1 15:24:54 INFO - blessings == 1.6 15:24:54 INFO - blobuploader == 1.2.4 15:24:54 INFO - docopt == 0.6.1 15:24:54 INFO - functools32 == 3.2.3-2 15:24:54 INFO - jsonschema == 2.5.1 15:24:54 INFO - manifestparser == 1.1 15:24:54 INFO - mozInstall == 1.13 15:24:54 INFO - mozcrash == 1.0 15:24:54 INFO - mozdebug == 0.1 15:24:54 INFO - mozdevice == 0.51 15:24:54 INFO - mozfile == 1.2 15:24:54 INFO - mozhttpd == 0.7 15:24:54 INFO - mozinfo == 0.10 15:24:54 INFO - mozleak == 0.1 15:24:54 INFO - mozlog == 3.5 15:24:54 INFO - moznetwork == 0.27 15:24:54 INFO - mozprocess == 0.25 15:24:54 INFO - mozprofile == 0.28 15:24:54 INFO - mozrunner == 6.13 15:24:54 INFO - mozscreenshot == 0.1 15:24:54 INFO - mozsystemmonitor == 0.3 15:24:54 INFO - moztest == 0.8 15:24:54 INFO - mozversion == 1.4 15:24:54 INFO - psutil == 3.1.1 15:24:54 INFO - requests == 1.2.3 15:24:54 INFO - wsgiref == 0.1.2 15:24:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:54 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')]} 15:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:54 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')]} 15:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:54 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 0x1f701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2139a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22dca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e0090>, '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 0x22e0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22daf90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', '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 15:24:54 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 15:24:54 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 15:24:54 INFO - Using env: {'DISPLAY': ':0', 15:24:54 INFO - 'HOME': '/home/cltbld', 15:24:54 INFO - 'LANG': 'en_US.UTF-8', 15:24:54 INFO - 'LANGUAGE': 'en_US:en', 15:24:54 INFO - 'LOGNAME': 'cltbld', 15:24:54 INFO - 'MAIL': '/var/mail/cltbld', 15:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:54 INFO - 'MOZ_NO_REMOTE': '1', 15:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:54 INFO - 'NO_EM_RESTART': '1', 15:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:54 INFO - 'PWD': '/builds/slave/test', 15:24:54 INFO - 'SHELL': '/bin/bash', 15:24:54 INFO - 'SHLVL': '1', 15:24:54 INFO - 'TERM': 'linux', 15:24:54 INFO - 'TMOUT': '86400', 15:24:54 INFO - 'USER': 'cltbld', 15:24:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:54 INFO - '_': '/tools/buildbot/bin/python'} 15:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:54 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)) 15:24:54 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)) 15:24:54 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)) 15:24:54 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)) 15:24:54 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)) 15:24:54 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)) 15:24:54 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)) 15:24:54 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)) 15:24:54 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)) 15:24:54 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:24:55 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)) 15:24:55 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)) 15:24:55 INFO - Installing collected packages: simplejson 15:24:55 INFO - Running setup.py install for simplejson 15:24:55 INFO - building 'simplejson._speedups' extension 15:24: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 15:24:56 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 15:24:56 INFO - Successfully installed simplejson 15:24:56 INFO - Cleaning up... 15:24:56 INFO - Return code: 0 15:24:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2139a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22dca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e0090>, '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 0x22e0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22daf90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', '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 15:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:24:56 INFO - Using env: {'DISPLAY': ':0', 15:24:56 INFO - 'HOME': '/home/cltbld', 15:24:56 INFO - 'LANG': 'en_US.UTF-8', 15:24:56 INFO - 'LANGUAGE': 'en_US:en', 15:24:56 INFO - 'LOGNAME': 'cltbld', 15:24:56 INFO - 'MAIL': '/var/mail/cltbld', 15:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:56 INFO - 'MOZ_NO_REMOTE': '1', 15:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:56 INFO - 'NO_EM_RESTART': '1', 15:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:56 INFO - 'PWD': '/builds/slave/test', 15:24:56 INFO - 'SHELL': '/bin/bash', 15:24:56 INFO - 'SHLVL': '1', 15:24:56 INFO - 'TERM': 'linux', 15:24:56 INFO - 'TMOUT': '86400', 15:24:56 INFO - 'USER': 'cltbld', 15:24:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:56 INFO - '_': '/tools/buildbot/bin/python'} 15:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:24:57 INFO - Cleaning up... 15:24:57 INFO - Return code: 0 15:24:57 INFO - Running post-action listener: _resource_record_post_action 15:24:57 INFO - Running post-action listener: _start_resource_monitoring 15:24:57 INFO - Starting resource monitoring. 15:24:57 INFO - [mozharness: 2017-09-17 22:24:57.135230Z] Finished create-virtualenv step (success) 15:24:57 INFO - [mozharness: 2017-09-17 22:24:57.135871Z] Running install step. 15:24:57 INFO - Running pre-action listener: _resource_record_pre_action 15:24:57 INFO - Running main action method: install 15:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:57 INFO - Reading from file tmpfile_stdout 15:24:57 INFO - Detecting whether we're running mozinstall >=1.0... 15:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:24:57 INFO - Reading from file tmpfile_stdout 15:24:57 INFO - Output received: 15:24:57 INFO - Usage: mozinstall [options] installer 15:24:57 INFO - Options: 15:24:57 INFO - -h, --help show this help message and exit 15:24:57 INFO - -d DEST, --destination=DEST 15:24:57 INFO - Directory to install application into. [default: 15:24:57 INFO - "/builds/slave/test"] 15:24:57 INFO - --app=APP Application being installed. [default: firefox] 15:24:57 INFO - mkdir: /builds/slave/test/build/application 15:24:57 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'] 15:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:25:15 INFO - Reading from file tmpfile_stdout 15:25:15 INFO - Output received: 15:25:15 INFO - /builds/slave/test/build/application/firefox/firefox 15:25:15 INFO - Running post-action listener: _resource_record_post_action 15:25:15 INFO - [mozharness: 2017-09-17 22:25:15.257305Z] Finished install step (success) 15:25:15 INFO - [mozharness: 2017-09-17 22:25:15.257556Z] Running setup-mitmproxy step. 15:25:15 INFO - Running pre-action listener: _resource_record_pre_action 15:25:15 INFO - Running main action method: setup_mitmproxy 15:25:15 INFO - Skipping: mitmproxy is not required 15:25:15 INFO - Running post-action listener: _resource_record_post_action 15:25:15 INFO - [mozharness: 2017-09-17 22:25:15.258684Z] Finished setup-mitmproxy step (success) 15:25:15 INFO - [mozharness: 2017-09-17 22:25:15.258901Z] Running run-tests step. 15:25:15 INFO - Running pre-action listener: _resource_record_pre_action 15:25:15 INFO - Running pre-action listener: _set_gcov_prefix 15:25:15 INFO - Running main action method: run_tests 15:25:15 WARNING - Try message not found. 15:25:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:25:15 INFO - Python 2.7.3 15:25:15 INFO - Return code: 0 15:25:15 INFO - grabbing minidump binary from tooltool 15:25:15 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')]} 15:25:15 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 0x22e0090>, '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 0x22e0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22daf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:25:15 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 15:25:15 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 15:25:15 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 15:25:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:25:15 INFO - Return code: 0 15:25:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:25:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:25:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:25:15 INFO - ENV: RUST_BACKTRACE is now full 15:25:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:25:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:25:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 15:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 15:25:15 INFO - Using env: {'DISPLAY': ':0', 15:25:15 INFO - 'HOME': '/home/cltbld', 15:25:15 INFO - 'LANG': 'en_US.UTF-8', 15:25:15 INFO - 'LANGUAGE': 'en_US:en', 15:25:15 INFO - 'LOGNAME': 'cltbld', 15:25:15 INFO - 'MAIL': '/var/mail/cltbld', 15:25:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:15 INFO - 'MOZ_NO_REMOTE': '1', 15:25:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:15 INFO - 'NO_EM_RESTART': '1', 15:25:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:15 INFO - 'PWD': '/builds/slave/test', 15:25:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:15 INFO - 'RUST_BACKTRACE': 'full', 15:25:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:25:15 INFO - 'SHELL': '/bin/bash', 15:25:15 INFO - 'SHLVL': '1', 15:25:15 INFO - 'TERM': 'linux', 15:25:15 INFO - 'TMOUT': '86400', 15:25:15 INFO - 'USER': 'cltbld', 15:25:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:15 INFO - '_': '/tools/buildbot/bin/python'} 15:25:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 15:25:15 INFO - mozversion application_buildid: 20170917213235 15:25:15 INFO - mozversion application_changeset: ae39864562c6048fdc2950c5dfedb48e247c3300 15:25:15 INFO - mozversion application_display_name: Nightly 15:25:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:25:15 INFO - mozversion application_name: Firefox 15:25:15 INFO - mozversion application_remotingname: firefox 15:25:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:25:15 INFO - mozversion application_vendor: Mozilla 15:25:15 INFO - mozversion application_version: 57.0a1 15:25:15 INFO - mozversion platform_buildid: 20170917213235 15:25:15 INFO - mozversion platform_changeset: ae39864562c6048fdc2950c5dfedb48e247c3300 15:25:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:25:15 INFO - mozversion platform_version: 57.0a1 15:25:15 INFO - using testdate: 1505687115 15:25:15 INFO - actual date: 1505687115 15:25:15 INFO - starting webserver on 'localhost:35586' 15:25:15 INFO - SUITE-START | Running 2 tests 15:25:15 INFO - TEST-START | dromaeo_css 15:25:15 INFO - Initialising browser for dromaeo_css test... 15:25:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35586/getInfo.html -profile /tmp/tmpkvA4LS/profile 15:25:15 INFO - TEST-INFO | started process 22372 (/builds/slave/test/build/application/firefox/firefox http://localhost:35586/getInfo.html) 15:25:21 INFO - TEST-INFO | 22372: exit 0 15:25:21 INFO - Browser initialized. 15:25:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:25:22 INFO - Using env: {'DISPLAY': ':0', 15:25:22 INFO - 'HOME': '/home/cltbld', 15:25:22 INFO - 'JSGC_DISABLE_POISONING': '1', 15:25:22 INFO - 'LANG': 'en_US.UTF-8', 15:25:22 INFO - 'LANGUAGE': 'en_US:en', 15:25:22 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:25:22 INFO - 'LOGNAME': 'cltbld', 15:25:22 INFO - 'MAIL': '/var/mail/cltbld', 15:25:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:22 INFO - 'MOZ_CRASHREPORTER': '1', 15:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:22 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:25:22 INFO - 'MOZ_NO_REMOTE': '1', 15:25:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:22 INFO - 'NO_EM_RESTART': '1', 15:25:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:22 INFO - 'PWD': '/builds/slave/test', 15:25:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:22 INFO - 'RUST_BACKTRACE': 'full', 15:25:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:25:22 INFO - 'SHELL': '/bin/bash', 15:25:22 INFO - 'SHLVL': '1', 15:25:22 INFO - 'STYLO_FORCE_DISABLED': '1', 15:25:22 INFO - 'TERM': 'linux', 15:25:22 INFO - 'TMOUT': '86400', 15:25:22 INFO - 'USER': 'cltbld', 15:25:22 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:22 INFO - '_': '/tools/buildbot/bin/python'} 15:25:22 INFO - TEST-INFO | started process 22608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkvA4LS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:22 INFO - PID 22608 | 15:25:22 INFO - PID 22608 | (/builds/slave/test/build/application/firefox/firefox:22658): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:25:22 INFO - PID 22608 | 15:25:33 INFO - PID 22608 | RSS: Main: 154411008 15:25:33 INFO - PID 22608 | 15:28:30 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:35586/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35586/tests/dromaeo/cssquery-ext.html) 15:28:32 INFO - PID 22608 | RSS: Main: 155357184 15:28:32 INFO - PID 22608 | 15:31:34 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:35586/tests/dromaeo/cssquery-ext.html (next: http://localhost:35586/tests/dromaeo/cssquery-jquery.html) 15:31:34 INFO - PID 22608 | RSS: Main: 155361280 15:31:34 INFO - PID 22608 | 15:34:36 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:35586/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35586/tests/dromaeo/cssquery-mootools.html) 15:34:37 INFO - PID 22608 | RSS: Main: 157265920 15:34:37 INFO - PID 22608 | 15:37:38 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:35586/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35586/tests/dromaeo/cssquery-prototype.html) 15:37:39 INFO - PID 22608 | RSS: Main: 155869184 15:37:39 INFO - PID 22608 | 15:40:42 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:35586/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35586/tests/dromaeo/cssquery-yui.html) 15:40:43 INFO - PID 22608 | RSS: Main: 156975104 15:40:43 INFO - PID 22608 | 15:43:44 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:35586/tests/dromaeo/cssquery-yui.html (next: http://localhost:35586/tests/dromaeo/cssquery-dojo.html) 15:43:45 INFO - PID 22608 | RSS: Main: 159621120 15:43:45 INFO - PID 22608 | 15:43:45 INFO - PID 22608 | __start_tp_report 15:43:45 INFO - PID 22608 | _x_x_mozilla_page_load 15:43:45 INFO - PID 22608 | _x_x_mozilla_page_load_details 15:43:45 INFO - PID 22608 | |i|pagename|runs| 15:43:45 INFO - PID 22608 | |0;dojo.html;3135.3885992231517;3153.385089907466;3172.9365412691745;3180.2208458927566;3180.363927214558;6259.248890133191;6343.904841427382;6364.299927008031;6369.936300636992;6475.611463312199;6289.905651415221;6316.431521163095;6324.588901721397;6358.046293056044;6361;5829.533637309027;5848.4736373726355;5860.67766272857;5864.648121112726;5906.173135760997;5876.7355469004;5937.67342796146;5948.226730525047;5950.464458198761;5958.9702051489685;5899.262592175978;5933.940660593404;5939.4654481096695;5972.343042265347;5975.850603734898;5717.514011309044;5755.395683453219;5783.797567085174;5872.324682661506;5970.223870896777;5804.187413762077;5820.301563812327;5870.559708021873;5880.9411905880825;5895.734691938873;6192.845178870519;6325.620462772203;6330.936690633081;6375.776847810304;6402.199725034371;6767.695453704595;6790.830229244259;6835;6854.246032936373;6866.176058872918;6891.483138764563;6895.172579290517;6942.72229110835;6947.131608548932;6951.339622735832;6326.715297811609;6330.9683451582905;6374.9681251594375;6423.518236132262;6430.807075787734;6963.582185068912;7032.437405007587;7081.362677358959;7082.716691332392;7112.324329188718;6740.393364597112;6753.3921947025;6766.72933082681;6775.830604234933;6783.423409010191;6787.762428314985;6794.3545363190415;6798.728050878009;6880.174379074543;6885.311468853175;6610.10763546915;6734.326567343324;6782.287859774653;6788.321167883271;6879.140107486564;6809.421199198124;6866.313368663194;6878.209005964378;6891.173059232924;6892.069570608004;5405.621606487587;5414.83755487336;5433.483819037264;5434.130539113723;5442.537384322377;4332.696711230246;4627.676062675648;4639.884002899955;4666.580007799246;4708.223143181337;5779.653220806765;5788.392218816964;5795.710214489259;5798.246227990334;5800.88398232033;6754.12196414463;6755.49333799967;6760.357766012221;6774.729010839511;6774.796756097325;5767.538596912237;5771.336296325976;5772.451617096369;5774.797882074107;5777.624454410534;5723.6851973141875;5787.71061446926;5825.533957283407;5924.940750592526;5927.644341339534;6552.115464412339;6576.408123268929;6639.966800165968;6655.567388119756;6667.166604174478;6819;6829.93170068293;6908.585484870924;6919.757808476679;6922.480813938874;6370.108184854032;6482.2869484357625;6505.056766768697;6585.209774827052;6596.637184954873;6764.154480689914;6764.729410823512;6774.085498457645;6774.729010839708;6810.829729256809;6858.725650973905;6865.210500792273;6941.2364639888565;6960.4779641526075;6964.79105626832;6404.295527491879;6603.372679595431;6615.702293396713;6692.564983276072;6696.464282857457;6564.310747371648;6576.013597960153;6579.374959378852;6579.539432239889;6581.111549940888;6521.967390163209;6529.053287273414;6609.438197753245;6618.106555614931;6619.304972977768;6726.327367263235;6746.966265168643;6762.357576030269;6791.89812152828;6791.966040169965;6319.557630965788;6418.133551970424;6466.191726034246;6509.251436084911;6545.21457425112 15:43:45 INFO - PID 22608 | |1;ext.html;818.5252553518959;848.3043903998722;852.8379607874504;857.2627540315324;858.3433673239969;37255.441168382495;39855.60144398555;40822.387664184986;40846;40940.181196376056;38696.22607547847;38792;38960.220795584144;39015;39120;6925.480588955836;7036.472264580151;7048.189458212294;7062.85874282514;7067.89398159028;6969.6863641136015;7043.5421697589745;7045.506814522985;7060.576365418091;7068.3285087916565;6977.965110174442;7006.789796306119;7046.2601426850215;7661.23387661235;7797.376209903194;7753.457257991915;7797.532148071134;7806.453548251625;7813.9609301953415;7817.1791961843755;7441;7626.656800443993;7635.350995165418;7680.19357967411;7700.884486732703;36030.81984590086;36347.81826090853;36474.45288320677;36483.4527482088;36502.269954601026;3488.6511348865165;3501.7898926064518;3508.929821403583;3520;3534.452159915217;30926.22684432907;31038.224044398845;31072.37855242905;31111.84444077765;31154.376912461623;5121.487851214886;5139.12634852076;5150.562202212816;5206.505381988705;5232.136697444917;190553;191510;191904;191913;192023;40616.79691601523;41262;46316.536834631894;46350.76824615855;46860.297095543596;48511.27233091507;48926.75536622294;49238;49328.75335623299;49406;16119.758203626721;16235.594110147105;16271;16274.837251627569;16284.185790710653;13409.463621455228;13420.26188559619;13421.597352079454;13454.730905381837;13531.66170845717;13106.410211540504;13210.537631183055;13274.336283185801;13320.666983325495;13374;5348.117560602457;5402.135658294654;5419.132938729863;5455.09990851513;5597.524210442158;969.4910172159532;1012.1801340913884;1015.9288849780593;1017.7099526634873;1019.9133073688671;22535.211267605882;22627.773722262566;23176.884115579312;23190.188343408237;23351.182708605458;1056.57736905237;1113.2819331531116;1123.764009558002;1130.2992144870234;1145.2613064573304;11921.165518413627;12051.216670916363;12054.15620906528;12059.21615095016;12113.394330283627;230368;232997;233463;234282;235818;52176.21735673968;52200;52264;52315.47684523106;52352.73823630858;1442.1131004432198;1451.8112645356248;1461.5103940179947;1462.824461064679;1466.2082475463344;22434;22482.213122540634;22599.548009039398;22680.886595567576;22898.771012289664;35300.117497062776;35360.82319588386;35412.29175416426;35520.644793551735;35542.46686299759;198009;200218;200312;200799;200875;29687;29895.402091957603;29968.25079373033;31848.681513184572;33777.66222337844;43541;43799.12401752011;43860.561394385644;43959.560404395546;44270;31127.53308700326;31233.531497028016;31597.21006974844;31606.367872641957;31676.208094797814;30958.84520577383;31137.377252455277;31280.21799455032;31357.216069598442;31457;34208;35569.28861422809;35591.28817423689;35605.64394356127;35605.82197088998;30798.230044249074;30851.845740771154;30916.381672365977;31098.68901310958;31568.842155789072;22430.327090187322;23200.883995579916;23487.53024939526;23624.29127126189;23680.52638947177 15:43:45 INFO - PID 22608 | |2;jquery.html;550.6255746092658;559.2059275828324;560.9579281553885;574.2477354665389;587.9823605291841;22205.333839984807;22542.323730288077;22940.426489337773;22940.426489337773;22951.1967081152;23784.16755413561;24525.87737061312;24903.87548062257;25880.611790823106;26103.86948065262;6429.485641148697;6441.774537891175;6486.189226346707;6489.805305840809;6511.544191906569;6406;6502.6098434093865;6505.674716264168;6511.706973186194;6515.0227465880025;6751.898721519181;7056.753013644524;7116.5730056196535;7117.679704413314;7193.784186474414;7085.397741192005;7126.358627723504;7161;7201.567905925661;7202.891956620629;6598.901016484757;6877.552959057645;6890.827729306758;6895.75864844728;6902.413294869942;30973;31152.221194470094;31462.213444664067;31490.842545787353;31509.8424507876;2036.4196204081766;2065.7211276477783;2068.8758674479577;2069.782672819347;2072.357569153567;20534.47819155049;20747.54767166299;21286.467838304012;21387.8930605346;21598.89200553987;2525.0404846158526;2574.3178057814694;2636.8022398320204;2641.749033841782;2651.6287719719253;125630.37184814109;131734.3413282937;132425.337873311;138545.6145438543;140489;20069.59860802805;20157.899210504147;21213.681794773092;22154.667679984814;22494.775052249595;40848;41015;41021.17957640831;41161.382579261335;41169.382459263135;11169.106471482262;11279.492422840993;11348.432578371048;11358.26171298863;11403;9357.344985850925;9490.145886870216;9490.28822838276;9499.28755343352;9517.143457088896;11144.442777861237;11231.66305010851;11331.526901502917;11381.886181138249;11620.779818119145;3823.655870971626;4200.285951388271;4239.46749491916;4333.696641235147;4341.461708707393;928.2295694573488;935.7988032573029;948.9193418559362;953.7663272498282;953.8426159683574;18954.905225473784;19075.61848763017;19234.134463949154;19298;19685.803141968398;1012.9797404051877;1025.2823023883163;1025.8820235672845;1026.9537870795832;1029.1406675425953;10553.786314573768;10666.200034997251;10689.83965240522;10814.188935829687;10890.401027943539;488679;491078;503129;504150;504296;103211;105536;108506.45746771216;108633.45683271532;112575;999.2705325112709;1152.8962393384636;1167.0605162843822;1168.8363629091934;1176.688177632928;20583.485412864797;20666.586668266853;20713.68929466029;20776;20914.58170836605;54272;54711;54939.72530137324;55068;56256.43743562512;70381;70528;70676.29323706697;71012.28987710057;71668;19675.31136410219;19869.900650496656;19941.900290498455;20066.698999514727;20358.28745993883;22187.1125154992;22643.20748773785;22665.773342267024;22679.773202267766;22906.885465572566;17969;17971;18324.175412106222;18338.266469341077;18376.81623183751;15932.920335398248;16515.58711032234;16617;17098.316067357166;17167.914160429118;18703.625927481648;18719.438416847515;18834.623307533497;18885;19035.809641903405;19585.902070489556;19669.114889829707;19866.90066549658;19916.70124948098;19932.402027939184;18143.455696329132;18165.909170454062;18226.270949161884;18444.81555184431;18487.81512184861 15:43:45 INFO - PID 22608 | |3;mootools.html;1284.7880099783536;1339.7253563019578;1349.6693310139012;1356.952506662267;1363.1752789562308;14600.415983360666;15383.615409614766;15385.846061545373;15394.076355418683;15400.61498462539;15181.240937953085;15229.4669686561;15231.54305370838;15396.461123860667;15415.306311215994;2637.1956553251252;2784.220418282874;2786.4148528808973;2786.860656967154;2787.6236708044457;2561.180422264876;2582.0704546363295;2593.5072336256053;2600.2329312852753;2603.193010166845;2764.419471910901;2873.123697272331;2875.324298789783;2878.5106531889523;2879.0211328148425;2636.5122452346186;2645.285772841332;2665.2137619402224;2667.6131960865664;2667.719889411603;2595.4030572968136;2604.414006848463;2604.817662763607;2766.363736340633;2855.1006432973545;15223.771643425358;15335;15337.923310383489;15338.233088345538;15345.616359590987;7948.562829044458;8229.094799572102;8247.670093196264;8250;8250.38122140836;5347.1177255752755;5358.946410535884;5421.430749771257;5540.9168862467095;5557.555395568385;1923.6248931458372;1938.176275083098;1946.6106778644328;1974.032723965261;1976.6936124900662;26176.8691156543;26340.341491462674;26353;26377.868110659514;26386.47227055448;6656.167979002625;6765.289644587346;6801.4558835293055;6816.386525212655;7001.789946301619;17096.0597167157;17166.22751976164;17170.828291717175;17187.226574804165;17226.655466890592;7644.847103057908;7838.804029899184;7880.64537095832;7886.802829929183;7896.960515197387;6996.370326670522;7087.220405755363;7234.5659260444545;7389.704411823467;7402.9629851850395;5047;5117.130087885069;5176.7152806596;5181.4300426953005;5212.843614691566;1397.5597686728647;1411.5765270418833;1419.7515434799075;1435.9928200358931;1444.487207041506;819.8688209886509;829.742779738283;831.5509624802539;836.8828364029041;849.7280870121501;6902.171739391305;6922.826929326707;6968.407685346802;6971.233164351917;6987.196472405739;689.4932224814758;709.3970125393374;711.4806191480249;722.2019668266595;722.7578761115085;5111.488851114858;5358.437364076716;5391.7034563099405;5467.781288748405;5586.469285417878;21222.363329100153;21660.56678866414;21908.45228869291;21932.342029739135;21999.12003519873;21113;21635.134594616353;21790.891045544988;21982.780172198072;22010.559788804134;10565.841512377321;11070.778584428266;11071.225014249087;11091.389973551532;11105.83341249882;8220.465669731448;8242.093369729444;8243.917560824315;8246.83506329882;8248.752537423887;17495.650086997935;18111;18138.727919081488;18157.727634085764;18342.17460214267;18684.7197292038;18852.245910163987;18872.433826985212;19034.80965190386;19285.132169052147;10966.616168434066;11264.549418023187;11353.886461135284;11363.204575679623;11394.25937314072;14030.29848507591;14146.575602731935;14148.858511414754;14183.929080354532;14276.42894284217;11007.944960275147;11120.332780033224;11293;11320.320780753182;11362.715932101764;10842.295250808673;10916.126709863032;10958.780824383628;11183.273087249303;11195;9454.196393306645;9519.143277105093;9542.236621070437;9562.330636855353;9570.569324380558;7499.775006749806;7573;7573.848523029619;7576.812863169564;7605.581693006938;7193.208747037717;7300.452466065172;7308.524945878501;7370.5946172961;7373.152087510005 15:43:45 INFO - PID 22608 | |4;prototype.html;492.85033365109626;513.7302915969113;518.3442944674989;526.239583801407;532.419662567801;6269.4295338911115;6311.305756366802;6327.620342779436;6408.935910640892;6412.134361861147;6243.71903264353;6262.561620686553;6264.937350626492;6334.936650633493;6338.271098823637;5177.715225662587;5190.558802501791;5215.973920130413;5229.660072095321;5233.973830130844;4870.683405578644;5201.86995325118;5204.245384419257;5208.973955130219;5216.513293711293;4966.250480886925;4984.258657738247;5013.097642424362;5023.32185155003;5031;4931.534232883559;4989.176785830352;4990.800367985276;5012.699238045729;5032.270320803463;4508.6618503612035;4511.503734589192;4512.413386259798;4517.390152329459;4523.231050721385;6167.753289868445;6198.132261483351;6199.256089269272;6213.161223234851;6256.843578910518;5736.483716465496;5752.338481074647;5825.825225243207;5839.270091238595;5848.590598658096;6575.967120164416;6594.142761440982;6629.93370066298;6646.501512386591;6700.463962882957;4944.110060189165;4956.132676781584;4969.8012079516775;4973.303737476756;4973.975130124362;6740.258571557125;6768.932310676929;6801.65991700413;6855.211650660188;6917.9308206917285;5004.69502327534;5009.248612708123;5016.749162541858;5036.697798132051;5037.69773813565;5065.986802639487;5076.568491678175;5107.514786095315;5140.866540385698;5177.559907407913;5769.769209231667;5809.535237181015;5813.186153938452;5813.244278243801;5839.795607153729;6561.1470508833545;6614.684860298953;6644.5382015957375;6671.266160722316;6715.731370745213;1744.276125407967;1755.0873545756135;1761.9911900440416;1776.9644607108044;1787.7742210947454;1171.1392126786805;1217.6042786094554;1224.13086708438;1232.8719221912029;1238.2694210415898;5667.603267771216;5669.518090962314;5671.376148623648;5736.254286942754;5827.94172058274;6758.560693554903;6796.8300792479595;6834.983679814467;6855.348741869514;6906.689198986058;5649.4633009864;5662.244704141729;5724.62247274102;5735.77056917727;5750.539956803529;3504.9824750876082;3520.436730123219;3525.7179425645886;3563.5367402237544;3592.946105808415;6433.402939442622;6481.254655714559;6492.220933488012;6496.512761542903;6522.315156908551;6725.327467253235;6761.256261811197;6782.593044417351;6782.864342713118;6791.830204244933;6307;6308.27454842699;6353.936460635427;6390.265119511223;6404.679766011587;6539.574927629689;6692.196936367667;6696.397324240842;6730.25967143604;6747.797566073025;6590.308017658269;6668.0331351954665;6684.966575167093;6692.899606505809;6789.592624442549;6331.7336532692725;6346.730653869337;6404.647744374104;6510.981595705346;6534.542582019213;4897.118518666674;4960.627952903619;4991.5008499151245;5014.899702006012;5051.595872330278;6488.416042556192;6624.701888414937;6677.095463473404;6820.761273355409;6842.73409419259;6517.152770139852;6541.443977261795;6618.6690665467495;6625.204975402982;6645.468362530889;6455.741770329322;6496.350364963466;6502.739890404331;6511.218653761579;6536.084948107174;6222.502199824094;6384.45732112757;6418.454431373386;6456.6771661415805;6493.740250389931;6564.442022427956;6617.205935287796;6648.534602577966;6669.233038200669;6691.130153080263;6169.50643948474;6323.525735569942;6381.946978748454;6404.967975160094;6421.197350331208 15:43:45 INFO - PID 22608 | |5;yui.html;899.3749344205779;921.5760750054974;930.7440453875179;938.2447130060303;949.9382540134889;19013.239470421184;20060.4984875378;20062.598748025048;20088.899555502237;20095;17870.821291787077;18325.63348733028;18703.251869925185;18934.14796334165;19086.61826763464;962.3359881681635;968.9031096890325;974.0211087856694;974.853771934212;975.2490582251662;983.1741337276686;990.5592011554861;1000.6897861662871;1017.6082208349765;1018.6027449294781;1040.2926010312983;1062.4581463453655;1063.558623171383;1065.850780890672;1065.9040686338267;1002.4286156890576;1039.6621098143096;1060.6446840308467;1062.6865074802913;1062.7768168684586;747.9102507699057;749.4716225061319;750.4409215134705;751.462704166518;751.9172890981988;19642.607147857107;19893.80106198934;19923.701144482846;19925.50186245341;19931;19372.32196873117;19426.320078797173;20177;20326.898365508077;20331.593368132555;16782.244798983953;16854.66290674192;16996.745048824276;17328.566785830328;17430.389936352167;3703;3737.0844143185095;3744.344739670547;3744.3821769408014;3745.906352341186;146956;148581;149029.99999999892;150465;150622;16501.504954851374;16956.406525771537;17075.658486830194;17076.402325918534;17083.40208092711;31109;32761;32837.17907052343;32891;33237.66762332394;8393.790155246168;8737.43206691563;8851.60167792451;8855.33584981129;8871.911280887109;4158.7296825706235;4303.203907277164;4309.633681137076;4317.0934103838545;4345.847895323648;5342.198670199424;5413.891722165535;5442.809501667422;5449.836504904859;5479.75341109651;972.8103019911191;999.820032394176;1018.3991445047458;1018.4958445569342;1022.9641962531275;684.7911387027004;691.9515633905578;696.7770313499733;711.0827033127208;712.590260600157;11210.011544862458;11273;11505.424728763695;12024.218425802295;12407.131500795038;680.7719413996367;683.2381894188044;687.1582311668167;692.650211643117;702.6873041496588;5512.641678290898;5653.717314134359;5672.602917795714;5814.883702325929;5845.532357411482;117301;118134.40932795453;118806;120300;122788;111020;111144;112080;114062.42968785104;114548.42725786318;95402;95651.52174239223;98267;98468.50765746126;98853;10191.490425478845;10267.383956962607;10324.741881452723;10373.58505659765;10407.47962601882;43372.13255734804;43621.781891090344;43725.34411983886;45523.54476455193;45718.54281457276;57105.42894571001;57568;58260.4173958255;58355.416445835;59451.702741487745;14576.635584110481;15003.174825384272;15077.849221507644;15165.848341516885;15205.087694738351;15717.135557543987;15848.44530441429;15852.682946340778;16000.359985600911;16120.596985075466;14399.496017639332;14743.483978060716;14757.114573125647;14766.852331476548;15028.774568381701;13981.580552583438;14192.929035354757;14285.785713214102;14290.214038227998;14293.714125717219;13449.46202151903;13467.932660336635;13564.72870542564;13747.587572372844;13790.241536715175;11345.659630211107;11407.144464165054;11418.486168122288;11649.825252621047;12046;10912.290701104403;10971.890281097087;11051.668449946514;11081.61214357526;11111.00000999914 15:43:45 INFO - PID 22608 | __end_tp_report 15:43:45 INFO - PID 22608 | __start_cc_report 15:43:45 INFO - PID 22608 | _x_x_mozilla_cycle_collect,290 15:43:45 INFO - PID 22608 | __end_cc_report 15:43:45 INFO - PID 22608 | __startTimestamp1505688225180__endTimestamp 15:43:45 INFO - PID 22608 | 15:43:45 INFO - PID 22608 | ------- Summary: start ------- 15:43:45 INFO - PID 22608 | Number of tests: 6 15:43:45 INFO - PID 22608 | 15:43:45 INFO - PID 22608 | [#0] dojo.html Cycles:165 Average:6268.51 Median:6509.25 stddev:766.32 (11.8%) stddev-sans-first:728.19 15:43:45 INFO - PID 22608 | Values: 3135.4 3153.4 3172.9 3180.2 3180.4 6259.2 6343.9 6364.3 6369.9 6475.6 6289.9 6316.4 6324.6 6358.0 6361.0 5829.5 5848.5 5860.7 5864.6 5906.2 5876.7 5937.7 5948.2 5950.5 5959.0 5899.3 5933.9 5939.5 5972.3 5975.9 5717.5 5755.4 5783.8 5872.3 5970.2 5804.2 5820.3 5870.6 5880.9 5895.7 6192.8 6325.6 6330.9 6375.8 6402.2 6767.7 6790.8 6835.0 6854.2 6866.2 6891.5 6895.2 6942.7 6947.1 6951.3 6326.7 6331.0 6375.0 6423.5 6430.8 6963.6 7032.4 7081.4 7082.7 7112.3 6740.4 6753.4 6766.7 6775.8 6783.4 6787.8 6794.4 6798.7 6880.2 6885.3 6610.1 6734.3 6782.3 6788.3 6879.1 6809.4 6866.3 6878.2 6891.2 6892.1 5405.6 5414.8 5433.5 5434.1 5442.5 4332.7 4627.7 4639.9 4666.6 4708.2 5779.7 5788.4 5795.7 5798.2 5800.9 6754.1 6755.5 6760.4 6774.7 6774.8 5767.5 5771.3 5772.5 5774.8 5777.6 5723.7 5787.7 5825.5 5924.9 5927.6 6552.1 6576.4 6640.0 6655.6 6667.2 6819.0 6829.9 6908.6 6919.8 6922.5 6370.1 6482.3 6505.1 6585.2 6596.6 6764.2 6764.7 6774.1 6774.7 6810.8 6858.7 6865.2 6941.2 6960.5 6964.8 6404.3 6603.4 6615.7 6692.6 6696.5 6564.3 6576.0 6579.4 6579.5 6581.1 6522.0 6529.1 6609.4 6618.1 6619.3 6726.3 6747.0 6762.4 6791.9 6792.0 6319.6 6418.1 6466.2 6509.3 6545.2 15:43:45 INFO - PID 22608 | 15:43:45 INFO - PID 22608 | [#1] ext.html Cycles:180 Average:37097.51 Median:3495.22 stddev:54201.45 (1550.7%) stddev-sans-first:54285.05 15:43:45 INFO - PID 22608 | Values: 818.5 848.3 852.8 857.3 858.3 37255.4 39855.6 40822.4 40846.0 40940.2 38696.2 38792.0 38960.2 39015.0 39120.0 6925.5 7036.5 7048.2 7062.9 7067.9 6969.7 7043.5 7045.5 7060.6 7068.3 6978.0 7006.8 7046.3 7661.2 7797.4 7753.5 7797.5 7806.5 7814.0 7817.2 7441.0 7626.7 7635.4 7680.2 7700.9 36030.8 36347.8 36474.5 36483.5 36502.3 3488.7 3501.8 3508.9 3520.0 3534.5 30926.2 31038.2 31072.4 31111.8 31154.4 5121.5 5139.1 5150.6 5206.5 5232.1 190553.0 191510.0 191904.0 191913.0 192023.0 40616.8 41262.0 46316.5 46350.8 46860.3 48511.3 48926.8 49238.0 49328.8 49406.0 16119.8 16235.6 16271.0 16274.8 16284.2 13409.5 13420.3 13421.6 13454.7 13531.7 13106.4 13210.5 13274.3 13320.7 13374.0 5348.1 5402.1 5419.1 5455.1 5597.5 969.5 1012.2 1015.9 1017.7 1019.9 22535.2 22627.8 23176.9 23190.2 23351.2 1056.6 1113.3 1123.8 1130.3 1145.3 11921.2 12051.2 12054.2 12059.2 12113.4 230368.0 232997.0 233463.0 234282.0 235818.0 52176.2 52200.0 52264.0 52315.5 52352.7 1442.1 1451.8 1461.5 1462.8 1466.2 22434.0 22482.2 22599.5 22680.9 22898.8 35300.1 35360.8 35412.3 35520.6 35542.5 198009.0 200218.0 200312.0 200799.0 200875.0 29687.0 29895.4 29968.3 31848.7 33777.7 43541.0 43799.1 43860.6 43959.6 44270.0 31127.5 31233.5 31597.2 31606.4 31676.2 30958.8 31137.4 31280.2 31357.2 31457.0 34208.0 35569.3 35591.3 35605.6 35605.8 30798.2 30851.8 30916.4 31098.7 31568.8 22430.3 23200.9 23487.5 23624.3 23680.5 15:43:45 INFO - PID 22608 | 15:43:45 INFO - PID 22608 | [#2] jquery.html Cycles:180 Average:35883.45 Median:22518.55 stddev:83293.87 (369.9%) stddev-sans-first:83485.28 15:43:45 INFO - PID 22608 | Values: 550.6 559.2 561.0 574.2 588.0 22205.3 22542.3 22940.4 22940.4 22951.2 23784.2 24525.9 24903.9 25880.6 26103.9 6429.5 6441.8 6486.2 6489.8 6511.5 6406.0 6502.6 6505.7 6511.7 6515.0 6751.9 7056.8 7116.6 7117.7 7193.8 7085.4 7126.4 7161.0 7201.6 7202.9 6598.9 6877.6 6890.8 6895.8 6902.4 30973.0 31152.2 31462.2 31490.8 31509.8 2036.4 2065.7 2068.9 2069.8 2072.4 20534.5 20747.5 21286.5 21387.9 21598.9 2525.0 2574.3 2636.8 2641.7 2651.6 125630.4 131734.3 132425.3 138545.6 140489.0 20069.6 20157.9 21213.7 22154.7 22494.8 40848.0 41015.0 41021.2 41161.4 41169.4 11169.1 11279.5 11348.4 11358.3 11403.0 9357.3 9490.1 9490.3 9499.3 9517.1 11144.4 11231.7 11331.5 11381.9 11620.8 3823.7 4200.3 4239.5 4333.7 4341.5 928.2 935.8 948.9 953.8 953.8 18954.9 19075.6 19234.1 19298.0 19685.8 1013.0 1025.3 1025.9 1027.0 1029.1 10553.8 10666.2 10689.8 10814.2 10890.4 488679.0 491078.0 503129.0 504150.0 504296.0 103211.0 105536.0 108506.5 108633.5 112575.0 999.3 1152.9 1167.1 1168.8 1176.7 20583.5 20666.6 20713.7 20776.0 20914.6 54272.0 54711.0 54939.7 55068.0 56256.4 70381.0 70528.0 70676.3 71012.3 71668.0 19675.3 19869.9 19941.9 20066.7 20358.3 22187.1 22643.2 22665.8 22679.8 22906.9 17969.0 17971.0 18324.2 18338.3 18376.8 15932.9 16515.6 16617.0 17098.3 17167.9 18703.6 18719.4 18834.6 18885.0 19035.8 19585.9 19669.1 19866.9 19916.7 19932.4 18143.5 18165.9 18226.3 18444.8 18487.8 15:43:45 INFO - PID 22608 | 15:43:45 INFO - PID 22608 | [#3] mootools.html Cycles:180 Average:9273.40 Median:14494.76 stddev:6669.22 (46.0%) stddev-sans-first:6660.92 15:43:45 INFO - PID 22608 | Values: 1284.8 1339.7 1349.7 1357.0 1363.2 14600.4 15383.6 15385.8 15394.1 15400.6 15181.2 15229.5 15231.5 15396.5 15415.3 2637.2 2784.2 2786.4 2786.9 2787.6 2561.2 2582.1 2593.5 2600.2 2603.2 2764.4 2873.1 2875.3 2878.5 2879.0 2636.5 2645.3 2665.2 2667.6 2667.7 2595.4 2604.4 2604.8 2766.4 2855.1 15223.8 15335.0 15337.9 15338.2 15345.6 7948.6 8229.1 8247.7 8250.0 8250.4 5347.1 5358.9 5421.4 5540.9 5557.6 1923.6 1938.2 1946.6 1974.0 1976.7 26176.9 26340.3 26353.0 26377.9 26386.5 6656.2 6765.3 6801.5 6816.4 7001.8 17096.1 17166.2 17170.8 17187.2 17226.7 7644.8 7838.8 7880.6 7886.8 7897.0 6996.4 7087.2 7234.6 7389.7 7403.0 5047.0 5117.1 5176.7 5181.4 5212.8 1397.6 1411.6 1419.8 1436.0 1444.5 819.9 829.7 831.6 836.9 849.7 6902.2 6922.8 6968.4 6971.2 6987.2 689.5 709.4 711.5 722.2 722.8 5111.5 5358.4 5391.7 5467.8 5586.5 21222.4 21660.6 21908.5 21932.3 21999.1 21113.0 21635.1 21790.9 21982.8 22010.6 10565.8 11070.8 11071.2 11091.4 11105.8 8220.5 8242.1 8243.9 8246.8 8248.8 17495.7 18111.0 18138.7 18157.7 18342.2 18684.7 18852.2 18872.4 19034.8 19285.1 10966.6 11264.5 11353.9 11363.2 11394.3 14030.3 14146.6 14148.9 14183.9 14276.4 11007.9 11120.3 11293.0 11320.3 11362.7 10842.3 10916.1 10958.8 11183.3 11195.0 9454.2 9519.1 9542.2 9562.3 9570.6 7499.8 7573.0 7573.8 7576.8 7605.6 7193.2 7300.5 7308.5 7370.6 7373.2 15:43:45 INFO - PID 22608 | 15:43:45 INFO - PID 22608 | [#4] prototype.html Cycles:180 Average:5536.75 Median:6233.11 stddev:1542.84 (24.8%) stddev-sans-first:1500.00 15:43:45 INFO - PID 22608 | Values: 492.9 513.7 518.3 526.2 532.4 6269.4 6311.3 6327.6 6408.9 6412.1 6243.7 6262.6 6264.9 6334.9 6338.3 5177.7 5190.6 5216.0 5229.7 5234.0 4870.7 5201.9 5204.2 5209.0 5216.5 4966.3 4984.3 5013.1 5023.3 5031.0 4931.5 4989.2 4990.8 5012.7 5032.3 4508.7 4511.5 4512.4 4517.4 4523.2 6167.8 6198.1 6199.3 6213.2 6256.8 5736.5 5752.3 5825.8 5839.3 5848.6 6576.0 6594.1 6629.9 6646.5 6700.5 4944.1 4956.1 4969.8 4973.3 4974.0 6740.3 6768.9 6801.7 6855.2 6917.9 5004.7 5009.2 5016.7 5036.7 5037.7 5066.0 5076.6 5107.5 5140.9 5177.6 5769.8 5809.5 5813.2 5813.2 5839.8 6561.1 6614.7 6644.5 6671.3 6715.7 1744.3 1755.1 1762.0 1777.0 1787.8 1171.1 1217.6 1224.1 1232.9 1238.3 5667.6 5669.5 5671.4 5736.3 5827.9 6758.6 6796.8 6835.0 6855.3 6906.7 5649.5 5662.2 5724.6 5735.8 5750.5 3505.0 3520.4 3525.7 3563.5 3592.9 6433.4 6481.3 6492.2 6496.5 6522.3 6725.3 6761.3 6782.6 6782.9 6791.8 6307.0 6308.3 6353.9 6390.3 6404.7 6539.6 6692.2 6696.4 6730.3 6747.8 6590.3 6668.0 6685.0 6692.9 6789.6 6331.7 6346.7 6404.6 6511.0 6534.5 4897.1 4960.6 4991.5 5014.9 5051.6 6488.4 6624.7 6677.1 6820.8 6842.7 6517.2 6541.4 6618.7 6625.2 6645.5 6455.7 6496.4 6502.7 6511.2 6536.1 6222.5 6384.5 6418.5 6456.7 6493.7 6564.4 6617.2 6648.5 6669.2 6691.1 6169.5 6323.5 6381.9 6405.0 6421.2 15:43:45 INFO - PID 22608 | 15:43:45 INFO - PID 22608 | [#5] yui.html Cycles:180 Average:24443.39 Median:19049.93 stddev:36403.59 (191.1%) stddev-sans-first:36462.78 15:43:45 INFO - PID 22608 | Values: 899.4 921.6 930.7 938.2 949.9 19013.2 20060.5 20062.6 20088.9 20095.0 17870.8 18325.6 18703.3 18934.1 19086.6 962.3 968.9 974.0 974.9 975.2 983.2 990.6 1000.7 1017.6 1018.6 1040.3 1062.5 1063.6 1065.9 1065.9 1002.4 1039.7 1060.6 1062.7 1062.8 747.9 749.5 750.4 751.5 751.9 19642.6 19893.8 19923.7 19925.5 19931.0 19372.3 19426.3 20177.0 20326.9 20331.6 16782.2 16854.7 16996.7 17328.6 17430.4 3703.0 3737.1 3744.3 3744.4 3745.9 146956.0 148581.0 149030.0 150465.0 150622.0 16501.5 16956.4 17075.7 17076.4 17083.4 31109.0 32761.0 32837.2 32891.0 33237.7 8393.8 8737.4 8851.6 8855.3 8871.9 4158.7 4303.2 4309.6 4317.1 4345.8 5342.2 5413.9 5442.8 5449.8 5479.8 972.8 999.8 1018.4 1018.5 1023.0 684.8 692.0 696.8 711.1 712.6 11210.0 11273.0 11505.4 12024.2 12407.1 680.8 683.2 687.2 692.7 702.7 5512.6 5653.7 5672.6 5814.9 5845.5 117301.0 118134.4 118806.0 120300.0 122788.0 111020.0 111144.0 112080.0 114062.4 114548.4 95402.0 95651.5 98267.0 98468.5 98853.0 10191.5 10267.4 10324.7 10373.6 10407.5 43372.1 43621.8 43725.3 45523.5 45718.5 57105.4 57568.0 58260.4 58355.4 59451.7 14576.6 15003.2 15077.8 15165.8 15205.1 15717.1 15848.4 15852.7 16000.4 16120.6 14399.5 14743.5 14757.1 14766.9 15028.8 13981.6 14192.9 14285.8 14290.2 14293.7 13449.5 13467.9 13564.7 13747.6 13790.2 11345.7 11407.1 11418.5 11649.8 12046.0 10912.3 10971.9 11051.7 11081.6 11111.0 15:43:45 INFO - PID 22608 | -------- Summary: end -------- 15:43:45 INFO - PID 22608 | 15:43:45 INFO - TEST-INFO | 22608: exit 0 15:43:45 INFO - TEST-OK | dromaeo_css | took 1110314ms 15:43:45 INFO - TEST-START | kraken 15:43:45 INFO - Initialising browser for kraken test... 15:43:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35586/getInfo.html -profile /tmp/tmpbgHg1l/profile 15:43:45 INFO - TEST-INFO | started process 22985 (/builds/slave/test/build/application/firefox/firefox http://localhost:35586/getInfo.html) 15:43:51 INFO - TEST-INFO | 22985: exit 0 15:43:51 INFO - Browser initialized. 15:43:51 INFO - Running cycle 1/1 for kraken test... 15:43:51 INFO - Using env: {'DISPLAY': ':0', 15:43:51 INFO - 'HOME': '/home/cltbld', 15:43:51 INFO - 'JSGC_DISABLE_POISONING': '1', 15:43:51 INFO - 'LANG': 'en_US.UTF-8', 15:43:51 INFO - 'LANGUAGE': 'en_US:en', 15:43:51 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:43:51 INFO - 'LOGNAME': 'cltbld', 15:43:51 INFO - 'MAIL': '/var/mail/cltbld', 15:43:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:43:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:43:51 INFO - 'MOZ_CRASHREPORTER': '1', 15:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:51 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:43:51 INFO - 'MOZ_NO_REMOTE': '1', 15:43:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:51 INFO - 'NO_EM_RESTART': '1', 15:43:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:51 INFO - 'PWD': '/builds/slave/test', 15:43:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:43:51 INFO - 'RUST_BACKTRACE': 'full', 15:43:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:43:51 INFO - 'SHELL': '/bin/bash', 15:43:51 INFO - 'SHLVL': '1', 15:43:51 INFO - 'STYLO_FORCE_DISABLED': '1', 15:43:51 INFO - 'TERM': 'linux', 15:43:51 INFO - 'TMOUT': '86400', 15:43:51 INFO - 'USER': 'cltbld', 15:43:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138', 15:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:51 INFO - '_': '/tools/buildbot/bin/python'} 15:43:51 INFO - TEST-INFO | started process 23222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbgHg1l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:52 INFO - PID 23222 | 15:43:52 INFO - PID 23222 | (/builds/slave/test/build/application/firefox/firefox:23271): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:43:52 INFO - PID 23222 | 15:44:03 INFO - PID 23222 | RSS: Main: 155533312 15:44:03 INFO - PID 23222 | 15:44:05 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35586/tests/kraken/driver.html?testName=audio-beat-detection) 15:44:06 INFO - PID 23222 | RSS: Main: 160460800 15:44:06 INFO - PID 23222 | 15:44:09 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35586/tests/kraken/driver.html?testName=audio-dft) 15:44:09 INFO - PID 23222 | RSS: Main: 160833536 15:44:09 INFO - PID 23222 | 15:44:12 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35586/tests/kraken/driver.html?testName=audio-fft) 15:44:13 INFO - PID 23222 | RSS: Main: 157581312 15:44:13 INFO - PID 23222 | 15:44:15 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35586/tests/kraken/driver.html?testName=audio-oscillator) 15:44:16 INFO - PID 23222 | RSS: Main: 158474240 15:44:16 INFO - PID 23222 | 15:44:18 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35586/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:44:18 INFO - PID 23222 | RSS: Main: 158388224 15:44:18 INFO - PID 23222 | 15:44:22 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35586/tests/kraken/driver.html?testName=imaging-darkroom) 15:44:22 INFO - PID 23222 | RSS: Main: 160657408 15:44:22 INFO - PID 23222 | 15:44:26 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35586/tests/kraken/driver.html?testName=imaging-desaturate) 15:44:27 INFO - PID 23222 | RSS: Main: 160579584 15:44:27 INFO - PID 23222 | 15:44:30 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35586/tests/kraken/driver.html?testName=json-parse-financial) 15:44:30 INFO - PID 23222 | RSS: Main: 160800768 15:44:30 INFO - PID 23222 | 15:44:32 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35586/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:44:32 INFO - PID 23222 | RSS: Main: 160886784 15:44:32 INFO - PID 23222 | 15:44:34 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:44:35 INFO - PID 23222 | RSS: Main: 161202176 15:44:35 INFO - PID 23222 | 15:44:37 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:44:37 INFO - PID 23222 | RSS: Main: 157868032 15:44:37 INFO - PID 23222 | 15:44:40 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:44:41 INFO - PID 23222 | RSS: Main: 158285824 15:44:41 INFO - PID 23222 | 15:44:43 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:44:44 INFO - PID 23222 | RSS: Main: 158470144 15:44:44 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35586/tests/kraken/driver.html?testName=ai-astar) 15:44:46 INFO - PID 23222 | RSS: Main: 159797248 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | __start_tp_report 15:44:46 INFO - PID 23222 | _x_x_mozilla_page_load 15:44:46 INFO - PID 23222 | _x_x_mozilla_page_load_details 15:44:46 INFO - PID 23222 | |i|pagename|runs| 15:44:46 INFO - PID 23222 | |0;ai-astar;110;109;107;109;109;109;112;110;107;107 15:44:46 INFO - PID 23222 | |1;audio-beat-detection;118;119;118;117;119;118;114;115;150;117 15:44:46 INFO - PID 23222 | |2;audio-dft;163;161;161;163;161;161;162;166;164;163 15:44:46 INFO - PID 23222 | |3;audio-fft;74;75;74;74;75;75;76;74;75;73 15:44:46 INFO - PID 23222 | |4;audio-oscillator;79;79;83;79;81;81;79;79;79;79 15:44:46 INFO - PID 23222 | |5;imaging-gaussian-blur;114;114;114;117;116;117;117;117;117;117 15:44:46 INFO - PID 23222 | |6;imaging-darkroom;147;148;149;148;147;150;148;147;148;147 15:44:46 INFO - PID 23222 | |7;imaging-desaturate;94;94;94;94;94;95;94;93;94;94 15:44:46 INFO - PID 23222 | |8;json-parse-financial;53;52;53;52;51;52;52;51;52;54 15:44:46 INFO - PID 23222 | |9;json-stringify-tinderbox;38;38;38;37;38;38;38;40;38;38 15:44:46 INFO - PID 23222 | |10;stanford-crypto-aes;72;78;80;74;75;74;76;74;75;74 15:44:46 INFO - PID 23222 | |11;stanford-crypto-ccm;116;108;116;115;117;109;113;118;113;114 15:44:46 INFO - PID 23222 | |12;stanford-crypto-pbkdf2;170;171;164;166;169;164;166;173;177;168 15:44:46 INFO - PID 23222 | |13;stanford-crypto-sha256-iterative;67;63;64;65;68;70;64;63;65;65 15:44:46 INFO - PID 23222 | __end_tp_report 15:44:46 INFO - PID 23222 | __start_cc_report 15:44:46 INFO - PID 23222 | _x_x_mozilla_cycle_collect,799 15:44:46 INFO - PID 23222 | __end_cc_report 15:44:46 INFO - PID 23222 | __startTimestamp1505688286599__endTimestamp 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | ------- Summary: start ------- 15:44:46 INFO - PID 23222 | Number of tests: 14 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.00 stddev:1.60 (1.5%) stddev-sans-first:1.64 15:44:46 INFO - PID 23222 | Values: 110.0 109.0 107.0 109.0 109.0 109.0 112.0 110.0 107.0 107.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:118.00 stddev:10.49 (8.9%) stddev-sans-first:11.09 15:44:46 INFO - PID 23222 | Values: 118.0 119.0 118.0 117.0 119.0 118.0 114.0 115.0 150.0 117.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 15:44:46 INFO - PID 23222 | Values: 163.0 161.0 161.0 163.0 161.0 161.0 162.0 166.0 164.0 163.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#3] audio-fft Cycles:10 Average:74.50 Median:75.00 stddev:0.85 (1.1%) stddev-sans-first:0.88 15:44:46 INFO - PID 23222 | Values: 74.0 75.0 74.0 74.0 75.0 75.0 76.0 74.0 75.0 73.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:79.00 stddev:1.40 (1.8%) stddev-sans-first:1.45 15:44:46 INFO - PID 23222 | Values: 79.0 79.0 83.0 79.0 81.0 81.0 79.0 79.0 79.0 79.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:117.00 stddev:1.41 (1.2%) stddev-sans-first:1.30 15:44:46 INFO - PID 23222 | Values: 114.0 114.0 114.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 15:44:46 INFO - PID 23222 | Values: 147.0 148.0 149.0 148.0 147.0 150.0 148.0 147.0 148.0 147.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 15:44:46 INFO - PID 23222 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 94.0 93.0 94.0 94.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:0.92 (1.8%) stddev-sans-first:0.93 15:44:46 INFO - PID 23222 | Values: 53.0 52.0 53.0 52.0 51.0 52.0 52.0 51.0 52.0 54.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.74 (1.9%) stddev-sans-first:0.78 15:44:46 INFO - PID 23222 | Values: 38.0 38.0 38.0 37.0 38.0 38.0 38.0 40.0 38.0 38.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:2.30 (3.1%) stddev-sans-first:2.13 15:44:46 INFO - PID 23222 | Values: 72.0 78.0 80.0 74.0 75.0 74.0 76.0 74.0 75.0 74.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#11] stanford-crypto-ccm Cycles:10 Average:113.90 Median:115.50 stddev:3.28 (2.8%) stddev-sans-first:3.39 15:44:46 INFO - PID 23222 | Values: 116.0 108.0 116.0 115.0 117.0 109.0 113.0 118.0 113.0 114.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.50 stddev:4.13 (2.4%) stddev-sans-first:4.36 15:44:46 INFO - PID 23222 | Values: 170.0 171.0 164.0 166.0 169.0 164.0 166.0 173.0 177.0 168.0 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:2.27 (3.5%) stddev-sans-first:2.33 15:44:46 INFO - PID 23222 | Values: 67.0 63.0 64.0 65.0 68.0 70.0 64.0 63.0 65.0 65.0 15:44:46 INFO - PID 23222 | -------- Summary: end -------- 15:44:46 INFO - PID 23222 | 15:44:46 INFO - PID 23222 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:44:47 INFO - TEST-INFO | 23222: exit 0 15:44:47 INFO - TEST-OK | kraken | took 61405ms 15:44:47 INFO - SUITE-END | took 1171s 15:44:47 INFO - Completed test suite (00:19:32) 15:44:47 INFO - javascript benchmark 15:44:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8564.019561345576, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.3885992231517, 3153.385089907466, 3172.9365412691745, 3180.2208458927566, 3180.363927214558, 6259.248890133191, 6343.904841427382, 6364.299927008031, 6369.936300636992, 6475.611463312199, 6289.905651415221, 6316.431521163095, 6324.588901721397, 6358.046293056044, 6361.0, 5829.533637309027, 5848.4736373726355, 5860.67766272857, 5864.648121112726, 5906.173135760997, 5876.7355469004, 5937.67342796146, 5948.226730525047, 5950.464458198761, 5958.9702051489685, 5899.262592175978, 5933.940660593404, 5939.4654481096695, 5972.343042265347, 5975.850603734898, 5717.514011309044, 5755.395683453219, 5783.797567085174, 5872.324682661506, 5970.223870896777, 5804.187413762077, 5820.301563812327, 5870.559708021873, 5880.9411905880825, 5895.734691938873, 6192.845178870519, 6325.620462772203, 6330.936690633081, 6375.776847810304, 6402.199725034371, 6767.695453704595, 6790.830229244259, 6835.0, 6854.246032936373, 6866.176058872918, 6891.483138764563, 6895.172579290517, 6942.72229110835, 6947.131608548932, 6951.339622735832, 6326.715297811609, 6330.9683451582905, 6374.9681251594375, 6423.518236132262, 6430.807075787734, 6963.582185068912, 7032.437405007587, 7081.362677358959, 7082.716691332392, 7112.324329188718, 6740.393364597112, 6753.3921947025, 6766.72933082681, 6775.830604234933, 6783.423409010191, 6787.762428314985, 6794.3545363190415, 6798.728050878009, 6880.174379074543, 6885.311468853175, 6610.10763546915, 6734.326567343324, 6782.287859774653, 6788.321167883271, 6879.140107486564, 6809.421199198124, 6866.313368663194, 6878.209005964378, 6891.173059232924, 6892.069570608004, 5405.621606487587, 5414.83755487336, 5433.483819037264, 5434.130539113723, 5442.537384322377, 4332.696711230246, 4627.676062675648, 4639.884002899955, 4666.580007799246, 4708.223143181337, 5779.653220806765, 5788.392218816964, 5795.710214489259, 5798.246227990334, 5800.88398232033, 6754.12196414463, 6755.49333799967, 6760.357766012221, 6774.729010839511, 6774.796756097325, 5767.538596912237, 5771.336296325976, 5772.451617096369, 5774.797882074107, 5777.624454410534, 5723.6851973141875, 5787.71061446926, 5825.533957283407, 5924.940750592526, 5927.644341339534, 6552.115464412339, 6576.408123268929, 6639.966800165968, 6655.567388119756, 6667.166604174478, 6819.0, 6829.93170068293, 6908.585484870924, 6919.757808476679, 6922.480813938874, 6370.108184854032, 6482.2869484357625, 6505.056766768697, 6585.209774827052, 6596.637184954873, 6764.154480689914, 6764.729410823512, 6774.085498457645, 6774.729010839708, 6810.829729256809, 6858.725650973905, 6865.210500792273, 6941.2364639888565, 6960.4779641526075, 6964.79105626832, 6404.295527491879, 6603.372679595431, 6615.702293396713, 6692.564983276072, 6696.464282857457, 6564.310747371648, 6576.013597960153, 6579.374959378852, 6579.539432239889, 6581.111549940888, 6521.967390163209, 6529.053287273414, 6609.438197753245, 6618.106555614931, 6619.304972977768, 6726.327367263235, 6746.966265168643, 6762.357576030269, 6791.89812152828, 6791.966040169965, 6319.557630965788, 6418.133551970424, 6466.191726034246, 6509.251436084911, 6545.21457425112], "value": 6208.771255643745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.5252553518959, 848.3043903998722, 852.8379607874504, 857.2627540315324, 858.3433673239969, 37255.441168382495, 39855.60144398555, 40822.387664184986, 40846.0, 40940.181196376056, 38696.22607547847, 38792.0, 38960.220795584144, 39015.0, 39120.0, 6925.480588955836, 7036.472264580151, 7048.189458212294, 7062.85874282514, 7067.89398159028, 6969.6863641136015, 7043.5421697589745, 7045.506814522985, 7060.576365418091, 7068.3285087916565, 6977.965110174442, 7006.789796306119, 7046.2601426850215, 7661.23387661235, 7797.376209903194, 7753.457257991915, 7797.532148071134, 7806.453548251625, 7813.9609301953415, 7817.1791961843755, 7441.0, 7626.656800443993, 7635.350995165418, 7680.19357967411, 7700.884486732703, 36030.81984590086, 36347.81826090853, 36474.45288320677, 36483.4527482088, 36502.269954601026, 3488.6511348865165, 3501.7898926064518, 3508.929821403583, 3520.0, 3534.452159915217, 30926.22684432907, 31038.224044398845, 31072.37855242905, 31111.84444077765, 31154.376912461623, 5121.487851214886, 5139.12634852076, 5150.562202212816, 5206.505381988705, 5232.136697444917, 190553.0, 191510.0, 191904.0, 191913.0, 192023.0, 40616.79691601523, 41262.0, 46316.536834631894, 46350.76824615855, 46860.297095543596, 48511.27233091507, 48926.75536622294, 49238.0, 49328.75335623299, 49406.0, 16119.758203626721, 16235.594110147105, 16271.0, 16274.837251627569, 16284.185790710653, 13409.463621455228, 13420.26188559619, 13421.597352079454, 13454.730905381837, 13531.66170845717, 13106.410211540504, 13210.537631183055, 13274.336283185801, 13320.666983325495, 13374.0, 5348.117560602457, 5402.135658294654, 5419.132938729863, 5455.09990851513, 5597.524210442158, 969.4910172159532, 1012.1801340913884, 1015.9288849780593, 1017.7099526634873, 1019.9133073688671, 22535.211267605882, 22627.773722262566, 23176.884115579312, 23190.188343408237, 23351.182708605458, 1056.57736905237, 1113.2819331531116, 1123.764009558002, 1130.2992144870234, 1145.2613064573304, 11921.165518413627, 12051.216670916363, 12054.15620906528, 12059.21615095016, 12113.394330283627, 230368.0, 232997.0, 233463.0, 234282.0, 235818.0, 52176.21735673968, 52200.0, 52264.0, 52315.47684523106, 52352.73823630858, 1442.1131004432198, 1451.8112645356248, 1461.5103940179947, 1462.824461064679, 1466.2082475463344, 22434.0, 22482.213122540634, 22599.548009039398, 22680.886595567576, 22898.771012289664, 35300.117497062776, 35360.82319588386, 35412.29175416426, 35520.644793551735, 35542.46686299759, 198009.0, 200218.0, 200312.0, 200799.0, 200875.0, 29687.0, 29895.402091957603, 29968.25079373033, 31848.681513184572, 33777.66222337844, 43541.0, 43799.12401752011, 43860.561394385644, 43959.560404395546, 44270.0, 31127.53308700326, 31233.531497028016, 31597.21006974844, 31606.367872641957, 31676.208094797814, 30958.84520577383, 31137.377252455277, 31280.21799455032, 31357.216069598442, 31457.0, 34208.0, 35569.28861422809, 35591.28817423689, 35605.64394356127, 35605.82197088998, 30798.230044249074, 30851.845740771154, 30916.381672365977, 31098.68901310958, 31568.842155789072, 22430.327090187322, 23200.883995579916, 23487.53024939526, 23624.29127126189, 23680.52638947177], "value": 16746.338743273758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.6255746092658, 559.2059275828324, 560.9579281553885, 574.2477354665389, 587.9823605291841, 22205.333839984807, 22542.323730288077, 22940.426489337773, 22940.426489337773, 22951.1967081152, 23784.16755413561, 24525.87737061312, 24903.87548062257, 25880.611790823106, 26103.86948065262, 6429.485641148697, 6441.774537891175, 6486.189226346707, 6489.805305840809, 6511.544191906569, 6406.0, 6502.6098434093865, 6505.674716264168, 6511.706973186194, 6515.0227465880025, 6751.898721519181, 7056.753013644524, 7116.5730056196535, 7117.679704413314, 7193.784186474414, 7085.397741192005, 7126.358627723504, 7161.0, 7201.567905925661, 7202.891956620629, 6598.901016484757, 6877.552959057645, 6890.827729306758, 6895.75864844728, 6902.413294869942, 30973.0, 31152.221194470094, 31462.213444664067, 31490.842545787353, 31509.8424507876, 2036.4196204081766, 2065.7211276477783, 2068.8758674479577, 2069.782672819347, 2072.357569153567, 20534.47819155049, 20747.54767166299, 21286.467838304012, 21387.8930605346, 21598.89200553987, 2525.0404846158526, 2574.3178057814694, 2636.8022398320204, 2641.749033841782, 2651.6287719719253, 125630.37184814109, 131734.3413282937, 132425.337873311, 138545.6145438543, 140489.0, 20069.59860802805, 20157.899210504147, 21213.681794773092, 22154.667679984814, 22494.775052249595, 40848.0, 41015.0, 41021.17957640831, 41161.382579261335, 41169.382459263135, 11169.106471482262, 11279.492422840993, 11348.432578371048, 11358.26171298863, 11403.0, 9357.344985850925, 9490.145886870216, 9490.28822838276, 9499.28755343352, 9517.143457088896, 11144.442777861237, 11231.66305010851, 11331.526901502917, 11381.886181138249, 11620.779818119145, 3823.655870971626, 4200.285951388271, 4239.46749491916, 4333.696641235147, 4341.461708707393, 928.2295694573488, 935.7988032573029, 948.9193418559362, 953.7663272498282, 953.8426159683574, 18954.905225473784, 19075.61848763017, 19234.134463949154, 19298.0, 19685.803141968398, 1012.9797404051877, 1025.2823023883163, 1025.8820235672845, 1026.9537870795832, 1029.1406675425953, 10553.786314573768, 10666.200034997251, 10689.83965240522, 10814.188935829687, 10890.401027943539, 488679.0, 491078.0, 503129.0, 504150.0, 504296.0, 103211.0, 105536.0, 108506.45746771216, 108633.45683271532, 112575.0, 999.2705325112709, 1152.8962393384636, 1167.0605162843822, 1168.8363629091934, 1176.688177632928, 20583.485412864797, 20666.586668266853, 20713.68929466029, 20776.0, 20914.58170836605, 54272.0, 54711.0, 54939.72530137324, 55068.0, 56256.43743562512, 70381.0, 70528.0, 70676.29323706697, 71012.28987710057, 71668.0, 19675.31136410219, 19869.900650496656, 19941.900290498455, 20066.698999514727, 20358.28745993883, 22187.1125154992, 22643.20748773785, 22665.773342267024, 22679.773202267766, 22906.885465572566, 17969.0, 17971.0, 18324.175412106222, 18338.266469341077, 18376.81623183751, 15932.920335398248, 16515.58711032234, 16617.0, 17098.316067357166, 17167.914160429118, 18703.625927481648, 18719.438416847515, 18834.623307533497, 18885.0, 19035.809641903405, 19585.902070489556, 19669.114889829707, 19866.90066549658, 19916.70124948098, 19932.402027939184, 18143.455696329132, 18165.909170454062, 18226.270949161884, 18444.81555184431, 18487.81512184861], "value": 12879.775817550932, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.7880099783536, 1339.7253563019578, 1349.6693310139012, 1356.952506662267, 1363.1752789562308, 14600.415983360666, 15383.615409614766, 15385.846061545373, 15394.076355418683, 15400.61498462539, 15181.240937953085, 15229.4669686561, 15231.54305370838, 15396.461123860667, 15415.306311215994, 2637.1956553251252, 2784.220418282874, 2786.4148528808973, 2786.860656967154, 2787.6236708044457, 2561.180422264876, 2582.0704546363295, 2593.5072336256053, 2600.2329312852753, 2603.193010166845, 2764.419471910901, 2873.123697272331, 2875.324298789783, 2878.5106531889523, 2879.0211328148425, 2636.5122452346186, 2645.285772841332, 2665.2137619402224, 2667.6131960865664, 2667.719889411603, 2595.4030572968136, 2604.414006848463, 2604.817662763607, 2766.363736340633, 2855.1006432973545, 15223.771643425358, 15335.0, 15337.923310383489, 15338.233088345538, 15345.616359590987, 7948.562829044458, 8229.094799572102, 8247.670093196264, 8250.0, 8250.38122140836, 5347.1177255752755, 5358.946410535884, 5421.430749771257, 5540.9168862467095, 5557.555395568385, 1923.6248931458372, 1938.176275083098, 1946.6106778644328, 1974.032723965261, 1976.6936124900662, 26176.8691156543, 26340.341491462674, 26353.0, 26377.868110659514, 26386.47227055448, 6656.167979002625, 6765.289644587346, 6801.4558835293055, 6816.386525212655, 7001.789946301619, 17096.0597167157, 17166.22751976164, 17170.828291717175, 17187.226574804165, 17226.655466890592, 7644.847103057908, 7838.804029899184, 7880.64537095832, 7886.802829929183, 7896.960515197387, 6996.370326670522, 7087.220405755363, 7234.5659260444545, 7389.704411823467, 7402.9629851850395, 5047.0, 5117.130087885069, 5176.7152806596, 5181.4300426953005, 5212.843614691566, 1397.5597686728647, 1411.5765270418833, 1419.7515434799075, 1435.9928200358931, 1444.487207041506, 819.8688209886509, 829.742779738283, 831.5509624802539, 836.8828364029041, 849.7280870121501, 6902.171739391305, 6922.826929326707, 6968.407685346802, 6971.233164351917, 6987.196472405739, 689.4932224814758, 709.3970125393374, 711.4806191480249, 722.2019668266595, 722.7578761115085, 5111.488851114858, 5358.437364076716, 5391.7034563099405, 5467.781288748405, 5586.469285417878, 21222.363329100153, 21660.56678866414, 21908.45228869291, 21932.342029739135, 21999.12003519873, 21113.0, 21635.134594616353, 21790.891045544988, 21982.780172198072, 22010.559788804134, 10565.841512377321, 11070.778584428266, 11071.225014249087, 11091.389973551532, 11105.83341249882, 8220.465669731448, 8242.093369729444, 8243.917560824315, 8246.83506329882, 8248.752537423887, 17495.650086997935, 18111.0, 18138.727919081488, 18157.727634085764, 18342.17460214267, 18684.7197292038, 18852.245910163987, 18872.433826985212, 19034.80965190386, 19285.132169052147, 10966.616168434066, 11264.549418023187, 11353.886461135284, 11363.204575679623, 11394.25937314072, 14030.29848507591, 14146.575602731935, 14148.858511414754, 14183.929080354532, 14276.42894284217, 11007.944960275147, 11120.332780033224, 11293.0, 11320.320780753182, 11362.715932101764, 10842.295250808673, 10916.126709863032, 10958.780824383628, 11183.273087249303, 11195.0, 9454.196393306645, 9519.143277105093, 9542.236621070437, 9562.330636855353, 9570.569324380558, 7499.775006749806, 7573.0, 7573.848523029619, 7576.812863169564, 7605.581693006938, 7193.208747037717, 7300.452466065172, 7308.524945878501, 7370.5946172961, 7373.152087510005], "value": 6562.474502146822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.85033365109626, 513.7302915969113, 518.3442944674989, 526.239583801407, 532.419662567801, 6269.4295338911115, 6311.305756366802, 6327.620342779436, 6408.935910640892, 6412.134361861147, 6243.71903264353, 6262.561620686553, 6264.937350626492, 6334.936650633493, 6338.271098823637, 5177.715225662587, 5190.558802501791, 5215.973920130413, 5229.660072095321, 5233.973830130844, 4870.683405578644, 5201.86995325118, 5204.245384419257, 5208.973955130219, 5216.513293711293, 4966.250480886925, 4984.258657738247, 5013.097642424362, 5023.32185155003, 5031.0, 4931.534232883559, 4989.176785830352, 4990.800367985276, 5012.699238045729, 5032.270320803463, 4508.6618503612035, 4511.503734589192, 4512.413386259798, 4517.390152329459, 4523.231050721385, 6167.753289868445, 6198.132261483351, 6199.256089269272, 6213.161223234851, 6256.843578910518, 5736.483716465496, 5752.338481074647, 5825.825225243207, 5839.270091238595, 5848.590598658096, 6575.967120164416, 6594.142761440982, 6629.93370066298, 6646.501512386591, 6700.463962882957, 4944.110060189165, 4956.132676781584, 4969.8012079516775, 4973.303737476756, 4973.975130124362, 6740.258571557125, 6768.932310676929, 6801.65991700413, 6855.211650660188, 6917.9308206917285, 5004.69502327534, 5009.248612708123, 5016.749162541858, 5036.697798132051, 5037.69773813565, 5065.986802639487, 5076.568491678175, 5107.514786095315, 5140.866540385698, 5177.559907407913, 5769.769209231667, 5809.535237181015, 5813.186153938452, 5813.244278243801, 5839.795607153729, 6561.1470508833545, 6614.684860298953, 6644.5382015957375, 6671.266160722316, 6715.731370745213, 1744.276125407967, 1755.0873545756135, 1761.9911900440416, 1776.9644607108044, 1787.7742210947454, 1171.1392126786805, 1217.6042786094554, 1224.13086708438, 1232.8719221912029, 1238.2694210415898, 5667.603267771216, 5669.518090962314, 5671.376148623648, 5736.254286942754, 5827.94172058274, 6758.560693554903, 6796.8300792479595, 6834.983679814467, 6855.348741869514, 6906.689198986058, 5649.4633009864, 5662.244704141729, 5724.62247274102, 5735.77056917727, 5750.539956803529, 3504.9824750876082, 3520.436730123219, 3525.7179425645886, 3563.5367402237544, 3592.946105808415, 6433.402939442622, 6481.254655714559, 6492.220933488012, 6496.512761542903, 6522.315156908551, 6725.327467253235, 6761.256261811197, 6782.593044417351, 6782.864342713118, 6791.830204244933, 6307.0, 6308.27454842699, 6353.936460635427, 6390.265119511223, 6404.679766011587, 6539.574927629689, 6692.196936367667, 6696.397324240842, 6730.25967143604, 6747.797566073025, 6590.308017658269, 6668.0331351954665, 6684.966575167093, 6692.899606505809, 6789.592624442549, 6331.7336532692725, 6346.730653869337, 6404.647744374104, 6510.981595705346, 6534.542582019213, 4897.118518666674, 4960.627952903619, 4991.5008499151245, 5014.899702006012, 5051.595872330278, 6488.416042556192, 6624.701888414937, 6677.095463473404, 6820.761273355409, 6842.73409419259, 6517.152770139852, 6541.443977261795, 6618.6690665467495, 6625.204975402982, 6645.468362530889, 6455.741770329322, 6496.350364963466, 6502.739890404331, 6511.218653761579, 6536.084948107174, 6222.502199824094, 6384.45732112757, 6418.454431373386, 6456.6771661415805, 6493.740250389931, 6564.442022427956, 6617.205935287796, 6648.534602577966, 6669.233038200669, 6691.130153080263, 6169.50643948474, 6323.525735569942, 6381.946978748454, 6404.967975160094, 6421.197350331208], "value": 5081.300396266812, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.3749344205779, 921.5760750054974, 930.7440453875179, 938.2447130060303, 949.9382540134889, 19013.239470421184, 20060.4984875378, 20062.598748025048, 20088.899555502237, 20095.0, 17870.821291787077, 18325.63348733028, 18703.251869925185, 18934.14796334165, 19086.61826763464, 962.3359881681635, 968.9031096890325, 974.0211087856694, 974.853771934212, 975.2490582251662, 983.1741337276686, 990.5592011554861, 1000.6897861662871, 1017.6082208349765, 1018.6027449294781, 1040.2926010312983, 1062.4581463453655, 1063.558623171383, 1065.850780890672, 1065.9040686338267, 1002.4286156890576, 1039.6621098143096, 1060.6446840308467, 1062.6865074802913, 1062.7768168684586, 747.9102507699057, 749.4716225061319, 750.4409215134705, 751.462704166518, 751.9172890981988, 19642.607147857107, 19893.80106198934, 19923.701144482846, 19925.50186245341, 19931.0, 19372.32196873117, 19426.320078797173, 20177.0, 20326.898365508077, 20331.593368132555, 16782.244798983953, 16854.66290674192, 16996.745048824276, 17328.566785830328, 17430.389936352167, 3703.0, 3737.0844143185095, 3744.344739670547, 3744.3821769408014, 3745.906352341186, 146956.0, 148581.0, 149029.99999999892, 150465.0, 150622.0, 16501.504954851374, 16956.406525771537, 17075.658486830194, 17076.402325918534, 17083.40208092711, 31109.0, 32761.0, 32837.17907052343, 32891.0, 33237.66762332394, 8393.790155246168, 8737.43206691563, 8851.60167792451, 8855.33584981129, 8871.911280887109, 4158.7296825706235, 4303.203907277164, 4309.633681137076, 4317.0934103838545, 4345.847895323648, 5342.198670199424, 5413.891722165535, 5442.809501667422, 5449.836504904859, 5479.75341109651, 972.8103019911191, 999.820032394176, 1018.3991445047458, 1018.4958445569342, 1022.9641962531275, 684.7911387027004, 691.9515633905578, 696.7770313499733, 711.0827033127208, 712.590260600157, 11210.011544862458, 11273.0, 11505.424728763695, 12024.218425802295, 12407.131500795038, 680.7719413996367, 683.2381894188044, 687.1582311668167, 692.650211643117, 702.6873041496588, 5512.641678290898, 5653.717314134359, 5672.602917795714, 5814.883702325929, 5845.532357411482, 117301.0, 118134.40932795453, 118806.0, 120300.0, 122788.0, 111020.0, 111144.0, 112080.0, 114062.42968785104, 114548.42725786318, 95402.0, 95651.52174239223, 98267.0, 98468.50765746126, 98853.0, 10191.490425478845, 10267.383956962607, 10324.741881452723, 10373.58505659765, 10407.47962601882, 43372.13255734804, 43621.781891090344, 43725.34411983886, 45523.54476455193, 45718.54281457276, 57105.42894571001, 57568.0, 58260.4173958255, 58355.416445835, 59451.702741487745, 14576.635584110481, 15003.174825384272, 15077.849221507644, 15165.848341516885, 15205.087694738351, 15717.135557543987, 15848.44530441429, 15852.682946340778, 16000.359985600911, 16120.596985075466, 14399.496017639332, 14743.483978060716, 14757.114573125647, 14766.852331476548, 15028.774568381701, 13981.580552583438, 14192.929035354757, 14285.785713214102, 14290.214038227998, 14293.714125717219, 13449.46202151903, 13467.932660336635, 13564.72870542564, 13747.587572372844, 13790.241536715175, 11345.659630211107, 11407.144464165054, 11418.486168122288, 11649.825252621047, 12046.0, 10912.290701104403, 10971.890281097087, 11051.668449946514, 11081.61214357526, 11111.00000999914], "value": 8834.12284628457, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1417.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 107.0, 109.0, 109.0, 109.0, 112.0, 110.0, 107.0, 107.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 117.0, 119.0, 118.0, 114.0, 115.0, 150.0, 117.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 163.0, 161.0, 161.0, 162.0, 166.0, 164.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 74.0, 75.0, 75.0, 76.0, 74.0, 75.0, 73.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 83.0, 79.0, 81.0, 81.0, 79.0, 79.0, 79.0, 79.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 148.0, 147.0, 150.0, 148.0, 147.0, 148.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 51.0, 52.0, 52.0, 51.0, 52.0, 54.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 37.0, 38.0, 38.0, 38.0, 40.0, 38.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 78.0, 80.0, 74.0, 75.0, 74.0, 76.0, 74.0, 75.0, 74.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 116.0, 115.0, 117.0, 109.0, 113.0, 118.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 164.0, 166.0, 169.0, 164.0, 166.0, 173.0, 177.0, 168.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 64.0, 65.0, 68.0, 70.0, 64.0, 63.0, 65.0, 65.0], "value": 65.4, "unit": "score"}]}]} 15:44:47 INFO - Return code: 0 15:44:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:44:47 INFO - # TBPL SUCCESS # 15:44:47 INFO - Running post-action listener: _package_coverage_data 15:44:47 INFO - Running post-action listener: _resource_record_post_action 15:44:47 INFO - [mozharness: 2017-09-17 22:44:47.885309Z] Finished run-tests step (success) 15:44:47 INFO - Running post-run listener: _resource_record_post_run 15:44:47 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 333717504; Read time: 24; Write time: 285636 15:44:47 INFO - TinderboxPrint: CPU usage
13.1% 15:44:47 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 15:44:47 INFO - TinderboxPrint: I/O write bytes / time
333,717,504 / 285,636 15:44:47 INFO - TinderboxPrint: CPU idle
8,242.4 (86.9%) 15:44:47 INFO - TinderboxPrint: CPU user
1,192.5 (12.6%) 15:44:47 INFO - TinderboxPrint: Swap in / out
0 / 0 15:44:47 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10522624; Read time: 0; Write time: 1712 15:44:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:44:47 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323194880; Read time: 8; Write time: 283924 15:44:48 INFO - Running post-run listener: _upload_blobber_files 15:44:48 INFO - Blob upload gear active. 15:44:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:44:48 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 15:44:48 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:44:48 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:44:48 INFO - (blobuploader) - INFO - Open directory for files ... 15:44:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 15:44:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 15:44:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:50 INFO - (blobuploader) - INFO - Done attempting. 15:44:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 15:44:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 15:44:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:50 INFO - (blobuploader) - INFO - Done attempting. 15:44:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:44:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:57 INFO - (blobuploader) - INFO - Done attempting. 15:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:59 INFO - (blobuploader) - INFO - Done attempting. 15:44:59 INFO - (blobuploader) - INFO - Iteration through files over. 15:44:59 INFO - Return code: 0 15:44:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:44:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:44:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b145d67560ffcf001ea0a1e70e427cc2b5be3e86f7e4826a64fa15f6f8c1edf7c2494a6738a101f180c0c4a8922da7abca3c82bc8f0998bbf56721e37068bd31", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77e241b4224ea8746fe0c40231bb08f809358c417514d5e1b43fabefeac6a1a8a7967c3e41dc2111a8a62bf6827a3889955ad913bba6c56283d46267039dce6c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3f5059a86ea68b48f5ef7f6c89458639da60bd1d21a587e108cbcd725b20c2b47343768cadb639758f8bd56b3eaf56ab2ed9e1230bf03345438fcd06882e4c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad428582d0a1219b0858461ef2b15f316ccdd74cf10e72d51584426941b549c576deea875952486da1645c59d4b8f15a0711563be3ceed8dc8dbb700badc88e4"} 15:44:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:44:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:44:59 INFO - Contents: 15:44:59 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b145d67560ffcf001ea0a1e70e427cc2b5be3e86f7e4826a64fa15f6f8c1edf7c2494a6738a101f180c0c4a8922da7abca3c82bc8f0998bbf56721e37068bd31", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77e241b4224ea8746fe0c40231bb08f809358c417514d5e1b43fabefeac6a1a8a7967c3e41dc2111a8a62bf6827a3889955ad913bba6c56283d46267039dce6c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3f5059a86ea68b48f5ef7f6c89458639da60bd1d21a587e108cbcd725b20c2b47343768cadb639758f8bd56b3eaf56ab2ed9e1230bf03345438fcd06882e4c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad428582d0a1219b0858461ef2b15f316ccdd74cf10e72d51584426941b549c576deea875952486da1645c59d4b8f15a0711563be3ceed8dc8dbb700badc88e4"} 15:44:59 INFO - Running post-run listener: copy_logs_to_upload_dir 15:44:59 INFO - Copying logs to upload dir... 15:44:59 INFO - mkdir: /builds/slave/test/build/upload/logs 15:44:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.641637 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-17 15:44:59.226492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 15:44:59.230701) ========= 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=eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b145d67560ffcf001ea0a1e70e427cc2b5be3e86f7e4826a64fa15f6f8c1edf7c2494a6738a101f180c0c4a8922da7abca3c82bc8f0998bbf56721e37068bd31", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77e241b4224ea8746fe0c40231bb08f809358c417514d5e1b43fabefeac6a1a8a7967c3e41dc2111a8a62bf6827a3889955ad913bba6c56283d46267039dce6c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3f5059a86ea68b48f5ef7f6c89458639da60bd1d21a587e108cbcd725b20c2b47343768cadb639758f8bd56b3eaf56ab2ed9e1230bf03345438fcd06882e4c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad428582d0a1219b0858461ef2b15f316ccdd74cf10e72d51584426941b549c576deea875952486da1645c59d4b8f15a0711563be3ceed8dc8dbb700badc88e4"} build_url:https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b145d67560ffcf001ea0a1e70e427cc2b5be3e86f7e4826a64fa15f6f8c1edf7c2494a6738a101f180c0c4a8922da7abca3c82bc8f0998bbf56721e37068bd31", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77e241b4224ea8746fe0c40231bb08f809358c417514d5e1b43fabefeac6a1a8a7967c3e41dc2111a8a62bf6827a3889955ad913bba6c56283d46267039dce6c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3f5059a86ea68b48f5ef7f6c89458639da60bd1d21a587e108cbcd725b20c2b47343768cadb639758f8bd56b3eaf56ab2ed9e1230bf03345438fcd06882e4c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad428582d0a1219b0858461ef2b15f316ccdd74cf10e72d51584426941b549c576deea875952486da1645c59d4b8f15a0711563be3ceed8dc8dbb700badc88e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 15:44:59.261946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:44:59.262365) ========= 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=eca2ab57546de7b41f256b19000001ef-1505687056.621358-83723138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:44:59.315372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 15:44:59.315779) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 15:44:59.316178) ========= ========= Total master_lag: 0.34 =========