builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1505125104.21 results: success (0) revision: f9a5e9ed62103c84e4cde915f4d08f1ce71be83e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:24.205320) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:24.205795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:24.206069) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:24.234420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:24.234717) ========= 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=3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-11 03:18:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.6M=0.001s 2017-09-11 03:18:24 (20.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.268346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:24.521800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:24.522134) ========= 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=3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.058195 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:24.593539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:24.593877) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9a5e9ed62103c84e4cde915f4d08f1ce71be83e --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 f9a5e9ed62103c84e4cde915f4d08f1ce71be83e --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=3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-11 03:18:24,640 truncating revision to first 12 chars 2017-09-11 03:18:24,640 Setting DEBUG logging. 2017-09-11 03:18:24,640 attempt 1/10 2017-09-11 03:18:24,640 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9a5e9ed6210?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-11 03:18:25,009 unpacking tar archive at: mozilla-central-f9a5e9ed6210/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660328 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:25.270349) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:25.270669) ========= script_repo_revision: f9a5e9ed62103c84e4cde915f4d08f1ce71be83e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:25.271037) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:25.271345) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 03:18:25.284900) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-11 03:18:25.285185) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:25 INFO - MultiFileLogger online at 20170911 03:18:25 in /builds/slave/test 03:18:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:18:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:18:25 INFO - {'append_to_log': False, 03:18:25 INFO - 'base_work_dir': '/builds/slave/test', 03:18:25 INFO - 'blob_upload_branch': 'Firefox', 03:18:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:18:25 INFO - 'branch': 'Firefox', 03:18:25 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:25 INFO - 'code_coverage': False, 03:18:25 INFO - 'config_files': ('talos/linux_config.py',), 03:18:25 INFO - 'default_actions': ('clobber', 03:18:25 INFO - 'read-buildbot-config', 03:18:25 INFO - 'download-and-extract', 03:18:25 INFO - 'populate-webroot', 03:18:25 INFO - 'create-virtualenv', 03:18:25 INFO - 'install', 03:18:25 INFO - 'setup-mitmproxy', 03:18:25 INFO - 'run-tests'), 03:18:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:25 INFO - 'disable_ccov_upload': False, 03:18:25 INFO - 'disable_stylo': False, 03:18:25 INFO - 'download_minidump_stackwalk': True, 03:18:25 INFO - 'download_symbols': 'ondemand', 03:18:25 INFO - 'enable_stylo': False, 03:18:25 INFO - 'enable_webrender': False, 03:18:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:18:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:25 INFO - 'gecko_profile': False, 03:18:25 INFO - 'gecko_profile_interval': 0, 03:18:25 INFO - 'installer_path': 'installer.exe', 03:18:25 INFO - 'log_level': 'info', 03:18:25 INFO - 'log_name': 'talos', 03:18:25 INFO - 'log_to_console': True, 03:18:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:25 INFO - 'opt_config_files': (), 03:18:25 INFO - 'pip_index': False, 03:18:25 INFO - 'suite': 'dromaeojs-e10s', 03:18:25 INFO - 'system_bits': '32', 03:18:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:25 INFO - 'title': 'talos-linux64-ix-059', 03:18:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:25 INFO - 'use_talos_json': True, 03:18:25 INFO - 'verify': 'False', 03:18:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:18:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:25 INFO - 'work_dir': 'build'} 03:18:25 INFO - [mozharness: 2017-09-11 10:18:25.603120Z] Running clobber step. 03:18:25 INFO - Running pre-action listener: _resource_record_pre_action 03:18:25 INFO - Running main action method: clobber 03:18:25 INFO - rmtree: /builds/slave/test/build 03:18:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:18:27 INFO - Running post-action listener: _resource_record_post_action 03:18:27 INFO - [mozharness: 2017-09-11 10:18:27.354924Z] Finished clobber step (success) 03:18:27 INFO - [mozharness: 2017-09-11 10:18:27.355085Z] Running read-buildbot-config step. 03:18:27 INFO - Running pre-action listener: _resource_record_pre_action 03:18:27 INFO - Running main action method: read_buildbot_config 03:18:27 INFO - Using buildbot properties: 03:18:27 INFO - { 03:18:27 INFO - "project": "", 03:18:27 INFO - "product": "firefox", 03:18:27 INFO - "who": "archaeopteryx@coole-files.de", 03:18:27 INFO - "installer_path": "public/build/target.tar.bz2", 03:18:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:18:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:18:27 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:18:27 INFO - "stage_platform": "linux64-qr", 03:18:27 INFO - "basedir": "/builds/slave/test", 03:18:27 INFO - "buildnumber": 47, 03:18:27 INFO - "platform": "ubuntu64_hw_qr", 03:18:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:18:27 INFO - "slavebuilddir": "test", 03:18:27 INFO - "taskId": "B63euNLGTzGqkybKc0FEOA", 03:18:27 INFO - "branch": "mozilla-central", 03:18:27 INFO - "script_repo_revision": "production", 03:18:27 INFO - "revision": "f9a5e9ed62103c84e4cde915f4d08f1ce71be83e", 03:18:27 INFO - "slavename": "talos-linux64-ix-059", 03:18:27 INFO - "repo_path": "mozilla-central" 03:18:27 INFO - } 03:18:27 INFO - Finding installer, test and symbols from parent task. 03:18:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B63euNLGTzGqkybKc0FEOA'}, attempt #1 03:18:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B63euNLGTzGqkybKc0FEOA'}, attempt #1 03:18:28 INFO - Task dependencies: TV-2xJbFQNaqNCVPY33lrg 03:18:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg'}, attempt #1 03:18:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2 03:18:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.test_packages.json 03:18:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.crashreporter-symbols.zip 03:18:28 INFO - Running post-action listener: _resource_record_post_action 03:18:28 INFO - [mozharness: 2017-09-11 10:18:28.720912Z] Finished read-buildbot-config step (success) 03:18:28 INFO - [mozharness: 2017-09-11 10:18:28.721138Z] Running download-and-extract step. 03:18:28 INFO - Running pre-action listener: _resource_record_pre_action 03:18:28 INFO - Running main action method: download_and_extract 03:18:28 INFO - mkdir: /builds/slave/test/build/tests 03:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:28 INFO - trying https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.test_packages.json 03:18:28 INFO - Downloading https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:18:29 INFO - Downloaded 989 bytes. 03:18:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:18:29 INFO - Using the following test package requirements: 03:18:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:18:29 INFO - u'common': [u'target.common.tests.zip'], 03:18:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:18:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:18:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:18:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:18:29 INFO - u'mozbase': [u'target.common.tests.zip'], 03:18:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:18:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:18:29 INFO - u'web-platform': [u'target.common.tests.zip', 03:18:29 INFO - u'target.web-platform.tests.tar.gz'], 03:18:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:18:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:18:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.common.tests.zip 03:18:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:18:29 INFO - Fetch https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.common.tests.zip into memory 03:18:30 INFO - Content-Length response header: 55028367 03:18:30 INFO - Bytes received: 55028367 03:18:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.talos.tests.zip 03:18:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:18:41 INFO - Fetch https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.talos.tests.zip into memory 03:18:42 INFO - Content-Length response header: 14497963 03:18:42 INFO - Bytes received: 14497963 03:18: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')]} 03:18:42 INFO - trying https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2 03:18:42 INFO - Downloading https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:18:43 INFO - Downloaded 62877338 bytes. 03:18:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2 03:18:43 INFO - mkdir: /builds/slave/test/properties 03:18:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:18:43 INFO - Writing to file /builds/slave/test/properties/build_url 03:18:43 INFO - Contents: 03:18:43 INFO - build_url:https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2 03:18:43 INFO - Running post-action listener: _resource_record_post_action 03:18:43 INFO - Running post-action listener: find_tests_for_verification 03:18:43 INFO - Running post-action listener: set_extra_try_arguments 03:18:43 INFO - [mozharness: 2017-09-11 10:18:43.433090Z] Finished download-and-extract step (success) 03:18:43 INFO - [mozharness: 2017-09-11 10:18:43.433190Z] Running populate-webroot step. 03:18:43 INFO - Running pre-action listener: _resource_record_pre_action 03:18:43 INFO - Running main action method: populate_webroot 03:18:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:18:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:43 INFO - 'tests': ['tresize', 03:18:43 INFO - 'tcanvasmark']}, 03:18:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:18:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:43 INFO - 'tests': ['dromaeo_css', 03:18:43 INFO - 'kraken']}, 03:18:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:18:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:43 INFO - 'talos_options': ['--disable-stylo'], 03:18:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:18:43 INFO - 'tests': ['damp', 'tps']}, 03:18:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:43 INFO - 'talos_options': ['--disable-stylo'], 03:18:43 INFO - 'tests': ['damp', 'tps']}, 03:18:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:43 INFO - 'tests': ['dromaeo_dom']}, 03:18:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:18:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:43 INFO - 'tests': ['basic_compositor_video', 03:18:43 INFO - 'glvideo']}, 03:18:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:18:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:18:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:43 INFO - 'talos_options': ['--disable-stylo'], 03:18:43 INFO - 'tests': ['ts_paint_webext', 03:18:43 INFO - 'tp5o_webext']}, 03:18:43 INFO - 'other-e10s': {'tests': ['a11yr', 03:18:43 INFO - 'ts_paint', 03:18:43 INFO - 'tpaint', 03:18:43 INFO - 'sessionrestore', 03:18:43 INFO - 'sessionrestore_many_windows', 03:18:43 INFO - 'sessionrestore_no_auto_restore', 03:18:43 INFO - 'tabpaint']}, 03:18:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:43 INFO - 'tests': ['a11yr', 03:18:43 INFO - 'ts_paint', 03:18:43 INFO - 'tpaint', 03:18:43 INFO - 'sessionrestore', 03:18:43 INFO - 'sessionrestore_many_windows', 03:18:43 INFO - 'sessionrestore_no_auto_restore', 03:18:43 INFO - 'tabpaint']}, 03:18:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:18:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:18:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:43 INFO - 'tests': ['bloom_basic_singleton']}, 03:18:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:43 INFO - 'tests': ['bloom_basic']}, 03:18:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:18:43 INFO - 'tsvgr_opacity', 03:18:43 INFO - 'tart', 03:18:43 INFO - 'tscrollx', 03:18:43 INFO - 'tsvg_static']}, 03:18:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:43 INFO - 'tests': ['tsvgx', 03:18:43 INFO - 'tsvgr_opacity', 03:18:43 INFO - 'tart', 03:18:43 INFO - 'tscrollx', 03:18:43 INFO - 'tsvg_static']}, 03:18:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:18:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:43 INFO - 'talos_options': ['--disable-stylo'], 03:18:43 INFO - 'tests': ['tp5o']}, 03:18:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:18:43 INFO - 'talos_options': ['--mitmproxy', 03:18:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:18:43 INFO - '--firstNonBlankPaint'], 03:18:43 INFO - 'tests': ['tp6_google', 03:18:43 INFO - 'tp6_youtube', 03:18:43 INFO - 'tp6_amazon', 03:18:43 INFO - 'tp6_facebook']}, 03:18:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:18:43 INFO - 'talos_options': ['--disable-stylo', 03:18:43 INFO - '--mitmproxy', 03:18:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:18:43 INFO - '--firstNonBlankPaint'], 03:18:43 INFO - 'tests': ['tp6_google', 03:18:43 INFO - 'tp6_youtube', 03:18:43 INFO - 'tp6_amazon', 03:18:43 INFO - 'tp6_facebook']}, 03:18:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:18:43 INFO - 'talos_options': ['--stylo-threads=1', 03:18:43 INFO - '--mitmproxy', 03:18:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:18:43 INFO - '--firstNonBlankPaint'], 03:18:43 INFO - 'tests': ['tp6_google', 03:18:43 INFO - 'tp6_youtube', 03:18:43 INFO - 'tp6_amazon', 03:18:43 INFO - 'tp6_facebook']}, 03:18:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:18:43 INFO - 'talos_options': ['--xperf_path', 03:18:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:43 INFO - 'tests': ['tp5n']}, 03:18:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:43 INFO - 'talos_options': ['--disable-stylo', 03:18:43 INFO - '--xperf_path', 03:18:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:43 INFO - 'tests': ['tp5n']}}} 03:18:43 INFO - Running post-action listener: _resource_record_post_action 03:18:43 INFO - [mozharness: 2017-09-11 10:18:43.448158Z] Finished populate-webroot step (success) 03:18:43 INFO - [mozharness: 2017-09-11 10:18:43.448263Z] Running create-virtualenv step. 03:18:43 INFO - Running pre-action listener: _resource_record_pre_action 03:18:43 INFO - Running main action method: create_virtualenv 03:18:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:18:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:18:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:18:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:18:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:18:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:44 INFO - Installing pip...............done. 03:18:45 INFO - Return code: 0 03:18:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:18:45 INFO - Reading from file tmpfile_stdout 03:18:45 INFO - Output received: 03:18:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:18:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:46 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 0x25c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2792a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2935a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2939090>, '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 0x2939d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2933f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:18:46 INFO - Using env: {'DISPLAY': ':0', 03:18:46 INFO - 'HOME': '/home/cltbld', 03:18:46 INFO - 'LANG': 'en_US.UTF-8', 03:18:46 INFO - 'LANGUAGE': 'en_US:en', 03:18:46 INFO - 'LOGNAME': 'cltbld', 03:18:46 INFO - 'MAIL': '/var/mail/cltbld', 03:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:46 INFO - 'MOZ_NO_REMOTE': '1', 03:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:46 INFO - 'NO_EM_RESTART': '1', 03:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:46 INFO - 'PWD': '/builds/slave/test', 03:18:46 INFO - 'SHELL': '/bin/bash', 03:18:46 INFO - 'SHLVL': '1', 03:18:46 INFO - 'TERM': 'linux', 03:18:46 INFO - 'TMOUT': '86400', 03:18:46 INFO - 'USER': 'cltbld', 03:18:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:46 INFO - '_': '/tools/buildbot/bin/python'} 03:18:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:18:47 INFO - Downloading/unpacking pip>=1.5 03:18:47 INFO - Running setup.py egg_info for package pip 03:18:47 INFO - warning: no files found matching 'pip/cacert.pem' 03:18:47 INFO - warning: no files found matching '*.html' under directory 'docs' 03:18:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:18:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:18:47 INFO - Installing collected packages: pip 03:18:47 INFO - Found existing installation: pip 1.1 03:18:47 INFO - Uninstalling pip: 03:18:47 INFO - Successfully uninstalled pip 03:18:47 INFO - Running setup.py install for pip 03:18:47 INFO - warning: no files found matching 'pip/cacert.pem' 03:18:47 INFO - warning: no files found matching '*.html' under directory 'docs' 03:18:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:18:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:18:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:18:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:18:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:18:47 INFO - Successfully installed pip 03:18:47 INFO - Cleaning up... 03:18:47 INFO - Return code: 0 03:18:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18: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')]} 03:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18: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', '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 0x25c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2792a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2935a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2939090>, '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 0x2939d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2933f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:18: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 psutil>=3.1.1 03:18:47 INFO - Using env: {'DISPLAY': ':0', 03:18:47 INFO - 'HOME': '/home/cltbld', 03:18:47 INFO - 'LANG': 'en_US.UTF-8', 03:18:47 INFO - 'LANGUAGE': 'en_US:en', 03:18:47 INFO - 'LOGNAME': 'cltbld', 03:18:47 INFO - 'MAIL': '/var/mail/cltbld', 03:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:47 INFO - 'MOZ_NO_REMOTE': '1', 03:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:47 INFO - 'NO_EM_RESTART': '1', 03:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:47 INFO - 'PWD': '/builds/slave/test', 03:18:47 INFO - 'SHELL': '/bin/bash', 03:18:47 INFO - 'SHLVL': '1', 03:18:47 INFO - 'TERM': 'linux', 03:18:47 INFO - 'TMOUT': '86400', 03:18:47 INFO - 'USER': 'cltbld', 03:18:47 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:47 INFO - '_': '/tools/buildbot/bin/python'} 03:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:47 INFO - Downloading/unpacking psutil>=3.1.1 03:18: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 03:18: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 03:18: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 03:18: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 03:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:48 INFO - Installing collected packages: psutil 03:18:48 INFO - Running setup.py install for psutil 03:18:48 INFO - building 'psutil._psutil_linux' extension 03:18:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:18:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:18:50 INFO - building 'psutil._psutil_posix' extension 03:18:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:18:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:18:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:50 INFO - Successfully installed psutil 03:18:50 INFO - Cleaning up... 03:18:50 INFO - Return code: 0 03:18:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2792a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2935a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2939090>, '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 0x2939d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2933f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:18: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 mozsystemmonitor==0.3 03:18:50 INFO - Using env: {'DISPLAY': ':0', 03:18:50 INFO - 'HOME': '/home/cltbld', 03:18:50 INFO - 'LANG': 'en_US.UTF-8', 03:18:50 INFO - 'LANGUAGE': 'en_US:en', 03:18:50 INFO - 'LOGNAME': 'cltbld', 03:18:50 INFO - 'MAIL': '/var/mail/cltbld', 03:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:50 INFO - 'MOZ_NO_REMOTE': '1', 03:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:50 INFO - 'NO_EM_RESTART': '1', 03:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:50 INFO - 'PWD': '/builds/slave/test', 03:18:50 INFO - 'SHELL': '/bin/bash', 03:18:50 INFO - 'SHLVL': '1', 03:18:50 INFO - 'TERM': 'linux', 03:18:50 INFO - 'TMOUT': '86400', 03:18:50 INFO - 'USER': 'cltbld', 03:18:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:50 INFO - '_': '/tools/buildbot/bin/python'} 03:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:18:52 INFO - Installing collected packages: mozsystemmonitor 03:18:52 INFO - Running setup.py install for mozsystemmonitor 03:18:52 INFO - Successfully installed mozsystemmonitor 03:18:52 INFO - Cleaning up... 03:18:52 INFO - Return code: 0 03:18:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:52 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 0x25c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2792a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2935a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2939090>, '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 0x2939d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2933f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:18:52 INFO - Using env: {'DISPLAY': ':0', 03:18:52 INFO - 'HOME': '/home/cltbld', 03:18:52 INFO - 'LANG': 'en_US.UTF-8', 03:18:52 INFO - 'LANGUAGE': 'en_US:en', 03:18:52 INFO - 'LOGNAME': 'cltbld', 03:18:52 INFO - 'MAIL': '/var/mail/cltbld', 03:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:52 INFO - 'MOZ_NO_REMOTE': '1', 03:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:52 INFO - 'NO_EM_RESTART': '1', 03:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:52 INFO - 'PWD': '/builds/slave/test', 03:18:52 INFO - 'SHELL': '/bin/bash', 03:18:52 INFO - 'SHLVL': '1', 03:18:52 INFO - 'TERM': 'linux', 03:18:52 INFO - 'TMOUT': '86400', 03:18:52 INFO - 'USER': 'cltbld', 03:18:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:52 INFO - '_': '/tools/buildbot/bin/python'} 03:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:52 INFO - Downloading/unpacking jsonschema==2.5.1 03:18: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 03:18: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 03:18: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 03:18: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 03:18:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:18:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:53 INFO - Downloading functools32-3.2.3-2.tar.gz 03:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:18:53 INFO - warning: no files found matching '*.txt' 03:18:53 INFO - no previously-included directories found matching 'build' 03:18:53 INFO - no previously-included directories found matching 'dist' 03:18:53 INFO - no previously-included directories found matching '.git*' 03:18:53 INFO - Installing collected packages: jsonschema, functools32 03:18:53 INFO - Running setup.py install for functools32 03:18:53 INFO - warning: no files found matching '*.txt' 03:18:53 INFO - no previously-included directories found matching 'build' 03:18:53 INFO - no previously-included directories found matching 'dist' 03:18:53 INFO - no previously-included directories found matching '.git*' 03:18:53 INFO - Successfully installed jsonschema functools32 03:18:53 INFO - Cleaning up... 03:18:53 INFO - Return code: 0 03:18:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18: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')]} 03:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2792a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2935a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2939090>, '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 0x2939d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2933f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:18:53 INFO - Using env: {'DISPLAY': ':0', 03:18:53 INFO - 'HOME': '/home/cltbld', 03:18:53 INFO - 'LANG': 'en_US.UTF-8', 03:18:53 INFO - 'LANGUAGE': 'en_US:en', 03:18:53 INFO - 'LOGNAME': 'cltbld', 03:18:53 INFO - 'MAIL': '/var/mail/cltbld', 03:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:53 INFO - 'MOZ_NO_REMOTE': '1', 03:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:53 INFO - 'NO_EM_RESTART': '1', 03:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:53 INFO - 'PWD': '/builds/slave/test', 03:18:53 INFO - 'SHELL': '/bin/bash', 03:18:53 INFO - 'SHLVL': '1', 03:18:53 INFO - 'TERM': 'linux', 03:18:53 INFO - 'TMOUT': '86400', 03:18:53 INFO - 'USER': 'cltbld', 03:18:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:53 INFO - '_': '/tools/buildbot/bin/python'} 03:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:18:54 INFO - Cleaning up... 03:18:54 INFO - Return code: 0 03:18:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:54 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 0x25c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2792a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2935a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2939090>, '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 0x2939d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2933f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:18:54 INFO - Using env: {'DISPLAY': ':0', 03:18:54 INFO - 'HOME': '/home/cltbld', 03:18:54 INFO - 'LANG': 'en_US.UTF-8', 03:18:54 INFO - 'LANGUAGE': 'en_US:en', 03:18:54 INFO - 'LOGNAME': 'cltbld', 03:18:54 INFO - 'MAIL': '/var/mail/cltbld', 03:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:54 INFO - 'MOZ_NO_REMOTE': '1', 03:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:54 INFO - 'NO_EM_RESTART': '1', 03:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:54 INFO - 'PWD': '/builds/slave/test', 03:18:54 INFO - 'SHELL': '/bin/bash', 03:18:54 INFO - 'SHLVL': '1', 03:18:54 INFO - 'TERM': 'linux', 03:18:54 INFO - 'TMOUT': '86400', 03:18:54 INFO - 'USER': 'cltbld', 03:18:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:54 INFO - '_': '/tools/buildbot/bin/python'} 03:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:18:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:18:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:55 INFO - Downloading docopt-0.6.1.tar.gz 03:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:18:56 INFO - Installing collected packages: blobuploader, requests, docopt 03:18:56 INFO - Running setup.py install for blobuploader 03:18:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:18:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:18:56 INFO - Running setup.py install for requests 03:18:56 INFO - Running setup.py install for docopt 03:18:56 INFO - Successfully installed blobuploader requests docopt 03:18:56 INFO - Cleaning up... 03:18:56 INFO - Return code: 0 03:18:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18: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')]} 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:56 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 0x25c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2792a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2935a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2939090>, '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 0x2939d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2933f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:56 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 03:18:56 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 03:18:56 INFO - Using env: {'DISPLAY': ':0', 03:18:56 INFO - 'HOME': '/home/cltbld', 03:18:56 INFO - 'LANG': 'en_US.UTF-8', 03:18:56 INFO - 'LANGUAGE': 'en_US:en', 03:18:56 INFO - 'LOGNAME': 'cltbld', 03:18:56 INFO - 'MAIL': '/var/mail/cltbld', 03:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:56 INFO - 'MOZ_NO_REMOTE': '1', 03:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:56 INFO - 'NO_EM_RESTART': '1', 03:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:56 INFO - 'PWD': '/builds/slave/test', 03:18:56 INFO - 'SHELL': '/bin/bash', 03:18:56 INFO - 'SHLVL': '1', 03:18:56 INFO - 'TERM': 'linux', 03:18:56 INFO - 'TMOUT': '86400', 03:18:56 INFO - 'USER': 'cltbld', 03:18:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:56 INFO - '_': '/tools/buildbot/bin/python'} 03:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:56 INFO - Running setup.py (path:/tmp/pip-uHm0FX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:56 INFO - Running setup.py (path:/tmp/pip-JfjpiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:56 INFO - Running setup.py (path:/tmp/pip-8N6lsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:57 INFO - Running setup.py (path:/tmp/pip-TpHcCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:57 INFO - Running setup.py (path:/tmp/pip-m7vUeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:57 INFO - Running setup.py (path:/tmp/pip-xIalCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:57 INFO - Running setup.py (path:/tmp/pip-qfea1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:57 INFO - Running setup.py (path:/tmp/pip-WVrTBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:57 INFO - Running setup.py (path:/tmp/pip-bGcm7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:57 INFO - Running setup.py (path:/tmp/pip-GY0Y0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:57 INFO - Running setup.py (path:/tmp/pip-DTxEE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:57 INFO - Running setup.py (path:/tmp/pip-9czZh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:57 INFO - Running setup.py (path:/tmp/pip-hsGE0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:57 INFO - Running setup.py (path:/tmp/pip-OpdmHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:57 INFO - Running setup.py (path:/tmp/pip-lb1266-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:57 INFO - Running setup.py (path:/tmp/pip-1PxIYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:57 INFO - Running setup.py (path:/tmp/pip-8uwCTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:18:58 INFO - Running setup.py install for manifestparser 03:18:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Running setup.py install for mozcrash 03:18:58 INFO - Running setup.py install for mozdebug 03:18:58 INFO - Running setup.py install for mozdevice 03:18:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Running setup.py install for mozfile 03:18:58 INFO - Running setup.py install for mozhttpd 03:18:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Running setup.py install for mozinfo 03:18:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Running setup.py install for mozInstall 03:18:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:18:58 INFO - Running setup.py install for mozleak 03:18:58 INFO - Running setup.py install for mozlog 03:18:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Running setup.py install for moznetwork 03:18:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Running setup.py install for mozprocess 03:18:59 INFO - Running setup.py install for mozprofile 03:18:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Running setup.py install for mozrunner 03:18:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Running setup.py install for mozscreenshot 03:18:59 INFO - Running setup.py install for moztest 03:18:59 INFO - Running setup.py install for mozversion 03:18:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:18:59 INFO - Cleaning up... 03:18:59 INFO - Return code: 0 03:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18: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')]} 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:59 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 0x25c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2792a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2935a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2939090>, '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 0x2939d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2933f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:59 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 03:18:59 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 03:18:59 INFO - Using env: {'DISPLAY': ':0', 03:18:59 INFO - 'HOME': '/home/cltbld', 03:18:59 INFO - 'LANG': 'en_US.UTF-8', 03:18:59 INFO - 'LANGUAGE': 'en_US:en', 03:18:59 INFO - 'LOGNAME': 'cltbld', 03:18:59 INFO - 'MAIL': '/var/mail/cltbld', 03:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:59 INFO - 'MOZ_NO_REMOTE': '1', 03:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:59 INFO - 'NO_EM_RESTART': '1', 03:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:59 INFO - 'PWD': '/builds/slave/test', 03:18:59 INFO - 'SHELL': '/bin/bash', 03:18:59 INFO - 'SHLVL': '1', 03:18:59 INFO - 'TERM': 'linux', 03:18:59 INFO - 'TMOUT': '86400', 03:18:59 INFO - 'USER': 'cltbld', 03:18:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:59 INFO - '_': '/tools/buildbot/bin/python'} 03:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:59 INFO - Running setup.py (path:/tmp/pip-DbzJUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:00 INFO - Running setup.py (path:/tmp/pip-dmuO7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:00 INFO - Running setup.py (path:/tmp/pip-HdObu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:00 INFO - Running setup.py (path:/tmp/pip-zRc4qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:00 INFO - Running setup.py (path:/tmp/pip-YskYy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:00 INFO - Running setup.py (path:/tmp/pip-IGCLOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:00 INFO - Running setup.py (path:/tmp/pip-mOvKS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:00 INFO - Running setup.py (path:/tmp/pip-t6Ar8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:00 INFO - Running setup.py (path:/tmp/pip-bncaLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:00 INFO - Running setup.py (path:/tmp/pip-MTrZTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:00 INFO - Running setup.py (path:/tmp/pip-UAZLSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:00 INFO - Running setup.py (path:/tmp/pip-hIupHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:00 INFO - Running setup.py (path:/tmp/pip-TTDwbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:00 INFO - Running setup.py (path:/tmp/pip-iv42nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:00 INFO - Running setup.py (path:/tmp/pip-7KlOe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:00 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)) 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:00 INFO - Running setup.py (path:/tmp/pip-l8TKrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:01 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)) 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:01 INFO - Running setup.py (path:/tmp/pip-DECvQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:01 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)) 03:19:01 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)) 03:19:01 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)) 03:19:01 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)) 03:19:01 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)) 03:19:01 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)) 03:19:01 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)) 03:19:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:03 INFO - Downloading blessings-1.6.tar.gz 03:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:03 INFO - Installing collected packages: blessings 03:19:03 INFO - Running setup.py install for blessings 03:19:03 INFO - Successfully installed blessings 03:19:03 INFO - Cleaning up... 03:19:03 INFO - Return code: 0 03:19:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:03 INFO - Reading from file tmpfile_stdout 03:19:03 INFO - Current package versions: 03:19:03 INFO - argparse == 1.2.1 03:19:03 INFO - blessings == 1.6 03:19:03 INFO - blobuploader == 1.2.4 03:19:03 INFO - docopt == 0.6.1 03:19:03 INFO - functools32 == 3.2.3-2 03:19:03 INFO - jsonschema == 2.5.1 03:19:03 INFO - manifestparser == 1.1 03:19:03 INFO - mozInstall == 1.13 03:19:03 INFO - mozcrash == 1.0 03:19:03 INFO - mozdebug == 0.1 03:19:03 INFO - mozdevice == 0.51 03:19:03 INFO - mozfile == 1.2 03:19:03 INFO - mozhttpd == 0.7 03:19:03 INFO - mozinfo == 0.10 03:19:03 INFO - mozleak == 0.1 03:19:03 INFO - mozlog == 3.5 03:19:03 INFO - moznetwork == 0.27 03:19:03 INFO - mozprocess == 0.25 03:19:03 INFO - mozprofile == 0.28 03:19:03 INFO - mozrunner == 6.13 03:19:03 INFO - mozscreenshot == 0.1 03:19:03 INFO - mozsystemmonitor == 0.3 03:19:03 INFO - moztest == 0.8 03:19:03 INFO - mozversion == 1.4 03:19:03 INFO - psutil == 3.1.1 03:19:03 INFO - requests == 1.2.3 03:19:03 INFO - wsgiref == 0.1.2 03:19:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:03 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 0x25c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2792a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2935a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2939090>, '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 0x2939d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2933f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:03 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 03:19:03 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 03:19:03 INFO - Using env: {'DISPLAY': ':0', 03:19:03 INFO - 'HOME': '/home/cltbld', 03:19:03 INFO - 'LANG': 'en_US.UTF-8', 03:19:03 INFO - 'LANGUAGE': 'en_US:en', 03:19:03 INFO - 'LOGNAME': 'cltbld', 03:19:03 INFO - 'MAIL': '/var/mail/cltbld', 03:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:03 INFO - 'MOZ_NO_REMOTE': '1', 03:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:03 INFO - 'NO_EM_RESTART': '1', 03:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:03 INFO - 'PWD': '/builds/slave/test', 03:19:03 INFO - 'SHELL': '/bin/bash', 03:19:03 INFO - 'SHLVL': '1', 03:19:03 INFO - 'TERM': 'linux', 03:19:03 INFO - 'TMOUT': '86400', 03:19:03 INFO - 'USER': 'cltbld', 03:19:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:03 INFO - '_': '/tools/buildbot/bin/python'} 03:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:03 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)) 03:19:03 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)) 03:19:03 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)) 03:19:03 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)) 03:19:03 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)) 03:19:03 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)) 03:19:03 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)) 03:19:03 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)) 03:19:03 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)) 03:19:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:19:05 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)) 03:19:05 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)) 03:19:05 INFO - Installing collected packages: simplejson 03:19:05 INFO - Running setup.py install for simplejson 03:19:05 INFO - building 'simplejson._speedups' extension 03:19:05 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 03:19:06 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 03:19:06 INFO - Successfully installed simplejson 03:19:06 INFO - Cleaning up... 03:19:06 INFO - Return code: 0 03:19:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:06 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 0x25c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2792a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2935a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2939090>, '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 0x2939d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2933f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:06 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 03:19:06 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 03:19:06 INFO - Using env: {'DISPLAY': ':0', 03:19:06 INFO - 'HOME': '/home/cltbld', 03:19:06 INFO - 'LANG': 'en_US.UTF-8', 03:19:06 INFO - 'LANGUAGE': 'en_US:en', 03:19:06 INFO - 'LOGNAME': 'cltbld', 03:19:06 INFO - 'MAIL': '/var/mail/cltbld', 03:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:06 INFO - 'MOZ_NO_REMOTE': '1', 03:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:06 INFO - 'NO_EM_RESTART': '1', 03:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:06 INFO - 'PWD': '/builds/slave/test', 03:19:06 INFO - 'SHELL': '/bin/bash', 03:19:06 INFO - 'SHLVL': '1', 03:19:06 INFO - 'TERM': 'linux', 03:19:06 INFO - 'TMOUT': '86400', 03:19:06 INFO - 'USER': 'cltbld', 03:19:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:06 INFO - '_': '/tools/buildbot/bin/python'} 03:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:19:06 INFO - Cleaning up... 03:19:06 INFO - Return code: 0 03:19:06 INFO - Running post-action listener: _resource_record_post_action 03:19:06 INFO - Running post-action listener: _start_resource_monitoring 03:19:06 INFO - Starting resource monitoring. 03:19:06 INFO - [mozharness: 2017-09-11 10:19:06.453639Z] Finished create-virtualenv step (success) 03:19:06 INFO - [mozharness: 2017-09-11 10:19:06.454574Z] Running install step. 03:19:06 INFO - Running pre-action listener: _resource_record_pre_action 03:19:06 INFO - Running main action method: install 03:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:06 INFO - Reading from file tmpfile_stdout 03:19:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:19:06 INFO - Reading from file tmpfile_stdout 03:19:06 INFO - Output received: 03:19:06 INFO - Usage: mozinstall [options] installer 03:19:06 INFO - Options: 03:19:06 INFO - -h, --help show this help message and exit 03:19:06 INFO - -d DEST, --destination=DEST 03:19:06 INFO - Directory to install application into. [default: 03:19:06 INFO - "/builds/slave/test"] 03:19:06 INFO - --app=APP Application being installed. [default: firefox] 03:19:06 INFO - mkdir: /builds/slave/test/build/application 03:19:06 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'] 03:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:19:23 INFO - Reading from file tmpfile_stdout 03:19:23 INFO - Output received: 03:19:23 INFO - /builds/slave/test/build/application/firefox/firefox 03:19:23 INFO - Running post-action listener: _resource_record_post_action 03:19:23 INFO - [mozharness: 2017-09-11 10:19:23.375405Z] Finished install step (success) 03:19:23 INFO - [mozharness: 2017-09-11 10:19:23.375627Z] Running setup-mitmproxy step. 03:19:23 INFO - Running pre-action listener: _resource_record_pre_action 03:19:23 INFO - Running main action method: setup_mitmproxy 03:19:23 INFO - Skipping: mitmproxy is not required 03:19:23 INFO - Running post-action listener: _resource_record_post_action 03:19:23 INFO - [mozharness: 2017-09-11 10:19:23.376164Z] Finished setup-mitmproxy step (success) 03:19:23 INFO - [mozharness: 2017-09-11 10:19:23.376284Z] Running run-tests step. 03:19:23 INFO - Running pre-action listener: _resource_record_pre_action 03:19:23 INFO - Running pre-action listener: _set_gcov_prefix 03:19:23 INFO - Running main action method: run_tests 03:19:23 WARNING - Try message not found. 03:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:19:23 INFO - Python 2.7.3 03:19:23 INFO - Return code: 0 03:19:23 INFO - grabbing minidump binary from tooltool 03:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:23 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 0x2939090>, '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 0x2939d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2933f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:19:23 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 03:19:23 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 03:19:23 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 03:19:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:23 INFO - Return code: 0 03:19:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:19:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:19:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:19:23 INFO - ENV: RUST_BACKTRACE is now full 03:19:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:19:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:19:23 INFO - Using env: {'DISPLAY': ':0', 03:19:23 INFO - 'HOME': '/home/cltbld', 03:19:23 INFO - 'LANG': 'en_US.UTF-8', 03:19:23 INFO - 'LANGUAGE': 'en_US:en', 03:19:23 INFO - 'LOGNAME': 'cltbld', 03:19:23 INFO - 'MAIL': '/var/mail/cltbld', 03:19:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:23 INFO - 'MOZ_ACCELERATED': '1', 03:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:23 INFO - 'MOZ_NO_REMOTE': '1', 03:19:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:23 INFO - 'MOZ_WEBRENDER': '1', 03:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:23 INFO - 'NO_EM_RESTART': '1', 03:19:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:23 INFO - 'PWD': '/builds/slave/test', 03:19:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:23 INFO - 'RUST_BACKTRACE': 'full', 03:19:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:19:23 INFO - 'SHELL': '/bin/bash', 03:19:23 INFO - 'SHLVL': '1', 03:19:23 INFO - 'TERM': 'linux', 03:19:23 INFO - 'TMOUT': '86400', 03:19:23 INFO - 'USER': 'cltbld', 03:19:23 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:23 INFO - '_': '/tools/buildbot/bin/python'} 03:19:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:19:23 INFO - mozversion application_buildid: 20170911091903 03:19:23 INFO - mozversion application_changeset: f9a5e9ed62103c84e4cde915f4d08f1ce71be83e 03:19:23 INFO - mozversion application_display_name: Nightly 03:19:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:23 INFO - mozversion application_name: Firefox 03:19:23 INFO - mozversion application_remotingname: firefox 03:19:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:19:23 INFO - mozversion application_vendor: Mozilla 03:19:23 INFO - mozversion application_version: 57.0a1 03:19:23 INFO - mozversion platform_buildid: 20170911091903 03:19:23 INFO - mozversion platform_changeset: f9a5e9ed62103c84e4cde915f4d08f1ce71be83e 03:19:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:19:23 INFO - mozversion platform_version: 57.0a1 03:19:23 INFO - using testdate: 1505125163 03:19:23 INFO - actual date: 1505125163 03:19:23 INFO - starting webserver on 'localhost:44350' 03:19:23 INFO - SUITE-START | Running 2 tests 03:19:23 INFO - TEST-START | dromaeo_css 03:19:23 INFO - Initialising browser for dromaeo_css test... 03:19:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44350/getInfo.html -profile /tmp/tmp6nMCfU/profile 03:19:23 INFO - TEST-INFO | started process 3545 (/builds/slave/test/build/application/firefox/firefox http://localhost:44350/getInfo.html) 03:19:33 INFO - TEST-INFO | 3545: exit 0 03:19:33 INFO - Browser initialized. 03:19:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:33 INFO - Using env: {'DISPLAY': ':0', 03:19:33 INFO - 'HOME': '/home/cltbld', 03:19:33 INFO - 'JSGC_DISABLE_POISONING': '1', 03:19:33 INFO - 'LANG': 'en_US.UTF-8', 03:19:33 INFO - 'LANGUAGE': 'en_US:en', 03:19:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:19:33 INFO - 'LOGNAME': 'cltbld', 03:19:33 INFO - 'MAIL': '/var/mail/cltbld', 03:19:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:33 INFO - 'MOZ_ACCELERATED': '1', 03:19:33 INFO - 'MOZ_CRASHREPORTER': '1', 03:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:19:33 INFO - 'MOZ_NO_REMOTE': '1', 03:19:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:33 INFO - 'MOZ_WEBRENDER': '1', 03:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:33 INFO - 'NO_EM_RESTART': '1', 03:19:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:33 INFO - 'PWD': '/builds/slave/test', 03:19:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:33 INFO - 'RUST_BACKTRACE': 'full', 03:19:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:19:33 INFO - 'SHELL': '/bin/bash', 03:19:33 INFO - 'SHLVL': '1', 03:19:33 INFO - 'TERM': 'linux', 03:19:33 INFO - 'TMOUT': '86400', 03:19:33 INFO - 'USER': 'cltbld', 03:19:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:33 INFO - '_': '/tools/buildbot/bin/python'} 03:19:33 INFO - TEST-INFO | started process 3757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6nMCfU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:34 INFO - PID 3757 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:19:34 INFO - PID 3757 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:19:34 INFO - PID 3757 | 03:19:34 INFO - PID 3757 | (/builds/slave/test/build/application/firefox/firefox:3819): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:19:34 INFO - PID 3757 | 03:19:44 INFO - PID 3757 | RSS: Main: 212475904 03:19:44 INFO - PID 3757 | 03:22:42 INFO - PID 3757 | Cycle 1(1): loaded http://localhost:44350/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44350/tests/dromaeo/cssquery-ext.html) 03:22:43 INFO - PID 3757 | RSS: Main: 218763264 03:22:43 INFO - PID 3757 | 03:25:46 INFO - PID 3757 | Cycle 1(1): loaded http://localhost:44350/tests/dromaeo/cssquery-ext.html (next: http://localhost:44350/tests/dromaeo/cssquery-jquery.html) 03:25:46 INFO - PID 3757 | RSS: Main: 221011968 03:25:46 INFO - PID 3757 | 03:28:48 INFO - PID 3757 | Cycle 1(1): loaded http://localhost:44350/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44350/tests/dromaeo/cssquery-mootools.html) 03:28:49 INFO - PID 3757 | RSS: Main: 223621120 03:28:49 INFO - PID 3757 | 03:31:51 INFO - PID 3757 | Cycle 1(1): loaded http://localhost:44350/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44350/tests/dromaeo/cssquery-prototype.html) 03:31:52 INFO - PID 3757 | RSS: Main: 219578368 03:31:52 INFO - PID 3757 | 03:34:55 INFO - PID 3757 | Cycle 1(1): loaded http://localhost:44350/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44350/tests/dromaeo/cssquery-yui.html) 03:34:56 INFO - PID 3757 | RSS: Main: 224079872 03:34:56 INFO - PID 3757 | 03:37:58 INFO - PID 3757 | Cycle 1(1): loaded http://localhost:44350/tests/dromaeo/cssquery-yui.html (next: http://localhost:44350/tests/dromaeo/cssquery-dojo.html) 03:37:58 INFO - PID 3757 | RSS: Main: 220835840 03:37:58 INFO - PID 3757 | 03:37:58 INFO - PID 3757 | __start_tp_report 03:37:58 INFO - PID 3757 | _x_x_mozilla_page_load 03:37:58 INFO - PID 3757 | _x_x_mozilla_page_load_details 03:37:58 INFO - PID 3757 | |i|pagename|runs| 03:37:58 INFO - PID 3757 | |0;dojo.html;3087.907362779116;3101.1626860747597;3108.4094022135796;3125.2655625927887;3131;6128.601640893339;6237.189165408497;6272.435480806726;6284.308726040132;6318.431341179305;6182.1963144791225;6224.470919971808;6224.7510099596075;6235.968820155893;6258.561900666955;5692.629979051369;5720.713964301789;5735.08238681811;5744.79893203738;5797.942020579803;5789.363170051291;5797;5800.4489573490455;5839.9124013139835;5925.229720136376;5809.9709501452435;5840.912386314209;5844.941550584483;5926.051831706928;5937.37657545958;5524;5633.8309850704545;5661.575381846378;5815.982203114438;5836.474717275423;5679.062954612484;5706.80026199081;5716.828495145152;5726.5418766499;5729.169270455803;6082.2093127893095;6121.3572574879445;6201.255849298068;6224.221972253468;6298.118263443122;6396.200474940632;6500.902486462707;6531.673416329212;6656.234533028715;6715.832104197434;6807.149106361705;6828.112345395117;6828.146481689789;6842.931570684279;6855.07456493372;6258;6327.683615819191;6333.904991425133;6338.6196828189995;6345.904811427832;6906.827329316707;6914.585124892422;6915.585064896122;6990.895136572955;6998.510104292753;6453.548251622341;6453.774117905851;6498.155239818793;6518.250401203827;6671.532992690465;6503.8699226015215;6608.900866487006;6705.530612857053;6758.560693554903;6785.728570857209;6706.128203333633;6706.865862682816;6744.393004629607;6748.595084294958;6769.323067693192;6641.833954151185;6708.563943343765;6718.630475323904;6804.08144900442;6815.863682726318;5120;5242.68543887368;5308.442613525602;5317.813876514303;5326.147816349366;4525.886852828639;4579.267317229294;4626.306054091913;4627.930581041287;4643.373144625432;5779.739911703983;5797;5801.680907550125;5817.650940943557;5818.5054270386645;6690.899636505456;6698.263191048981;6778.72885084601;6789.592624442549;6796.388325050769;5716.056850619684;5755.223044888887;5761;5797.188393624896;5821.039528477754;5639.887202255932;5731.312242530839;5769.53843692512;5811.128330750421;5820.126980952807;6543.083968244449;6543.770968016097;6557.049227861933;6582.736690532421;6587.505937054644;6644.568103073285;6661.533692641468;6669.533132680665;6748.93251067483;6750.3924646782025;6369.331220221995;6390.648514331757;6469.159009328757;6474.902876456763;6480.8703825922275;6296.307406185408;6369.14016607752;6408.070829729756;6466.902996455151;6467.579607325509;6599.977003564455;6717.16035495563;6790.151231096113;6797.1843378794865;6818.386345228953;6484.059811327425;6598.406143447113;6603.141591593254;6606.8348291293105;6607.240167380813;6460;6496.187976502937;6501.837454063686;6530.379613936669;6584.111144995556;6259.1550140730415;6401.615903045832;6477.1579694639395;6488.772892948913;6490.902636460552;6468.997305417668;6525.282218956006;6608.041833933957;6615.569987950767;6641.601503909781;6302.212223472066;6306.054091886253;6312.179416675803;6393.2647745508;6407.199100112486 03:37:58 INFO - PID 3757 | |1;ext.html;816.7917181118816;859.7377799771075;862.3144600042965;863.8876945997023;871.5903525343086;38035.80982095089;41314.17371652573;41710;41742.37386439206;41843.37234941474;38829.611703882954;39105.80447097767;39109.21781564367;39174.60825391745;39402.408963865564;7012.649367531629;7113.181984071821;7125.89311160333;7129.465290103237;7177.102862142232;7254.27457254273;7768.300852923236;7770.9222907771045;7792.064952205743;7809.492382995116;7794.727184548542;7821.21787821219;7830.725924592641;7837.843243135134;7848.018997625297;7725.111612164589;7775.455718099735;7782.533048017081;7800.570968596725;7807.258310460497;7686;7741.8451630967065;7742.303192712683;7748.457607967444;7756.224377562255;38580;38926.02684932871;38943;38978.61021389778;39084.80457597694;3505.8948231553095;3541.6635419635095;3543.344481270973;3545.9290814183573;3547.2373439710327;31174.376512469622;31367.372652546823;31368;31541.526877096632;31561.21096972571;4946.8763280918265;5100.132977393815;5123.564497017758;5135.152699804527;5143.8456846294675;181887;181979.09010454864;183703.08148459307;184456;184705;47998.760006199744;48013;48040;48065.5193448068;48109.27836082462;43218.351724724154;44188.116237675065;51409.74295128501;52160.21759673608;52163.47836521662;15535.378584856706;15637.530874073796;15639.530814075595;15641.530754077168;15658.608534786494;12370.44333005017;12520.561780337826;12605.243685378906;12629.052821038458;12654.240745555297;14416.639584010274;14427.062240954514;14451.78322325166;14467.131972081708;14569.125852448888;5716.857078573069;5803.361630220672;5849.011336145731;5862.530997520274;5872.500837428781;997.8602995580625;1002.5989604158249;1003.4330603209163;1024.6516184497157;1026.9281150319405;22642.43393915165;22672.433189170402;22716.65925011126;22842.42893927632;22884.65673014906;1105.9944700276446;1118.5861231344454;1118.888111188891;1121.2151493954264;1121.5738019552518;11855.940720296343;11865.644030679094;11913.16607837443;11924.642260732191;12075.215111017756;218738;219678;220386;220511;220929;52129.2180617291;52160;52173.73913130486;52260.47739522632;52532;1425.230375597166;1445.2051371745708;1450.572081236038;1452.0416525093387;1460.189594774889;22145.446363841034;22353.217637382615;22442.551148976603;22693.092276309424;23004.539909202056;35916.28167436584;36045.45931810972;36163.638363616024;36303;36480.635193648784;191572;193443;193514.03242983695;194094;194882;30294.84852575723;30637.846810765805;30938;31071;33148.834255828566;37221;42041;42454;42561.78719106385;43415;31335.84332078325;31446.52830207503;31745.5238171423;31786;32203.677963220067;31019.224519387197;31032;31334.529982049833;31448.68551314549;31604;35660.28679426449;35661.465078023335;35731.285374291845;35858.64141358553;36123.81938090398;30447.54328685116;30645;30901.69098308988;30913.381732364778;30953;22363.44091397728;22756.20353287627;22775;23165.88417057904;23266.883665581565 03:37:58 INFO - PID 3757 | |2;jquery.html;549.4395716369306;559.3092530724557;563.6139244617437;563.873128546077;570.3498012266015;21227.363179104614;21808.781912180875;21973.780262197393;22144.114235430585;22155.224567140114;23565.46824456409;23791.405214869636;24235.757642423614;24271;24340.634890476656;6385.904211436832;6550.574212676184;6612.404883560479;6615.735370585171;6625.370589793986;6501.7724379646725;6593.934060659404;6611.603303801763;6616.338366163393;6628.767993120242;6238.220222472191;6521.608703477783;6521.967390163042;6549.410553050225;6583.4074933256;6449.54853160279;6511.186101737283;6516.250631177404;6518.543701940866;6519.9674001630165;5838.737256823453;6047.485963693091;6058.909116363258;6064.332923378425;6080.787172448987;28480;28819.855900720573;28903.42193156125;29016.27459313513;29041.41917161666;2039.8062184092487;2055.5683306505653;2076.179908935962;2077.9376618701463;2080.4694802825334;19332.806671933242;19495.512612184666;19981.600367992705;20002.299919502893;20051.899740501205;2476.5418397596504;2492.9002839886384;2505.9749402506104;2513.6229565565127;2521.1050077222503;121214;127330.99999999907;129713;135265.61835954082;137187;14459.08391147015;14553.708925821424;14615.269236538343;14825.258737063104;15003.249837508081;22775.772242277697;22954.19660311881;23007;23022.884885575466;23162.420939476648;9636.132748052709;9987.300888937705;10042.14641755459;10086.596536138471;10157.898421015843;9169.40398874071;9225.907740922505;9308.90691093094;9309.069093090773;9360.391574547633;9029.961554421194;9047.411918225294;9207.309451791143;9228.354015219005;9371.718848434557;2589.3138318345655;2604.960925586118;2643.0177366974767;2677.8125531212627;2685.1273336165823;935.5836652689624;947.5925352098526;962.4898803634085;981.1611072533025;983.1937810995058;18837.340693075676;19100.426987190127;19127.23491060342;19271.036448177536;19313.61372772565;1020.6682828080903;1022.2792930983638;1023.9129673977646;1034.3483605328595;1038.7351225437617;10643.733906652396;10687.946560267148;10736.73158171052;10848.620298289521;10990.753762829452;415589;435273;444545;449483;450646;109372;112024;113453;114455.42772286086;114480;991.2862738828032;1037.4812593703148;1115.0856297835696;1137.8293256011664;1142.948567314456;20200.696989544875;20238.696419553424;20316.695249571563;20320.695189571874;20584.073716682487;55185;57169.85660286854;57244;57644.423555763904;57815.421845781006;64821.67589162024;67512.6624366875;67646;68356.31643683699;69184.65407673131;13834.169949803045;14158.929205353907;14180.858191417954;14194.858051419353;14199.64500887486;21656.133754649636;22257.332280031624;22511.437214069778;22612.547749045258;22712.886435567718;17886.910565447088;18185.45443636693;18205.908970455064;18286.542836429195;18320.908395457936;15592.298346574658;15968.441104561749;16210.594735131715;16457;16703.91648041752;18201.362952296608;18228.81771182324;18370.816291837444;18384.908075460073;18477.445676629723;13276.468941242241;13730.45078196901;13912.652183695489;13939.930300348433;13944.930275348559;15849.841501585297;17792.11039448048;17813.73279400784;17875.73186402179;17968.281268749102 03:37:58 INFO - PID 3757 | |3;mootools.html;1288.8388951381078;1348.4538761801473;1362.6593351662082;1366.2690460603567;1375.7042235919275;14922.328495217715;15463;15566.299516521756;15578.610534736637;15581.376744930203;15327.233638318095;15441.382344706199;15449;15471.845281547181;15485.070895746263;2733.7676297514636;2758;2801.6918139004692;2803.4393121375706;2807.719228077186;2717.1731339385515;2792.4833905727405;2795.4409118176345;2804.747572718455;2812.4656315300026;2738.5070687276284;2742.122520793347;2825.6891741908375;2861.241770930705;2861.4277144571065;2754.807163498556;2763.77889768818;2778.652668416448;2811.1988083396136;2822.6048353230562;2738.3564862257354;2739.315171207198;2747.3406382468265;2754.559270516708;2756.8897244110212;14963.177025263607;15362.30869610859;15446.5366039019;15455.845441545553;15492.147931863743;7992.800179995488;8226;8284.875726864102;8303.584820758937;8311.91945047146;5123.795048198068;5210.817621383233;5247.816326428557;5354.3574771027725;5360.517553420211;1830.103249407794;1854.7959724430302;1872.981270187308;1905.7427247321573;1907.3515004898263;23928.521429571487;24705.87647061753;25311.62032569513;26076.60885086725;26102.216933492025;6520.250171230275;6658.966705166443;6710.328967103251;6717.664116794141;6727.360900714424;17180.570485737957;17313.7402938956;17387.130643467775;17469.47591572255;17583.29666813313;7606.619669016527;7694.345980591713;7715.267049630276;7757.534547927143;7869.252421019994;7189.676464559107;7205.89191162133;7239.963800180965;7287.963560182271;7352.669129889167;4925.1381008324115;5010.24641375523;5039.4708555601865;5044.9495505045215;5087.3386459759995;1388.430743395203;1396.8742813146662;1404.2557444554197;1414.2645824171373;1418.6098822823599;871.289898732531;885.9955700221586;896.6727144592177;910.8360495110944;920.8756817829641;7244.203137654854;7378.335949764547;7386.0767404074495;7402.629868506553;7412.629368531552;704.3625518905399;711.6121713666064;717.5371885134059;719.8668246374333;725.7351066860664;5273.736313184402;5300.655457395257;5365.248865158881;5443.428440013741;5559.332880054339;21068.683969740465;21301.254456093964;21511.35465935993;21844.89077554602;21872.781272187392;20557;21191.576168476546;21379.358619241135;21398.78601213999;21641.134354625952;10233;10422.270441069204;10428.217883658755;10544.947275263574;10565.366078035342;8353.373496987871;8398.328133749163;8441.87337189955;8500.872486912825;8673.653053878026;17768.200430980894;18354.265829366675;18382.816171838644;18581.90709046446;18767.249310027444;18875.62248755045;19136.71294930605;19377.70933436028;19490.90254548718;19717.901410492857;10926.890731092588;11098.61154859576;11128.721781955515;11145.888541114486;11149.94425027902;13853.099548529313;13944.721105578035;13959.232242226775;14178.787318190442;14316.57050288493;11022.834657479983;11310.377929213972;11512.963833255048;11623;11623.5350585979;10972.451377431256;11412.258203216765;11438.656840294805;11459.48432320531;11497.310161390344;9360.53197340144;9390.95304523473;9436.292278079034;9563.904360956301;9565.04349565038;6803.421709154777;7017.3684368407085;7182.922561615799;7185.101862267216;7370.77887663371;6911.824989751854;6920.58476491392;6933.861322773617;6941.409980151744;6960.37356637905 03:37:58 INFO - PID 3757 | |4;prototype.html;476.79974410747485;501.76417083970523;508.3823154866836;515.5231410944875;525.5165247971867;6069.60547564408;6124.142620033193;6161.29145148307;6199.287081985573;6222.284437289713;5967.970160149204;6034.517238620911;6040;6040.909386359197;6077.24034495688;5025.497450254982;5026.2209357549455;5049.889024414623;5056.999999999991;5074.594032477393;4649.558291962275;4964.87587810304;4980.477049909761;5042.974785126087;5086.31334769805;4768.73771942543;4808.927866082012;4826.638002149835;4827.903441931159;4831.516848315158;4804.543568361;4816.205326121186;4841.346418233528;4851.563359297645;4871.4154301483695;4251.532331443539;4297.140571885604;4318.309070548728;4323.627570494988;4324.437823083011;5829.446202610745;5880.26496687914;5880.4119588041285;5917.704114794286;5954.374790646963;5478.561715062785;5510.779568817243;5539.833804985817;5551.111822108443;5584.804531841407;6312.779052733178;6324.430801227865;6347.746090156388;6448.677566121675;6472.838179045514;4536.457604414515;4638.11875743611;4687.859364219079;4715.31627913954;4727.45634252062;6532.444742196919;6542.574732642411;6610.570312929644;6734.629595372302;6768.69540870662;4821.228603423436;4880.780364883518;4903.656744027884;4905.730184839868;4931.211006238985;4854.8786280342565;4927.236278376858;4961.875953101201;4975.577075948512;4986.551210391082;5495.53287970527;5499.780008799603;5565.910919439669;5570.916436253459;5599;6384.872302553923;6467.838304042342;6483.675816209171;6501.1548498694865;6533.085368048477;1710.153474030363;1718.0121430177448;1726.8273172682632;1727.3004433204571;1729.8183690712547;1124.8312753086939;1180.4805885410392;1192.8330033795276;1208.4139192491634;1213.7390461050916;5512.944870551323;5579.9163012554845;5588.764494202352;5607;5638.210650508932;6501.44737697301;6535.803925882231;6538.967305163444;6572.8356791080605;6614.305497922745;5555.472230138131;5555.833325000256;5572.916406253909;5631.605787594911;5677.886442271131;3441.466572681188;3461.7749846259912;3470.4620783778555;3485.233248685285;3526.2418580005424;6262.780802671976;6275.748970041239;6281.371862813682;6312.936870631235;6369.9681501592195;6698.363655452724;6709.765158219537;6768.627725475146;6800;6835.624040677811;6182.659953702409;6336.52476064297;6338.112664227012;6347.301796802348;6360.77737279193;6519.706613202323;6549.901751473636;6561.967190164019;6630.270670226175;6635.767748128792;5995;6385.553011289165;6476.838079047873;6494.3505649436565;6511.153550038464;6232.906506402317;6238.532110091671;6280.4152968332455;6285.622862628257;6393.776217832539;4827.879303017312;4844.449776071623;4875.463698993179;4880.145974454527;4886.315915771866;6333.936660633519;6534.8366290843105;6568.540202185801;6582.473402127914;6592.604443733391;6098.512119030378;6293.339199383999;6346.9682651586445;6372.617642941438;6384.201974753156;6250;6294.71673774672;6320.968395157995;6328.746850125944;6390.456811171102;6119.877602448015;6171.3828617139725;6188.721507532082;6201.751929922933;6234.563580549499;6331.303556608861;6360.872782544231;6420.422162005442;6430.164078669743;6437.774677886251;6034.818955431344;6113.388661134029;6215.906761398493;6229.56393052482;6245.500359971101 03:37:58 INFO - PID 3757 | |5;yui.html;895.4761464543243;899.5906862377615;911.4895658431279;920.3695468604003;921.7004473546098;19007.52481187969;19789.901050494744;19816.801831981677;19881;19941.202351905926;17689.82310176898;17762.73355899659;17850.64298714025;17857.91071044643;17864;938.2353381993653;938.3572253006712;939.8402271613808;941.087145468894;941.3034354577632;949.3496954586096;951.3435729346728;951.6859436385976;952.1192896570644;955.5461155950902;978.7014960437064;1012.6607586458508;1017.3997341568473;1018.399144504742;1035.4201647077623;1022.9846552301722;1026.1021606094666;1026.825439675257;1027.024326889458;1027.8201314769922;706.3466293678327;750.8498300339954;750.9861686722935;751.6579956119953;753.5666991479866;19131.617367652707;19271.51821204481;19304.903475482533;19341.4197574073;19344.80655193444;20943.266985655428;20949.47626309339;21346.679799803016;21414.678779818158;21631.351059468085;16474.258658360282;16704.83295167045;16846.915765421218;16925.3229870805;17088.487345379657;3757.2861156380472;3762.529683789526;3765.830537625786;3765.9435108473394;3769.1142581493327;105627.47186264019;117493;132131;133364;135946;16988.49034528966;17144.65710685804;17243.74134387985;17414.216360263817;17496.737548936777;30625.693743062286;30898.691013090032;30899.227519312197;30941.535876961865;31146.532802007987;8245.587720613945;8536.146385361415;8553.272971797342;8595.742127736054;8605.053444121142;4328.415663885398;4396.538363471854;4404.273294906368;4406.140802543538;4410.5368936261875;5264;5380.031594312983;5450.482204190595;5485.424030476823;5505.256790333334;1000.3547711725896;1026.820306446369;1027.1320733979776;1035.7410647338165;1036.4921188617523;669.2370697404962;673.5251647588439;693.3066933066933;698.7833771530842;700.0689083518907;12105.959603525363;12150.54193496786;12255.448504817305;12391.814122788166;12468.314242716557;654.2247436787422;657.7138944559132;660.7687309441753;665.0821865825227;670.6546128743701;5743.712814359265;5888.587798854125;5892.145638882338;5919.112133180058;5950.077737950624;114431;117306;118432;120283;126413;103815;103882.48058759658;105893;107722;107890;87268;87403;87589;89392;91150.54424727833;10623;10830.241883068109;10837.078848297982;10884.945575272073;11039.061679757311;42124.368134478624;42197;42666;42754.572454276306;43749.78125109354;52190.47809521856;52434.47565524449;52701.7364913173;53005.7349713249;54384.45615543952;14344.713105738036;14467.638309042359;14679.19264440466;14703.852961470247;14786.926065370035;17829.197686103897;17881.46355609334;17901.10494475297;17972.910135449238;18052.909735451238;14758.262086895827;14832.851671483579;14854.925725371304;14873.553793386216;15096.54710358691;16144.515664530083;16198.595035123744;16348.182590870647;16396.016239025696;16633.3346666132;16365.445282698125;16584.336626534805;16640.75038874442;16651.000939943642;16801;11443.828342574701;11724.120690948384;11761.235519691192;11798;11804.409779511161;11672.299662020307;11767.235129716884;11883.702907427383;11911.166218364979;12005.81991270149 03:37:58 INFO - PID 3757 | __end_tp_report 03:37:58 INFO - PID 3757 | __start_cc_report 03:37:58 INFO - PID 3757 | _x_x_mozilla_cycle_collect,346 03:37:58 INFO - PID 3757 | __end_cc_report 03:37:58 INFO - PID 3757 | __startTimestamp1505126278508__endTimestamp 03:37:58 INFO - PID 3757 | 03:37:58 INFO - PID 3757 | ------- Summary: start ------- 03:37:58 INFO - PID 3757 | Number of tests: 6 03:37:58 INFO - PID 3757 | 03:37:58 INFO - PID 3757 | [#0] dojo.html Cycles:165 Average:6156.24 Median:6390.65 stddev:741.96 (11.6%) stddev-sans-first:704.11 03:37:58 INFO - PID 3757 | Values: 3087.9 3101.2 3108.4 3125.3 3131.0 6128.6 6237.2 6272.4 6284.3 6318.4 6182.2 6224.5 6224.8 6236.0 6258.6 5692.6 5720.7 5735.1 5744.8 5797.9 5789.4 5797.0 5800.4 5839.9 5925.2 5810.0 5840.9 5844.9 5926.1 5937.4 5524.0 5633.8 5661.6 5816.0 5836.5 5679.1 5706.8 5716.8 5726.5 5729.2 6082.2 6121.4 6201.3 6224.2 6298.1 6396.2 6500.9 6531.7 6656.2 6715.8 6807.1 6828.1 6828.1 6842.9 6855.1 6258.0 6327.7 6333.9 6338.6 6345.9 6906.8 6914.6 6915.6 6990.9 6998.5 6453.5 6453.8 6498.2 6518.3 6671.5 6503.9 6608.9 6705.5 6758.6 6785.7 6706.1 6706.9 6744.4 6748.6 6769.3 6641.8 6708.6 6718.6 6804.1 6815.9 5120.0 5242.7 5308.4 5317.8 5326.1 4525.9 4579.3 4626.3 4627.9 4643.4 5779.7 5797.0 5801.7 5817.7 5818.5 6690.9 6698.3 6778.7 6789.6 6796.4 5716.1 5755.2 5761.0 5797.2 5821.0 5639.9 5731.3 5769.5 5811.1 5820.1 6543.1 6543.8 6557.0 6582.7 6587.5 6644.6 6661.5 6669.5 6748.9 6750.4 6369.3 6390.6 6469.2 6474.9 6480.9 6296.3 6369.1 6408.1 6466.9 6467.6 6600.0 6717.2 6790.2 6797.2 6818.4 6484.1 6598.4 6603.1 6606.8 6607.2 6460.0 6496.2 6501.8 6530.4 6584.1 6259.2 6401.6 6477.2 6488.8 6490.9 6469.0 6525.3 6608.0 6615.6 6641.6 6302.2 6306.1 6312.2 6393.3 6407.2 03:37:58 INFO - PID 3757 | 03:37:58 INFO - PID 3757 | [#1] ext.html Cycles:180 Average:36511.43 Median:3542.50 stddev:51653.52 (1458.1%) stddev-sans-first:51728.88 03:37:58 INFO - PID 3757 | Values: 816.8 859.7 862.3 863.9 871.6 38035.8 41314.2 41710.0 41742.4 41843.4 38829.6 39105.8 39109.2 39174.6 39402.4 7012.6 7113.2 7125.9 7129.5 7177.1 7254.3 7768.3 7770.9 7792.1 7809.5 7794.7 7821.2 7830.7 7837.8 7848.0 7725.1 7775.5 7782.5 7800.6 7807.3 7686.0 7741.8 7742.3 7748.5 7756.2 38580.0 38926.0 38943.0 38978.6 39084.8 3505.9 3541.7 3543.3 3545.9 3547.2 31174.4 31367.4 31368.0 31541.5 31561.2 4946.9 5100.1 5123.6 5135.2 5143.8 181887.0 181979.1 183703.1 184456.0 184705.0 47998.8 48013.0 48040.0 48065.5 48109.3 43218.4 44188.1 51409.7 52160.2 52163.5 15535.4 15637.5 15639.5 15641.5 15658.6 12370.4 12520.6 12605.2 12629.1 12654.2 14416.6 14427.1 14451.8 14467.1 14569.1 5716.9 5803.4 5849.0 5862.5 5872.5 997.9 1002.6 1003.4 1024.7 1026.9 22642.4 22672.4 22716.7 22842.4 22884.7 1106.0 1118.6 1118.9 1121.2 1121.6 11855.9 11865.6 11913.2 11924.6 12075.2 218738.0 219678.0 220386.0 220511.0 220929.0 52129.2 52160.0 52173.7 52260.5 52532.0 1425.2 1445.2 1450.6 1452.0 1460.2 22145.4 22353.2 22442.6 22693.1 23004.5 35916.3 36045.5 36163.6 36303.0 36480.6 191572.0 193443.0 193514.0 194094.0 194882.0 30294.8 30637.8 30938.0 31071.0 33148.8 37221.0 42041.0 42454.0 42561.8 43415.0 31335.8 31446.5 31745.5 31786.0 32203.7 31019.2 31032.0 31334.5 31448.7 31604.0 35660.3 35661.5 35731.3 35858.6 36123.8 30447.5 30645.0 30901.7 30913.4 30953.0 22363.4 22756.2 22775.0 23165.9 23266.9 03:37:58 INFO - PID 3757 | 03:37:58 INFO - PID 3757 | [#2] jquery.html Cycles:180 Average:32799.47 Median:22662.72 stddev:74423.56 (328.4%) stddev-sans-first:74592.94 03:37:58 INFO - PID 3757 | Values: 549.4 559.3 563.6 563.9 570.3 21227.4 21808.8 21973.8 22144.1 22155.2 23565.5 23791.4 24235.8 24271.0 24340.6 6385.9 6550.6 6612.4 6615.7 6625.4 6501.8 6593.9 6611.6 6616.3 6628.8 6238.2 6521.6 6522.0 6549.4 6583.4 6449.5 6511.2 6516.3 6518.5 6520.0 5838.7 6047.5 6058.9 6064.3 6080.8 28480.0 28819.9 28903.4 29016.3 29041.4 2039.8 2055.6 2076.2 2077.9 2080.5 19332.8 19495.5 19981.6 20002.3 20051.9 2476.5 2492.9 2506.0 2513.6 2521.1 121214.0 127331.0 129713.0 135265.6 137187.0 14459.1 14553.7 14615.3 14825.3 15003.2 22775.8 22954.2 23007.0 23022.9 23162.4 9636.1 9987.3 10042.1 10086.6 10157.9 9169.4 9225.9 9308.9 9309.1 9360.4 9030.0 9047.4 9207.3 9228.4 9371.7 2589.3 2605.0 2643.0 2677.8 2685.1 935.6 947.6 962.5 981.2 983.2 18837.3 19100.4 19127.2 19271.0 19313.6 1020.7 1022.3 1023.9 1034.3 1038.7 10643.7 10687.9 10736.7 10848.6 10990.8 415589.0 435273.0 444545.0 449483.0 450646.0 109372.0 112024.0 113453.0 114455.4 114480.0 991.3 1037.5 1115.1 1137.8 1142.9 20200.7 20238.7 20316.7 20320.7 20584.1 55185.0 57169.9 57244.0 57644.4 57815.4 64821.7 67512.7 67646.0 68356.3 69184.7 13834.2 14158.9 14180.9 14194.9 14199.6 21656.1 22257.3 22511.4 22612.5 22712.9 17886.9 18185.5 18205.9 18286.5 18320.9 15592.3 15968.4 16210.6 16457.0 16703.9 18201.4 18228.8 18370.8 18384.9 18477.4 13276.5 13730.5 13912.7 13939.9 13944.9 15849.8 17792.1 17813.7 17875.7 17968.3 03:37:58 INFO - PID 3757 | 03:37:58 INFO - PID 3757 | [#3] mootools.html Cycles:180 Average:9240.19 Median:2744.73 stddev:6599.55 (240.4%) stddev-sans-first:6591.02 03:37:58 INFO - PID 3757 | Values: 1288.8 1348.5 1362.7 1366.3 1375.7 14922.3 15463.0 15566.3 15578.6 15581.4 15327.2 15441.4 15449.0 15471.8 15485.1 2733.8 2758.0 2801.7 2803.4 2807.7 2717.2 2792.5 2795.4 2804.7 2812.5 2738.5 2742.1 2825.7 2861.2 2861.4 2754.8 2763.8 2778.7 2811.2 2822.6 2738.4 2739.3 2747.3 2754.6 2756.9 14963.2 15362.3 15446.5 15455.8 15492.1 7992.8 8226.0 8284.9 8303.6 8311.9 5123.8 5210.8 5247.8 5354.4 5360.5 1830.1 1854.8 1873.0 1905.7 1907.4 23928.5 24705.9 25311.6 26076.6 26102.2 6520.3 6659.0 6710.3 6717.7 6727.4 17180.6 17313.7 17387.1 17469.5 17583.3 7606.6 7694.3 7715.3 7757.5 7869.3 7189.7 7205.9 7240.0 7288.0 7352.7 4925.1 5010.2 5039.5 5044.9 5087.3 1388.4 1396.9 1404.3 1414.3 1418.6 871.3 886.0 896.7 910.8 920.9 7244.2 7378.3 7386.1 7402.6 7412.6 704.4 711.6 717.5 719.9 725.7 5273.7 5300.7 5365.2 5443.4 5559.3 21068.7 21301.3 21511.4 21844.9 21872.8 20557.0 21191.6 21379.4 21398.8 21641.1 10233.0 10422.3 10428.2 10544.9 10565.4 8353.4 8398.3 8441.9 8500.9 8673.7 17768.2 18354.3 18382.8 18581.9 18767.2 18875.6 19136.7 19377.7 19490.9 19717.9 10926.9 11098.6 11128.7 11145.9 11149.9 13853.1 13944.7 13959.2 14178.8 14316.6 11022.8 11310.4 11513.0 11623.0 11623.5 10972.5 11412.3 11438.7 11459.5 11497.3 9360.5 9391.0 9436.3 9563.9 9565.0 6803.4 7017.4 7182.9 7185.1 7370.8 6911.8 6920.6 6933.9 6941.4 6960.4 03:37:58 INFO - PID 3757 | 03:37:58 INFO - PID 3757 | [#4] prototype.html Cycles:180 Average:5363.23 Median:5981.49 stddev:1500.37 (25.1%) stddev-sans-first:1459.06 03:37:58 INFO - PID 3757 | Values: 476.8 501.8 508.4 515.5 525.5 6069.6 6124.1 6161.3 6199.3 6222.3 5968.0 6034.5 6040.0 6040.9 6077.2 5025.5 5026.2 5049.9 5057.0 5074.6 4649.6 4964.9 4980.5 5043.0 5086.3 4768.7 4808.9 4826.6 4827.9 4831.5 4804.5 4816.2 4841.3 4851.6 4871.4 4251.5 4297.1 4318.3 4323.6 4324.4 5829.4 5880.3 5880.4 5917.7 5954.4 5478.6 5510.8 5539.8 5551.1 5584.8 6312.8 6324.4 6347.7 6448.7 6472.8 4536.5 4638.1 4687.9 4715.3 4727.5 6532.4 6542.6 6610.6 6734.6 6768.7 4821.2 4880.8 4903.7 4905.7 4931.2 4854.9 4927.2 4961.9 4975.6 4986.6 5495.5 5499.8 5565.9 5570.9 5599.0 6384.9 6467.8 6483.7 6501.2 6533.1 1710.2 1718.0 1726.8 1727.3 1729.8 1124.8 1180.5 1192.8 1208.4 1213.7 5512.9 5579.9 5588.8 5607.0 5638.2 6501.4 6535.8 6539.0 6572.8 6614.3 5555.5 5555.8 5572.9 5631.6 5677.9 3441.5 3461.8 3470.5 3485.2 3526.2 6262.8 6275.7 6281.4 6312.9 6370.0 6698.4 6709.8 6768.6 6800.0 6835.6 6182.7 6336.5 6338.1 6347.3 6360.8 6519.7 6549.9 6562.0 6630.3 6635.8 5995.0 6385.6 6476.8 6494.4 6511.2 6232.9 6238.5 6280.4 6285.6 6393.8 4827.9 4844.4 4875.5 4880.1 4886.3 6333.9 6534.8 6568.5 6582.5 6592.6 6098.5 6293.3 6347.0 6372.6 6384.2 6250.0 6294.7 6321.0 6328.7 6390.5 6119.9 6171.4 6188.7 6201.8 6234.6 6331.3 6360.9 6420.4 6430.2 6437.8 6034.8 6113.4 6215.9 6229.6 6245.5 03:37:58 INFO - PID 3757 | 03:37:58 INFO - PID 3757 | [#5] yui.html Cycles:180 Average:23340.80 Median:19201.57 stddev:33070.94 (172.2%) stddev-sans-first:33120.76 03:37:58 INFO - PID 3757 | Values: 895.5 899.6 911.5 920.4 921.7 19007.5 19789.9 19816.8 19881.0 19941.2 17689.8 17762.7 17850.6 17857.9 17864.0 938.2 938.4 939.8 941.1 941.3 949.3 951.3 951.7 952.1 955.5 978.7 1012.7 1017.4 1018.4 1035.4 1023.0 1026.1 1026.8 1027.0 1027.8 706.3 750.8 751.0 751.7 753.6 19131.6 19271.5 19304.9 19341.4 19344.8 20943.3 20949.5 21346.7 21414.7 21631.4 16474.3 16704.8 16846.9 16925.3 17088.5 3757.3 3762.5 3765.8 3765.9 3769.1 105627.5 117493.0 132131.0 133364.0 135946.0 16988.5 17144.7 17243.7 17414.2 17496.7 30625.7 30898.7 30899.2 30941.5 31146.5 8245.6 8536.1 8553.3 8595.7 8605.1 4328.4 4396.5 4404.3 4406.1 4410.5 5264.0 5380.0 5450.5 5485.4 5505.3 1000.4 1026.8 1027.1 1035.7 1036.5 669.2 673.5 693.3 698.8 700.1 12106.0 12150.5 12255.4 12391.8 12468.3 654.2 657.7 660.8 665.1 670.7 5743.7 5888.6 5892.1 5919.1 5950.1 114431.0 117306.0 118432.0 120283.0 126413.0 103815.0 103882.5 105893.0 107722.0 107890.0 87268.0 87403.0 87589.0 89392.0 91150.5 10623.0 10830.2 10837.1 10884.9 11039.1 42124.4 42197.0 42666.0 42754.6 43749.8 52190.5 52434.5 52701.7 53005.7 54384.5 14344.7 14467.6 14679.2 14703.9 14786.9 17829.2 17881.5 17901.1 17972.9 18052.9 14758.3 14832.9 14854.9 14873.6 15096.5 16144.5 16198.6 16348.2 16396.0 16633.3 16365.4 16584.3 16640.8 16651.0 16801.0 11443.8 11724.1 11761.2 11798.0 11804.4 11672.3 11767.2 11883.7 11911.2 12005.8 03:37:58 INFO - PID 3757 | -------- Summary: end -------- 03:37:58 INFO - PID 3757 | 03:37:59 INFO - TEST-INFO | 3757: exit 0 03:37:59 INFO - TEST-OK | dromaeo_css | took 1115664ms 03:37:59 INFO - TEST-START | kraken 03:37:59 INFO - Initialising browser for kraken test... 03:37:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44350/getInfo.html -profile /tmp/tmp7Mqqxo/profile 03:37:59 INFO - TEST-INFO | started process 4188 (/builds/slave/test/build/application/firefox/firefox http://localhost:44350/getInfo.html) 03:38:05 INFO - TEST-INFO | 4188: exit 0 03:38:05 INFO - Browser initialized. 03:38:05 INFO - Running cycle 1/1 for kraken test... 03:38:05 INFO - Using env: {'DISPLAY': ':0', 03:38:05 INFO - 'HOME': '/home/cltbld', 03:38:05 INFO - 'JSGC_DISABLE_POISONING': '1', 03:38:05 INFO - 'LANG': 'en_US.UTF-8', 03:38:05 INFO - 'LANGUAGE': 'en_US:en', 03:38:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:38:05 INFO - 'LOGNAME': 'cltbld', 03:38:05 INFO - 'MAIL': '/var/mail/cltbld', 03:38:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:38:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:38:05 INFO - 'MOZ_ACCELERATED': '1', 03:38:05 INFO - 'MOZ_CRASHREPORTER': '1', 03:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:38:05 INFO - 'MOZ_NO_REMOTE': '1', 03:38:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:38:05 INFO - 'MOZ_WEBRENDER': '1', 03:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:05 INFO - 'NO_EM_RESTART': '1', 03:38:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:05 INFO - 'PWD': '/builds/slave/test', 03:38:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:38:05 INFO - 'RUST_BACKTRACE': 'full', 03:38:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:38:05 INFO - 'SHELL': '/bin/bash', 03:38:05 INFO - 'SHLVL': '1', 03:38:05 INFO - 'TERM': 'linux', 03:38:05 INFO - 'TMOUT': '86400', 03:38:05 INFO - 'USER': 'cltbld', 03:38:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401', 03:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:05 INFO - '_': '/tools/buildbot/bin/python'} 03:38:05 INFO - TEST-INFO | started process 4394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Mqqxo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:06 INFO - PID 4394 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:38:06 INFO - PID 4394 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:38:06 INFO - PID 4394 | 03:38:06 INFO - PID 4394 | (/builds/slave/test/build/application/firefox/firefox:4456): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:38:06 INFO - PID 4394 | 03:38:17 INFO - PID 4394 | RSS: Main: 209072128 03:38:17 INFO - PID 4394 | 03:38:19 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44350/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:20 INFO - PID 4394 | RSS: Main: 215511040 03:38:20 INFO - PID 4394 | 03:38:23 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44350/tests/kraken/driver.html?testName=audio-dft) 03:38:24 INFO - PID 4394 | RSS: Main: 215203840 03:38:24 INFO - PID 4394 | 03:38:27 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44350/tests/kraken/driver.html?testName=audio-fft) 03:38:27 INFO - PID 4394 | RSS: Main: 210923520 03:38:27 INFO - PID 4394 | 03:38:30 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44350/tests/kraken/driver.html?testName=audio-oscillator) 03:38:30 INFO - PID 4394 | RSS: Main: 210984960 03:38:30 INFO - PID 4394 | 03:38:32 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44350/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:33 INFO - PID 4394 | RSS: Main: 212406272 03:38:33 INFO - PID 4394 | 03:38:36 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44350/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:37 INFO - PID 4394 | RSS: Main: 214171648 03:38:37 INFO - PID 4394 | 03:38:41 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44350/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:41 INFO - PID 4394 | RSS: Main: 212430848 03:38:41 INFO - PID 4394 | 03:38:44 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44350/tests/kraken/driver.html?testName=json-parse-financial) 03:38:45 INFO - PID 4394 | RSS: Main: 214749184 03:38:45 INFO - PID 4394 | 03:38:47 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44350/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:47 INFO - PID 4394 | RSS: Main: 214822912 03:38:47 INFO - PID 4394 | 03:38:49 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44350/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:50 INFO - PID 4394 | RSS: Main: 214065152 03:38:50 INFO - PID 4394 | 03:38:52 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44350/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:53 INFO - PID 4394 | RSS: Main: 214470656 03:38:53 INFO - PID 4394 | 03:38:55 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:56 INFO - PID 4394 | RSS: Main: 214966272 03:38:56 INFO - PID 4394 | 03:38:59 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:39:00 INFO - PID 4394 | RSS: Main: 215564288 03:39:00 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | Cycle 1(1): loaded http://localhost:44350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44350/tests/kraken/driver.html?testName=ai-astar) 03:39:02 INFO - PID 4394 | RSS: Main: 217247744 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | __start_tp_report 03:39:02 INFO - PID 4394 | _x_x_mozilla_page_load 03:39:02 INFO - PID 4394 | _x_x_mozilla_page_load_details 03:39:02 INFO - PID 4394 | |i|pagename|runs| 03:39:02 INFO - PID 4394 | |0;ai-astar;118;112;109;105;118;109;109;109;116;108 03:39:02 INFO - PID 4394 | |1;audio-beat-detection;128;127;125;143;125;118;118;122;151;121 03:39:02 INFO - PID 4394 | |2;audio-dft;164;163;163;164;167;172;170;169;163;163 03:39:02 INFO - PID 4394 | |3;audio-fft;76;80;77;80;74;75;73;81;81;81 03:39:02 INFO - PID 4394 | |4;audio-oscillator;89;89;85;86;78;78;83;81;85;83 03:39:02 INFO - PID 4394 | |5;imaging-gaussian-blur;115;114;123;115;115;117;117;112;117;115 03:39:02 INFO - PID 4394 | |6;imaging-darkroom;151;147;152;158;147;148;149;149;150;152 03:39:02 INFO - PID 4394 | |7;imaging-desaturate;105;93;101;99;98;94;94;94;102;101 03:39:02 INFO - PID 4394 | |8;json-parse-financial;57;53;59;55;54;55;55;57;55;55 03:39:02 INFO - PID 4394 | |9;json-stringify-tinderbox;44;46;40;46;46;39;39;43;39;39 03:39:02 INFO - PID 4394 | |10;stanford-crypto-aes;77;86;87;80;93;80;77;76;78;78 03:39:02 INFO - PID 4394 | |11;stanford-crypto-ccm;121;119;132;125;149;124;125;133;121;125 03:39:02 INFO - PID 4394 | |12;stanford-crypto-pbkdf2;185;177;175;171;170;182;175;173;172;177 03:39:02 INFO - PID 4394 | |13;stanford-crypto-sha256-iterative;68;66;67;70;67;66;66;66;70;66 03:39:02 INFO - PID 4394 | __end_tp_report 03:39:02 INFO - PID 4394 | __start_cc_report 03:39:02 INFO - PID 4394 | _x_x_mozilla_cycle_collect,958 03:39:02 INFO - PID 4394 | __end_cc_report 03:39:02 INFO - PID 4394 | __startTimestamp1505126342264__endTimestamp 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | ------- Summary: start ------- 03:39:02 INFO - PID 4394 | Number of tests: 14 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#0] ai-astar Cycles:10 Average:111.30 Median:110.50 stddev:4.52 (4.1%) stddev-sans-first:4.10 03:39:02 INFO - PID 4394 | Values: 118.0 112.0 109.0 105.0 118.0 109.0 109.0 109.0 116.0 108.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:126.00 stddev:10.84 (8.6%) stddev-sans-first:11.50 03:39:02 INFO - PID 4394 | Values: 128.0 127.0 125.0 143.0 125.0 118.0 118.0 122.0 151.0 121.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:3.43 (2.1%) stddev-sans-first:3.57 03:39:02 INFO - PID 4394 | Values: 164.0 163.0 163.0 164.0 167.0 172.0 170.0 169.0 163.0 163.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#3] audio-fft Cycles:10 Average:77.80 Median:80.00 stddev:3.16 (3.9%) stddev-sans-first:3.28 03:39:02 INFO - PID 4394 | Values: 76.0 80.0 77.0 80.0 74.0 75.0 73.0 81.0 81.0 81.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#4] audio-oscillator Cycles:10 Average:83.70 Median:85.00 stddev:3.92 (4.6%) stddev-sans-first:3.66 03:39:02 INFO - PID 4394 | Values: 89.0 89.0 85.0 86.0 78.0 78.0 83.0 81.0 85.0 83.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:116.00 stddev:2.91 (2.5%) stddev-sans-first:3.06 03:39:02 INFO - PID 4394 | Values: 115.0 114.0 123.0 115.0 115.0 117.0 117.0 112.0 117.0 115.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:3.27 (2.2%) stddev-sans-first:3.46 03:39:02 INFO - PID 4394 | Values: 151.0 147.0 152.0 158.0 147.0 148.0 149.0 149.0 150.0 152.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#7] imaging-desaturate Cycles:10 Average:98.10 Median:94.00 stddev:4.18 (4.4%) stddev-sans-first:3.61 03:39:02 INFO - PID 4394 | Values: 105.0 93.0 101.0 99.0 98.0 94.0 94.0 94.0 102.0 101.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:1.72 (3.1%) stddev-sans-first:1.73 03:39:02 INFO - PID 4394 | Values: 57.0 53.0 59.0 55.0 54.0 55.0 55.0 57.0 55.0 55.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#9] json-stringify-tinderbox Cycles:10 Average:42.10 Median:43.50 stddev:3.21 (7.4%) stddev-sans-first:3.33 03:39:02 INFO - PID 4394 | Values: 44.0 46.0 40.0 46.0 46.0 39.0 39.0 43.0 39.0 39.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:5.59 (7.0%) stddev-sans-first:5.72 03:39:02 INFO - PID 4394 | Values: 77.0 86.0 87.0 80.0 93.0 80.0 77.0 76.0 78.0 78.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:125.00 stddev:8.82 (7.1%) stddev-sans-first:9.05 03:39:02 INFO - PID 4394 | Values: 121.0 119.0 132.0 125.0 149.0 124.0 125.0 133.0 121.0 125.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:176.00 stddev:4.79 (2.7%) stddev-sans-first:3.71 03:39:02 INFO - PID 4394 | Values: 185.0 177.0 175.0 171.0 170.0 182.0 175.0 173.0 172.0 177.0 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.69 03:39:02 INFO - PID 4394 | Values: 68.0 66.0 67.0 70.0 67.0 66.0 66.0 66.0 70.0 66.0 03:39:02 INFO - PID 4394 | -------- Summary: end -------- 03:39:02 INFO - PID 4394 | 03:39:02 INFO - PID 4394 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:39:03 INFO - TEST-INFO | 4394: exit 0 03:39:03 INFO - TEST-OK | kraken | took 63768ms 03:39:03 INFO - SUITE-END | took 1179s 03:39:03 INFO - Completed test suite (00:19:39) 03:39:03 INFO - javascript benchmark 03:39:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8370.318740287243, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.907362779116, 3101.1626860747597, 3108.4094022135796, 3125.2655625927887, 3131.0, 6128.601640893339, 6237.189165408497, 6272.435480806726, 6284.308726040132, 6318.431341179305, 6182.1963144791225, 6224.470919971808, 6224.7510099596075, 6235.968820155893, 6258.561900666955, 5692.629979051369, 5720.713964301789, 5735.08238681811, 5744.79893203738, 5797.942020579803, 5789.363170051291, 5797.0, 5800.4489573490455, 5839.9124013139835, 5925.229720136376, 5809.9709501452435, 5840.912386314209, 5844.941550584483, 5926.051831706928, 5937.37657545958, 5524.0, 5633.8309850704545, 5661.575381846378, 5815.982203114438, 5836.474717275423, 5679.062954612484, 5706.80026199081, 5716.828495145152, 5726.5418766499, 5729.169270455803, 6082.2093127893095, 6121.3572574879445, 6201.255849298068, 6224.221972253468, 6298.118263443122, 6396.200474940632, 6500.902486462707, 6531.673416329212, 6656.234533028715, 6715.832104197434, 6807.149106361705, 6828.112345395117, 6828.146481689789, 6842.931570684279, 6855.07456493372, 6258.0, 6327.683615819191, 6333.904991425133, 6338.6196828189995, 6345.904811427832, 6906.827329316707, 6914.585124892422, 6915.585064896122, 6990.895136572955, 6998.510104292753, 6453.548251622341, 6453.774117905851, 6498.155239818793, 6518.250401203827, 6671.532992690465, 6503.8699226015215, 6608.900866487006, 6705.530612857053, 6758.560693554903, 6785.728570857209, 6706.128203333633, 6706.865862682816, 6744.393004629607, 6748.595084294958, 6769.323067693192, 6641.833954151185, 6708.563943343765, 6718.630475323904, 6804.08144900442, 6815.863682726318, 5120.0, 5242.68543887368, 5308.442613525602, 5317.813876514303, 5326.147816349366, 4525.886852828639, 4579.267317229294, 4626.306054091913, 4627.930581041287, 4643.373144625432, 5779.739911703983, 5797.0, 5801.680907550125, 5817.650940943557, 5818.5054270386645, 6690.899636505456, 6698.263191048981, 6778.72885084601, 6789.592624442549, 6796.388325050769, 5716.056850619684, 5755.223044888887, 5761.0, 5797.188393624896, 5821.039528477754, 5639.887202255932, 5731.312242530839, 5769.53843692512, 5811.128330750421, 5820.126980952807, 6543.083968244449, 6543.770968016097, 6557.049227861933, 6582.736690532421, 6587.505937054644, 6644.568103073285, 6661.533692641468, 6669.533132680665, 6748.93251067483, 6750.3924646782025, 6369.331220221995, 6390.648514331757, 6469.159009328757, 6474.902876456763, 6480.8703825922275, 6296.307406185408, 6369.14016607752, 6408.070829729756, 6466.902996455151, 6467.579607325509, 6599.977003564455, 6717.16035495563, 6790.151231096113, 6797.1843378794865, 6818.386345228953, 6484.059811327425, 6598.406143447113, 6603.141591593254, 6606.8348291293105, 6607.240167380813, 6460.0, 6496.187976502937, 6501.837454063686, 6530.379613936669, 6584.111144995556, 6259.1550140730415, 6401.615903045832, 6477.1579694639395, 6488.772892948913, 6490.902636460552, 6468.997305417668, 6525.282218956006, 6608.041833933957, 6615.569987950767, 6641.601503909781, 6302.212223472066, 6306.054091886253, 6312.179416675803, 6393.2647745508, 6407.199100112486], "value": 6099.13302425841, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.7917181118816, 859.7377799771075, 862.3144600042965, 863.8876945997023, 871.5903525343086, 38035.80982095089, 41314.17371652573, 41710.0, 41742.37386439206, 41843.37234941474, 38829.611703882954, 39105.80447097767, 39109.21781564367, 39174.60825391745, 39402.408963865564, 7012.649367531629, 7113.181984071821, 7125.89311160333, 7129.465290103237, 7177.102862142232, 7254.27457254273, 7768.300852923236, 7770.9222907771045, 7792.064952205743, 7809.492382995116, 7794.727184548542, 7821.21787821219, 7830.725924592641, 7837.843243135134, 7848.018997625297, 7725.111612164589, 7775.455718099735, 7782.533048017081, 7800.570968596725, 7807.258310460497, 7686.0, 7741.8451630967065, 7742.303192712683, 7748.457607967444, 7756.224377562255, 38580.0, 38926.02684932871, 38943.0, 38978.61021389778, 39084.80457597694, 3505.8948231553095, 3541.6635419635095, 3543.344481270973, 3545.9290814183573, 3547.2373439710327, 31174.376512469622, 31367.372652546823, 31368.0, 31541.526877096632, 31561.21096972571, 4946.8763280918265, 5100.132977393815, 5123.564497017758, 5135.152699804527, 5143.8456846294675, 181887.0, 181979.09010454864, 183703.08148459307, 184456.0, 184705.0, 47998.760006199744, 48013.0, 48040.0, 48065.5193448068, 48109.27836082462, 43218.351724724154, 44188.116237675065, 51409.74295128501, 52160.21759673608, 52163.47836521662, 15535.378584856706, 15637.530874073796, 15639.530814075595, 15641.530754077168, 15658.608534786494, 12370.44333005017, 12520.561780337826, 12605.243685378906, 12629.052821038458, 12654.240745555297, 14416.639584010274, 14427.062240954514, 14451.78322325166, 14467.131972081708, 14569.125852448888, 5716.857078573069, 5803.361630220672, 5849.011336145731, 5862.530997520274, 5872.500837428781, 997.8602995580625, 1002.5989604158249, 1003.4330603209163, 1024.6516184497157, 1026.9281150319405, 22642.43393915165, 22672.433189170402, 22716.65925011126, 22842.42893927632, 22884.65673014906, 1105.9944700276446, 1118.5861231344454, 1118.888111188891, 1121.2151493954264, 1121.5738019552518, 11855.940720296343, 11865.644030679094, 11913.16607837443, 11924.642260732191, 12075.215111017756, 218738.0, 219678.0, 220386.0, 220511.0, 220929.0, 52129.2180617291, 52160.0, 52173.73913130486, 52260.47739522632, 52532.0, 1425.230375597166, 1445.2051371745708, 1450.572081236038, 1452.0416525093387, 1460.189594774889, 22145.446363841034, 22353.217637382615, 22442.551148976603, 22693.092276309424, 23004.539909202056, 35916.28167436584, 36045.45931810972, 36163.638363616024, 36303.0, 36480.635193648784, 191572.0, 193443.0, 193514.03242983695, 194094.0, 194882.0, 30294.84852575723, 30637.846810765805, 30938.0, 31071.0, 33148.834255828566, 37221.0, 42041.0, 42454.0, 42561.78719106385, 43415.0, 31335.84332078325, 31446.52830207503, 31745.5238171423, 31786.0, 32203.677963220067, 31019.224519387197, 31032.0, 31334.529982049833, 31448.68551314549, 31604.0, 35660.28679426449, 35661.465078023335, 35731.285374291845, 35858.64141358553, 36123.81938090398, 30447.54328685116, 30645.0, 30901.69098308988, 30913.381732364778, 30953.0, 22363.44091397728, 22756.20353287627, 22775.0, 23165.88417057904, 23266.883665581565], "value": 16848.490548408477, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.4395716369306, 559.3092530724557, 563.6139244617437, 563.873128546077, 570.3498012266015, 21227.363179104614, 21808.781912180875, 21973.780262197393, 22144.114235430585, 22155.224567140114, 23565.46824456409, 23791.405214869636, 24235.757642423614, 24271.0, 24340.634890476656, 6385.904211436832, 6550.574212676184, 6612.404883560479, 6615.735370585171, 6625.370589793986, 6501.7724379646725, 6593.934060659404, 6611.603303801763, 6616.338366163393, 6628.767993120242, 6238.220222472191, 6521.608703477783, 6521.967390163042, 6549.410553050225, 6583.4074933256, 6449.54853160279, 6511.186101737283, 6516.250631177404, 6518.543701940866, 6519.9674001630165, 5838.737256823453, 6047.485963693091, 6058.909116363258, 6064.332923378425, 6080.787172448987, 28480.0, 28819.855900720573, 28903.42193156125, 29016.27459313513, 29041.41917161666, 2039.8062184092487, 2055.5683306505653, 2076.179908935962, 2077.9376618701463, 2080.4694802825334, 19332.806671933242, 19495.512612184666, 19981.600367992705, 20002.299919502893, 20051.899740501205, 2476.5418397596504, 2492.9002839886384, 2505.9749402506104, 2513.6229565565127, 2521.1050077222503, 121214.0, 127330.99999999907, 129713.0, 135265.61835954082, 137187.0, 14459.08391147015, 14553.708925821424, 14615.269236538343, 14825.258737063104, 15003.249837508081, 22775.772242277697, 22954.19660311881, 23007.0, 23022.884885575466, 23162.420939476648, 9636.132748052709, 9987.300888937705, 10042.14641755459, 10086.596536138471, 10157.898421015843, 9169.40398874071, 9225.907740922505, 9308.90691093094, 9309.069093090773, 9360.391574547633, 9029.961554421194, 9047.411918225294, 9207.309451791143, 9228.354015219005, 9371.718848434557, 2589.3138318345655, 2604.960925586118, 2643.0177366974767, 2677.8125531212627, 2685.1273336165823, 935.5836652689624, 947.5925352098526, 962.4898803634085, 981.1611072533025, 983.1937810995058, 18837.340693075676, 19100.426987190127, 19127.23491060342, 19271.036448177536, 19313.61372772565, 1020.6682828080903, 1022.2792930983638, 1023.9129673977646, 1034.3483605328595, 1038.7351225437617, 10643.733906652396, 10687.946560267148, 10736.73158171052, 10848.620298289521, 10990.753762829452, 415589.0, 435273.0, 444545.0, 449483.0, 450646.0, 109372.0, 112024.0, 113453.0, 114455.42772286086, 114480.0, 991.2862738828032, 1037.4812593703148, 1115.0856297835696, 1137.8293256011664, 1142.948567314456, 20200.696989544875, 20238.696419553424, 20316.695249571563, 20320.695189571874, 20584.073716682487, 55185.0, 57169.85660286854, 57244.0, 57644.423555763904, 57815.421845781006, 64821.67589162024, 67512.6624366875, 67646.0, 68356.31643683699, 69184.65407673131, 13834.169949803045, 14158.929205353907, 14180.858191417954, 14194.858051419353, 14199.64500887486, 21656.133754649636, 22257.332280031624, 22511.437214069778, 22612.547749045258, 22712.886435567718, 17886.910565447088, 18185.45443636693, 18205.908970455064, 18286.542836429195, 18320.908395457936, 15592.298346574658, 15968.441104561749, 16210.594735131715, 16457.0, 16703.91648041752, 18201.362952296608, 18228.81771182324, 18370.816291837444, 18384.908075460073, 18477.445676629723, 13276.468941242241, 13730.45078196901, 13912.652183695489, 13939.930300348433, 13944.930275348559, 15849.841501585297, 17792.11039448048, 17813.73279400784, 17875.73186402179, 17968.281268749102], "value": 11749.056421230647, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1288.8388951381078, 1348.4538761801473, 1362.6593351662082, 1366.2690460603567, 1375.7042235919275, 14922.328495217715, 15463.0, 15566.299516521756, 15578.610534736637, 15581.376744930203, 15327.233638318095, 15441.382344706199, 15449.0, 15471.845281547181, 15485.070895746263, 2733.7676297514636, 2758.0, 2801.6918139004692, 2803.4393121375706, 2807.719228077186, 2717.1731339385515, 2792.4833905727405, 2795.4409118176345, 2804.747572718455, 2812.4656315300026, 2738.5070687276284, 2742.122520793347, 2825.6891741908375, 2861.241770930705, 2861.4277144571065, 2754.807163498556, 2763.77889768818, 2778.652668416448, 2811.1988083396136, 2822.6048353230562, 2738.3564862257354, 2739.315171207198, 2747.3406382468265, 2754.559270516708, 2756.8897244110212, 14963.177025263607, 15362.30869610859, 15446.5366039019, 15455.845441545553, 15492.147931863743, 7992.800179995488, 8226.0, 8284.875726864102, 8303.584820758937, 8311.91945047146, 5123.795048198068, 5210.817621383233, 5247.816326428557, 5354.3574771027725, 5360.517553420211, 1830.103249407794, 1854.7959724430302, 1872.981270187308, 1905.7427247321573, 1907.3515004898263, 23928.521429571487, 24705.87647061753, 25311.62032569513, 26076.60885086725, 26102.216933492025, 6520.250171230275, 6658.966705166443, 6710.328967103251, 6717.664116794141, 6727.360900714424, 17180.570485737957, 17313.7402938956, 17387.130643467775, 17469.47591572255, 17583.29666813313, 7606.619669016527, 7694.345980591713, 7715.267049630276, 7757.534547927143, 7869.252421019994, 7189.676464559107, 7205.89191162133, 7239.963800180965, 7287.963560182271, 7352.669129889167, 4925.1381008324115, 5010.24641375523, 5039.4708555601865, 5044.9495505045215, 5087.3386459759995, 1388.430743395203, 1396.8742813146662, 1404.2557444554197, 1414.2645824171373, 1418.6098822823599, 871.289898732531, 885.9955700221586, 896.6727144592177, 910.8360495110944, 920.8756817829641, 7244.203137654854, 7378.335949764547, 7386.0767404074495, 7402.629868506553, 7412.629368531552, 704.3625518905399, 711.6121713666064, 717.5371885134059, 719.8668246374333, 725.7351066860664, 5273.736313184402, 5300.655457395257, 5365.248865158881, 5443.428440013741, 5559.332880054339, 21068.683969740465, 21301.254456093964, 21511.35465935993, 21844.89077554602, 21872.781272187392, 20557.0, 21191.576168476546, 21379.358619241135, 21398.78601213999, 21641.134354625952, 10233.0, 10422.270441069204, 10428.217883658755, 10544.947275263574, 10565.366078035342, 8353.373496987871, 8398.328133749163, 8441.87337189955, 8500.872486912825, 8673.653053878026, 17768.200430980894, 18354.265829366675, 18382.816171838644, 18581.90709046446, 18767.249310027444, 18875.62248755045, 19136.71294930605, 19377.70933436028, 19490.90254548718, 19717.901410492857, 10926.890731092588, 11098.61154859576, 11128.721781955515, 11145.888541114486, 11149.94425027902, 13853.099548529313, 13944.721105578035, 13959.232242226775, 14178.787318190442, 14316.57050288493, 11022.834657479983, 11310.377929213972, 11512.963833255048, 11623.0, 11623.5350585979, 10972.451377431256, 11412.258203216765, 11438.656840294805, 11459.48432320531, 11497.310161390344, 9360.53197340144, 9390.95304523473, 9436.292278079034, 9563.904360956301, 9565.04349565038, 6803.421709154777, 7017.3684368407085, 7182.922561615799, 7185.101862267216, 7370.77887663371, 6911.824989751854, 6920.58476491392, 6933.861322773617, 6941.409980151744, 6960.37356637905], "value": 6566.56823364375, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.79974410747485, 501.76417083970523, 508.3823154866836, 515.5231410944875, 525.5165247971867, 6069.60547564408, 6124.142620033193, 6161.29145148307, 6199.287081985573, 6222.284437289713, 5967.970160149204, 6034.517238620911, 6040.0, 6040.909386359197, 6077.24034495688, 5025.497450254982, 5026.2209357549455, 5049.889024414623, 5056.999999999991, 5074.594032477393, 4649.558291962275, 4964.87587810304, 4980.477049909761, 5042.974785126087, 5086.31334769805, 4768.73771942543, 4808.927866082012, 4826.638002149835, 4827.903441931159, 4831.516848315158, 4804.543568361, 4816.205326121186, 4841.346418233528, 4851.563359297645, 4871.4154301483695, 4251.532331443539, 4297.140571885604, 4318.309070548728, 4323.627570494988, 4324.437823083011, 5829.446202610745, 5880.26496687914, 5880.4119588041285, 5917.704114794286, 5954.374790646963, 5478.561715062785, 5510.779568817243, 5539.833804985817, 5551.111822108443, 5584.804531841407, 6312.779052733178, 6324.430801227865, 6347.746090156388, 6448.677566121675, 6472.838179045514, 4536.457604414515, 4638.11875743611, 4687.859364219079, 4715.31627913954, 4727.45634252062, 6532.444742196919, 6542.574732642411, 6610.570312929644, 6734.629595372302, 6768.69540870662, 4821.228603423436, 4880.780364883518, 4903.656744027884, 4905.730184839868, 4931.211006238985, 4854.8786280342565, 4927.236278376858, 4961.875953101201, 4975.577075948512, 4986.551210391082, 5495.53287970527, 5499.780008799603, 5565.910919439669, 5570.916436253459, 5599.0, 6384.872302553923, 6467.838304042342, 6483.675816209171, 6501.1548498694865, 6533.085368048477, 1710.153474030363, 1718.0121430177448, 1726.8273172682632, 1727.3004433204571, 1729.8183690712547, 1124.8312753086939, 1180.4805885410392, 1192.8330033795276, 1208.4139192491634, 1213.7390461050916, 5512.944870551323, 5579.9163012554845, 5588.764494202352, 5607.0, 5638.210650508932, 6501.44737697301, 6535.803925882231, 6538.967305163444, 6572.8356791080605, 6614.305497922745, 5555.472230138131, 5555.833325000256, 5572.916406253909, 5631.605787594911, 5677.886442271131, 3441.466572681188, 3461.7749846259912, 3470.4620783778555, 3485.233248685285, 3526.2418580005424, 6262.780802671976, 6275.748970041239, 6281.371862813682, 6312.936870631235, 6369.9681501592195, 6698.363655452724, 6709.765158219537, 6768.627725475146, 6800.0, 6835.624040677811, 6182.659953702409, 6336.52476064297, 6338.112664227012, 6347.301796802348, 6360.77737279193, 6519.706613202323, 6549.901751473636, 6561.967190164019, 6630.270670226175, 6635.767748128792, 5995.0, 6385.553011289165, 6476.838079047873, 6494.3505649436565, 6511.153550038464, 6232.906506402317, 6238.532110091671, 6280.4152968332455, 6285.622862628257, 6393.776217832539, 4827.879303017312, 4844.449776071623, 4875.463698993179, 4880.145974454527, 4886.315915771866, 6333.936660633519, 6534.8366290843105, 6568.540202185801, 6582.473402127914, 6592.604443733391, 6098.512119030378, 6293.339199383999, 6346.9682651586445, 6372.617642941438, 6384.201974753156, 6250.0, 6294.71673774672, 6320.968395157995, 6328.746850125944, 6390.456811171102, 6119.877602448015, 6171.3828617139725, 6188.721507532082, 6201.751929922933, 6234.563580549499, 6331.303556608861, 6360.872782544231, 6420.422162005442, 6430.164078669743, 6437.774677886251, 6034.818955431344, 6113.388661134029, 6215.906761398493, 6229.56393052482, 6245.500359971101], "value": 4923.042504510085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.4761464543243, 899.5906862377615, 911.4895658431279, 920.3695468604003, 921.7004473546098, 19007.52481187969, 19789.901050494744, 19816.801831981677, 19881.0, 19941.202351905926, 17689.82310176898, 17762.73355899659, 17850.64298714025, 17857.91071044643, 17864.0, 938.2353381993653, 938.3572253006712, 939.8402271613808, 941.087145468894, 941.3034354577632, 949.3496954586096, 951.3435729346728, 951.6859436385976, 952.1192896570644, 955.5461155950902, 978.7014960437064, 1012.6607586458508, 1017.3997341568473, 1018.399144504742, 1035.4201647077623, 1022.9846552301722, 1026.1021606094666, 1026.825439675257, 1027.024326889458, 1027.8201314769922, 706.3466293678327, 750.8498300339954, 750.9861686722935, 751.6579956119953, 753.5666991479866, 19131.617367652707, 19271.51821204481, 19304.903475482533, 19341.4197574073, 19344.80655193444, 20943.266985655428, 20949.47626309339, 21346.679799803016, 21414.678779818158, 21631.351059468085, 16474.258658360282, 16704.83295167045, 16846.915765421218, 16925.3229870805, 17088.487345379657, 3757.2861156380472, 3762.529683789526, 3765.830537625786, 3765.9435108473394, 3769.1142581493327, 105627.47186264019, 117493.0, 132131.0, 133364.0, 135946.0, 16988.49034528966, 17144.65710685804, 17243.74134387985, 17414.216360263817, 17496.737548936777, 30625.693743062286, 30898.691013090032, 30899.227519312197, 30941.535876961865, 31146.532802007987, 8245.587720613945, 8536.146385361415, 8553.272971797342, 8595.742127736054, 8605.053444121142, 4328.415663885398, 4396.538363471854, 4404.273294906368, 4406.140802543538, 4410.5368936261875, 5264.0, 5380.031594312983, 5450.482204190595, 5485.424030476823, 5505.256790333334, 1000.3547711725896, 1026.820306446369, 1027.1320733979776, 1035.7410647338165, 1036.4921188617523, 669.2370697404962, 673.5251647588439, 693.3066933066933, 698.7833771530842, 700.0689083518907, 12105.959603525363, 12150.54193496786, 12255.448504817305, 12391.814122788166, 12468.314242716557, 654.2247436787422, 657.7138944559132, 660.7687309441753, 665.0821865825227, 670.6546128743701, 5743.712814359265, 5888.587798854125, 5892.145638882338, 5919.112133180058, 5950.077737950624, 114431.0, 117306.0, 118432.0, 120283.0, 126413.0, 103815.0, 103882.48058759658, 105893.0, 107722.0, 107890.0, 87268.0, 87403.0, 87589.0, 89392.0, 91150.54424727833, 10623.0, 10830.241883068109, 10837.078848297982, 10884.945575272073, 11039.061679757311, 42124.368134478624, 42197.0, 42666.0, 42754.572454276306, 43749.78125109354, 52190.47809521856, 52434.47565524449, 52701.7364913173, 53005.7349713249, 54384.45615543952, 14344.713105738036, 14467.638309042359, 14679.19264440466, 14703.852961470247, 14786.926065370035, 17829.197686103897, 17881.46355609334, 17901.10494475297, 17972.910135449238, 18052.909735451238, 14758.262086895827, 14832.851671483579, 14854.925725371304, 14873.553793386216, 15096.54710358691, 16144.515664530083, 16198.595035123744, 16348.182590870647, 16396.016239025696, 16633.3346666132, 16365.445282698125, 16584.336626534805, 16640.75038874442, 16651.000939943642, 16801.0, 11443.828342574701, 11724.120690948384, 11761.235519691192, 11798.0, 11804.409779511161, 11672.299662020307, 11767.235129716884, 11883.702907427383, 11911.166218364979, 12005.81991270149], "value": 8810.926175361743, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 112.0, 109.0, 105.0, 118.0, 109.0, 109.0, 109.0, 116.0, 108.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 125.0, 143.0, 125.0, 118.0, 118.0, 122.0, 151.0, 121.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 164.0, 167.0, 172.0, 170.0, 169.0, 163.0, 163.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 77.0, 80.0, 74.0, 75.0, 73.0, 81.0, 81.0, 81.0], "value": 77.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 85.0, 86.0, 78.0, 78.0, 83.0, 81.0, 85.0, 83.0], "value": 83.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 123.0, 115.0, 115.0, 117.0, 117.0, 112.0, 117.0, 115.0], "value": 116.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 147.0, 152.0, 158.0, 147.0, 148.0, 149.0, 149.0, 150.0, 152.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 93.0, 101.0, 99.0, 98.0, 94.0, 94.0, 94.0, 102.0, 101.0], "value": 98.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 59.0, 55.0, 54.0, 55.0, 55.0, 57.0, 55.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 46.0, 40.0, 46.0, 46.0, 39.0, 39.0, 43.0, 39.0, 39.0], "value": 42.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 86.0, 87.0, 80.0, 93.0, 80.0, 77.0, 76.0, 78.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 132.0, 125.0, 149.0, 124.0, 125.0, 133.0, 121.0, 125.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 177.0, 175.0, 171.0, 170.0, 182.0, 175.0, 173.0, 172.0, 177.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 70.0, 67.0, 66.0, 66.0, 66.0, 70.0, 66.0], "value": 67.2, "unit": "score"}]}]} 03:39:03 INFO - Return code: 0 03:39:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:39:03 INFO - # TBPL SUCCESS # 03:39:03 INFO - Running post-action listener: _package_coverage_data 03:39:03 INFO - Running post-action listener: _resource_record_post_action 03:39:03 INFO - [mozharness: 2017-09-11 10:39:03.574233Z] Finished run-tests step (success) 03:39:03 INFO - Running post-run listener: _resource_record_post_run 03:39:03 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 21639168; Write bytes: 373751808; Read time: 8804; Write time: 346344 03:39:03 INFO - TinderboxPrint: CPU usage
13.3% 03:39:03 INFO - TinderboxPrint: I/O read bytes / time
21,639,168 / 8,804 03:39:03 INFO - TinderboxPrint: I/O write bytes / time
373,751,808 / 346,344 03:39:03 INFO - TinderboxPrint: CPU idle
8,272.1 (86.7%) 03:39:03 INFO - TinderboxPrint: CPU user
1,201.8 (12.6%) 03:39:03 INFO - TinderboxPrint: Swap in / out
0 / 0 03:39:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13275136; Read time: 0; Write time: 15432 03:39:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:39:03 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 19894272; Write bytes: 360476672; Read time: 8768; Write time: 330912 03:39:04 INFO - Running post-run listener: _upload_blobber_files 03:39:04 INFO - Blob upload gear active. 03:39:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:39:04 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 03:39:04 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'] 03:39:04 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 03:39:04 INFO - (blobuploader) - INFO - Open directory for files ... 03:39:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:39:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:39:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:05 INFO - (blobuploader) - INFO - Done attempting. 03:39:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:39:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:12 INFO - (blobuploader) - INFO - Done attempting. 03:39:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:39:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:39:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:13 INFO - (blobuploader) - INFO - Done attempting. 03:39:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:39:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:39:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:14 INFO - (blobuploader) - INFO - Done attempting. 03:39:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:39:14 INFO - Return code: 0 03:39:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:39:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:39:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27866b64039eade177eb06f0c819d1b28b95ce2d963581ddd65b30c7ace6ff81d25d08ce373744057c36aa263fd66e7a5d8363f20bb7562ca10bb991f038f7d8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/109fc518e6b170b867e941a4fd7658f99e062f093f85d8407ff5f30a1c87e2c680e4a886ff30484fcf4b5349119a3727d18c8f4097d91081fe348d98f1e872f1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/542c93cad173e1a94175097f9234a5ade9f865a851bc831cce62df543f798930798a79ee46576c78536b1c7637a664a2915db6b3f173e8b050d3c6186a476e1c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cb17f10bc527e4dbe89e5b04fa46f303ba302f48b4083f7a2075e7e1fdbdd630040788102a133023b438098f55cc147872af7f53b320503ba048ee0ee1af71f"} 03:39:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:39:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:39:14 INFO - Contents: 03:39:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27866b64039eade177eb06f0c819d1b28b95ce2d963581ddd65b30c7ace6ff81d25d08ce373744057c36aa263fd66e7a5d8363f20bb7562ca10bb991f038f7d8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/109fc518e6b170b867e941a4fd7658f99e062f093f85d8407ff5f30a1c87e2c680e4a886ff30484fcf4b5349119a3727d18c8f4097d91081fe348d98f1e872f1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/542c93cad173e1a94175097f9234a5ade9f865a851bc831cce62df543f798930798a79ee46576c78536b1c7637a664a2915db6b3f173e8b050d3c6186a476e1c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cb17f10bc527e4dbe89e5b04fa46f303ba302f48b4083f7a2075e7e1fdbdd630040788102a133023b438098f55cc147872af7f53b320503ba048ee0ee1af71f"} 03:39:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:39:14 INFO - Copying logs to upload dir... 03:39:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:39:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.477543 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-11 03:39:14.790537) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 03:39:14.793589) ========= 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=3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27866b64039eade177eb06f0c819d1b28b95ce2d963581ddd65b30c7ace6ff81d25d08ce373744057c36aa263fd66e7a5d8363f20bb7562ca10bb991f038f7d8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/109fc518e6b170b867e941a4fd7658f99e062f093f85d8407ff5f30a1c87e2c680e4a886ff30484fcf4b5349119a3727d18c8f4097d91081fe348d98f1e872f1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/542c93cad173e1a94175097f9234a5ade9f865a851bc831cce62df543f798930798a79ee46576c78536b1c7637a664a2915db6b3f173e8b050d3c6186a476e1c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cb17f10bc527e4dbe89e5b04fa46f303ba302f48b4083f7a2075e7e1fdbdd630040788102a133023b438098f55cc147872af7f53b320503ba048ee0ee1af71f"} build_url:https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011117 build_url: 'https://queue.taskcluster.net/v1/task/TV-2xJbFQNaqNCVPY33lrg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27866b64039eade177eb06f0c819d1b28b95ce2d963581ddd65b30c7ace6ff81d25d08ce373744057c36aa263fd66e7a5d8363f20bb7562ca10bb991f038f7d8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/109fc518e6b170b867e941a4fd7658f99e062f093f85d8407ff5f30a1c87e2c680e4a886ff30484fcf4b5349119a3727d18c8f4097d91081fe348d98f1e872f1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/542c93cad173e1a94175097f9234a5ade9f865a851bc831cce62df543f798930798a79ee46576c78536b1c7637a664a2915db6b3f173e8b050d3c6186a476e1c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cb17f10bc527e4dbe89e5b04fa46f303ba302f48b4083f7a2075e7e1fdbdd630040788102a133023b438098f55cc147872af7f53b320503ba048ee0ee1af71f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 03:39:14.821492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:39:14.821801) ========= 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=3a3620fb28aea1604ab609ef000001d2-1505125102.925044-780717401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 03:39:14.904227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 03:39:14.904542) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 03:39:14.904826) ========= ========= Total master_lag: 0.17 =========