builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-046 starttime: 1504955302.77 results: success (0) revision: c71b01e993510268bab7d60154b2f80692fd507d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:22.767088) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:22.767459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:22.768057) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:22.808222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:22.808514) ========= 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=652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-09 04:08:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.1M=0s 2017-09-09 04:08:22 (50.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081241 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:22.906645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:22.906947) ========= 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=652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015815 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:22.956702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:22.957011) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c71b01e993510268bab7d60154b2f80692fd507d --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 c71b01e993510268bab7d60154b2f80692fd507d --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=652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-09 04:08:23,010 truncating revision to first 12 chars 2017-09-09 04:08:23,011 Setting DEBUG logging. 2017-09-09 04:08:23,011 attempt 1/10 2017-09-09 04:08:23,011 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c71b01e99351?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-09 04:08:23,675 unpacking tar archive at: mozilla-central-c71b01e99351/testing/mozharness/ program finished with exit code 0 elapsedTime=0.973432 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:23.947552) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:23.947927) ========= script_repo_revision: c71b01e993510268bab7d60154b2f80692fd507d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:23.948426) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:23.949075) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 04:08:23.963045) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-09 04:08:23.963391) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:24 INFO - MultiFileLogger online at 20170909 04:08:24 in /builds/slave/test 04:08:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:08:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:24 INFO - {'append_to_log': False, 04:08:24 INFO - 'base_work_dir': '/builds/slave/test', 04:08:24 INFO - 'blob_upload_branch': 'Firefox', 04:08:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:24 INFO - 'branch': 'Firefox', 04:08:24 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:24 INFO - 'code_coverage': False, 04:08:24 INFO - 'config_files': ('talos/linux_config.py',), 04:08:24 INFO - 'default_actions': ('clobber', 04:08:24 INFO - 'read-buildbot-config', 04:08:24 INFO - 'download-and-extract', 04:08:24 INFO - 'populate-webroot', 04:08:24 INFO - 'create-virtualenv', 04:08:24 INFO - 'install', 04:08:24 INFO - 'setup-mitmproxy', 04:08:24 INFO - 'run-tests'), 04:08:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:24 INFO - 'disable_ccov_upload': False, 04:08:24 INFO - 'disable_stylo': False, 04:08:24 INFO - 'download_minidump_stackwalk': True, 04:08:24 INFO - 'download_symbols': 'ondemand', 04:08:24 INFO - 'enable_stylo': False, 04:08:24 INFO - 'enable_webrender': False, 04:08:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:08:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:24 INFO - 'gecko_profile': False, 04:08:24 INFO - 'gecko_profile_interval': 0, 04:08:24 INFO - 'installer_path': 'installer.exe', 04:08:24 INFO - 'log_level': 'info', 04:08:24 INFO - 'log_name': 'talos', 04:08:24 INFO - 'log_to_console': True, 04:08:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:24 INFO - 'opt_config_files': (), 04:08:24 INFO - 'pip_index': False, 04:08:24 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:08:24 INFO - 'system_bits': '32', 04:08:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:24 INFO - 'title': 'talos-linux64-ix-046', 04:08:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:24 INFO - 'use_talos_json': True, 04:08:24 INFO - 'verify': 'False', 04:08:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:24 INFO - 'work_dir': 'build'} 04:08:24 INFO - [mozharness: 2017-09-09 11:08:24.158003Z] Running clobber step. 04:08:24 INFO - Running pre-action listener: _resource_record_pre_action 04:08:24 INFO - Running main action method: clobber 04:08:24 INFO - rmtree: /builds/slave/test/build 04:08:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:25 INFO - Running post-action listener: _resource_record_post_action 04:08:25 INFO - [mozharness: 2017-09-09 11:08:25.168218Z] Finished clobber step (success) 04:08:25 INFO - [mozharness: 2017-09-09 11:08:25.168314Z] Running read-buildbot-config step. 04:08:25 INFO - Running pre-action listener: _resource_record_pre_action 04:08:25 INFO - Running main action method: read_buildbot_config 04:08:25 INFO - Using buildbot properties: 04:08:25 INFO - { 04:08:25 INFO - "project": "", 04:08:25 INFO - "product": "firefox", 04:08:25 INFO - "who": "archaeopteryx@coole-files.de", 04:08:25 INFO - "installer_path": "public/build/target.tar.bz2", 04:08:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:08:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:08:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:08:25 INFO - "stage_platform": "linux64-pgo", 04:08:25 INFO - "basedir": "/builds/slave/test", 04:08:25 INFO - "buildnumber": 6, 04:08:25 INFO - "platform": "ubuntu64_hw", 04:08:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:08:25 INFO - "slavebuilddir": "test", 04:08:25 INFO - "taskId": "Rvg6ByK2QZW5ekvJZQSikA", 04:08:25 INFO - "branch": "mozilla-central", 04:08:25 INFO - "script_repo_revision": "production", 04:08:25 INFO - "revision": "c71b01e993510268bab7d60154b2f80692fd507d", 04:08:25 INFO - "slavename": "talos-linux64-ix-046", 04:08:25 INFO - "repo_path": "mozilla-central" 04:08:25 INFO - } 04:08:25 INFO - Finding installer, test and symbols from parent task. 04:08:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rvg6ByK2QZW5ekvJZQSikA'}, attempt #1 04:08:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rvg6ByK2QZW5ekvJZQSikA'}, attempt #1 04:08:26 INFO - Task dependencies: XvLPM4gBSoCLFs5hXh0goQ 04:08:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ'}, attempt #1 04:08:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.tar.bz2 04:08:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.test_packages.json 04:08:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.crashreporter-symbols.zip 04:08:26 INFO - Running post-action listener: _resource_record_post_action 04:08:26 INFO - [mozharness: 2017-09-09 11:08:26.532312Z] Finished read-buildbot-config step (success) 04:08:26 INFO - [mozharness: 2017-09-09 11:08:26.532529Z] Running download-and-extract step. 04:08:26 INFO - Running pre-action listener: _resource_record_pre_action 04:08:26 INFO - Running main action method: download_and_extract 04:08:26 INFO - mkdir: /builds/slave/test/build/tests 04:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:26 INFO - trying https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.test_packages.json 04:08:26 INFO - Downloading https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:08:27 INFO - Downloaded 989 bytes. 04:08:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:08:27 INFO - Using the following test package requirements: 04:08:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:08:27 INFO - u'common': [u'target.common.tests.zip'], 04:08:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:08:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:08:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:08:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:08:27 INFO - u'mozbase': [u'target.common.tests.zip'], 04:08:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:08:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:08:27 INFO - u'web-platform': [u'target.common.tests.zip', 04:08:27 INFO - u'target.web-platform.tests.tar.gz'], 04:08:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:08:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:08:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.common.tests.zip 04:08:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:08:27 INFO - Fetch https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.common.tests.zip into memory 04:08:28 INFO - Content-Length response header: 55703354 04:08:28 INFO - Bytes received: 55703354 04:08:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.talos.tests.zip 04:08:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:08:39 INFO - Fetch https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.talos.tests.zip into memory 04:08:40 INFO - Content-Length response header: 14497963 04:08:40 INFO - Bytes received: 14497963 04:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:40 INFO - trying https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.tar.bz2 04:08:40 INFO - Downloading https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:08:41 INFO - Downloaded 63691075 bytes. 04:08:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.tar.bz2 04:08:41 INFO - mkdir: /builds/slave/test/properties 04:08:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:41 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:41 INFO - Contents: 04:08:41 INFO - build_url:https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.tar.bz2 04:08:41 INFO - Running post-action listener: _resource_record_post_action 04:08:41 INFO - Running post-action listener: find_tests_for_verification 04:08:41 INFO - Running post-action listener: set_extra_try_arguments 04:08:41 INFO - [mozharness: 2017-09-09 11:08:41.595245Z] Finished download-and-extract step (success) 04:08:41 INFO - [mozharness: 2017-09-09 11:08:41.595341Z] Running populate-webroot step. 04:08:41 INFO - Running pre-action listener: _resource_record_pre_action 04:08:41 INFO - Running main action method: populate_webroot 04:08:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:08:41 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:41 INFO - 'tests': ['tresize', 04:08:41 INFO - 'tcanvasmark']}, 04:08:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:08:41 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:41 INFO - 'tests': ['dromaeo_css', 04:08:41 INFO - 'kraken']}, 04:08:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:08:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:41 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:08:41 INFO - 'talos_options': ['--disable-stylo'], 04:08:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:08:41 INFO - 'tests': ['damp', 'tps']}, 04:08:41 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:08:41 INFO - 'talos_options': ['--disable-stylo'], 04:08:41 INFO - 'tests': ['damp', 'tps']}, 04:08:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:41 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:41 INFO - 'tests': ['dromaeo_dom']}, 04:08:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:08:41 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:41 INFO - 'tests': ['basic_compositor_video', 04:08:41 INFO - 'glvideo']}, 04:08:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:08:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:08:41 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:08:41 INFO - 'talos_options': ['--disable-stylo'], 04:08:41 INFO - 'tests': ['ts_paint_webext', 04:08:41 INFO - 'tp5o_webext']}, 04:08:41 INFO - 'other-e10s': {'tests': ['a11yr', 04:08:41 INFO - 'ts_paint', 04:08:41 INFO - 'tpaint', 04:08:41 INFO - 'sessionrestore', 04:08:41 INFO - 'sessionrestore_many_windows', 04:08:41 INFO - 'sessionrestore_no_auto_restore', 04:08:41 INFO - 'tabpaint']}, 04:08:41 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:41 INFO - 'tests': ['a11yr', 04:08:41 INFO - 'ts_paint', 04:08:41 INFO - 'tpaint', 04:08:41 INFO - 'sessionrestore', 04:08:41 INFO - 'sessionrestore_many_windows', 04:08:41 INFO - 'sessionrestore_no_auto_restore', 04:08:41 INFO - 'tabpaint']}, 04:08:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:08:41 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:08:41 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:41 INFO - 'tests': ['bloom_basic_singleton']}, 04:08:41 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:41 INFO - 'tests': ['bloom_basic']}, 04:08:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:08:41 INFO - 'tsvgr_opacity', 04:08:41 INFO - 'tart', 04:08:41 INFO - 'tscrollx', 04:08:41 INFO - 'tsvg_static']}, 04:08:41 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:08:41 INFO - 'tests': ['tsvgx', 04:08:41 INFO - 'tsvgr_opacity', 04:08:41 INFO - 'tart', 04:08:41 INFO - 'tscrollx', 04:08:41 INFO - 'tsvg_static']}, 04:08:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:08:41 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:08:41 INFO - 'talos_options': ['--disable-stylo'], 04:08:41 INFO - 'tests': ['tp5o']}, 04:08:41 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:08:41 INFO - 'talos_options': ['--mitmproxy', 04:08:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:08:41 INFO - '--firstNonBlankPaint'], 04:08:41 INFO - 'tests': ['tp6_google', 04:08:41 INFO - 'tp6_youtube', 04:08:41 INFO - 'tp6_amazon', 04:08:41 INFO - 'tp6_facebook']}, 04:08:41 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:08:41 INFO - 'talos_options': ['--disable-stylo', 04:08:41 INFO - '--mitmproxy', 04:08:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:08:41 INFO - '--firstNonBlankPaint'], 04:08:41 INFO - 'tests': ['tp6_google', 04:08:41 INFO - 'tp6_youtube', 04:08:41 INFO - 'tp6_amazon', 04:08:41 INFO - 'tp6_facebook']}, 04:08:41 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:08:41 INFO - 'talos_options': ['--stylo-threads=1', 04:08:41 INFO - '--mitmproxy', 04:08:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:08:41 INFO - '--firstNonBlankPaint'], 04:08:41 INFO - 'tests': ['tp6_google', 04:08:41 INFO - 'tp6_youtube', 04:08:41 INFO - 'tp6_amazon', 04:08:41 INFO - 'tp6_facebook']}, 04:08:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:08:41 INFO - 'talos_options': ['--xperf_path', 04:08:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:41 INFO - 'tests': ['tp5n']}, 04:08:41 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:08:41 INFO - 'talos_options': ['--disable-stylo', 04:08:41 INFO - '--xperf_path', 04:08:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:41 INFO - 'tests': ['tp5n']}}} 04:08:41 INFO - Running post-action listener: _resource_record_post_action 04:08:41 INFO - [mozharness: 2017-09-09 11:08:41.610363Z] Finished populate-webroot step (success) 04:08:41 INFO - [mozharness: 2017-09-09 11:08:41.610452Z] Running create-virtualenv step. 04:08:41 INFO - Running pre-action listener: _resource_record_pre_action 04:08:41 INFO - Running main action method: create_virtualenv 04:08:41 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:41 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:08:41 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:08:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:08:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:42 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:42 INFO - Installing pip...............done. 04:08:42 INFO - Return code: 0 04:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:08:42 INFO - Reading from file tmpfile_stdout 04:08:42 INFO - Output received: 04:08:42 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:08:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08: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')]} 04:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196a090>, '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 0x196ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08: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', 'pip>=1.5'] in /builds/slave/test/build 04:08: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 pip>=1.5 04:08:42 INFO - Using env: {'DISPLAY': ':0', 04:08:42 INFO - 'HOME': '/home/cltbld', 04:08:42 INFO - 'LANG': 'en_US.UTF-8', 04:08:42 INFO - 'LANGUAGE': 'en_US:en', 04:08:42 INFO - 'LOGNAME': 'cltbld', 04:08:42 INFO - 'MAIL': '/var/mail/cltbld', 04:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:42 INFO - 'MOZ_NO_REMOTE': '1', 04:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:42 INFO - 'NO_EM_RESTART': '1', 04:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:42 INFO - 'PWD': '/builds/slave/test', 04:08:42 INFO - 'SHELL': '/bin/bash', 04:08:42 INFO - 'SHLVL': '1', 04:08:42 INFO - 'TERM': 'linux', 04:08:42 INFO - 'TMOUT': '86400', 04:08:42 INFO - 'USER': 'cltbld', 04:08:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:42 INFO - '_': '/tools/buildbot/bin/python'} 04:08:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:08:45 INFO - Downloading/unpacking pip>=1.5 04:08:45 INFO - Running setup.py egg_info for package pip 04:08:45 INFO - warning: no files found matching 'pip/cacert.pem' 04:08:45 INFO - warning: no files found matching '*.html' under directory 'docs' 04:08:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:08:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:08:45 INFO - Installing collected packages: pip 04:08:45 INFO - Found existing installation: pip 1.1 04:08:45 INFO - Uninstalling pip: 04:08:45 INFO - Successfully uninstalled pip 04:08:45 INFO - Running setup.py install for pip 04:08:45 INFO - warning: no files found matching 'pip/cacert.pem' 04:08:45 INFO - warning: no files found matching '*.html' under directory 'docs' 04:08:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:08:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:08:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:08:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:08:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:08:45 INFO - Successfully installed pip 04:08:45 INFO - Cleaning up... 04:08:45 INFO - Return code: 0 04:08:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08: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')]} 04:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08: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', '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 0x15fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196a090>, '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 0x196ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:08: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 psutil>=3.1.1 04:08:45 INFO - Using env: {'DISPLAY': ':0', 04:08:45 INFO - 'HOME': '/home/cltbld', 04:08:45 INFO - 'LANG': 'en_US.UTF-8', 04:08:45 INFO - 'LANGUAGE': 'en_US:en', 04:08:45 INFO - 'LOGNAME': 'cltbld', 04:08:45 INFO - 'MAIL': '/var/mail/cltbld', 04:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:45 INFO - 'MOZ_NO_REMOTE': '1', 04:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:45 INFO - 'NO_EM_RESTART': '1', 04:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:45 INFO - 'PWD': '/builds/slave/test', 04:08:45 INFO - 'SHELL': '/bin/bash', 04:08:45 INFO - 'SHLVL': '1', 04:08:45 INFO - 'TERM': 'linux', 04:08:45 INFO - 'TMOUT': '86400', 04:08:45 INFO - 'USER': 'cltbld', 04:08:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:45 INFO - '_': '/tools/buildbot/bin/python'} 04:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:45 INFO - Downloading/unpacking psutil>=3.1.1 04:08: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 04:08: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 04:08: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 04:08: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 04:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:46 INFO - Installing collected packages: psutil 04:08:46 INFO - Running setup.py install for psutil 04:08:46 INFO - building 'psutil._psutil_linux' extension 04:08:46 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 04:08:47 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 04:08:47 INFO - building 'psutil._psutil_posix' extension 04:08:47 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 04:08:47 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 04:08:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:47 INFO - Successfully installed psutil 04:08:47 INFO - Cleaning up... 04:08:47 INFO - Return code: 0 04:08:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:47 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 0x15fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196a090>, '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 0x196ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:47 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 04:08:47 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 04:08:47 INFO - Using env: {'DISPLAY': ':0', 04:08:47 INFO - 'HOME': '/home/cltbld', 04:08:47 INFO - 'LANG': 'en_US.UTF-8', 04:08:47 INFO - 'LANGUAGE': 'en_US:en', 04:08:47 INFO - 'LOGNAME': 'cltbld', 04:08:47 INFO - 'MAIL': '/var/mail/cltbld', 04:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:47 INFO - 'MOZ_NO_REMOTE': '1', 04:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:47 INFO - 'NO_EM_RESTART': '1', 04:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:47 INFO - 'PWD': '/builds/slave/test', 04:08:47 INFO - 'SHELL': '/bin/bash', 04:08:47 INFO - 'SHLVL': '1', 04:08:47 INFO - 'TERM': 'linux', 04:08:47 INFO - 'TMOUT': '86400', 04:08:47 INFO - 'USER': 'cltbld', 04:08:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:47 INFO - '_': '/tools/buildbot/bin/python'} 04:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:08: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 04:08: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 04:08: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 04:08: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 04:08:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:08:48 INFO - Installing collected packages: mozsystemmonitor 04:08:48 INFO - Running setup.py install for mozsystemmonitor 04:08:48 INFO - Successfully installed mozsystemmonitor 04:08:48 INFO - Cleaning up... 04:08:48 INFO - Return code: 0 04:08:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08: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')]} 04:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:48 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 0x15fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196a090>, '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 0x196ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:48 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 04:08:48 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 04:08:48 INFO - Using env: {'DISPLAY': ':0', 04:08:48 INFO - 'HOME': '/home/cltbld', 04:08:48 INFO - 'LANG': 'en_US.UTF-8', 04:08:48 INFO - 'LANGUAGE': 'en_US:en', 04:08:48 INFO - 'LOGNAME': 'cltbld', 04:08:48 INFO - 'MAIL': '/var/mail/cltbld', 04:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:48 INFO - 'MOZ_NO_REMOTE': '1', 04:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:48 INFO - 'NO_EM_RESTART': '1', 04:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:48 INFO - 'PWD': '/builds/slave/test', 04:08:48 INFO - 'SHELL': '/bin/bash', 04:08:48 INFO - 'SHLVL': '1', 04:08:48 INFO - 'TERM': 'linux', 04:08:48 INFO - 'TMOUT': '86400', 04:08:48 INFO - 'USER': 'cltbld', 04:08:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:48 INFO - '_': '/tools/buildbot/bin/python'} 04:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:49 INFO - Downloading/unpacking jsonschema==2.5.1 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:08:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:50 INFO - Downloading functools32-3.2.3-2.tar.gz 04:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:08:50 INFO - warning: no files found matching '*.txt' 04:08:50 INFO - no previously-included directories found matching 'build' 04:08:50 INFO - no previously-included directories found matching 'dist' 04:08:50 INFO - no previously-included directories found matching '.git*' 04:08:50 INFO - Installing collected packages: jsonschema, functools32 04:08:50 INFO - Running setup.py install for functools32 04:08:50 INFO - warning: no files found matching '*.txt' 04:08:50 INFO - no previously-included directories found matching 'build' 04:08:50 INFO - no previously-included directories found matching 'dist' 04:08:50 INFO - no previously-included directories found matching '.git*' 04:08:50 INFO - Successfully installed jsonschema functools32 04:08:50 INFO - Cleaning up... 04:08:50 INFO - Return code: 0 04:08:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196a090>, '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 0x196ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:08:50 INFO - Using env: {'DISPLAY': ':0', 04:08:50 INFO - 'HOME': '/home/cltbld', 04:08:50 INFO - 'LANG': 'en_US.UTF-8', 04:08:50 INFO - 'LANGUAGE': 'en_US:en', 04:08:50 INFO - 'LOGNAME': 'cltbld', 04:08:50 INFO - 'MAIL': '/var/mail/cltbld', 04:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:50 INFO - 'MOZ_NO_REMOTE': '1', 04:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:50 INFO - 'NO_EM_RESTART': '1', 04:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:50 INFO - 'PWD': '/builds/slave/test', 04:08:50 INFO - 'SHELL': '/bin/bash', 04:08:50 INFO - 'SHLVL': '1', 04:08:50 INFO - 'TERM': 'linux', 04:08:50 INFO - 'TMOUT': '86400', 04:08:50 INFO - 'USER': 'cltbld', 04:08:50 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:50 INFO - '_': '/tools/buildbot/bin/python'} 04:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:08:50 INFO - Cleaning up... 04:08:50 INFO - Return code: 0 04:08:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196a090>, '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 0x196ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:08:50 INFO - Using env: {'DISPLAY': ':0', 04:08:50 INFO - 'HOME': '/home/cltbld', 04:08:50 INFO - 'LANG': 'en_US.UTF-8', 04:08:50 INFO - 'LANGUAGE': 'en_US:en', 04:08:50 INFO - 'LOGNAME': 'cltbld', 04:08:50 INFO - 'MAIL': '/var/mail/cltbld', 04:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:50 INFO - 'MOZ_NO_REMOTE': '1', 04:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:50 INFO - 'NO_EM_RESTART': '1', 04:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:50 INFO - 'PWD': '/builds/slave/test', 04:08:50 INFO - 'SHELL': '/bin/bash', 04:08:50 INFO - 'SHLVL': '1', 04:08:50 INFO - 'TERM': 'linux', 04:08:50 INFO - 'TMOUT': '86400', 04:08:50 INFO - 'USER': 'cltbld', 04:08:50 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:50 INFO - '_': '/tools/buildbot/bin/python'} 04:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:50 INFO - Downloading/unpacking blobuploader==1.2.4 04:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08: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 04:08: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 04:08: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 04:08: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 04:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:08:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08: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 04:08: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 04:08: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 04:08: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 04:08:52 INFO - Downloading docopt-0.6.1.tar.gz 04:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:52 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:52 INFO - Running setup.py install for blobuploader 04:08:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:08:52 INFO - Running setup.py install for requests 04:08:53 INFO - Running setup.py install for docopt 04:08:53 INFO - Successfully installed blobuploader requests docopt 04:08:53 INFO - Cleaning up... 04:08:53 INFO - Return code: 0 04:08:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:53 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 0x15fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196a090>, '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 0x196ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:53 INFO - Using env: {'DISPLAY': ':0', 04:08:53 INFO - 'HOME': '/home/cltbld', 04:08:53 INFO - 'LANG': 'en_US.UTF-8', 04:08:53 INFO - 'LANGUAGE': 'en_US:en', 04:08:53 INFO - 'LOGNAME': 'cltbld', 04:08:53 INFO - 'MAIL': '/var/mail/cltbld', 04:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:53 INFO - 'MOZ_NO_REMOTE': '1', 04:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:53 INFO - 'NO_EM_RESTART': '1', 04:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:53 INFO - 'PWD': '/builds/slave/test', 04:08:53 INFO - 'SHELL': '/bin/bash', 04:08:53 INFO - 'SHLVL': '1', 04:08:53 INFO - 'TERM': 'linux', 04:08:53 INFO - 'TMOUT': '86400', 04:08:53 INFO - 'USER': 'cltbld', 04:08:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:53 INFO - '_': '/tools/buildbot/bin/python'} 04:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:53 INFO - Running setup.py (path:/tmp/pip-w41e1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:53 INFO - Running setup.py (path:/tmp/pip-_lm7x0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:53 INFO - Running setup.py (path:/tmp/pip-i_Y0mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:53 INFO - Running setup.py (path:/tmp/pip-5ZTvZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:53 INFO - Running setup.py (path:/tmp/pip-1Dr6RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:53 INFO - Running setup.py (path:/tmp/pip-6We0NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:53 INFO - Running setup.py (path:/tmp/pip-lGXPbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:53 INFO - Running setup.py (path:/tmp/pip-tzPUbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:54 INFO - Running setup.py (path:/tmp/pip-pkZiHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:54 INFO - Running setup.py (path:/tmp/pip-kKxMZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:54 INFO - Running setup.py (path:/tmp/pip-K2Uz5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:54 INFO - Running setup.py (path:/tmp/pip-esZpnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:54 INFO - Running setup.py (path:/tmp/pip-VseEAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:54 INFO - Running setup.py (path:/tmp/pip-LxLUN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:54 INFO - Running setup.py (path:/tmp/pip-3haJRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:54 INFO - Running setup.py (path:/tmp/pip-KAJpnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:54 INFO - Running setup.py (path:/tmp/pip-JVaUtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:54 INFO - Running setup.py install for manifestparser 04:08:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for mozcrash 04:08:54 INFO - Running setup.py install for mozdebug 04:08:54 INFO - Running setup.py install for mozdevice 04:08:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Running setup.py install for mozfile 04:08:55 INFO - Running setup.py install for mozhttpd 04:08:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Running setup.py install for mozinfo 04:08:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Running setup.py install for mozInstall 04:08:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Running setup.py install for mozleak 04:08:55 INFO - Running setup.py install for mozlog 04:08:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Running setup.py install for moznetwork 04:08:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Running setup.py install for mozprocess 04:08:55 INFO - Running setup.py install for mozprofile 04:08:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Running setup.py install for mozrunner 04:08:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:08:56 INFO - Running setup.py install for mozscreenshot 04:08:56 INFO - Running setup.py install for moztest 04:08:56 INFO - Running setup.py install for mozversion 04:08:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:08:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:56 INFO - Cleaning up... 04:08:56 INFO - Return code: 0 04:08:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08: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')]} 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:56 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 0x15fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196a090>, '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 0x196ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:56 INFO - Using env: {'DISPLAY': ':0', 04:08:56 INFO - 'HOME': '/home/cltbld', 04:08:56 INFO - 'LANG': 'en_US.UTF-8', 04:08:56 INFO - 'LANGUAGE': 'en_US:en', 04:08:56 INFO - 'LOGNAME': 'cltbld', 04:08:56 INFO - 'MAIL': '/var/mail/cltbld', 04:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:56 INFO - 'MOZ_NO_REMOTE': '1', 04:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:56 INFO - 'NO_EM_RESTART': '1', 04:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:56 INFO - 'PWD': '/builds/slave/test', 04:08:56 INFO - 'SHELL': '/bin/bash', 04:08:56 INFO - 'SHLVL': '1', 04:08:56 INFO - 'TERM': 'linux', 04:08:56 INFO - 'TMOUT': '86400', 04:08:56 INFO - 'USER': 'cltbld', 04:08:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:56 INFO - '_': '/tools/buildbot/bin/python'} 04:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:56 INFO - Running setup.py (path:/tmp/pip-EO0nTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:56 INFO - Running setup.py (path:/tmp/pip-zwv9CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:56 INFO - Running setup.py (path:/tmp/pip-d8Jh9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:56 INFO - Running setup.py (path:/tmp/pip-0KY4aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:56 INFO - Running setup.py (path:/tmp/pip-6d9MPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:57 INFO - Running setup.py (path:/tmp/pip-uHWqz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:57 INFO - Running setup.py (path:/tmp/pip-c9QeuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:57 INFO - Running setup.py (path:/tmp/pip-A2yjlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:57 INFO - Running setup.py (path:/tmp/pip-Ux2S8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:57 INFO - Running setup.py (path:/tmp/pip-Ro0GbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:57 INFO - Running setup.py (path:/tmp/pip-aDakaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:57 INFO - Running setup.py (path:/tmp/pip-Da39yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:57 INFO - Running setup.py (path:/tmp/pip-N7xIqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:57 INFO - Running setup.py (path:/tmp/pip-4RJaCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:57 INFO - Running setup.py (path:/tmp/pip-HY32Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:57 INFO - Running setup.py (path:/tmp/pip-5UVcqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:57 INFO - Running setup.py (path:/tmp/pip-28jhaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:08:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:58 INFO - Downloading blessings-1.6.tar.gz 04:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:59 INFO - Installing collected packages: blessings 04:08:59 INFO - Running setup.py install for blessings 04:08:59 INFO - Successfully installed blessings 04:08:59 INFO - Cleaning up... 04:08:59 INFO - Return code: 0 04:08:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:59 INFO - Reading from file tmpfile_stdout 04:08:59 INFO - Current package versions: 04:08:59 INFO - argparse == 1.2.1 04:08:59 INFO - blessings == 1.6 04:08:59 INFO - blobuploader == 1.2.4 04:08:59 INFO - docopt == 0.6.1 04:08:59 INFO - functools32 == 3.2.3-2 04:08:59 INFO - jsonschema == 2.5.1 04:08:59 INFO - manifestparser == 1.1 04:08:59 INFO - mozInstall == 1.13 04:08:59 INFO - mozcrash == 1.0 04:08:59 INFO - mozdebug == 0.1 04:08:59 INFO - mozdevice == 0.51 04:08:59 INFO - mozfile == 1.2 04:08:59 INFO - mozhttpd == 0.7 04:08:59 INFO - mozinfo == 0.10 04:08:59 INFO - mozleak == 0.1 04:08:59 INFO - mozlog == 3.5 04:08:59 INFO - moznetwork == 0.27 04:08:59 INFO - mozprocess == 0.25 04:08:59 INFO - mozprofile == 0.28 04:08:59 INFO - mozrunner == 6.13 04:08:59 INFO - mozscreenshot == 0.1 04:08:59 INFO - mozsystemmonitor == 0.3 04:08:59 INFO - moztest == 0.8 04:08:59 INFO - mozversion == 1.4 04:08:59 INFO - psutil == 3.1.1 04:08:59 INFO - requests == 1.2.3 04:08:59 INFO - wsgiref == 0.1.2 04:08:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:59 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 0x15fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196a090>, '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 0x196ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:59 INFO - Using env: {'DISPLAY': ':0', 04:08:59 INFO - 'HOME': '/home/cltbld', 04:08:59 INFO - 'LANG': 'en_US.UTF-8', 04:08:59 INFO - 'LANGUAGE': 'en_US:en', 04:08:59 INFO - 'LOGNAME': 'cltbld', 04:08:59 INFO - 'MAIL': '/var/mail/cltbld', 04:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:59 INFO - 'MOZ_NO_REMOTE': '1', 04:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:59 INFO - 'NO_EM_RESTART': '1', 04:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:59 INFO - 'PWD': '/builds/slave/test', 04:08:59 INFO - 'SHELL': '/bin/bash', 04:08:59 INFO - 'SHLVL': '1', 04:08:59 INFO - 'TERM': 'linux', 04:08:59 INFO - 'TMOUT': '86400', 04:08:59 INFO - 'USER': 'cltbld', 04:08:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:59 INFO - '_': '/tools/buildbot/bin/python'} 04:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:08:59 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:09:00 INFO - Installing collected packages: simplejson 04:09:00 INFO - Running setup.py install for simplejson 04:09:00 INFO - building 'simplejson._speedups' extension 04:09:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:09:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 04:09:01 INFO - Successfully installed simplejson 04:09:01 INFO - Cleaning up... 04:09:01 INFO - Return code: 0 04:09:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:01 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 0x15fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196a090>, '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 0x196ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:09:01 INFO - Using env: {'DISPLAY': ':0', 04:09:01 INFO - 'HOME': '/home/cltbld', 04:09:01 INFO - 'LANG': 'en_US.UTF-8', 04:09:01 INFO - 'LANGUAGE': 'en_US:en', 04:09:01 INFO - 'LOGNAME': 'cltbld', 04:09:01 INFO - 'MAIL': '/var/mail/cltbld', 04:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:01 INFO - 'MOZ_NO_REMOTE': '1', 04:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:01 INFO - 'NO_EM_RESTART': '1', 04:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:01 INFO - 'PWD': '/builds/slave/test', 04:09:01 INFO - 'SHELL': '/bin/bash', 04:09:01 INFO - 'SHLVL': '1', 04:09:01 INFO - 'TERM': 'linux', 04:09:01 INFO - 'TMOUT': '86400', 04:09:01 INFO - 'USER': 'cltbld', 04:09:01 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:01 INFO - '_': '/tools/buildbot/bin/python'} 04:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:09:02 INFO - Cleaning up... 04:09:02 INFO - Return code: 0 04:09:02 INFO - Running post-action listener: _resource_record_post_action 04:09:02 INFO - Running post-action listener: _start_resource_monitoring 04:09:02 INFO - Starting resource monitoring. 04:09:02 INFO - [mozharness: 2017-09-09 11:09:02.136178Z] Finished create-virtualenv step (success) 04:09:02 INFO - [mozharness: 2017-09-09 11:09:02.136643Z] Running install step. 04:09:02 INFO - Running pre-action listener: _resource_record_pre_action 04:09:02 INFO - Running main action method: install 04:09:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:02 INFO - Reading from file tmpfile_stdout 04:09:02 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:02 INFO - Reading from file tmpfile_stdout 04:09:02 INFO - Output received: 04:09:02 INFO - Usage: mozinstall [options] installer 04:09:02 INFO - Options: 04:09:02 INFO - -h, --help show this help message and exit 04:09:02 INFO - -d DEST, --destination=DEST 04:09:02 INFO - Directory to install application into. [default: 04:09:02 INFO - "/builds/slave/test"] 04:09:02 INFO - --app=APP Application being installed. [default: firefox] 04:09:02 INFO - mkdir: /builds/slave/test/build/application 04:09:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:09:18 INFO - Reading from file tmpfile_stdout 04:09:18 INFO - Output received: 04:09:18 INFO - /builds/slave/test/build/application/firefox/firefox 04:09:18 INFO - Running post-action listener: _resource_record_post_action 04:09:18 INFO - [mozharness: 2017-09-09 11:09:18.872325Z] Finished install step (success) 04:09:18 INFO - [mozharness: 2017-09-09 11:09:18.872471Z] Running setup-mitmproxy step. 04:09:18 INFO - Running pre-action listener: _resource_record_pre_action 04:09:18 INFO - Running main action method: setup_mitmproxy 04:09:18 INFO - Skipping: mitmproxy is not required 04:09:18 INFO - Running post-action listener: _resource_record_post_action 04:09:18 INFO - [mozharness: 2017-09-09 11:09:18.872995Z] Finished setup-mitmproxy step (success) 04:09:18 INFO - [mozharness: 2017-09-09 11:09:18.873098Z] Running run-tests step. 04:09:18 INFO - Running pre-action listener: _resource_record_pre_action 04:09:18 INFO - Running pre-action listener: _set_gcov_prefix 04:09:18 INFO - Running main action method: run_tests 04:09:18 WARNING - Try message not found. 04:09:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:18 INFO - Python 2.7.3 04:09:18 INFO - Return code: 0 04:09:18 INFO - grabbing minidump binary from tooltool 04:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:18 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 0x196a090>, '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 0x196ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:09:18 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:09:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:09:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:19 INFO - Return code: 0 04:09:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:09:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:19 INFO - ENV: RUST_BACKTRACE is now full 04:09:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:09:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 04:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 04:09:19 INFO - Using env: {'DISPLAY': ':0', 04:09:19 INFO - 'HOME': '/home/cltbld', 04:09:19 INFO - 'LANG': 'en_US.UTF-8', 04:09:19 INFO - 'LANGUAGE': 'en_US:en', 04:09:19 INFO - 'LOGNAME': 'cltbld', 04:09:19 INFO - 'MAIL': '/var/mail/cltbld', 04:09:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:19 INFO - 'MOZ_NO_REMOTE': '1', 04:09:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:19 INFO - 'NO_EM_RESTART': '1', 04:09:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:19 INFO - 'PWD': '/builds/slave/test', 04:09:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:19 INFO - 'RUST_BACKTRACE': 'full', 04:09:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:09:19 INFO - 'SHELL': '/bin/bash', 04:09:19 INFO - 'SHLVL': '1', 04:09:19 INFO - 'TERM': 'linux', 04:09:19 INFO - 'TMOUT': '86400', 04:09:19 INFO - 'USER': 'cltbld', 04:09:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:19 INFO - '_': '/tools/buildbot/bin/python'} 04:09:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 04:09:19 INFO - mozversion application_buildid: 20170909094504 04:09:19 INFO - mozversion application_changeset: c71b01e993510268bab7d60154b2f80692fd507d 04:09:19 INFO - mozversion application_display_name: Nightly 04:09:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:19 INFO - mozversion application_name: Firefox 04:09:19 INFO - mozversion application_remotingname: firefox 04:09:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:09:19 INFO - mozversion application_vendor: Mozilla 04:09:19 INFO - mozversion application_version: 57.0a1 04:09:19 INFO - mozversion platform_buildid: 20170909094504 04:09:19 INFO - mozversion platform_changeset: c71b01e993510268bab7d60154b2f80692fd507d 04:09:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:09:19 INFO - mozversion platform_version: 57.0a1 04:09:19 INFO - using testdate: 1504955359 04:09:19 INFO - actual date: 1504955359 04:09:19 INFO - starting webserver on 'localhost:36737' 04:09:19 INFO - SUITE-START | Running 2 tests 04:09:19 INFO - TEST-START | dromaeo_css 04:09:19 INFO - Initialising browser for dromaeo_css test... 04:09:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36737/getInfo.html -profile /tmp/tmpLTo3Xm/profile 04:09:19 INFO - TEST-INFO | started process 5634 (/builds/slave/test/build/application/firefox/firefox http://localhost:36737/getInfo.html) 04:09:24 INFO - TEST-INFO | 5634: exit 0 04:09:24 INFO - Browser initialized. 04:09:24 INFO - Running cycle 1/1 for dromaeo_css test... 04:09:24 INFO - Using env: {'DISPLAY': ':0', 04:09:24 INFO - 'HOME': '/home/cltbld', 04:09:24 INFO - 'JSGC_DISABLE_POISONING': '1', 04:09:24 INFO - 'LANG': 'en_US.UTF-8', 04:09:24 INFO - 'LANGUAGE': 'en_US:en', 04:09:24 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:09:24 INFO - 'LOGNAME': 'cltbld', 04:09:24 INFO - 'MAIL': '/var/mail/cltbld', 04:09:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:24 INFO - 'MOZ_CRASHREPORTER': '1', 04:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:24 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:09:24 INFO - 'MOZ_NO_REMOTE': '1', 04:09:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:24 INFO - 'NO_EM_RESTART': '1', 04:09:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:24 INFO - 'PWD': '/builds/slave/test', 04:09:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:24 INFO - 'RUST_BACKTRACE': 'full', 04:09:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:09:24 INFO - 'SHELL': '/bin/bash', 04:09:24 INFO - 'SHLVL': '1', 04:09:24 INFO - 'STYLO_FORCE_DISABLED': '1', 04:09:24 INFO - 'TERM': 'linux', 04:09:24 INFO - 'TMOUT': '86400', 04:09:24 INFO - 'USER': 'cltbld', 04:09:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:24 INFO - '_': '/tools/buildbot/bin/python'} 04:09:24 INFO - TEST-INFO | started process 5834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLTo3Xm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:25 INFO - PID 5834 | 04:09:25 INFO - PID 5834 | (/builds/slave/test/build/application/firefox/firefox:5885): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:09:25 INFO - PID 5834 | 04:09:35 INFO - PID 5834 | RSS: Main: 162635776 04:09:35 INFO - PID 5834 | 04:12:32 INFO - PID 5834 | Cycle 1(1): loaded http://localhost:36737/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36737/tests/dromaeo/cssquery-ext.html) 04:12:34 INFO - PID 5834 | RSS: Main: 165711872 04:12:34 INFO - PID 5834 | 04:15:35 INFO - PID 5834 | Cycle 1(1): loaded http://localhost:36737/tests/dromaeo/cssquery-ext.html (next: http://localhost:36737/tests/dromaeo/cssquery-jquery.html) 04:15:36 INFO - PID 5834 | RSS: Main: 162627584 04:15:36 INFO - PID 5834 | 04:18:37 INFO - PID 5834 | Cycle 1(1): loaded http://localhost:36737/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36737/tests/dromaeo/cssquery-mootools.html) 04:18:38 INFO - PID 5834 | RSS: Main: 164614144 04:18:38 INFO - PID 5834 | 04:21:39 INFO - PID 5834 | Cycle 1(1): loaded http://localhost:36737/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36737/tests/dromaeo/cssquery-prototype.html) 04:21:40 INFO - PID 5834 | RSS: Main: 163667968 04:21:40 INFO - PID 5834 | 04:24:43 INFO - PID 5834 | Cycle 1(1): loaded http://localhost:36737/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36737/tests/dromaeo/cssquery-yui.html) 04:24:44 INFO - PID 5834 | RSS: Main: 164507648 04:24:44 INFO - PID 5834 | 04:27:45 INFO - PID 5834 | Cycle 1(1): loaded http://localhost:36737/tests/dromaeo/cssquery-yui.html (next: http://localhost:36737/tests/dromaeo/cssquery-dojo.html) 04:27:45 INFO - PID 5834 | RSS: Main: 167591936 04:27:45 INFO - PID 5834 | 04:27:45 INFO - PID 5834 | __start_tp_report 04:27:45 INFO - PID 5834 | _x_x_mozilla_page_load 04:27:45 INFO - PID 5834 | _x_x_mozilla_page_load_details 04:27:45 INFO - PID 5834 | |i|pagename|runs| 04:27:45 INFO - PID 5834 | |0;dojo.html;3870.3807390817474;3897;3911.943775180703;3929.6070392960705;3953.644172024517;6347.111404403381;6370.777022804203;6416.069669897862;6458.644774537399;6474.061261117141;6322.715477803498;6402.16771819664;6421;6421.165248517698;6432.839179020527;5657.207990881269;5686.601937864351;5703.885922281552;5734.741936612862;5761.4814666679995;5713.971430142843;5784.913226301609;5787.33445653751;5792.4497172768515;5814.941850581504;5520.834374968757;5651.491365777079;5692.117721753135;5735.655860648333;5792;5653.604247702662;5678.43215678433;5729.885402291972;5738.9669859425285;5743.396943320933;5574.60977731559;5659.122835960392;5662.49037586615;5717.599768016241;5721.399253078408;6303.432691057827;6327.3988971047675;6339.397757213057;6360.363963603649;6372.203474565679;6846.075779769717;6872.175338959357;6934.826629334307;6942.757003504904;6946.444284457231;6791.422729068036;6882.862342753167;6940.444764418834;6997.930020699779;7038.120234970629;6384.648844313608;6394.9360506394805;6405.839854003687;6421;6426.2931077581425;7028.753993610301;7037.683304251321;7048.612326321999;7052;7134.964325178341;6719.328067193339;6771.289014653489;6868.690908909111;6876.724931002704;6890.379865812101;6899.482538809509;6928.16861976556;6992.405645520086;6996.090508233897;7005.719771209197;6741.797746067626;6747.595144291358;6794.490413219029;6860.725570977205;6937.340952609494;6865.656717164122;6900.275471075565;6907;6925.376716095576;6972.372486476242;4904.583110435653;4938.086454005948;4952.752362381866;4974.427940786856;5024.924626130611;4534.387857639243;4554.658400619966;4560.270356742905;4562.840300589463;4569.840055598104;6232.657203853741;6237.064440333896;6329.4303512683155;6329.9872020476505;6387.936120638734;6829.658517074126;6863.245043045261;6866.828329291808;6915.031895534629;6956.79129626112;6330.240371155399;6332.176817013851;6333.8733225336155;6335.1447554579545;6365.713542890581;5546.334439867161;5594.1888426177975;5605.831825045255;5606.046972014768;5610.354809196913;7106.786796396116;7189.5686258824635;7273.16358618755;7294.161171465244;7300.488965772345;6717.05961165447;6799.218089919723;6842.623655698984;6847.246802851682;6984.650767461708;7204.24355442671;7205;7205.495615307088;7209.4592905533345;7223.638818058971;6803.897941530782;6826;6893.586384816927;6893.965530172317;6920.757773477904;6838.452923766186;6862.382385585322;6894.655267236518;6974.267701891431;6982.546134501241;6513.706883190173;6568.343165683394;6636.070950066898;6666.933330666631;6736.629485378351;6659.833504162435;6662.433693135944;6697.598144111174;6710.731570737116;6732.3267673232285;6572.76995305162;6573.5398522103;6589.4069533742195;6659.234188068434;6683.331666833278;6634.83412914681;6703.262641109376;6772.661366931732;6782.626955517494;6805.081314022544;6444.162258906312;6511.902321465087;6513.902291465726;6515.381038801306;6533.8693226136165 04:27:45 INFO - PID 5834 | |1;ext.html;963.9855402168967;981.9067188617081;984.4290311619261;986.9802603947926;990.5195979949723;41238.58761412385;45097.549024509746;45148.774256128716;45283.773581132045;45298;42705.14589708204;42848.78575607125;42933.570664293424;43011.35482967758;43024.35463468043;7524.887126693104;7932.286094251516;8117.188281171894;8131.918680813175;8132.064812546574;8046.758597242063;8118.066422361416;8145.633446494922;8148.918510814905;8150.714724984627;8084.393670474708;8089.271965523102;8116.228958248987;8123.431359804816;8198.057223419293;8058.717944871931;8143.144969778147;8153.22544358285;8155.796105097361;8161.387895907801;8156.551389673566;8165.183481651788;8187.79530511736;8236.341092712568;8238.258556729863;41013.589864101275;41088;41114.38328425076;41175.1764964702;41287.58712412867;3692.7415080944343;3731.570869350005;3738.9626103738888;3740.869069582579;3762.49206357141;34083.318333633186;34186.658133418845;34222.657773422194;34308.656913430794;34316.656833431596;5487.917681234785;5491.36849262332;5494.066008778477;5532.253145825302;5638;213848;214034;214237;214698;214970;48175.5182448178;48847.511524885005;52366.21450678243;52553;53989.46010539923;57353.99261025927;57379.71310143506;57412.13881791777;57839.42160578424;57886.7105664469;16821.915890420714;17014.914925425295;17077.829221707623;17110.743338849927;17132.571685707706;13922.721545569031;13934.442622295197;13977;13977.860221397656;14208.360623771956;15450.9227453862;15527.611809704622;15610.29753661088;15618;15715.292811823496;6042.305134909541;6099.298580663191;6111.9694401528595;6177.076183939591;6235.282942461584;1095.3044816541394;1098.6594155811565;1101.531848964187;1114.5151858941385;1120.56298043763;25867.482650346887;25924.870375648003;25985;26046.869765651052;26096.086636967615;1186.1044911092242;1190.8094704847183;1200.789861774186;1211.5759484180642;1234.5555599983998;13600.25198614066;13646.795298070538;13744.725105497833;13896.51362202318;13967.860321396656;276022;276939;277753;278058;278694;58554.12168817471;59078;59161.40838591645;59300;59612.40387596155;1519.384649217069;1527.8166620005447;1542.5295284937977;1559.766035094745;1561.2271925396774;25056.37359066038;25332.240032799047;25370.8286464192;25493.745062549136;25747.613785792855;38267.23465530729;38337.99999999889;38353;38477.61522384852;38519;174612;175099;175223;175854;176224;37175.25649487049;39206.80396597999;39821.80089099536;40051;40189.1962160761;50644;51300.74349628228;51376.74311628418;51390.74304628453;51703.48296516987;37621.2475750478;37842.243155137294;37969.4304585437;38129.23741525209;38247.6175238244;37375.62624373721;37678.17413694039;37767.43348849715;37797.24405511819;37837.81081094687;43753;44396;44507.332390014824;44651;44812.32781508345;36303.27393452169;36315;36356.27287454289;36506.634933650326;36552.81723591365;26589.601155982287;26798.330041749112;26920.057797976977;27173;27287.317817054733 04:27:45 INFO - PID 5834 | |2;jquery.html;559.9496045355917;577.907534794433;590.1501837354209;594.2838879150623;600.4295918877067;23451.76548234517;24176;24180.032798688033;24186;24201;24376.146834860785;25329;25890.35274118148;26109.738902610967;26113.47773044538;6640.867182656344;6777.491688123386;6781.355771201753;6781.72873085076;6787;6425.1968503937005;6583.835404114888;6675.332466753334;6720.5295629305965;6737.730490780363;6686.5653732507235;6694.497912656546;6694.631795251284;6704.396604305636;6709.630970296632;6254.43710066094;6497.837554061139;6499.675016249216;6696.196456425236;6720.428763555104;6061;6061.151438798572;6066.272047354301;6073.787417440412;6074.088886666991;29393.118206453626;29903.700962990526;29919.401611967856;29920.8503957481;29979.70020299791;2173.076442511926;2195.5169862630196;2195.9451013724624;2196.165457126298;2196.648536234195;19779;20806.375808725763;20870.47823804402;20909.790902090936;20929.476763080893;2513.924582262535;2529.2665127113114;2575.562154433732;2576.4203054312816;2582.5222333868296;135887;142539;143446.2827685855;159466;162699.18650406672;15004.24639056793;15472.5358239253;15487.380504779683;16104.275307611186;17831.46505604834;24879.253622391356;24919.37701557439;24928.5014299713;24999.25002249899;25018.249452516455;10313;10514.789704206027;10520.421376824195;10521.210909181842;10546.525406356732;9570.712878613653;9697.321187516805;9718.9028109718;9726.124648781644;9740.853887191697;9382.624695012122;9631.229501639851;9665.565049572786;9712.368696034735;9843.163331116792;2735.288824905539;2777.4170021879845;2835.6455443069617;2878.2660421592777;2931.135315082056;1004.6182450668845;1032.26193271811;1037.9740506487246;1040.9323393979366;1047.8166320893813;20582.073806678734;20665;21024;21088.472788180112;21207.257745978815;1089.591403223791;1093.1254996003324;1098;1105.1987309200927;1112.927659702133;11168.546053288192;11542.769144617061;11655.125865560118;11664.008559272557;11760.294382337088;601360;618017;633565;636953;637923;129319;133203;133453;133477;135695.32152339374;1075.7902209069314;1080.448971024783;1082.199172612277;1082.718493191776;1187.5309252845077;21767.56464870662;22150.446238844157;22331.756966176374;22536.549269014857;22686.773132268467;62480;62872.68563657152;63258.68370658117;65110;65605.67197163984;80203.59898200471;80869;80996.59501702453;81655.591722041;82533;14117.152970821784;14192;14445.06107103035;14943.925280373529;15178.696426071196;22664.66003009989;23038.539229215658;23651;23941.281761547183;23992.400189994692;19117;19263.133159008157;19675.40973770789;19679.31122410709;19803.504912377306;17100.828991709925;17400.738988914924;17401.91299043497;17680.292788288323;18236.90881545637;19587.216511339386;19731.506712332306;19935.800641993395;19957.101930413457;19961.101750420974;14831.184284864436;14950.551483455514;14967.550973470814;14970.550883473514;15007.699846003237;19360.128794204014;19515.219391224193;19650.21399144018;19662.803371966096;19752.802471975672 04:27:45 INFO - PID 5834 | |3;mootools.html;1376.545739905831;1431.2128329418817;1446.754051811192;1449.1667291307501;1464.2093269634397;16510.504684859443;17172.39896603619;17200.655986880287;17210.569735756613;17211.569710757205;16783.32866685331;16848.494545163634;16903.91548042258;16913.83086169138;16924.576885577866;2670.652815134035;2793.385455199853;2795.0915952315477;2795.412963277714;2796.1192224449233;2761.130243973152;2809.157252824155;2870.641169853768;2878.596996420503;2879.956800647992;2611.8171727979047;2634.420427505955;2637.4197676511235;2638.8416694998364;2644.6694163229595;2747.519184142777;2774.8057635965492;2780.457810726909;2780.958285625717;2781.1378472673537;2510.8619025953567;2539.428628558578;2548.8470691758366;2706.9713508866703;2776.0145148472407;16515.33938642453;16533.83466165347;16584;16588.83411165885;16597.66804663912;8000.799980000488;8254.42219044667;8262.628181731836;8262.793430164234;8268.586570671503;5337.893242135136;5427.941551397479;5430.266913966603;5493.807716729895;5565.1374037023925;2043.150948391708;2063.092239414653;2076.927307544229;2135.6614507114687;2144.1637761273114;30175.69824301751;30244.395112097856;30327.545086823717;30351;30352.392952141054;6746.797596072126;6796.218434880052;6809.693563789641;6898.068760717239;6961.895571566431;19001.90499047496;19206.807931920783;19357.032148392525;19377;19388.4183474496;7938.761837144895;8043.638036288381;8071.5964201789675;8076.555789431638;8093.392995525359;7170.641467926583;7237.384822290059;7422.554646721214;7460.626968651546;7478.663460144307;5556.111022236423;5632.690202038845;5700.23046888673;5735.971320143456;5752.741126649311;1509.932053057593;1533.516942163215;1605.1252067623172;1627.4466681328406;1670.8496235338878;942.1191186240886;962.2927148545813;962.6775030364906;972.1687956796978;987.0474991632965;9132.3150763693;9366;9372.906270937203;9486.146246837818;9509.809803803884;1042.4779821460752;1060.7984482948216;1064.3454275620438;1065.1106326217541;1076.8370160226937;5126.948730512647;5181.5595674368105;5673.744681489343;5735.885282294331;5881.088431293157;23850.88074559616;25119.62320565193;25289.114880979076;25305.114320998677;25345.112921047676;23864.64203036956;24354.878225608758;24645.50708985846;25087;25104.12135575246;12606.621801345975;12690.42893069814;12706.301153436465;12729.663385344591;12758.61724148277;9362.672306469241;9901.55443005052;9949.353292035994;10145.28982971185;10277.126444252322;21085.15659373608;21116.366509004754;21198;21236;21351.57296854085;21866.562668746854;21940;21977.67033494467;21997.67003494917;22078.33764987053;13005.934970325088;13173.736525269633;13262.602121936357;13277.136986095873;13286.734265314446;14701.33843977045;14742.11547307165;14839.92580037093;14845.628859278604;14849.109053456827;11461.656150315504;11481.138914581607;11521.193516453768;11773.47019384147;11826.290422574673;11887.405629718307;12011.75976480448;12028.398580070787;12249.326287054297;12310.138290319592;9837.065478779505;9987.60049598008;9996.750081248027;10001.399916005063;10002.549885255035;8035.55804430762;8047.235512626291;8147.959260203661;8181.427300088937;8195.836083278182;8186.222308880647;8286.295664868554;8380.287675547646;8394.488991981501;8445.155484451505 04:27:45 INFO - PID 5834 | |4;prototype.html;531.2695044314069;546.6364867363199;553.4410245651893;555.1256770586326;570.8087790590153;6241.719122639481;6246.593971391856;6273.905891411632;6318.399752023551;6329.208848893888;6238.844028899269;6258.906116408258;6265.310815810257;6277.68611569422;6302.779402720906;5112.948870511303;5115;5128.871778205537;5145.614078944075;5161.896762064756;4838.491958344376;4920.950790492103;5076.746162691869;5085.5423011928915;5089.643724939256;4895.853124406256;4898;4921.335619691349;4948.950510494903;4955.529224723664;4804.20730579454;4856.15017371962;4883;4939.456659767423;4948.529889660476;4343.73937563744;4373.300271956472;4390.626796722282;4394.1651086293505;4416.889577760549;6013.428724271187;6036.63780173191;6041.275046994345;6051.515878729691;6138.938610613882;5697.857553561194;5735.139729040678;5788.450097240755;5801.796937107181;5807.709614519257;6589.406953374171;6601.669916504204;6630.469562434993;6634.86730265392;6693.899591506131;4833.975830120862;4838.975805120987;4880.121578115938;4890.73100979446;4932.284818701304;6645.833854153637;6786.59280443175;6788.796336109925;6861.519693621449;6862.965685171592;5098.515641014098;5108.514691104339;5129.948700513021;5133.845984620468;5135.435102138762;5177.844664660066;5179.300794392784;5200.12795393658;5213.400458947193;5216.087184742655;5754.9424505754405;5767.8558036049435;5781.653100813965;5796.82609521715;5802.767889284466;6600.669966501656;6613.570117942319;6636.734530618721;6648.66756662165;6657.500687448461;1801.1084513165804;1802.1079565615105;1814.9183286752127;1820.2718912435132;1834.1379551610721;1205.5086800504248;1248.7377650693456;1268.8794564516356;1271.7075072733323;1275.489804078376;6163.506919446433;6164.167837341902;6201.286852012076;6226.941419958618;6248.594291197831;6613.86772264552;6634.502412318999;6706.497012724065;6744.258131605519;6763;5973.910391344133;6036.3360030396625;6087.878242435127;6102.816915492543;6165.229346331708;3474.374612569711;3488.633693462201;3490.267043920754;3530.2057037166946;3538;6895.862082758316;6984.4063254623925;7012.894806577905;7051.964740176266;7067.399271061914;6807.115075040213;6850.9314906850295;6874.896876546856;6904.516683832184;6948.861022779516;6968.616726080114;6979.860402792017;7096.254893236239;7098.219195888448;7123.643817808985;6621.602703837785;6714.764983225564;6718.697658605277;6772.153480814898;6799.626020568916;6640.402363787282;6651.467882569286;6653.866922661617;6721.865562688621;6766.830829229309;6967.303269672992;7017.508774385744;7064;7073.221945586084;7108.182559005781;5083.567896728671;5088.135017047185;5127.66670166438;5147.150720131136;5186.144286192736;6557.344265573404;6579.769708060195;6647.368499992493;6650.168728908887;6695.933040669531;6306.65313407767;6411.839704007437;6438;6496.765614533224;6512.185976752906;6502.642354670349;6508.9349106508325;6562.704678289584;6573.1783527059115;6590.8352291193105;6390.552661313849;6487.967560162169;6494.253160886558;6511.34886511345;6541.051547525677;6506.739730410731;6572.605643661395;6591.34086591337;6610.438112760469;6616.801495955129;6371.5221358397375;6394.87210255783;6432.485401167802;6470;6489.480841532761 04:27:45 INFO - PID 5834 | |5;yui.html;954.88541375035;966.608523547963;987.8024395120977;994.4083270454078;996.7807082441865;20600.793992060077;21105.68341474877;21134.682979755315;21166.788332116692;21196.364109076752;19446.416607501764;19622.90188549055;19657.115429805657;19742.40772776819;19743.308984185558;1013.0426746724348;1027.4862568715641;1029.53156313877;1030.4435604773414;1031.829748091564;1008.7125169326706;1028.6039874648277;1036.6216331039193;1037.398308980793;1054.4200689620716;1115.2806439846295;1115.4590023838432;1116.843641890136;1117.083991127272;1118.5413980268092;1064.8243039898407;1092.847001419802;1106.4744246482937;1112.1325366214367;1116.2911551165028;783.0681489028038;784.8391079828622;785.4698078796789;785.783909424907;786.4927122006332;18471.90764046171;18515.351962681376;18533.814661853343;18547.814521854878;18566.814331856644;22451.663225051638;23090.65364019541;23211.88394058019;23225.419364515852;23641.40896477602;17633.823661763345;18018.189181486865;18101.094945252815;18191.727124093017;18299.176537055864;4010.358342665189;4012.498437695288;4013.0569316210667;4013.5585085640555;4015.759054456742;160488.19755901262;161001;162701;163130.18434907869;164328.17835910863;18068.096595170187;18162;18197.90901045513;18511.81488185101;18674.906625467058;33778.32443351119;33882.491762623584;33960.32079358399;34553;35168.12079697977;9132.771680707903;9170.95414522923;9226.53867306632;9231.492267925194;9240.815183696288;4525.389072475239;4564.064366804797;4592.97703511487;4594.081183763261;4598.540145985375;6027.698615069229;6125.509959203253;6165.876682466325;6175.320714721377;6201.348858369896;1115.726646971497;1138.698244965085;1154.8036833738286;1159.5709587452698;1159.976800463986;707.5118168463744;711.0578483509371;714.585540386585;721.5201890742597;726.9127704675473;12309.446074926649;12726.872731272753;13235.536756213678;14456.927715361566;14457.204853733145;692.4149094015548;694.3577191098213;699.8460338725574;711.1750369571273;711.886098224292;5658.151277308437;5662.546996240291;5700.25896633435;5711.7144142792695;5837.270341207349;140360;141079.16581292325;142280;145207;147960.26019869832;97367;108349.47781524053;126150.36924815501;127519;135016.32491837675;109293.90706092997;109817.70546883607;110045.44977275222;111186.44406778076;115316;14688;14967.101973881601;14994.250287485364;15089;15090.396384144511;52194;52319.738401307746;52844.471555283955;53449.46550534445;53913;68025.65987170032;68380.31619683739;68511.31488685249;69400;71271;20388.592228155056;20565.89717051405;20630.79369206349;20697.068631911297;20851.165953362302;20908.47728806731;21066.2626808061;21181.78818211798;21289.89355053215;21440.463988400414;20187.09158087919;20232.19071237134;20306.289279875135;20413.183472660927;20419.79580204179;19743.60512789765;20092;20115;20188.697169542764;20266.695999559724;17982;18197.545061373043;18213.45359639213;18255.452336429928;18406.447806565826;15167.469138580538;15307.923460382626;15436.536903892902;15565.299561519532;15597.220138993232;15369.462068827537;15430.459933902259;15461.458848940232;15712.13583252932;15796 04:27:45 INFO - PID 5834 | __end_tp_report 04:27:45 INFO - PID 5834 | __start_cc_report 04:27:45 INFO - PID 5834 | _x_x_mozilla_cycle_collect,369 04:27:45 INFO - PID 5834 | __end_cc_report 04:27:45 INFO - PID 5834 | __startTimestamp1504956465846__endTimestamp 04:27:45 INFO - PID 5834 | 04:27:45 INFO - PID 5834 | ------- Summary: start ------- 04:27:45 INFO - PID 5834 | Number of tests: 6 04:27:45 INFO - PID 5834 | 04:27:45 INFO - PID 5834 | [#0] dojo.html Cycles:165 Average:6342.60 Median:6572.77 stddev:764.80 (11.6%) stddev-sans-first:742.15 04:27:45 INFO - PID 5834 | Values: 3870.4 3897.0 3911.9 3929.6 3953.6 6347.1 6370.8 6416.1 6458.6 6474.1 6322.7 6402.2 6421.0 6421.2 6432.8 5657.2 5686.6 5703.9 5734.7 5761.5 5714.0 5784.9 5787.3 5792.4 5814.9 5520.8 5651.5 5692.1 5735.7 5792.0 5653.6 5678.4 5729.9 5739.0 5743.4 5574.6 5659.1 5662.5 5717.6 5721.4 6303.4 6327.4 6339.4 6360.4 6372.2 6846.1 6872.2 6934.8 6942.8 6946.4 6791.4 6882.9 6940.4 6997.9 7038.1 6384.6 6394.9 6405.8 6421.0 6426.3 7028.8 7037.7 7048.6 7052.0 7135.0 6719.3 6771.3 6868.7 6876.7 6890.4 6899.5 6928.2 6992.4 6996.1 7005.7 6741.8 6747.6 6794.5 6860.7 6937.3 6865.7 6900.3 6907.0 6925.4 6972.4 4904.6 4938.1 4952.8 4974.4 5024.9 4534.4 4554.7 4560.3 4562.8 4569.8 6232.7 6237.1 6329.4 6330.0 6387.9 6829.7 6863.2 6866.8 6915.0 6956.8 6330.2 6332.2 6333.9 6335.1 6365.7 5546.3 5594.2 5605.8 5606.0 5610.4 7106.8 7189.6 7273.2 7294.2 7300.5 6717.1 6799.2 6842.6 6847.2 6984.7 7204.2 7205.0 7205.5 7209.5 7223.6 6803.9 6826.0 6893.6 6894.0 6920.8 6838.5 6862.4 6894.7 6974.3 6982.5 6513.7 6568.3 6636.1 6666.9 6736.6 6659.8 6662.4 6697.6 6710.7 6732.3 6572.8 6573.5 6589.4 6659.2 6683.3 6634.8 6703.3 6772.7 6782.6 6805.1 6444.2 6511.9 6513.9 6515.4 6533.9 04:27:45 INFO - PID 5834 | 04:27:45 INFO - PID 5834 | [#1] ext.html Cycles:180 Average:41188.37 Median:38257.43 stddev:58842.45 (153.8%) stddev-sans-first:58930.00 04:27:45 INFO - PID 5834 | Values: 964.0 981.9 984.4 987.0 990.5 41238.6 45097.5 45148.8 45283.8 45298.0 42705.1 42848.8 42933.6 43011.4 43024.4 7524.9 7932.3 8117.2 8131.9 8132.1 8046.8 8118.1 8145.6 8148.9 8150.7 8084.4 8089.3 8116.2 8123.4 8198.1 8058.7 8143.1 8153.2 8155.8 8161.4 8156.6 8165.2 8187.8 8236.3 8238.3 41013.6 41088.0 41114.4 41175.2 41287.6 3692.7 3731.6 3739.0 3740.9 3762.5 34083.3 34186.7 34222.7 34308.7 34316.7 5487.9 5491.4 5494.1 5532.3 5638.0 213848.0 214034.0 214237.0 214698.0 214970.0 48175.5 48847.5 52366.2 52553.0 53989.5 57354.0 57379.7 57412.1 57839.4 57886.7 16821.9 17014.9 17077.8 17110.7 17132.6 13922.7 13934.4 13977.0 13977.9 14208.4 15450.9 15527.6 15610.3 15618.0 15715.3 6042.3 6099.3 6112.0 6177.1 6235.3 1095.3 1098.7 1101.5 1114.5 1120.6 25867.5 25924.9 25985.0 26046.9 26096.1 1186.1 1190.8 1200.8 1211.6 1234.6 13600.3 13646.8 13744.7 13896.5 13967.9 276022.0 276939.0 277753.0 278058.0 278694.0 58554.1 59078.0 59161.4 59300.0 59612.4 1519.4 1527.8 1542.5 1559.8 1561.2 25056.4 25332.2 25370.8 25493.7 25747.6 38267.2 38338.0 38353.0 38477.6 38519.0 174612.0 175099.0 175223.0 175854.0 176224.0 37175.3 39206.8 39821.8 40051.0 40189.2 50644.0 51300.7 51376.7 51390.7 51703.5 37621.2 37842.2 37969.4 38129.2 38247.6 37375.6 37678.2 37767.4 37797.2 37837.8 43753.0 44396.0 44507.3 44651.0 44812.3 36303.3 36315.0 36356.3 36506.6 36552.8 26589.6 26798.3 26920.1 27173.0 27287.3 04:27:45 INFO - PID 5834 | 04:27:45 INFO - PID 5834 | [#2] jquery.html Cycles:180 Average:40324.17 Median:22862.66 stddev:104521.86 (457.2%) stddev-sans-first:104772.43 04:27:45 INFO - PID 5834 | Values: 559.9 577.9 590.2 594.3 600.4 23451.8 24176.0 24180.0 24186.0 24201.0 24376.1 25329.0 25890.4 26109.7 26113.5 6640.9 6777.5 6781.4 6781.7 6787.0 6425.2 6583.8 6675.3 6720.5 6737.7 6686.6 6694.5 6694.6 6704.4 6709.6 6254.4 6497.8 6499.7 6696.2 6720.4 6061.0 6061.2 6066.3 6073.8 6074.1 29393.1 29903.7 29919.4 29920.9 29979.7 2173.1 2195.5 2195.9 2196.2 2196.6 19779.0 20806.4 20870.5 20909.8 20929.5 2513.9 2529.3 2575.6 2576.4 2582.5 135887.0 142539.0 143446.3 159466.0 162699.2 15004.2 15472.5 15487.4 16104.3 17831.5 24879.3 24919.4 24928.5 24999.3 25018.2 10313.0 10514.8 10520.4 10521.2 10546.5 9570.7 9697.3 9718.9 9726.1 9740.9 9382.6 9631.2 9665.6 9712.4 9843.2 2735.3 2777.4 2835.6 2878.3 2931.1 1004.6 1032.3 1038.0 1040.9 1047.8 20582.1 20665.0 21024.0 21088.5 21207.3 1089.6 1093.1 1098.0 1105.2 1112.9 11168.5 11542.8 11655.1 11664.0 11760.3 601360.0 618017.0 633565.0 636953.0 637923.0 129319.0 133203.0 133453.0 133477.0 135695.3 1075.8 1080.4 1082.2 1082.7 1187.5 21767.6 22150.4 22331.8 22536.5 22686.8 62480.0 62872.7 63258.7 65110.0 65605.7 80203.6 80869.0 80996.6 81655.6 82533.0 14117.2 14192.0 14445.1 14943.9 15178.7 22664.7 23038.5 23651.0 23941.3 23992.4 19117.0 19263.1 19675.4 19679.3 19803.5 17100.8 17400.7 17401.9 17680.3 18236.9 19587.2 19731.5 19935.8 19957.1 19961.1 14831.2 14950.6 14967.6 14970.6 15007.7 19360.1 19515.2 19650.2 19662.8 19752.8 04:27:45 INFO - PID 5834 | 04:27:45 INFO - PID 5834 | [#3] mootools.html Cycles:180 Average:10300.65 Median:2544.14 stddev:7681.86 (301.9%) stddev-sans-first:7674.15 04:27:45 INFO - PID 5834 | Values: 1376.5 1431.2 1446.8 1449.2 1464.2 16510.5 17172.4 17200.7 17210.6 17211.6 16783.3 16848.5 16903.9 16913.8 16924.6 2670.7 2793.4 2795.1 2795.4 2796.1 2761.1 2809.2 2870.6 2878.6 2880.0 2611.8 2634.4 2637.4 2638.8 2644.7 2747.5 2774.8 2780.5 2781.0 2781.1 2510.9 2539.4 2548.8 2707.0 2776.0 16515.3 16533.8 16584.0 16588.8 16597.7 8000.8 8254.4 8262.6 8262.8 8268.6 5337.9 5427.9 5430.3 5493.8 5565.1 2043.2 2063.1 2076.9 2135.7 2144.2 30175.7 30244.4 30327.5 30351.0 30352.4 6746.8 6796.2 6809.7 6898.1 6961.9 19001.9 19206.8 19357.0 19377.0 19388.4 7938.8 8043.6 8071.6 8076.6 8093.4 7170.6 7237.4 7422.6 7460.6 7478.7 5556.1 5632.7 5700.2 5736.0 5752.7 1509.9 1533.5 1605.1 1627.4 1670.8 942.1 962.3 962.7 972.2 987.0 9132.3 9366.0 9372.9 9486.1 9509.8 1042.5 1060.8 1064.3 1065.1 1076.8 5126.9 5181.6 5673.7 5735.9 5881.1 23850.9 25119.6 25289.1 25305.1 25345.1 23864.6 24354.9 24645.5 25087.0 25104.1 12606.6 12690.4 12706.3 12729.7 12758.6 9362.7 9901.6 9949.4 10145.3 10277.1 21085.2 21116.4 21198.0 21236.0 21351.6 21866.6 21940.0 21977.7 21997.7 22078.3 13005.9 13173.7 13262.6 13277.1 13286.7 14701.3 14742.1 14839.9 14845.6 14849.1 11461.7 11481.1 11521.2 11773.5 11826.3 11887.4 12011.8 12028.4 12249.3 12310.1 9837.1 9987.6 9996.8 10001.4 10002.5 8035.6 8047.2 8148.0 8181.4 8195.8 8186.2 8286.3 8380.3 8394.5 8445.2 04:27:45 INFO - PID 5834 | 04:27:45 INFO - PID 5834 | [#4] prototype.html Cycles:180 Average:5595.54 Median:6244.16 stddev:1578.15 (25.3%) stddev-sans-first:1536.12 04:27:45 INFO - PID 5834 | Values: 531.3 546.6 553.4 555.1 570.8 6241.7 6246.6 6273.9 6318.4 6329.2 6238.8 6258.9 6265.3 6277.7 6302.8 5112.9 5115.0 5128.9 5145.6 5161.9 4838.5 4921.0 5076.7 5085.5 5089.6 4895.9 4898.0 4921.3 4949.0 4955.5 4804.2 4856.2 4883.0 4939.5 4948.5 4343.7 4373.3 4390.6 4394.2 4416.9 6013.4 6036.6 6041.3 6051.5 6138.9 5697.9 5735.1 5788.5 5801.8 5807.7 6589.4 6601.7 6630.5 6634.9 6693.9 4834.0 4839.0 4880.1 4890.7 4932.3 6645.8 6786.6 6788.8 6861.5 6863.0 5098.5 5108.5 5129.9 5133.8 5135.4 5177.8 5179.3 5200.1 5213.4 5216.1 5754.9 5767.9 5781.7 5796.8 5802.8 6600.7 6613.6 6636.7 6648.7 6657.5 1801.1 1802.1 1814.9 1820.3 1834.1 1205.5 1248.7 1268.9 1271.7 1275.5 6163.5 6164.2 6201.3 6226.9 6248.6 6613.9 6634.5 6706.5 6744.3 6763.0 5973.9 6036.3 6087.9 6102.8 6165.2 3474.4 3488.6 3490.3 3530.2 3538.0 6895.9 6984.4 7012.9 7052.0 7067.4 6807.1 6850.9 6874.9 6904.5 6948.9 6968.6 6979.9 7096.3 7098.2 7123.6 6621.6 6714.8 6718.7 6772.2 6799.6 6640.4 6651.5 6653.9 6721.9 6766.8 6967.3 7017.5 7064.0 7073.2 7108.2 5083.6 5088.1 5127.7 5147.2 5186.1 6557.3 6579.8 6647.4 6650.2 6695.9 6306.7 6411.8 6438.0 6496.8 6512.2 6502.6 6508.9 6562.7 6573.2 6590.8 6390.6 6488.0 6494.3 6511.3 6541.1 6506.7 6572.6 6591.3 6610.4 6616.8 6371.5 6394.9 6432.5 6470.0 6489.5 04:27:45 INFO - PID 5834 | 04:27:45 INFO - PID 5834 | [#5] yui.html Cycles:180 Average:28021.71 Median:20103.50 stddev:40789.05 (202.9%) stddev-sans-first:40852.84 04:27:45 INFO - PID 5834 | Values: 954.9 966.6 987.8 994.4 996.8 20600.8 21105.7 21134.7 21166.8 21196.4 19446.4 19622.9 19657.1 19742.4 19743.3 1013.0 1027.5 1029.5 1030.4 1031.8 1008.7 1028.6 1036.6 1037.4 1054.4 1115.3 1115.5 1116.8 1117.1 1118.5 1064.8 1092.8 1106.5 1112.1 1116.3 783.1 784.8 785.5 785.8 786.5 18471.9 18515.4 18533.8 18547.8 18566.8 22451.7 23090.7 23211.9 23225.4 23641.4 17633.8 18018.2 18101.1 18191.7 18299.2 4010.4 4012.5 4013.1 4013.6 4015.8 160488.2 161001.0 162701.0 163130.2 164328.2 18068.1 18162.0 18197.9 18511.8 18674.9 33778.3 33882.5 33960.3 34553.0 35168.1 9132.8 9171.0 9226.5 9231.5 9240.8 4525.4 4564.1 4593.0 4594.1 4598.5 6027.7 6125.5 6165.9 6175.3 6201.3 1115.7 1138.7 1154.8 1159.6 1160.0 707.5 711.1 714.6 721.5 726.9 12309.4 12726.9 13235.5 14456.9 14457.2 692.4 694.4 699.8 711.2 711.9 5658.2 5662.5 5700.3 5711.7 5837.3 140360.0 141079.2 142280.0 145207.0 147960.3 97367.0 108349.5 126150.4 127519.0 135016.3 109293.9 109817.7 110045.4 111186.4 115316.0 14688.0 14967.1 14994.3 15089.0 15090.4 52194.0 52319.7 52844.5 53449.5 53913.0 68025.7 68380.3 68511.3 69400.0 71271.0 20388.6 20565.9 20630.8 20697.1 20851.2 20908.5 21066.3 21181.8 21289.9 21440.5 20187.1 20232.2 20306.3 20413.2 20419.8 19743.6 20092.0 20115.0 20188.7 20266.7 17982.0 18197.5 18213.5 18255.5 18406.4 15167.5 15307.9 15436.5 15565.3 15597.2 15369.5 15430.5 15461.5 15712.1 15796.0 04:27:45 INFO - PID 5834 | -------- Summary: end -------- 04:27:45 INFO - PID 5834 | 04:27:46 INFO - TEST-INFO | 5834: exit 0 04:27:46 INFO - TEST-OK | dromaeo_css | took 1107320ms 04:27:46 INFO - TEST-START | kraken 04:27:46 INFO - Initialising browser for kraken test... 04:27:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36737/getInfo.html -profile /tmp/tmpjkQcjd/profile 04:27:46 INFO - TEST-INFO | started process 6211 (/builds/slave/test/build/application/firefox/firefox http://localhost:36737/getInfo.html) 04:27:51 INFO - TEST-INFO | 6211: exit 0 04:27:52 INFO - Browser initialized. 04:27:52 INFO - Running cycle 1/1 for kraken test... 04:27:52 INFO - Using env: {'DISPLAY': ':0', 04:27:52 INFO - 'HOME': '/home/cltbld', 04:27:52 INFO - 'JSGC_DISABLE_POISONING': '1', 04:27:52 INFO - 'LANG': 'en_US.UTF-8', 04:27:52 INFO - 'LANGUAGE': 'en_US:en', 04:27:52 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:27:52 INFO - 'LOGNAME': 'cltbld', 04:27:52 INFO - 'MAIL': '/var/mail/cltbld', 04:27:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:27:52 INFO - 'MOZ_CRASHREPORTER': '1', 04:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:52 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:27:52 INFO - 'MOZ_NO_REMOTE': '1', 04:27:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:52 INFO - 'NO_EM_RESTART': '1', 04:27:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:52 INFO - 'PWD': '/builds/slave/test', 04:27:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:52 INFO - 'RUST_BACKTRACE': 'full', 04:27:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:27:52 INFO - 'SHELL': '/bin/bash', 04:27:52 INFO - 'SHLVL': '1', 04:27:52 INFO - 'STYLO_FORCE_DISABLED': '1', 04:27:52 INFO - 'TERM': 'linux', 04:27:52 INFO - 'TMOUT': '86400', 04:27:52 INFO - 'USER': 'cltbld', 04:27:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259', 04:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:52 INFO - '_': '/tools/buildbot/bin/python'} 04:27:52 INFO - TEST-INFO | started process 6414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjkQcjd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:52 INFO - PID 6414 | 04:27:52 INFO - PID 6414 | (/builds/slave/test/build/application/firefox/firefox:6464): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:27:52 INFO - PID 6414 | 04:28:03 INFO - PID 6414 | RSS: Main: 162177024 04:28:03 INFO - PID 6414 | 04:28:05 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36737/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:06 INFO - PID 6414 | RSS: Main: 167235584 04:28:06 INFO - PID 6414 | 04:28:09 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36737/tests/kraken/driver.html?testName=audio-dft) 04:28:09 INFO - PID 6414 | RSS: Main: 167714816 04:28:09 INFO - PID 6414 | 04:28:12 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36737/tests/kraken/driver.html?testName=audio-fft) 04:28:13 INFO - PID 6414 | RSS: Main: 163217408 04:28:13 INFO - PID 6414 | 04:28:15 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36737/tests/kraken/driver.html?testName=audio-oscillator) 04:28:16 INFO - PID 6414 | RSS: Main: 164171776 04:28:16 INFO - PID 6414 | 04:28:18 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36737/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:18 INFO - PID 6414 | RSS: Main: 164290560 04:28:18 INFO - PID 6414 | 04:28:21 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36737/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:22 INFO - PID 6414 | RSS: Main: 164065280 04:28:22 INFO - PID 6414 | 04:28:25 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36737/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:26 INFO - PID 6414 | RSS: Main: 167231488 04:28:26 INFO - PID 6414 | 04:28:29 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36737/tests/kraken/driver.html?testName=json-parse-financial) 04:28:29 INFO - PID 6414 | RSS: Main: 166723584 04:28:29 INFO - PID 6414 | 04:28:31 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36737/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:32 INFO - PID 6414 | RSS: Main: 168001536 04:28:32 INFO - PID 6414 | 04:28:33 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36737/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:34 INFO - PID 6414 | RSS: Main: 167067648 04:28:34 INFO - PID 6414 | 04:28:36 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36737/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:36 INFO - PID 6414 | RSS: Main: 164569088 04:28:36 INFO - PID 6414 | 04:28:39 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:40 INFO - PID 6414 | RSS: Main: 164036608 04:28:40 INFO - PID 6414 | 04:28:42 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:43 INFO - PID 6414 | RSS: Main: 165146624 04:28:43 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | Cycle 1(1): loaded http://localhost:36737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36737/tests/kraken/driver.html?testName=ai-astar) 04:28:45 INFO - PID 6414 | RSS: Main: 166719488 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | __start_tp_report 04:28:45 INFO - PID 6414 | _x_x_mozilla_page_load 04:28:45 INFO - PID 6414 | _x_x_mozilla_page_load_details 04:28:45 INFO - PID 6414 | |i|pagename|runs| 04:28:45 INFO - PID 6414 | |0;ai-astar;106;104;105;107;107;109;107;105;104;105 04:28:45 INFO - PID 6414 | |1;audio-beat-detection;111;112;113;111;115;112;111;152;110;113 04:28:45 INFO - PID 6414 | |2;audio-dft;160;163;162;162;162;162;162;162;166;168 04:28:45 INFO - PID 6414 | |3;audio-fft;75;75;74;74;72;98;73;74;72;74 04:28:45 INFO - PID 6414 | |4;audio-oscillator;77;77;77;77;79;79;92;79;78;78 04:28:45 INFO - PID 6414 | |5;imaging-gaussian-blur;114;113;113;113;113;113;114;114;115;115 04:28:45 INFO - PID 6414 | |6;imaging-darkroom;149;151;150;149;149;150;150;150;149;149 04:28:45 INFO - PID 6414 | |7;imaging-desaturate;94;100;94;93;94;94;94;94;99;99 04:28:45 INFO - PID 6414 | |8;json-parse-financial;48;50;44;45;48;45;50;46;44;55 04:28:45 INFO - PID 6414 | |9;json-stringify-tinderbox;36;36;37;36;37;38;37;36;36;36 04:28:45 INFO - PID 6414 | |10;stanford-crypto-aes;74;71;73;72;72;76;72;73;76;78 04:28:45 INFO - PID 6414 | |11;stanford-crypto-ccm;107;111;112;110;113;116;118;107;118;122 04:28:45 INFO - PID 6414 | |12;stanford-crypto-pbkdf2;167;159;159;159;162;159;159;154;166;159 04:28:45 INFO - PID 6414 | |13;stanford-crypto-sha256-iterative;58;60;61;59;59;62;59;60;69;64 04:28:45 INFO - PID 6414 | __end_tp_report 04:28:45 INFO - PID 6414 | __start_cc_report 04:28:45 INFO - PID 6414 | _x_x_mozilla_cycle_collect,907 04:28:45 INFO - PID 6414 | __end_cc_report 04:28:45 INFO - PID 6414 | __startTimestamp1504956525422__endTimestamp 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | ------- Summary: start ------- 04:28:45 INFO - PID 6414 | Number of tests: 14 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#0] ai-astar Cycles:10 Average:105.90 Median:106.50 stddev:1.60 (1.5%) stddev-sans-first:1.69 04:28:45 INFO - PID 6414 | Values: 106.0 104.0 105.0 107.0 107.0 109.0 107.0 105.0 104.0 105.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#1] audio-beat-detection Cycles:10 Average:116.00 Median:112.50 stddev:12.73 (11.3%) stddev-sans-first:13.37 04:28:45 INFO - PID 6414 | Values: 111.0 112.0 113.0 111.0 115.0 112.0 111.0 152.0 110.0 113.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.00 stddev:2.33 (1.4%) stddev-sans-first:2.22 04:28:45 INFO - PID 6414 | Values: 160.0 163.0 162.0 162.0 162.0 162.0 162.0 162.0 166.0 168.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#3] audio-fft Cycles:10 Average:76.10 Median:74.00 stddev:7.77 (10.5%) stddev-sans-first:8.23 04:28:45 INFO - PID 6414 | Values: 75.0 75.0 74.0 74.0 72.0 98.0 73.0 74.0 72.0 74.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:78.50 stddev:4.55 (5.8%) stddev-sans-first:4.75 04:28:45 INFO - PID 6414 | Values: 77.0 77.0 77.0 77.0 79.0 79.0 92.0 79.0 78.0 78.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 04:28:45 INFO - PID 6414 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 114.0 114.0 115.0 115.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 04:28:45 INFO - PID 6414 | Values: 149.0 151.0 150.0 149.0 149.0 150.0 150.0 150.0 149.0 149.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:94.00 stddev:2.68 (2.8%) stddev-sans-first:2.78 04:28:45 INFO - PID 6414 | Values: 94.0 100.0 94.0 93.0 94.0 94.0 94.0 94.0 99.0 99.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#8] json-parse-financial Cycles:10 Average:47.50 Median:48.00 stddev:3.47 (7.2%) stddev-sans-first:3.68 04:28:45 INFO - PID 6414 | Values: 48.0 50.0 44.0 45.0 48.0 45.0 50.0 46.0 44.0 55.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#9] json-stringify-tinderbox Cycles:10 Average:36.50 Median:36.50 stddev:0.71 (1.9%) stddev-sans-first:0.73 04:28:45 INFO - PID 6414 | Values: 36.0 36.0 37.0 36.0 37.0 38.0 37.0 36.0 36.0 36.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:73.50 stddev:2.26 (3.1%) stddev-sans-first:2.40 04:28:45 INFO - PID 6414 | Values: 74.0 71.0 73.0 72.0 72.0 76.0 72.0 73.0 76.0 78.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#11] stanford-crypto-ccm Cycles:10 Average:113.40 Median:114.50 stddev:4.99 (4.4%) stddev-sans-first:4.73 04:28:45 INFO - PID 6414 | Values: 107.0 111.0 112.0 110.0 113.0 116.0 118.0 107.0 118.0 122.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:159.00 stddev:3.80 (2.4%) stddev-sans-first:3.17 04:28:45 INFO - PID 6414 | Values: 167.0 159.0 159.0 159.0 162.0 159.0 159.0 154.0 166.0 159.0 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:60.50 stddev:3.28 (5.4%) stddev-sans-first:3.28 04:28:45 INFO - PID 6414 | Values: 58.0 60.0 61.0 59.0 59.0 62.0 59.0 60.0 69.0 64.0 04:28:45 INFO - PID 6414 | -------- Summary: end -------- 04:28:45 INFO - PID 6414 | 04:28:45 INFO - PID 6414 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:28:46 INFO - TEST-INFO | 6414: exit 0 04:28:46 INFO - TEST-OK | kraken | took 59747ms 04:28:46 INFO - SUITE-END | took 1167s 04:28:46 INFO - Completed test suite (00:19:27) 04:28:46 INFO - javascript benchmark 04:28:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9068.73048936888, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3870.3807390817474, 3897.0, 3911.943775180703, 3929.6070392960705, 3953.644172024517, 6347.111404403381, 6370.777022804203, 6416.069669897862, 6458.644774537399, 6474.061261117141, 6322.715477803498, 6402.16771819664, 6421.0, 6421.165248517698, 6432.839179020527, 5657.207990881269, 5686.601937864351, 5703.885922281552, 5734.741936612862, 5761.4814666679995, 5713.971430142843, 5784.913226301609, 5787.33445653751, 5792.4497172768515, 5814.941850581504, 5520.834374968757, 5651.491365777079, 5692.117721753135, 5735.655860648333, 5792.0, 5653.604247702662, 5678.43215678433, 5729.885402291972, 5738.9669859425285, 5743.396943320933, 5574.60977731559, 5659.122835960392, 5662.49037586615, 5717.599768016241, 5721.399253078408, 6303.432691057827, 6327.3988971047675, 6339.397757213057, 6360.363963603649, 6372.203474565679, 6846.075779769717, 6872.175338959357, 6934.826629334307, 6942.757003504904, 6946.444284457231, 6791.422729068036, 6882.862342753167, 6940.444764418834, 6997.930020699779, 7038.120234970629, 6384.648844313608, 6394.9360506394805, 6405.839854003687, 6421.0, 6426.2931077581425, 7028.753993610301, 7037.683304251321, 7048.612326321999, 7052.0, 7134.964325178341, 6719.328067193339, 6771.289014653489, 6868.690908909111, 6876.724931002704, 6890.379865812101, 6899.482538809509, 6928.16861976556, 6992.405645520086, 6996.090508233897, 7005.719771209197, 6741.797746067626, 6747.595144291358, 6794.490413219029, 6860.725570977205, 6937.340952609494, 6865.656717164122, 6900.275471075565, 6907.0, 6925.376716095576, 6972.372486476242, 4904.583110435653, 4938.086454005948, 4952.752362381866, 4974.427940786856, 5024.924626130611, 4534.387857639243, 4554.658400619966, 4560.270356742905, 4562.840300589463, 4569.840055598104, 6232.657203853741, 6237.064440333896, 6329.4303512683155, 6329.9872020476505, 6387.936120638734, 6829.658517074126, 6863.245043045261, 6866.828329291808, 6915.031895534629, 6956.79129626112, 6330.240371155399, 6332.176817013851, 6333.8733225336155, 6335.1447554579545, 6365.713542890581, 5546.334439867161, 5594.1888426177975, 5605.831825045255, 5606.046972014768, 5610.354809196913, 7106.786796396116, 7189.5686258824635, 7273.16358618755, 7294.161171465244, 7300.488965772345, 6717.05961165447, 6799.218089919723, 6842.623655698984, 6847.246802851682, 6984.650767461708, 7204.24355442671, 7205.0, 7205.495615307088, 7209.4592905533345, 7223.638818058971, 6803.897941530782, 6826.0, 6893.586384816927, 6893.965530172317, 6920.757773477904, 6838.452923766186, 6862.382385585322, 6894.655267236518, 6974.267701891431, 6982.546134501241, 6513.706883190173, 6568.343165683394, 6636.070950066898, 6666.933330666631, 6736.629485378351, 6659.833504162435, 6662.433693135944, 6697.598144111174, 6710.731570737116, 6732.3267673232285, 6572.76995305162, 6573.5398522103, 6589.4069533742195, 6659.234188068434, 6683.331666833278, 6634.83412914681, 6703.262641109376, 6772.661366931732, 6782.626955517494, 6805.081314022544, 6444.162258906312, 6511.902321465087, 6513.902291465726, 6515.381038801306, 6533.8693226136165], "value": 6289.826072738731, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [963.9855402168967, 981.9067188617081, 984.4290311619261, 986.9802603947926, 990.5195979949723, 41238.58761412385, 45097.549024509746, 45148.774256128716, 45283.773581132045, 45298.0, 42705.14589708204, 42848.78575607125, 42933.570664293424, 43011.35482967758, 43024.35463468043, 7524.887126693104, 7932.286094251516, 8117.188281171894, 8131.918680813175, 8132.064812546574, 8046.758597242063, 8118.066422361416, 8145.633446494922, 8148.918510814905, 8150.714724984627, 8084.393670474708, 8089.271965523102, 8116.228958248987, 8123.431359804816, 8198.057223419293, 8058.717944871931, 8143.144969778147, 8153.22544358285, 8155.796105097361, 8161.387895907801, 8156.551389673566, 8165.183481651788, 8187.79530511736, 8236.341092712568, 8238.258556729863, 41013.589864101275, 41088.0, 41114.38328425076, 41175.1764964702, 41287.58712412867, 3692.7415080944343, 3731.570869350005, 3738.9626103738888, 3740.869069582579, 3762.49206357141, 34083.318333633186, 34186.658133418845, 34222.657773422194, 34308.656913430794, 34316.656833431596, 5487.917681234785, 5491.36849262332, 5494.066008778477, 5532.253145825302, 5638.0, 213848.0, 214034.0, 214237.0, 214698.0, 214970.0, 48175.5182448178, 48847.511524885005, 52366.21450678243, 52553.0, 53989.46010539923, 57353.99261025927, 57379.71310143506, 57412.13881791777, 57839.42160578424, 57886.7105664469, 16821.915890420714, 17014.914925425295, 17077.829221707623, 17110.743338849927, 17132.571685707706, 13922.721545569031, 13934.442622295197, 13977.0, 13977.860221397656, 14208.360623771956, 15450.9227453862, 15527.611809704622, 15610.29753661088, 15618.0, 15715.292811823496, 6042.305134909541, 6099.298580663191, 6111.9694401528595, 6177.076183939591, 6235.282942461584, 1095.3044816541394, 1098.6594155811565, 1101.531848964187, 1114.5151858941385, 1120.56298043763, 25867.482650346887, 25924.870375648003, 25985.0, 26046.869765651052, 26096.086636967615, 1186.1044911092242, 1190.8094704847183, 1200.789861774186, 1211.5759484180642, 1234.5555599983998, 13600.25198614066, 13646.795298070538, 13744.725105497833, 13896.51362202318, 13967.860321396656, 276022.0, 276939.0, 277753.0, 278058.0, 278694.0, 58554.12168817471, 59078.0, 59161.40838591645, 59300.0, 59612.40387596155, 1519.384649217069, 1527.8166620005447, 1542.5295284937977, 1559.766035094745, 1561.2271925396774, 25056.37359066038, 25332.240032799047, 25370.8286464192, 25493.745062549136, 25747.613785792855, 38267.23465530729, 38337.99999999889, 38353.0, 38477.61522384852, 38519.0, 174612.0, 175099.0, 175223.0, 175854.0, 176224.0, 37175.25649487049, 39206.80396597999, 39821.80089099536, 40051.0, 40189.1962160761, 50644.0, 51300.74349628228, 51376.74311628418, 51390.74304628453, 51703.48296516987, 37621.2475750478, 37842.243155137294, 37969.4304585437, 38129.23741525209, 38247.6175238244, 37375.62624373721, 37678.17413694039, 37767.43348849715, 37797.24405511819, 37837.81081094687, 43753.0, 44396.0, 44507.332390014824, 44651.0, 44812.32781508345, 36303.27393452169, 36315.0, 36356.27287454289, 36506.634933650326, 36552.81723591365, 26589.601155982287, 26798.330041749112, 26920.057797976977, 27173.0, 27287.317817054733], "value": 18780.85277898264, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.9496045355917, 577.907534794433, 590.1501837354209, 594.2838879150623, 600.4295918877067, 23451.76548234517, 24176.0, 24180.032798688033, 24186.0, 24201.0, 24376.146834860785, 25329.0, 25890.35274118148, 26109.738902610967, 26113.47773044538, 6640.867182656344, 6777.491688123386, 6781.355771201753, 6781.72873085076, 6787.0, 6425.1968503937005, 6583.835404114888, 6675.332466753334, 6720.5295629305965, 6737.730490780363, 6686.5653732507235, 6694.497912656546, 6694.631795251284, 6704.396604305636, 6709.630970296632, 6254.43710066094, 6497.837554061139, 6499.675016249216, 6696.196456425236, 6720.428763555104, 6061.0, 6061.151438798572, 6066.272047354301, 6073.787417440412, 6074.088886666991, 29393.118206453626, 29903.700962990526, 29919.401611967856, 29920.8503957481, 29979.70020299791, 2173.076442511926, 2195.5169862630196, 2195.9451013724624, 2196.165457126298, 2196.648536234195, 19779.0, 20806.375808725763, 20870.47823804402, 20909.790902090936, 20929.476763080893, 2513.924582262535, 2529.2665127113114, 2575.562154433732, 2576.4203054312816, 2582.5222333868296, 135887.0, 142539.0, 143446.2827685855, 159466.0, 162699.18650406672, 15004.24639056793, 15472.5358239253, 15487.380504779683, 16104.275307611186, 17831.46505604834, 24879.253622391356, 24919.37701557439, 24928.5014299713, 24999.25002249899, 25018.249452516455, 10313.0, 10514.789704206027, 10520.421376824195, 10521.210909181842, 10546.525406356732, 9570.712878613653, 9697.321187516805, 9718.9028109718, 9726.124648781644, 9740.853887191697, 9382.624695012122, 9631.229501639851, 9665.565049572786, 9712.368696034735, 9843.163331116792, 2735.288824905539, 2777.4170021879845, 2835.6455443069617, 2878.2660421592777, 2931.135315082056, 1004.6182450668845, 1032.26193271811, 1037.9740506487246, 1040.9323393979366, 1047.8166320893813, 20582.073806678734, 20665.0, 21024.0, 21088.472788180112, 21207.257745978815, 1089.591403223791, 1093.1254996003324, 1098.0, 1105.1987309200927, 1112.927659702133, 11168.546053288192, 11542.769144617061, 11655.125865560118, 11664.008559272557, 11760.294382337088, 601360.0, 618017.0, 633565.0, 636953.0, 637923.0, 129319.0, 133203.0, 133453.0, 133477.0, 135695.32152339374, 1075.7902209069314, 1080.448971024783, 1082.199172612277, 1082.718493191776, 1187.5309252845077, 21767.56464870662, 22150.446238844157, 22331.756966176374, 22536.549269014857, 22686.773132268467, 62480.0, 62872.68563657152, 63258.68370658117, 65110.0, 65605.67197163984, 80203.59898200471, 80869.0, 80996.59501702453, 81655.591722041, 82533.0, 14117.152970821784, 14192.0, 14445.06107103035, 14943.925280373529, 15178.696426071196, 22664.66003009989, 23038.539229215658, 23651.0, 23941.281761547183, 23992.400189994692, 19117.0, 19263.133159008157, 19675.40973770789, 19679.31122410709, 19803.504912377306, 17100.828991709925, 17400.738988914924, 17401.91299043497, 17680.292788288323, 18236.90881545637, 19587.216511339386, 19731.506712332306, 19935.800641993395, 19957.101930413457, 19961.101750420974, 14831.184284864436, 14950.551483455514, 14967.550973470814, 14970.550883473514, 15007.699846003237, 19360.128794204014, 19515.219391224193, 19650.21399144018, 19662.803371966096, 19752.802471975672], "value": 12656.873491226243, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.545739905831, 1431.2128329418817, 1446.754051811192, 1449.1667291307501, 1464.2093269634397, 16510.504684859443, 17172.39896603619, 17200.655986880287, 17210.569735756613, 17211.569710757205, 16783.32866685331, 16848.494545163634, 16903.91548042258, 16913.83086169138, 16924.576885577866, 2670.652815134035, 2793.385455199853, 2795.0915952315477, 2795.412963277714, 2796.1192224449233, 2761.130243973152, 2809.157252824155, 2870.641169853768, 2878.596996420503, 2879.956800647992, 2611.8171727979047, 2634.420427505955, 2637.4197676511235, 2638.8416694998364, 2644.6694163229595, 2747.519184142777, 2774.8057635965492, 2780.457810726909, 2780.958285625717, 2781.1378472673537, 2510.8619025953567, 2539.428628558578, 2548.8470691758366, 2706.9713508866703, 2776.0145148472407, 16515.33938642453, 16533.83466165347, 16584.0, 16588.83411165885, 16597.66804663912, 8000.799980000488, 8254.42219044667, 8262.628181731836, 8262.793430164234, 8268.586570671503, 5337.893242135136, 5427.941551397479, 5430.266913966603, 5493.807716729895, 5565.1374037023925, 2043.150948391708, 2063.092239414653, 2076.927307544229, 2135.6614507114687, 2144.1637761273114, 30175.69824301751, 30244.395112097856, 30327.545086823717, 30351.0, 30352.392952141054, 6746.797596072126, 6796.218434880052, 6809.693563789641, 6898.068760717239, 6961.895571566431, 19001.90499047496, 19206.807931920783, 19357.032148392525, 19377.0, 19388.4183474496, 7938.761837144895, 8043.638036288381, 8071.5964201789675, 8076.555789431638, 8093.392995525359, 7170.641467926583, 7237.384822290059, 7422.554646721214, 7460.626968651546, 7478.663460144307, 5556.111022236423, 5632.690202038845, 5700.23046888673, 5735.971320143456, 5752.741126649311, 1509.932053057593, 1533.516942163215, 1605.1252067623172, 1627.4466681328406, 1670.8496235338878, 942.1191186240886, 962.2927148545813, 962.6775030364906, 972.1687956796978, 987.0474991632965, 9132.3150763693, 9366.0, 9372.906270937203, 9486.146246837818, 9509.809803803884, 1042.4779821460752, 1060.7984482948216, 1064.3454275620438, 1065.1106326217541, 1076.8370160226937, 5126.948730512647, 5181.5595674368105, 5673.744681489343, 5735.885282294331, 5881.088431293157, 23850.88074559616, 25119.62320565193, 25289.114880979076, 25305.114320998677, 25345.112921047676, 23864.64203036956, 24354.878225608758, 24645.50708985846, 25087.0, 25104.12135575246, 12606.621801345975, 12690.42893069814, 12706.301153436465, 12729.663385344591, 12758.61724148277, 9362.672306469241, 9901.55443005052, 9949.353292035994, 10145.28982971185, 10277.126444252322, 21085.15659373608, 21116.366509004754, 21198.0, 21236.0, 21351.57296854085, 21866.562668746854, 21940.0, 21977.67033494467, 21997.67003494917, 22078.33764987053, 13005.934970325088, 13173.736525269633, 13262.602121936357, 13277.136986095873, 13286.734265314446, 14701.33843977045, 14742.11547307165, 14839.92580037093, 14845.628859278604, 14849.109053456827, 11461.656150315504, 11481.138914581607, 11521.193516453768, 11773.47019384147, 11826.290422574673, 11887.405629718307, 12011.75976480448, 12028.398580070787, 12249.326287054297, 12310.138290319592, 9837.065478779505, 9987.60049598008, 9996.750081248027, 10001.399916005063, 10002.549885255035, 8035.55804430762, 8047.235512626291, 8147.959260203661, 8181.427300088937, 8195.836083278182, 8186.222308880647, 8286.295664868554, 8380.287675547646, 8394.488991981501, 8445.155484451505], "value": 7199.4881022768905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.2695044314069, 546.6364867363199, 553.4410245651893, 555.1256770586326, 570.8087790590153, 6241.719122639481, 6246.593971391856, 6273.905891411632, 6318.399752023551, 6329.208848893888, 6238.844028899269, 6258.906116408258, 6265.310815810257, 6277.68611569422, 6302.779402720906, 5112.948870511303, 5115.0, 5128.871778205537, 5145.614078944075, 5161.896762064756, 4838.491958344376, 4920.950790492103, 5076.746162691869, 5085.5423011928915, 5089.643724939256, 4895.853124406256, 4898.0, 4921.335619691349, 4948.950510494903, 4955.529224723664, 4804.20730579454, 4856.15017371962, 4883.0, 4939.456659767423, 4948.529889660476, 4343.73937563744, 4373.300271956472, 4390.626796722282, 4394.1651086293505, 4416.889577760549, 6013.428724271187, 6036.63780173191, 6041.275046994345, 6051.515878729691, 6138.938610613882, 5697.857553561194, 5735.139729040678, 5788.450097240755, 5801.796937107181, 5807.709614519257, 6589.406953374171, 6601.669916504204, 6630.469562434993, 6634.86730265392, 6693.899591506131, 4833.975830120862, 4838.975805120987, 4880.121578115938, 4890.73100979446, 4932.284818701304, 6645.833854153637, 6786.59280443175, 6788.796336109925, 6861.519693621449, 6862.965685171592, 5098.515641014098, 5108.514691104339, 5129.948700513021, 5133.845984620468, 5135.435102138762, 5177.844664660066, 5179.300794392784, 5200.12795393658, 5213.400458947193, 5216.087184742655, 5754.9424505754405, 5767.8558036049435, 5781.653100813965, 5796.82609521715, 5802.767889284466, 6600.669966501656, 6613.570117942319, 6636.734530618721, 6648.66756662165, 6657.500687448461, 1801.1084513165804, 1802.1079565615105, 1814.9183286752127, 1820.2718912435132, 1834.1379551610721, 1205.5086800504248, 1248.7377650693456, 1268.8794564516356, 1271.7075072733323, 1275.489804078376, 6163.506919446433, 6164.167837341902, 6201.286852012076, 6226.941419958618, 6248.594291197831, 6613.86772264552, 6634.502412318999, 6706.497012724065, 6744.258131605519, 6763.0, 5973.910391344133, 6036.3360030396625, 6087.878242435127, 6102.816915492543, 6165.229346331708, 3474.374612569711, 3488.633693462201, 3490.267043920754, 3530.2057037166946, 3538.0, 6895.862082758316, 6984.4063254623925, 7012.894806577905, 7051.964740176266, 7067.399271061914, 6807.115075040213, 6850.9314906850295, 6874.896876546856, 6904.516683832184, 6948.861022779516, 6968.616726080114, 6979.860402792017, 7096.254893236239, 7098.219195888448, 7123.643817808985, 6621.602703837785, 6714.764983225564, 6718.697658605277, 6772.153480814898, 6799.626020568916, 6640.402363787282, 6651.467882569286, 6653.866922661617, 6721.865562688621, 6766.830829229309, 6967.303269672992, 7017.508774385744, 7064.0, 7073.221945586084, 7108.182559005781, 5083.567896728671, 5088.135017047185, 5127.66670166438, 5147.150720131136, 5186.144286192736, 6557.344265573404, 6579.769708060195, 6647.368499992493, 6650.168728908887, 6695.933040669531, 6306.65313407767, 6411.839704007437, 6438.0, 6496.765614533224, 6512.185976752906, 6502.642354670349, 6508.9349106508325, 6562.704678289584, 6573.1783527059115, 6590.8352291193105, 6390.552661313849, 6487.967560162169, 6494.253160886558, 6511.34886511345, 6541.051547525677, 6506.739730410731, 6572.605643661395, 6591.34086591337, 6610.438112760469, 6616.801495955129, 6371.5221358397375, 6394.87210255783, 6432.485401167802, 6470.0, 6489.480841532761], "value": 5139.292760868067, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [954.88541375035, 966.608523547963, 987.8024395120977, 994.4083270454078, 996.7807082441865, 20600.793992060077, 21105.68341474877, 21134.682979755315, 21166.788332116692, 21196.364109076752, 19446.416607501764, 19622.90188549055, 19657.115429805657, 19742.40772776819, 19743.308984185558, 1013.0426746724348, 1027.4862568715641, 1029.53156313877, 1030.4435604773414, 1031.829748091564, 1008.7125169326706, 1028.6039874648277, 1036.6216331039193, 1037.398308980793, 1054.4200689620716, 1115.2806439846295, 1115.4590023838432, 1116.843641890136, 1117.083991127272, 1118.5413980268092, 1064.8243039898407, 1092.847001419802, 1106.4744246482937, 1112.1325366214367, 1116.2911551165028, 783.0681489028038, 784.8391079828622, 785.4698078796789, 785.783909424907, 786.4927122006332, 18471.90764046171, 18515.351962681376, 18533.814661853343, 18547.814521854878, 18566.814331856644, 22451.663225051638, 23090.65364019541, 23211.88394058019, 23225.419364515852, 23641.40896477602, 17633.823661763345, 18018.189181486865, 18101.094945252815, 18191.727124093017, 18299.176537055864, 4010.358342665189, 4012.498437695288, 4013.0569316210667, 4013.5585085640555, 4015.759054456742, 160488.19755901262, 161001.0, 162701.0, 163130.18434907869, 164328.17835910863, 18068.096595170187, 18162.0, 18197.90901045513, 18511.81488185101, 18674.906625467058, 33778.32443351119, 33882.491762623584, 33960.32079358399, 34553.0, 35168.12079697977, 9132.771680707903, 9170.95414522923, 9226.53867306632, 9231.492267925194, 9240.815183696288, 4525.389072475239, 4564.064366804797, 4592.97703511487, 4594.081183763261, 4598.540145985375, 6027.698615069229, 6125.509959203253, 6165.876682466325, 6175.320714721377, 6201.348858369896, 1115.726646971497, 1138.698244965085, 1154.8036833738286, 1159.5709587452698, 1159.976800463986, 707.5118168463744, 711.0578483509371, 714.585540386585, 721.5201890742597, 726.9127704675473, 12309.446074926649, 12726.872731272753, 13235.536756213678, 14456.927715361566, 14457.204853733145, 692.4149094015548, 694.3577191098213, 699.8460338725574, 711.1750369571273, 711.886098224292, 5658.151277308437, 5662.546996240291, 5700.25896633435, 5711.7144142792695, 5837.270341207349, 140360.0, 141079.16581292325, 142280.0, 145207.0, 147960.26019869832, 97367.0, 108349.47781524053, 126150.36924815501, 127519.0, 135016.32491837675, 109293.90706092997, 109817.70546883607, 110045.44977275222, 111186.44406778076, 115316.0, 14688.0, 14967.101973881601, 14994.250287485364, 15089.0, 15090.396384144511, 52194.0, 52319.738401307746, 52844.471555283955, 53449.46550534445, 53913.0, 68025.65987170032, 68380.31619683739, 68511.31488685249, 69400.0, 71271.0, 20388.592228155056, 20565.89717051405, 20630.79369206349, 20697.068631911297, 20851.165953362302, 20908.47728806731, 21066.2626808061, 21181.78818211798, 21289.89355053215, 21440.463988400414, 20187.09158087919, 20232.19071237134, 20306.289279875135, 20413.183472660927, 20419.79580204179, 19743.60512789765, 20092.0, 20115.0, 20188.697169542764, 20266.695999559724, 17982.0, 18197.545061373043, 18213.45359639213, 18255.452336429928, 18406.447806565826, 15167.469138580538, 15307.923460382626, 15436.536903892902, 15565.299561519532, 15597.220138993232, 15369.462068827537, 15430.459933902259, 15461.458848940232, 15712.13583252932, 15796.0], "value": 10054.638209216833, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1391.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 105.0, 107.0, 107.0, 109.0, 107.0, 105.0, 104.0, 105.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 113.0, 111.0, 115.0, 112.0, 111.0, 152.0, 110.0, 113.0], "value": 116.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 166.0, 168.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 74.0, 72.0, 98.0, 73.0, 74.0, 72.0, 74.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 77.0, 79.0, 79.0, 92.0, 79.0, 78.0, 78.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 115.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 150.0, 149.0, 149.0, 150.0, 150.0, 150.0, 149.0, 149.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 100.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 99.0, 99.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 50.0, 44.0, 45.0, 48.0, 45.0, 50.0, 46.0, 44.0, 55.0], "value": 47.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 37.0, 36.0, 37.0, 38.0, 37.0, 36.0, 36.0, 36.0], "value": 36.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 73.0, 72.0, 72.0, 76.0, 72.0, 73.0, 76.0, 78.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 112.0, 110.0, 113.0, 116.0, 118.0, 107.0, 118.0, 122.0], "value": 113.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 159.0, 159.0, 159.0, 162.0, 159.0, 159.0, 154.0, 166.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 61.0, 59.0, 59.0, 62.0, 59.0, 60.0, 69.0, 64.0], "value": 61.1, "unit": "score"}]}]} 04:28:46 INFO - Return code: 0 04:28:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:28:46 INFO - # TBPL SUCCESS # 04:28:46 INFO - Running post-action listener: _package_coverage_data 04:28:46 INFO - Running post-action listener: _resource_record_post_action 04:28:46 INFO - [mozharness: 2017-09-09 11:28:46.705072Z] Finished run-tests step (success) 04:28:46 INFO - Running post-run listener: _resource_record_post_run 04:28:46 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 466944; Write bytes: 298373120; Read time: 268; Write time: 252692 04:28:46 INFO - TinderboxPrint: CPU usage
13.1% 04:28:46 INFO - TinderboxPrint: I/O read bytes / time
466,944 / 268 04:28:46 INFO - TinderboxPrint: I/O write bytes / time
298,373,120 / 252,692 04:28:46 INFO - TinderboxPrint: CPU idle
8,205.8 (86.9%) 04:28:46 INFO - TinderboxPrint: CPU user
1,184.4 (12.5%) 04:28:46 INFO - TinderboxPrint: Swap in / out
0 / 0 04:28:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 16891904; Read time: 0; Write time: 6412 04:28:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:28:46 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 466944; Write bytes: 281481216; Read time: 268; Write time: 246280 04:28:47 INFO - Running post-run listener: _upload_blobber_files 04:28:47 INFO - Blob upload gear active. 04:28:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:28:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:28:47 INFO - (blobuploader) - INFO - Open directory for files ... 04:28:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:28:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:28:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:48 INFO - (blobuploader) - INFO - Done attempting. 04:28:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:28:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:28:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:49 INFO - (blobuploader) - INFO - Done attempting. 04:28:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:28:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:28:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:50 INFO - (blobuploader) - INFO - Done attempting. 04:28:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:28:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:28:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:57 INFO - (blobuploader) - INFO - Done attempting. 04:28:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:28:57 INFO - Return code: 0 04:28:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:28:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:28:57 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b93e285c47b4b96d4bf0a576fa1a69ac69a026fda5aad8795ef674009e6b6557005ccd95932389bb6d85681bfd80205ba5af54b077b5e8448dded7ec2d41392", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4043e23ee7b0a1854296aa20bc38bfd76b213d8b401c68e4b9886b6483f5f0023fab0d14a5ce118667bb05809d2ac741cd2bd4e6f82d6b60fa6fbc35587c0192", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bce7a9df91ba3284f2b26aa3d14e6728306892d7fbf6cfdbc019dc649b8dd4880d1c96c5c6e5362b33c17f4978f4223edba490fad88e2d84690b29f80edc7391", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cac68b0fd90f3b7e4cfcf2d58410c9ef87c15b5623bddbede4e959d45d212d788cd3144c6b7ddd53dbb5552efbc23e37ef40f62bf0a25484dfd0f2654603b8ce"} 04:28:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:28:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:28:57 INFO - Contents: 04:28:57 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b93e285c47b4b96d4bf0a576fa1a69ac69a026fda5aad8795ef674009e6b6557005ccd95932389bb6d85681bfd80205ba5af54b077b5e8448dded7ec2d41392", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4043e23ee7b0a1854296aa20bc38bfd76b213d8b401c68e4b9886b6483f5f0023fab0d14a5ce118667bb05809d2ac741cd2bd4e6f82d6b60fa6fbc35587c0192", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bce7a9df91ba3284f2b26aa3d14e6728306892d7fbf6cfdbc019dc649b8dd4880d1c96c5c6e5362b33c17f4978f4223edba490fad88e2d84690b29f80edc7391", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cac68b0fd90f3b7e4cfcf2d58410c9ef87c15b5623bddbede4e959d45d212d788cd3144c6b7ddd53dbb5552efbc23e37ef40f62bf0a25484dfd0f2654603b8ce"} 04:28:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:28:57 INFO - Copying logs to upload dir... 04:28:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:28:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.904383 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-09 04:28:57.897971) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 04:28:57.901440) ========= 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=652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b93e285c47b4b96d4bf0a576fa1a69ac69a026fda5aad8795ef674009e6b6557005ccd95932389bb6d85681bfd80205ba5af54b077b5e8448dded7ec2d41392", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4043e23ee7b0a1854296aa20bc38bfd76b213d8b401c68e4b9886b6483f5f0023fab0d14a5ce118667bb05809d2ac741cd2bd4e6f82d6b60fa6fbc35587c0192", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bce7a9df91ba3284f2b26aa3d14e6728306892d7fbf6cfdbc019dc649b8dd4880d1c96c5c6e5362b33c17f4978f4223edba490fad88e2d84690b29f80edc7391", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cac68b0fd90f3b7e4cfcf2d58410c9ef87c15b5623bddbede4e959d45d212d788cd3144c6b7ddd53dbb5552efbc23e37ef40f62bf0a25484dfd0f2654603b8ce"} build_url:https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/XvLPM4gBSoCLFs5hXh0goQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b93e285c47b4b96d4bf0a576fa1a69ac69a026fda5aad8795ef674009e6b6557005ccd95932389bb6d85681bfd80205ba5af54b077b5e8448dded7ec2d41392", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4043e23ee7b0a1854296aa20bc38bfd76b213d8b401c68e4b9886b6483f5f0023fab0d14a5ce118667bb05809d2ac741cd2bd4e6f82d6b60fa6fbc35587c0192", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bce7a9df91ba3284f2b26aa3d14e6728306892d7fbf6cfdbc019dc649b8dd4880d1c96c5c6e5362b33c17f4978f4223edba490fad88e2d84690b29f80edc7391", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cac68b0fd90f3b7e4cfcf2d58410c9ef87c15b5623bddbede4e959d45d212d788cd3144c6b7ddd53dbb5552efbc23e37ef40f62bf0a25484dfd0f2654603b8ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 04:28:57.929474) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:28:57.929781) ========= 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=652eb03db935cfc1c15ebda0000001ad-1504955061.26371-1928345259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:28:58.013071) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 04:28:58.013378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 04:28:58.013673) ========= ========= Total master_lag: 0.19 =========