builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1506508890.33 results: success (0) revision: 35fbf14b96a633c3f66ea13c1a163a3f3a4219b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 03:41:30.331702) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 03:41:30.332195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 03:41:30.332477) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 03:41:30.368706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 03:41:30.368999) ========= 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=db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 03:41:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-09-27 03:41:30 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.345158 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 03:41:30.731481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 03:41:30.731799) ========= 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=db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019453 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 03:41:30.781841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 03:41:30.782185) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 35fbf14b96a633c3f66ea13c1a163a3f3a4219b9 --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 35fbf14b96a633c3f66ea13c1a163a3f3a4219b9 --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=db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 03:41:30,840 truncating revision to first 12 chars 2017-09-27 03:41:30,841 Setting DEBUG logging. 2017-09-27 03:41:30,841 attempt 1/10 2017-09-27 03:41:30,841 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/35fbf14b96a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 03:41:31,548 unpacking tar archive at: mozilla-central-35fbf14b96a6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.061451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 03:41:31.860563) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 03:41:31.860880) ========= script_repo_revision: 35fbf14b96a633c3f66ea13c1a163a3f3a4219b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 03:41:31.861356) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 03:41:31.861679) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 03:41:31.874469) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-27 03:41:31.874734) ========= /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=db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:41:32 INFO - MultiFileLogger online at 20170927 03:41:32 in /builds/slave/test 03:41:32 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:41:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:41:32 INFO - {'append_to_log': False, 03:41:32 INFO - 'base_work_dir': '/builds/slave/test', 03:41:32 INFO - 'blob_upload_branch': 'Firefox', 03:41:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:41:32 INFO - 'branch': 'Firefox', 03:41:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:41:32 INFO - 'code_coverage': False, 03:41:32 INFO - 'config_files': ('talos/linux_config.py',), 03:41:32 INFO - 'default_actions': ('clobber', 03:41:32 INFO - 'read-buildbot-config', 03:41:32 INFO - 'download-and-extract', 03:41:32 INFO - 'populate-webroot', 03:41:32 INFO - 'create-virtualenv', 03:41:32 INFO - 'install', 03:41:32 INFO - 'setup-mitmproxy', 03:41:32 INFO - 'run-tests'), 03:41:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:41:32 INFO - 'disable_ccov_upload': False, 03:41:32 INFO - 'disable_stylo': False, 03:41:32 INFO - 'download_minidump_stackwalk': True, 03:41:32 INFO - 'download_symbols': 'ondemand', 03:41:32 INFO - 'enable_stylo': False, 03:41:32 INFO - 'enable_webrender': False, 03:41:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:41:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:41:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:41:32 INFO - 'gecko_profile': False, 03:41:32 INFO - 'gecko_profile_interval': 0, 03:41:32 INFO - 'installer_path': 'installer.exe', 03:41:32 INFO - 'log_level': 'info', 03:41:32 INFO - 'log_name': 'talos', 03:41:32 INFO - 'log_to_console': True, 03:41:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:41:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:41:32 INFO - 'opt_config_files': (), 03:41:32 INFO - 'pip_index': False, 03:41:32 INFO - 'suite': 'dromaeojs-e10s', 03:41:32 INFO - 'system_bits': '32', 03:41:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:41:32 INFO - 'title': 'talos-linux64-ix-031', 03:41:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:41:32 INFO - 'use_talos_json': True, 03:41:32 INFO - 'verify': 'False', 03:41:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:41:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:41:32 INFO - 'work_dir': 'build'} 03:41:32 INFO - [mozharness: 2017-09-27 10:41:32.071723Z] Running clobber step. 03:41:32 INFO - Running pre-action listener: _resource_record_pre_action 03:41:32 INFO - Running main action method: clobber 03:41:32 INFO - rmtree: /builds/slave/test/build 03:41:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:41:33 INFO - Running post-action listener: _resource_record_post_action 03:41:33 INFO - [mozharness: 2017-09-27 10:41:33.073917Z] Finished clobber step (success) 03:41:33 INFO - [mozharness: 2017-09-27 10:41:33.074015Z] Running read-buildbot-config step. 03:41:33 INFO - Running pre-action listener: _resource_record_pre_action 03:41:33 INFO - Running main action method: read_buildbot_config 03:41:33 INFO - Using buildbot properties: 03:41:33 INFO - { 03:41:33 INFO - "project": "", 03:41:33 INFO - "product": "firefox", 03:41:33 INFO - "who": "archaeopteryx@coole-files.de", 03:41:33 INFO - "installer_path": "public/build/target.tar.bz2", 03:41:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:41:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:41:33 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:41:33 INFO - "stage_platform": "linux64-qr", 03:41:33 INFO - "basedir": "/builds/slave/test", 03:41:33 INFO - "buildnumber": 87, 03:41:33 INFO - "platform": "ubuntu64_hw_qr", 03:41:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:41:33 INFO - "slavebuilddir": "test", 03:41:33 INFO - "taskId": "VSdqv_xLSS6JIn8d9VkRDw", 03:41:33 INFO - "branch": "mozilla-central", 03:41:33 INFO - "script_repo_revision": "production", 03:41:33 INFO - "revision": "35fbf14b96a633c3f66ea13c1a163a3f3a4219b9", 03:41:33 INFO - "slavename": "talos-linux64-ix-031", 03:41:33 INFO - "repo_path": "mozilla-central" 03:41:33 INFO - } 03:41:33 INFO - Finding installer, test and symbols from parent task. 03:41:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VSdqv_xLSS6JIn8d9VkRDw'}, attempt #1 03:41:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VSdqv_xLSS6JIn8d9VkRDw'}, attempt #1 03:41:34 INFO - Task dependencies: FadbKXGRQEiHgoCzlzPmQA 03:41:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA'}, attempt #1 03:41:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.tar.bz2 03:41:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.test_packages.json 03:41:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.crashreporter-symbols.zip 03:41:34 INFO - Running post-action listener: _resource_record_post_action 03:41:34 INFO - [mozharness: 2017-09-27 10:41:34.516065Z] Finished read-buildbot-config step (success) 03:41:34 INFO - [mozharness: 2017-09-27 10:41:34.516283Z] Running download-and-extract step. 03:41:34 INFO - Running pre-action listener: _resource_record_pre_action 03:41:34 INFO - Running main action method: download_and_extract 03:41:34 INFO - mkdir: /builds/slave/test/build/tests 03:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:34 INFO - trying https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.test_packages.json 03:41:34 INFO - Downloading https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:41:35 INFO - Downloaded 989 bytes. 03:41:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:41:35 INFO - Using the following test package requirements: 03:41:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:41:35 INFO - u'common': [u'target.common.tests.zip'], 03:41:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:41:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:41:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:41:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:41:35 INFO - u'mozbase': [u'target.common.tests.zip'], 03:41:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:41:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:41:35 INFO - u'web-platform': [u'target.common.tests.zip', 03:41:35 INFO - u'target.web-platform.tests.tar.gz'], 03:41:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:41:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:41:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.common.tests.zip 03:41:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:41:35 INFO - Fetch https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.common.tests.zip into memory 03:41:37 INFO - Content-Length response header: 54946111 03:41:37 INFO - Bytes received: 54946111 03:41:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.talos.tests.zip 03:41:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:41:48 INFO - Fetch https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.talos.tests.zip into memory 03:41:49 INFO - Content-Length response header: 14513665 03:41:49 INFO - Bytes received: 14513665 03:41: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:41:50 INFO - trying https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.tar.bz2 03:41:50 INFO - Downloading https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:41:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:41:53 INFO - Downloaded 61763156 bytes. 03:41:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.tar.bz2 03:41:53 INFO - mkdir: /builds/slave/test/properties 03:41:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:41:53 INFO - Writing to file /builds/slave/test/properties/build_url 03:41:53 INFO - Contents: 03:41:53 INFO - build_url:https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.tar.bz2 03:41:53 INFO - Running post-action listener: _resource_record_post_action 03:41:53 INFO - Running post-action listener: find_tests_for_verification 03:41:53 INFO - Running post-action listener: set_extra_try_arguments 03:41:53 INFO - [mozharness: 2017-09-27 10:41:53.059754Z] Finished download-and-extract step (success) 03:41:53 INFO - [mozharness: 2017-09-27 10:41:53.059852Z] Running populate-webroot step. 03:41:53 INFO - Running pre-action listener: _resource_record_pre_action 03:41:53 INFO - Running main action method: populate_webroot 03:41:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:41:53 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['tresize', 03:41:53 INFO - 'tcanvasmark']}, 03:41:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:41:53 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['dromaeo_css', 03:41:53 INFO - 'kraken']}, 03:41:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:53 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'tests': ['damp', 'tps']}, 03:41:53 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['damp', 'tps']}, 03:41:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:41:53 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['dromaeo_dom']}, 03:41:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:41:53 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['basic_compositor_video', 03:41:53 INFO - 'glvideo']}, 03:41:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:41:53 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['ts_paint_webext', 03:41:53 INFO - 'tp5o_webext']}, 03:41:53 INFO - 'other-e10s': {'tests': ['a11yr', 03:41:53 INFO - 'ts_paint', 03:41:53 INFO - 'tpaint', 03:41:53 INFO - 'sessionrestore', 03:41:53 INFO - 'sessionrestore_many_windows', 03:41:53 INFO - 'sessionrestore_no_auto_restore', 03:41:53 INFO - 'tabpaint']}, 03:41:53 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['a11yr', 03:41:53 INFO - 'ts_paint', 03:41:53 INFO - 'tpaint', 03:41:53 INFO - 'sessionrestore', 03:41:53 INFO - 'sessionrestore_many_windows', 03:41:53 INFO - 'sessionrestore_no_auto_restore', 03:41:53 INFO - 'tabpaint']}, 03:41:53 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:41:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:41:53 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['perf_reftest_singletons']}, 03:41:53 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['perf_reftest']}, 03:41:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:41:53 INFO - 'tsvgr_opacity', 03:41:53 INFO - 'tart', 03:41:53 INFO - 'tscrollx', 03:41:53 INFO - 'tsvg_static']}, 03:41:53 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['tsvgx', 03:41:53 INFO - 'tsvgr_opacity', 03:41:53 INFO - 'tart', 03:41:53 INFO - 'tscrollx', 03:41:53 INFO - 'tsvg_static']}, 03:41:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:41:53 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'talos_options': ['--disable-stylo'], 03:41:53 INFO - 'tests': ['tp5o']}, 03:41:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:41:53 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:41:53 INFO - 'talos_options': ['--mitmproxy', 03:41:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:41:53 INFO - '--firstNonBlankPaint'], 03:41:53 INFO - 'tests': ['tp6_google', 03:41:53 INFO - 'tp6_youtube', 03:41:53 INFO - 'tp6_amazon', 03:41:53 INFO - 'tp6_facebook']}, 03:41:53 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:41:53 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:41:53 INFO - 'talos_options': ['--disable-stylo', 03:41:53 INFO - '--mitmproxy', 03:41:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:41:53 INFO - '--firstNonBlankPaint'], 03:41:53 INFO - 'tests': ['tp6_google', 03:41:53 INFO - 'tp6_youtube', 03:41:53 INFO - 'tp6_amazon', 03:41:53 INFO - 'tp6_facebook']}, 03:41:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:41:53 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:41:53 INFO - 'talos_options': ['--stylo-threads=1', 03:41:53 INFO - '--mitmproxy', 03:41:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:41:53 INFO - '--firstNonBlankPaint'], 03:41:53 INFO - 'tests': ['tp6_google', 03:41:53 INFO - 'tp6_youtube', 03:41:53 INFO - 'tp6_amazon', 03:41:53 INFO - 'tp6_facebook']}, 03:41:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'talos_options': ['--xperf_path', 03:41:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:53 INFO - 'tests': ['tp5n']}, 03:41:53 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:41:53 INFO - 'talos_options': ['--disable-stylo', 03:41:53 INFO - '--xperf_path', 03:41:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:53 INFO - 'tests': ['tp5n']}}} 03:41:53 INFO - Running post-action listener: _resource_record_post_action 03:41:53 INFO - [mozharness: 2017-09-27 10:41:53.075455Z] Finished populate-webroot step (success) 03:41:53 INFO - [mozharness: 2017-09-27 10:41:53.075544Z] Running create-virtualenv step. 03:41:53 INFO - Running pre-action listener: _resource_record_pre_action 03:41:53 INFO - Running main action method: create_virtualenv 03:41:53 INFO - Creating virtualenv /builds/slave/test/build/venv 03:41:53 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:41:53 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:41:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:41:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:41:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:41:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:41:53 INFO - Installing pip...............done. 03:41:53 INFO - Return code: 0 03:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:41:54 INFO - Reading from file tmpfile_stdout 03:41:54 INFO - Output received: 03:41:54 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:41:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:41: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:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41: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:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1278b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f440>, '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 0x1420130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a320>, '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': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', '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:41: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', 'pip>=1.5'] in /builds/slave/test/build 03:41: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 pip>=1.5 03:41:54 INFO - Using env: {'DISPLAY': ':0', 03:41:54 INFO - 'HOME': '/home/cltbld', 03:41:54 INFO - 'LANG': 'en_US.UTF-8', 03:41:54 INFO - 'LANGUAGE': 'en_US:en', 03:41:54 INFO - 'LOGNAME': 'cltbld', 03:41:54 INFO - 'MAIL': '/var/mail/cltbld', 03:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:54 INFO - 'MOZ_NO_REMOTE': '1', 03:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:54 INFO - 'NO_EM_RESTART': '1', 03:41:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:54 INFO - 'PWD': '/builds/slave/test', 03:41:54 INFO - 'SHELL': '/bin/bash', 03:41:54 INFO - 'SHLVL': '1', 03:41:54 INFO - 'TERM': 'linux', 03:41:54 INFO - 'TMOUT': '86400', 03:41:54 INFO - 'USER': 'cltbld', 03:41:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 03:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:54 INFO - '_': '/tools/buildbot/bin/python'} 03:41:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:41:55 INFO - Downloading/unpacking pip>=1.5 03:41:55 INFO - Running setup.py egg_info for package pip 03:41:55 INFO - warning: no files found matching 'pip/cacert.pem' 03:41:55 INFO - warning: no files found matching '*.html' under directory 'docs' 03:41:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:41:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:41:55 INFO - Installing collected packages: pip 03:41:55 INFO - Found existing installation: pip 1.1 03:41:55 INFO - Uninstalling pip: 03:41:55 INFO - Successfully uninstalled pip 03:41:55 INFO - Running setup.py install for pip 03:41:55 INFO - warning: no files found matching 'pip/cacert.pem' 03:41:55 INFO - warning: no files found matching '*.html' under directory 'docs' 03:41:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:41:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:41:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:41:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:41:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:41:55 INFO - Successfully installed pip 03:41:55 INFO - Cleaning up... 03:41:55 INFO - Return code: 0 03:41:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1278b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f440>, '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 0x1420130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a320>, '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': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', '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:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:41:55 INFO - Using env: {'DISPLAY': ':0', 03:41:55 INFO - 'HOME': '/home/cltbld', 03:41:55 INFO - 'LANG': 'en_US.UTF-8', 03:41:55 INFO - 'LANGUAGE': 'en_US:en', 03:41:55 INFO - 'LOGNAME': 'cltbld', 03:41:55 INFO - 'MAIL': '/var/mail/cltbld', 03:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:55 INFO - 'MOZ_NO_REMOTE': '1', 03:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:55 INFO - 'NO_EM_RESTART': '1', 03:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:55 INFO - 'PWD': '/builds/slave/test', 03:41:55 INFO - 'SHELL': '/bin/bash', 03:41:55 INFO - 'SHLVL': '1', 03:41:55 INFO - 'TERM': 'linux', 03:41:55 INFO - 'TMOUT': '86400', 03:41:55 INFO - 'USER': 'cltbld', 03:41:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 03:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:55 INFO - '_': '/tools/buildbot/bin/python'} 03:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:55 INFO - Downloading/unpacking psutil>=3.1.1 03:41: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:41: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:41: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:41: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:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:41:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:57 INFO - Installing collected packages: psutil 03:41:57 INFO - Running setup.py install for psutil 03:41:57 INFO - building 'psutil._psutil_linux' extension 03:41:57 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:41:58 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:41:58 INFO - building 'psutil._psutil_posix' extension 03:41:58 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:41:58 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:41:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:58 INFO - Successfully installed psutil 03:41:58 INFO - Cleaning up... 03:41:58 INFO - Return code: 0 03:41:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1278b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f440>, '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 0x1420130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a320>, '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': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', '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:41:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:41:58 INFO - Using env: {'DISPLAY': ':0', 03:41:58 INFO - 'HOME': '/home/cltbld', 03:41:58 INFO - 'LANG': 'en_US.UTF-8', 03:41:58 INFO - 'LANGUAGE': 'en_US:en', 03:41:58 INFO - 'LOGNAME': 'cltbld', 03:41:58 INFO - 'MAIL': '/var/mail/cltbld', 03:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:58 INFO - 'MOZ_NO_REMOTE': '1', 03:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:58 INFO - 'NO_EM_RESTART': '1', 03:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:58 INFO - 'PWD': '/builds/slave/test', 03:41:58 INFO - 'SHELL': '/bin/bash', 03:41:58 INFO - 'SHLVL': '1', 03:41:58 INFO - 'TERM': 'linux', 03:41:58 INFO - 'TMOUT': '86400', 03:41:58 INFO - 'USER': 'cltbld', 03:41:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 03:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:58 INFO - '_': '/tools/buildbot/bin/python'} 03:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:41:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:41:59 INFO - Installing collected packages: mozsystemmonitor 03:41:59 INFO - Running setup.py install for mozsystemmonitor 03:42:00 INFO - Successfully installed mozsystemmonitor 03:42:00 INFO - Cleaning up... 03:42:01 INFO - Return code: 0 03:42:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1278b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f440>, '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 0x1420130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a320>, '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': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', '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:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:42:01 INFO - Using env: {'DISPLAY': ':0', 03:42:01 INFO - 'HOME': '/home/cltbld', 03:42:01 INFO - 'LANG': 'en_US.UTF-8', 03:42:01 INFO - 'LANGUAGE': 'en_US:en', 03:42:01 INFO - 'LOGNAME': 'cltbld', 03:42:01 INFO - 'MAIL': '/var/mail/cltbld', 03:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:01 INFO - 'MOZ_NO_REMOTE': '1', 03:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:01 INFO - 'NO_EM_RESTART': '1', 03:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:01 INFO - 'PWD': '/builds/slave/test', 03:42:01 INFO - 'SHELL': '/bin/bash', 03:42:01 INFO - 'SHLVL': '1', 03:42:01 INFO - 'TERM': 'linux', 03:42:01 INFO - 'TMOUT': '86400', 03:42:01 INFO - 'USER': 'cltbld', 03:42:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 03:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:01 INFO - '_': '/tools/buildbot/bin/python'} 03:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:01 INFO - Downloading/unpacking jsonschema==2.5.1 03:42: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:42: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:42: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:42: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:42:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:42:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:42:02 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:42:02 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:42:02 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:42:02 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:42:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:42:02 INFO - warning: no files found matching '*.txt' 03:42:02 INFO - no previously-included directories found matching 'build' 03:42:02 INFO - no previously-included directories found matching 'dist' 03:42:02 INFO - no previously-included directories found matching '.git*' 03:42:02 INFO - Installing collected packages: jsonschema, functools32 03:42:02 INFO - Running setup.py install for functools32 03:42:02 INFO - warning: no files found matching '*.txt' 03:42:02 INFO - no previously-included directories found matching 'build' 03:42:02 INFO - no previously-included directories found matching 'dist' 03:42:02 INFO - no previously-included directories found matching '.git*' 03:42:02 INFO - Successfully installed jsonschema functools32 03:42:02 INFO - Cleaning up... 03:42:02 INFO - Return code: 0 03:42:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:42:02 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:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:02 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:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:02 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 0x10b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1278b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f440>, '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 0x1420130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a320>, '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': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', '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:42:02 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:42:02 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:42:02 INFO - Using env: {'DISPLAY': ':0', 03:42:02 INFO - 'HOME': '/home/cltbld', 03:42:02 INFO - 'LANG': 'en_US.UTF-8', 03:42:02 INFO - 'LANGUAGE': 'en_US:en', 03:42:02 INFO - 'LOGNAME': 'cltbld', 03:42:02 INFO - 'MAIL': '/var/mail/cltbld', 03:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:02 INFO - 'MOZ_NO_REMOTE': '1', 03:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:02 INFO - 'NO_EM_RESTART': '1', 03:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:02 INFO - 'PWD': '/builds/slave/test', 03:42:02 INFO - 'SHELL': '/bin/bash', 03:42:02 INFO - 'SHLVL': '1', 03:42:02 INFO - 'TERM': 'linux', 03:42:02 INFO - 'TMOUT': '86400', 03:42:02 INFO - 'USER': 'cltbld', 03:42:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 03:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:02 INFO - '_': '/tools/buildbot/bin/python'} 03:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:42:03 INFO - Cleaning up... 03:42:03 INFO - Return code: 0 03:42:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:42: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:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42: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:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:03 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 0x10b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1278b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f440>, '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 0x1420130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a320>, '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': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', '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:42:03 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:42:03 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:42:03 INFO - Using env: {'DISPLAY': ':0', 03:42:03 INFO - 'HOME': '/home/cltbld', 03:42:03 INFO - 'LANG': 'en_US.UTF-8', 03:42:03 INFO - 'LANGUAGE': 'en_US:en', 03:42:03 INFO - 'LOGNAME': 'cltbld', 03:42:03 INFO - 'MAIL': '/var/mail/cltbld', 03:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:03 INFO - 'MOZ_NO_REMOTE': '1', 03:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:03 INFO - 'NO_EM_RESTART': '1', 03:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:03 INFO - 'PWD': '/builds/slave/test', 03:42:03 INFO - 'SHELL': '/bin/bash', 03:42:03 INFO - 'SHLVL': '1', 03:42:03 INFO - 'TERM': 'linux', 03:42:03 INFO - 'TMOUT': '86400', 03:42:03 INFO - 'USER': 'cltbld', 03:42:03 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 03:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:03 INFO - '_': '/tools/buildbot/bin/python'} 03:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:42: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:42: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:42: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:42: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:42:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:42:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:42:04 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:42:04 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:42:04 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:42:04 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:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:42:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:42:04 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:42:04 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:42:04 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:42:04 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:42:05 INFO - Downloading docopt-0.6.1.tar.gz 03:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:42:05 INFO - Installing collected packages: blobuploader, requests, docopt 03:42:05 INFO - Running setup.py install for blobuploader 03:42:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:42:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:42:05 INFO - Running setup.py install for requests 03:42:05 INFO - Running setup.py install for docopt 03:42:05 INFO - Successfully installed blobuploader requests docopt 03:42:05 INFO - Cleaning up... 03:42:05 INFO - Return code: 0 03:42:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:05 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:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:05 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:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:05 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 0x10b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1278b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f440>, '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 0x1420130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a320>, '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': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', '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:42:05 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:42:05 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:42:05 INFO - Using env: {'DISPLAY': ':0', 03:42:05 INFO - 'HOME': '/home/cltbld', 03:42:05 INFO - 'LANG': 'en_US.UTF-8', 03:42:05 INFO - 'LANGUAGE': 'en_US:en', 03:42:05 INFO - 'LOGNAME': 'cltbld', 03:42:05 INFO - 'MAIL': '/var/mail/cltbld', 03:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:05 INFO - 'MOZ_NO_REMOTE': '1', 03:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:05 INFO - 'NO_EM_RESTART': '1', 03:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:05 INFO - 'PWD': '/builds/slave/test', 03:42:05 INFO - 'SHELL': '/bin/bash', 03:42:05 INFO - 'SHLVL': '1', 03:42:05 INFO - 'TERM': 'linux', 03:42:05 INFO - 'TMOUT': '86400', 03:42:05 INFO - 'USER': 'cltbld', 03:42:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 03:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:05 INFO - '_': '/tools/buildbot/bin/python'} 03:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:05 INFO - Running setup.py (path:/tmp/pip-2v6rd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:05 INFO - Running setup.py (path:/tmp/pip-4Fig6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:06 INFO - Running setup.py (path:/tmp/pip-jAeJbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:06 INFO - Running setup.py (path:/tmp/pip-8gTPVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:06 INFO - Running setup.py (path:/tmp/pip-FhLMNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:06 INFO - Running setup.py (path:/tmp/pip-d3RyBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:06 INFO - Running setup.py (path:/tmp/pip-Cy6VVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:06 INFO - Running setup.py (path:/tmp/pip-8BcNK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:06 INFO - Running setup.py (path:/tmp/pip-CaBbAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:06 INFO - Running setup.py (path:/tmp/pip-bGWIcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:06 INFO - Running setup.py (path:/tmp/pip-5ydDUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:06 INFO - Running setup.py (path:/tmp/pip-EMu3aS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:06 INFO - Running setup.py (path:/tmp/pip-6Myz9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:06 INFO - Running setup.py (path:/tmp/pip-at5ASC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:06 INFO - Running setup.py (path:/tmp/pip-C2Wp1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:06 INFO - Running setup.py (path:/tmp/pip-lUaIw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:07 INFO - Running setup.py (path:/tmp/pip-lny3eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:42:07 INFO - Running setup.py install for manifestparser 03:42:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Running setup.py install for mozcrash 03:42:07 INFO - Running setup.py install for mozdebug 03:42:07 INFO - Running setup.py install for mozdevice 03:42:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Running setup.py install for mozfile 03:42:07 INFO - Running setup.py install for mozhttpd 03:42:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Running setup.py install for mozinfo 03:42:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Running setup.py install for mozInstall 03:42:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:42:07 INFO - Running setup.py install for mozleak 03:42:07 INFO - Running setup.py install for mozlog 03:42:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:42:08 INFO - Running setup.py install for moznetwork 03:42:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:42:08 INFO - Running setup.py install for mozprocess 03:42:08 INFO - Running setup.py install for mozprofile 03:42:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:42:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:42:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:42:08 INFO - Running setup.py install for mozrunner 03:42:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:42:08 INFO - Running setup.py install for mozscreenshot 03:42:08 INFO - Running setup.py install for moztest 03:42:08 INFO - Running setup.py install for mozversion 03:42:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:42:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:42:08 INFO - Cleaning up... 03:42:08 INFO - Return code: 0 03:42:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:08 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:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:08 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:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:08 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 0x10b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1278b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f440>, '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 0x1420130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a320>, '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': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', '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:42:08 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:42:08 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:42:08 INFO - Using env: {'DISPLAY': ':0', 03:42:08 INFO - 'HOME': '/home/cltbld', 03:42:08 INFO - 'LANG': 'en_US.UTF-8', 03:42:08 INFO - 'LANGUAGE': 'en_US:en', 03:42:08 INFO - 'LOGNAME': 'cltbld', 03:42:08 INFO - 'MAIL': '/var/mail/cltbld', 03:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:08 INFO - 'MOZ_NO_REMOTE': '1', 03:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:08 INFO - 'NO_EM_RESTART': '1', 03:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:08 INFO - 'PWD': '/builds/slave/test', 03:42:08 INFO - 'SHELL': '/bin/bash', 03:42:08 INFO - 'SHLVL': '1', 03:42:08 INFO - 'TERM': 'linux', 03:42:08 INFO - 'TMOUT': '86400', 03:42:08 INFO - 'USER': 'cltbld', 03:42:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 03:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:08 INFO - '_': '/tools/buildbot/bin/python'} 03:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:09 INFO - Running setup.py (path:/tmp/pip-zj6b2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:09 INFO - Running setup.py (path:/tmp/pip-fBgRt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:09 INFO - Running setup.py (path:/tmp/pip-acoD_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:09 INFO - Running setup.py (path:/tmp/pip-Pji9YY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:09 INFO - Running setup.py (path:/tmp/pip-jwKsh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:09 INFO - Running setup.py (path:/tmp/pip-xhsPkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:09 INFO - Running setup.py (path:/tmp/pip-65wxOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:09 INFO - Running setup.py (path:/tmp/pip-hFsNur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:09 INFO - Running setup.py (path:/tmp/pip-GMYA49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:09 INFO - Running setup.py (path:/tmp/pip-mYDlE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:09 INFO - Running setup.py (path:/tmp/pip-njjqXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:09 INFO - Running setup.py (path:/tmp/pip-D9D2p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:09 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:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:09 INFO - Running setup.py (path:/tmp/pip-2YL6uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:10 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:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:10 INFO - Running setup.py (path:/tmp/pip-8keeMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:10 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:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:10 INFO - Running setup.py (path:/tmp/pip-IxMLgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:10 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:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:10 INFO - Running setup.py (path:/tmp/pip-FMB0oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:10 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:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:10 INFO - Running setup.py (path:/tmp/pip-8sHLKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:10 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:42:10 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:42:10 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:42:10 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:42:10 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:42:10 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:42:10 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:42:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:42:10 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:42:10 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:42:10 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:42:10 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:42:11 INFO - Downloading blessings-1.6.tar.gz 03:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:42:11 INFO - Installing collected packages: blessings 03:42:11 INFO - Running setup.py install for blessings 03:42:11 INFO - Successfully installed blessings 03:42:11 INFO - Cleaning up... 03:42:11 INFO - Return code: 0 03:42:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:42:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:11 INFO - Reading from file tmpfile_stdout 03:42:11 INFO - Current package versions: 03:42:11 INFO - argparse == 1.2.1 03:42:11 INFO - blessings == 1.6 03:42:11 INFO - blobuploader == 1.2.4 03:42:11 INFO - docopt == 0.6.1 03:42:11 INFO - functools32 == 3.2.3-2 03:42:11 INFO - jsonschema == 2.5.1 03:42:11 INFO - manifestparser == 1.1 03:42:11 INFO - mozInstall == 1.13 03:42:11 INFO - mozcrash == 1.0 03:42:11 INFO - mozdebug == 0.1 03:42:11 INFO - mozdevice == 0.51 03:42:11 INFO - mozfile == 1.2 03:42:11 INFO - mozhttpd == 0.7 03:42:11 INFO - mozinfo == 0.10 03:42:11 INFO - mozleak == 0.1 03:42:11 INFO - mozlog == 3.5 03:42:11 INFO - moznetwork == 0.27 03:42:11 INFO - mozprocess == 0.25 03:42:11 INFO - mozprofile == 0.28 03:42:11 INFO - mozrunner == 6.13 03:42:11 INFO - mozscreenshot == 0.1 03:42:11 INFO - mozsystemmonitor == 0.3 03:42:11 INFO - moztest == 0.8 03:42:11 INFO - mozversion == 1.4 03:42:11 INFO - psutil == 3.1.1 03:42:11 INFO - requests == 1.2.3 03:42:11 INFO - wsgiref == 0.1.2 03:42:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:11 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:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:11 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:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:11 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 0x10b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1278b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f440>, '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 0x1420130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a320>, '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': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', '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:42:11 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:42:11 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:42:11 INFO - Using env: {'DISPLAY': ':0', 03:42:11 INFO - 'HOME': '/home/cltbld', 03:42:11 INFO - 'LANG': 'en_US.UTF-8', 03:42:11 INFO - 'LANGUAGE': 'en_US:en', 03:42:11 INFO - 'LOGNAME': 'cltbld', 03:42:11 INFO - 'MAIL': '/var/mail/cltbld', 03:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:11 INFO - 'MOZ_NO_REMOTE': '1', 03:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:11 INFO - 'NO_EM_RESTART': '1', 03:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:11 INFO - 'PWD': '/builds/slave/test', 03:42:11 INFO - 'SHELL': '/bin/bash', 03:42:11 INFO - 'SHLVL': '1', 03:42:11 INFO - 'TERM': 'linux', 03:42:11 INFO - 'TMOUT': '86400', 03:42:11 INFO - 'USER': 'cltbld', 03:42:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 03:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:11 INFO - '_': '/tools/buildbot/bin/python'} 03:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:12 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:42:12 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:42:12 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:42:12 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:42:12 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:42:12 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:42:12 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:42:12 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:42:12 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:42:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:42:12 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:42:12 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:42:12 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:42:12 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:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:42:13 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:42:13 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:42:13 INFO - Installing collected packages: simplejson 03:42:13 INFO - Running setup.py install for simplejson 03:42:13 INFO - building 'simplejson._speedups' extension 03:42:13 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:42:14 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:42:14 INFO - Successfully installed simplejson 03:42:14 INFO - Cleaning up... 03:42:14 INFO - Return code: 0 03:42:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:14 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 0x10b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1278b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bdf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f440>, '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 0x1420130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a320>, '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': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', '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:42:14 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:42:14 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:42:14 INFO - Using env: {'DISPLAY': ':0', 03:42:14 INFO - 'HOME': '/home/cltbld', 03:42:14 INFO - 'LANG': 'en_US.UTF-8', 03:42:14 INFO - 'LANGUAGE': 'en_US:en', 03:42:14 INFO - 'LOGNAME': 'cltbld', 03:42:14 INFO - 'MAIL': '/var/mail/cltbld', 03:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:14 INFO - 'MOZ_NO_REMOTE': '1', 03:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:14 INFO - 'NO_EM_RESTART': '1', 03:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:14 INFO - 'PWD': '/builds/slave/test', 03:42:14 INFO - 'SHELL': '/bin/bash', 03:42:14 INFO - 'SHLVL': '1', 03:42:14 INFO - 'TERM': 'linux', 03:42:14 INFO - 'TMOUT': '86400', 03:42:14 INFO - 'USER': 'cltbld', 03:42:14 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 03:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:14 INFO - '_': '/tools/buildbot/bin/python'} 03:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:42:14 INFO - Cleaning up... 03:42:14 INFO - Return code: 0 03:42:14 INFO - Running post-action listener: _resource_record_post_action 03:42:14 INFO - Running post-action listener: _start_resource_monitoring 03:42:14 INFO - Starting resource monitoring. 03:42:14 INFO - [mozharness: 2017-09-27 10:42:14.565643Z] Finished create-virtualenv step (success) 03:42:14 INFO - [mozharness: 2017-09-27 10:42:14.566159Z] Running install step. 03:42:14 INFO - Running pre-action listener: _resource_record_pre_action 03:42:14 INFO - Running main action method: install 03:42:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:14 INFO - Reading from file tmpfile_stdout 03:42:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:42:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:42:14 INFO - Reading from file tmpfile_stdout 03:42:14 INFO - Output received: 03:42:14 INFO - Usage: mozinstall [options] installer 03:42:14 INFO - Options: 03:42:14 INFO - -h, --help show this help message and exit 03:42:14 INFO - -d DEST, --destination=DEST 03:42:14 INFO - Directory to install application into. [default: 03:42:14 INFO - "/builds/slave/test"] 03:42:14 INFO - --app=APP Application being installed. [default: firefox] 03:42:14 INFO - mkdir: /builds/slave/test/build/application 03:42:14 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:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:42:32 INFO - Reading from file tmpfile_stdout 03:42:32 INFO - Output received: 03:42:32 INFO - /builds/slave/test/build/application/firefox/firefox 03:42:32 INFO - Running post-action listener: _resource_record_post_action 03:42:32 INFO - [mozharness: 2017-09-27 10:42:32.713070Z] Finished install step (success) 03:42:32 INFO - [mozharness: 2017-09-27 10:42:32.713238Z] Running setup-mitmproxy step. 03:42:32 INFO - Running pre-action listener: _resource_record_pre_action 03:42:32 INFO - Running main action method: setup_mitmproxy 03:42:32 INFO - Skipping: mitmproxy is not required 03:42:32 INFO - Running post-action listener: _resource_record_post_action 03:42:32 INFO - [mozharness: 2017-09-27 10:42:32.714383Z] Finished setup-mitmproxy step (success) 03:42:32 INFO - [mozharness: 2017-09-27 10:42:32.714605Z] Running run-tests step. 03:42:32 INFO - Running pre-action listener: _resource_record_pre_action 03:42:32 INFO - Running pre-action listener: _set_gcov_prefix 03:42:32 INFO - Running main action method: run_tests 03:42:32 WARNING - Try message not found. 03:42:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:42:32 INFO - Python 2.7.3 03:42:32 INFO - Return code: 0 03:42:32 INFO - grabbing minidump binary from tooltool 03:42:32 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:42:32 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 0x141f440>, '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 0x1420130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a320>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:42:32 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:42:32 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:42:32 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:42:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:42:32 INFO - Return code: 0 03:42:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:42:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:42:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:42:32 INFO - ENV: RUST_BACKTRACE is now full 03:42:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:42:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:42:32 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/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:42:32 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/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-031 --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:42:32 INFO - Using env: {'DISPLAY': ':0', 03:42:32 INFO - 'HOME': '/home/cltbld', 03:42:32 INFO - 'LANG': 'en_US.UTF-8', 03:42:32 INFO - 'LANGUAGE': 'en_US:en', 03:42:32 INFO - 'LOGNAME': 'cltbld', 03:42:32 INFO - 'MAIL': '/var/mail/cltbld', 03:42:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:32 INFO - 'MOZ_ACCELERATED': '1', 03:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:32 INFO - 'MOZ_NO_REMOTE': '1', 03:42:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:32 INFO - 'MOZ_WEBRENDER': '1', 03:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:32 INFO - 'NO_EM_RESTART': '1', 03:42:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:32 INFO - 'PWD': '/builds/slave/test', 03:42:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:32 INFO - 'RUST_BACKTRACE': 'full', 03:42:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:42:32 INFO - 'SHELL': '/bin/bash', 03:42:32 INFO - 'SHLVL': '1', 03:42:32 INFO - 'TERM': 'linux', 03:42:32 INFO - 'TMOUT': '86400', 03:42:32 INFO - 'USER': 'cltbld', 03:42:32 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 03:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:32 INFO - '_': '/tools/buildbot/bin/python'} 03:42:32 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/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:42:33 INFO - mozversion application_buildid: 20170927094813 03:42:33 INFO - mozversion application_changeset: 35fbf14b96a633c3f66ea13c1a163a3f3a4219b9 03:42:33 INFO - mozversion application_display_name: Nightly 03:42:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:42:33 INFO - mozversion application_name: Firefox 03:42:33 INFO - mozversion application_remotingname: firefox 03:42:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:42:33 INFO - mozversion application_vendor: Mozilla 03:42:33 INFO - mozversion application_version: 58.0a1 03:42:33 INFO - mozversion platform_buildid: 20170927094813 03:42:33 INFO - mozversion platform_changeset: 35fbf14b96a633c3f66ea13c1a163a3f3a4219b9 03:42:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:42:33 INFO - mozversion platform_version: 58.0a1 03:42:33 INFO - using testdate: 1506508953 03:42:33 INFO - actual date: 1506508953 03:42:33 INFO - starting webserver on 'localhost:47067' 03:42:33 INFO - SUITE-START | Running 2 tests 03:42:33 INFO - TEST-START | dromaeo_css 03:42:33 INFO - Initialising browser for dromaeo_css test... 03:42:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47067/getInfo.html -profile /tmp/tmp084WbB/profile 03:42:33 INFO - TEST-INFO | started process 3318 (/builds/slave/test/build/application/firefox/firefox http://localhost:47067/getInfo.html) 03:42:39 INFO - TEST-INFO | 3318: exit 0 03:42:39 INFO - Browser initialized. 03:42:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:42:39 INFO - Using env: {'DISPLAY': ':0', 03:42:39 INFO - 'HOME': '/home/cltbld', 03:42:39 INFO - 'JSGC_DISABLE_POISONING': '1', 03:42:39 INFO - 'LANG': 'en_US.UTF-8', 03:42:39 INFO - 'LANGUAGE': 'en_US:en', 03:42:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:42:39 INFO - 'LOGNAME': 'cltbld', 03:42:39 INFO - 'MAIL': '/var/mail/cltbld', 03:42:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:39 INFO - 'MOZ_ACCELERATED': '1', 03:42:39 INFO - 'MOZ_CRASHREPORTER': '1', 03:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:42:39 INFO - 'MOZ_NO_REMOTE': '1', 03:42:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:39 INFO - 'MOZ_WEBRENDER': '1', 03:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:39 INFO - 'NO_EM_RESTART': '1', 03:42:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:39 INFO - 'PWD': '/builds/slave/test', 03:42:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:39 INFO - 'RUST_BACKTRACE': 'full', 03:42:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:42:39 INFO - 'SHELL': '/bin/bash', 03:42:39 INFO - 'SHLVL': '1', 03:42:39 INFO - 'TERM': 'linux', 03:42:39 INFO - 'TMOUT': '86400', 03:42:39 INFO - 'USER': 'cltbld', 03:42:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 03:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:39 INFO - '_': '/tools/buildbot/bin/python'} 03:42:39 INFO - TEST-INFO | started process 3564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp084WbB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:40 INFO - PID 3564 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:42:40 INFO - PID 3564 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:42:41 INFO - PID 3564 | 03:42:41 INFO - PID 3564 | (/builds/slave/test/build/application/firefox/firefox:3625): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:42:41 INFO - PID 3564 | 03:42:51 INFO - PID 3564 | RSS: Main: 198049792 03:42:51 INFO - PID 3564 | 03:45:48 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:47067/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47067/tests/dromaeo/cssquery-ext.html) 03:45:50 INFO - PID 3564 | RSS: Main: 197509120 03:45:50 INFO - PID 3564 | 03:48:52 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:47067/tests/dromaeo/cssquery-ext.html (next: http://localhost:47067/tests/dromaeo/cssquery-jquery.html) 03:48:53 INFO - PID 3564 | RSS: Main: 195411968 03:48:53 INFO - PID 3564 | 03:51:55 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:47067/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47067/tests/dromaeo/cssquery-mootools.html) 03:51:56 INFO - PID 3564 | RSS: Main: 197406720 03:51:56 INFO - PID 3564 | 03:54:58 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:47067/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47067/tests/dromaeo/cssquery-prototype.html) 03:54:58 INFO - PID 3564 | RSS: Main: 196173824 03:54:58 INFO - PID 3564 | 03:58:02 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:47067/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47067/tests/dromaeo/cssquery-yui.html) 03:58:03 INFO - PID 3564 | RSS: Main: 196333568 03:58:03 INFO - PID 3564 | 04:01:05 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:47067/tests/dromaeo/cssquery-yui.html (next: http://localhost:47067/tests/dromaeo/cssquery-dojo.html) 04:01:05 INFO - PID 3564 | RSS: Main: 198705152 04:01:05 INFO - PID 3564 | 04:01:05 INFO - PID 3564 | __start_tp_report 04:01:05 INFO - PID 3564 | _x_x_mozilla_page_load 04:01:05 INFO - PID 3564 | _x_x_mozilla_page_load_details 04:01:05 INFO - PID 3564 | |i|pagename|runs| 04:01:05 INFO - PID 3564 | |0;dojo.html;3197.8720851165954;3205.535197396376;3219.726323262523;3227.03189043287;3228.0477259208533;6065.454109130177;6245.469135123514;6319.241690997081;6322.873542529147;6337.271213810419;6179.351168127349;6237.750489980395;6276.874462510747;6277.152584401105;6329.113924050636;5716.314042314928;5761.855953601152;5775.27809023872;5793.449622285897;5804.2744656917885;5726.541876649879;5762.1068734346245;5792.391798861122;5795.884082318351;5867.911981320283;5736.4550367715;5775.884482310351;5796.13058041293;5829.5919285650025;5907.497862681677;5515.889682206373;5770.451807078321;5799.884002319972;5814.592978491507;5853.76584936602;5597.888042239132;5607.046802043662;5637.041702910515;5690.971545142289;5735.770569177228;6162.414570615784;6189.414598220513;6232.0963460298;6271.341509141565;6329.240491141092;6626.536142470029;6687.130673012477;6739.5282330236905;6770.356816102462;6776.7628133015105;6792.558483698544;6792.864142717168;6821.4542836572955;6841.897371539381;6862.210845752752;6225.782097626607;6264.812055638338;6332.1135041094285;6355.3009168991375;6376.7130479128555;6919.065926100013;6935.791926242221;7010.334018268256;7024.929750702529;7025.227225005246;6442.35576442352;6521.47828173745;6568.047633093175;6593.472522198213;6739.494537909676;6681.33186681328;6719.630420326929;6726;6730.831729206809;6782.050512928194;6664.133662623828;6664.933350666432;6748.257691653914;6757.797266082025;6764.594124352555;6488.28628850826;6704.195496540349;6732.697028633724;6796.422304104207;6824.965875170592;5103.464136265638;5178.71517066565;5251.238570407269;5253.605979551549;5258.2638430619745;4585.266357382803;4608.28571571407;4610.561996610317;4630.21286381316;4644.7213167210075;5681.517071049007;5743.368229494752;5806.361300256968;5808.5062769665055;5819.272590926134;6655.234648015444;6690.498212634072;6724.899126513106;6751.4261287790105;6818.352256535622;5607.102863541813;5724.713764311851;5728.140778883201;5740.942590574041;5813.069908814569;5636.464535869086;5671.064274394761;5696.772129114872;5726.141078838207;5785.132230165509;6485.156929599122;6506.512011599149;6542.1168142300185;6587.835304117435;6611.669416529155;6742.5280230383405;6773.085633439521;6835.658217089225;6852.314768523208;6870.27862074475;6394.072859435449;6483.481321494363;6514.250861151028;6608.801735947929;6611.371919667624;6515.869682606227;6551.737930482727;6552.83617909537;6574.671266436755;6585.275619681735;6646.136002319668;6763.93236067633;6769.289224631343;6831.0436538883605;6848.417884479875;6439.388258115471;6477.578957367756;6509.707063182263;6557;6570.342965703391;6322.810315690536;6401.807945761635;6416.743330266737;6423.839404014937;6438.130852334875;6328.082428047999;6372.553921225655;6376.947803612352;6387.808365749035;6388.744450221939;6344.143540622142;6442.872497313046;6483.675816209076;6503.577267477599;6606.570572912745;6346.587471814318;6351.396617321347;6382.329855365306;6414.807555773335;6419.518536109717 04:01:05 INFO - PID 3564 | |1;ext.html;785.120664855362;796.6773456750018;804.1917872538095;809.0655293136426;811.6428771340611;37404.625953740455;40670;40703.38944915828;40852;41245;38020.42969355455;38218.8089059555;38248.23503529928;38325.233495330074;38329;6945.965270173642;7030.964845175767;7044.718211271568;7050.964745176293;7097.148342198943;7025.297470252985;7912.881306780403;8112.918870811305;8133.511989280632;8137.75586732399;8054.556999365032;8074.475159114668;8121.350291976628;8129.146439623843;8144.918550814505;7873.96063019687;7907.209279072075;7962.5620590867475;8077.95961020194;8078.353731701509;7882.093559240703;7972.402069844785;8019.879701804478;8028.879566806502;8044.356451483867;36743.265134697154;36839;36910;37068;37178;3231.1922019495128;3257.1368587324378;3264.657210992835;3267.281198136406;3300.05948304732;30562.54156187659;30567;30643.846780765954;30658.38683226323;30719.232019199477;5202.375714914197;5245.370555533361;5285.894282114336;5297.099493086184;5328.547073498718;183312.08343958328;184491.15508844875;185146;185363;185443;46413;46532;46631;46787.298190527166;46861.297080543816;43373.34939975903;44352.778236108614;49639.50360496349;49681.50318496841;49809;15801;16013.679726405406;16020.118893460738;16112.436064737678;16134.75797863033;13097.607071787861;13128.146670466389;13172.341382930816;13176.670583235304;13250.271235082164;13758.243296618582;13830.65423364424;13918.234497102554;14031.298435078204;14110.435582576787;5619.80330688424;5633.873225354863;5640.464155905182;5725.2843394575675;5841.474267315962;982.1553464021079;987.9209663226925;1004.3923426327113;1006.5369929832212;1010.2927950434726;22768.886155569115;22787.430314242276;22852.542949140923;22915.312540623807;23014.07943682234;1092.1099304067159;1101.5373543111912;1107.4075369677184;1110.3559935237543;1121.5625905896707;12026.15816892809;12054.698632534082;12060.46221111805;12130.818037729441;12160.574379896661;200005;201214;202186;204468;208924;49507;49600.751996239786;49609;49831.501684982686;49990.50009499931;1421.9004669673232;1437.1736251655132;1446.5081872163514;1448.246911605959;1457.7813328000673;21639.13443462244;22269.331920042423;22469.550608988055;22531.549369012857;22716.432089197242;35367.64632353746;35525.64474355327;35609.64390356063;35692;35808.10479738027;185514;185697;187400.06299968413;187692;188163;29852.70147298499;30258.697413025588;32456.188595285308;33455.99632011043;33996;41949;42041;42343.57656423396;42399.36400953926;42784.786076069424;30936.381272374878;31084.37831243317;31103;31308.530372044894;31770;30264.84867575648;30314.696853031186;30821.537676935313;31035.224119397197;31474.68525314809;33984;34131.48802767911;34315.14212144716;34674.47988280228;35068;30009.699903001565;30335;30400.239993999443;30542.389152216387;30793.384132317675;22864.428389290402;22903.312900613008;22937.197198097987;22985.195518156783;23134 04:01:05 INFO - PID 3564 | |2;jquery.html;558.2296430925322;577.5495113811229;592.386879579635;593.3621357041179;610.1640752169527;22192.11231550738;22565.66151507729;22812.20157294495;22862.428439289026;23004.65493017604;22950.885245573747;24005.879970600166;24523.75476245237;24752;24793.50412991739;6633;6717.798466046002;6758;6787.151606049244;6820.454363650896;6597.37324954131;6636.2036555613395;6646.900296495556;6662.633555154464;6717.56335838169;6384.553081284312;6684.899726504106;6705.631190284533;6736.730530778763;6739.292374300677;6552.868942621169;6619.867602647968;6630.270670226247;6648.501362397839;6660.9000864987065;6088.1476593276975;6160.599561028519;6168.105624684441;6180.690965451709;6204.6587437690905;25733.35666608331;28201;28257.293567660767;28303.85848070767;28606.14181574556;1950.619629172312;2007.5784085342095;2020.3332900142918;2032.9695054574192;2035.4402539301661;18300.542486437946;18991.81008189928;19227.423177304703;19307.80692193074;19309.227630894748;2262.6040442922585;2316.2819525946843;2318.7449380568123;2320.9883950580306;2324.2097686786406;123635.38182309121;130698.3465082678;133566;138068.30965845208;139007.30496347556;14026.649333766738;14224.502142425172;14395.42418303277;14533.273336333352;14667;22527;22696.886515567647;22721.545569088525;22738.545229095656;22766.31701048971;9530.761730956781;9945.45300008492;10025.448600326907;10147.695569132939;10148.188144948386;9138.17756401927;9231.261499080058;9260.814783704289;9290.814183716422;9388.67139650109;8752.737417877473;8811.911880881109;8816.779580510538;8969.820603587892;9182.86225706615;2552.3619095226195;2628.2772237634804;2713.74219449152;2752.146834481317;2831.716828317193;932.379967321737;955.2405837359316;965.8502932045544;982.7346616413529;983.2674657380297;18266.26934922588;18673.253069877326;18731.438056858315;18975.24099036023;19196.232150714095;1018.3686114608989;1029.6807989523272;1031.0359813574332;1031.654395777423;1048.1405247696816;10240.283180177315;10390.636327728644;10406.427646479366;10507.264491485523;10578.735531611617;444650;445808;449255;462228;468919;110675;110892.4455377718;111172.44413777879;111273.44363278132;111290;1117.1900372230068;1136.846525719034;1137.374444055766;1142.1091548592112;1143.1312202725821;16851.1574421276;17318.134093295033;17354.566135846704;17537.912310438365;17629;54808.451915480335;55107;55871;56006.15990760223;57557;68440.28899277358;68582.31417685759;68826.311736882;69202.30797691959;69980.65009674919;14320.355583998537;14390.568282951528;14451.710965780836;14465.27673616294;14509.984301098822;21952.341429757133;22136.335909922727;22286.88856555707;22394;22478;17642.38251661186;17782.37761678387;17825.376111836023;17913.462596122135;18424.35514756977;16010.599735006717;16075.75886361729;16283.104429256504;16667.24997375145;16776.748348774534;17962.281508740027;18580;18762.812371876105;18837.6232475347;18875;14306.928465357607;14405.351759171072;14414.639634009234;14415.78376324335;14440.711185776016;17925;18609.720854187468;19019.809801901803;19091.713624295924;19095.90452047731 04:01:05 INFO - PID 3564 | |3;mootools.html;1351.4459071780568;1381.475039484996;1397.89515786316;1415.4550498058245;1418.2625034981809;14705.632359191011;15425.382984680613;15441.768373474379;15472.149031803261;15503.224838758046;15191.392344306214;15223.619409514768;15323.463678771246;15334.233288335594;15375.692486150298;2637;2663.294227029834;2708.2958430808035;2708.9322766930786;2719.3745438549145;2661.6945540838337;2731.726827317272;2746.6978632350424;2752.9174124776287;2753.559430491122;2622.8688565571742;2673.7593616574504;2687.4490729400522;2752.7660148887367;2761.1026416414643;2760.5721113227482;2761.6685997680306;2788.1914244868963;2788.219298596376;2791.986040069807;2560.142352311978;2594.3514121469634;2599.493098845726;2615.333090062041;2621.397078671897;14662.633434164125;15160.620984475367;15168.31742571587;15168.696626067416;15176.924115379463;7994.400419968526;8178.836423271501;8219.506829590244;8222.218889205516;8239.299659528888;4946.455889852114;5336.092864213093;5366.651167674088;5469.371022332403;5504.944950550484;1841.4199527148905;1871.897045662488;1904.0003997901074;1942.4464027752165;1944.445832937606;27092.187234383;27157.456850862873;27233.183004509898;27403.45193096147;27406.725932740617;6705.161854768154;7325.120985481776;7567.167611562723;7572.7728168155045;7637.923620763832;17149.57126071858;17310.480685579452;17396.130193490273;17432.21555030027;17463.825361746472;7853.293203611703;7957.562334071682;7976.840463190703;7989.920100798918;8540.231379175904;7359.411247100219;7503.287187717158;7551.358134558514;7565.394768418513;7640.465167438226;5007.524285192901;5117.05769182714;5127.717975511383;5196.92204616931;5217.3999990000875;1466.8679818816358;1467.2663668165917;1473.7273604383224;1488.4864721671006;1499.137995652504;868.5657171414293;869.6390997735995;894.7628878347243;895.2793001633747;902.1654969153507;7380.889286660705;7385.187629360766;7386.298301661333;7415.3326200642205;7534.397248220129;706.1244057368825;714.4891402647132;715.9427245820322;718.3821913154683;722.0288711682779;4845.152098382769;4874;5074.08666440037;5127.97436012825;5137.357830271216;20897.37307880766;21214.36356909295;21699.45751356197;21715.891420542797;22241.332760017227;20557.69163462549;20955.37133885986;21925.451863703536;21940.341789746333;22280.66579001316;11348.205625606293;11493.367864767519;11561.132915031407;11582.247153935135;11634.418279086012;8036.196380361917;8066.798330041796;8069.435139540411;8157.102718701057;8184.345252379676;18040.909795451465;18113.637727245645;18649.533761655526;18889.433317000512;18962.146703398656;19116.139773710496;19288.80711192926;19307.324243651405;19629.11668974928;19646.21415143378;11124.944375278072;11186.496607652512;11231.438428078727;11282.097432205239;11318.94340528292;13578.592642220749;13771.655708607364;13784.104033237807;13790.862091379358;13792.655183620489;11469.942650286695;11555.942220288845;11597.13021523406;11625;11710.648680539598;10700.090492308242;11263.66209013731;11482.885171148182;11485.942570287096;11551.76896462083;9375.765605859908;9563.713088607354;9585.281103917094;9653.131218190396;9663.468509231778;7208.315210055036;7218.89171662415;7231.783046508614;7250.20247772734;7307.1231452226075;7183.640817959185;7203.567785932861;7227.819304517429;7247.347738703542;7291.41668666516 04:01:05 INFO - PID 3564 | |4;prototype.html;516.6899860083947;524.0959345129651;548.6790227716785;551.9144532597448;552.3565046720571;6219.378062193784;6227.221597300338;6242.157308763316;6265.404786545277;6334.239891213061;6116.908246376297;6211.720472578733;6222.160008398865;6231.50147988161;6269.301112343716;5138.537531622153;5159.871003224912;5204.843854684365;5212.107280459343;5225.921611175835;5082.974585127069;5103.515166059237;5135.79308862417;5212.687238765668;5228.398734145565;5086.21163719624;5099.898002039976;5108.361454818148;5110.28456016158;5138.2806407103035;5071.594272458231;5094.770735316901;5099.4390617032095;5123.615728820316;5165;4632.212523870916;4656.767161641938;4718.41019872516;4719.693219940693;4731.834385796481;6068.757249710006;6073.18012068374;6077.270727512682;6095.695215239265;6120.785772497941;5835.212246346731;5864.912026319608;5876.942150412924;5909.349971503131;5911.408859114097;6355.618662880242;6532.248791389004;6549.312322206195;6559.639219842907;6584.27572966978;4937.679050861719;5045.899082018375;5062.1141300272675;5064.873378165538;5076.23856421536;6547.967260163717;6708.262091169968;6754.628495432749;6762.966185169092;6772.932270677329;5236.790528378822;5339.973300133553;5365.812196573102;5371.248025276464;5408.91886621701;5403.702796346239;5428.701421421781;5482.0406428874785;5503.596582871342;5514.448555144534;5451.528087416455;5563.304586926634;5635.126555383922;5657.4908258256955;5680.289963754531;6419.570496357592;6458.773942911976;6473.838154046187;6521.347865213535;6577.7635603894905;1720.028184075993;1720.673072116294;1750.7111326630964;1757.7539144519778;1771.4862689820065;1193.1945936492832;1232.5562797392931;1241.000994199678;1242.4967888005372;1247.875212478745;5457.2905522282645;5567.777288908398;5573;5577.9163312550345;5578.8047418340975;6383.840403989844;6449.839028974736;6641.203055633355;6649.268580456146;6653.434458071021;5505.642133261325;5541.312463455221;5557.499825015687;5617.578681598897;5648.519875810603;3484.2160513884173;3495.9825200873834;3507.8424120040327;3530.699890509284;3533.8939831805087;6316.589421687576;6332.176817013758;6348.460380867678;6384.201974753156;6389.904151437732;6761.309672581854;6772.966135169293;6774.390304872585;6797.456203503708;6848.6918088686125;6418.711157997808;6437.645929473924;6444;6448.677566121675;6487.610743355413;5988.622616798074;6539.103659938564;6587.176602924635;6639.767608133692;6658.533902626769;6283.654399008098;6494.188226471691;6506.967465162644;6529.08255046968;6575.50683698715;6147.969260153671;6273.466755325849;6321.778737744341;6424.710888010144;6458.354164583692;4933.975330123327;4947.505249475023;4954.900901982012;4989;5017.122003649274;6475.740970361321;6510.674466276572;6521.543491955517;6538.509611779041;6680.131582894387;6317.30509643948;6378.202724659418;6383.776193022494;6415.486761059197;6471.320511346241;6308.463780578702;6399.168108146097;6399.93600064012;6431.517636177212;6474.050828994404;6321.862064828375;6355.601767611118;6383.808485745435;6383.808485745435;6394.4564712;6427.742890284523;6465.676716164267;6466.547341686037;6477.384648458389;6505.674716264073;6174.969125154345;6220.160278362363;6255.280642725963;6265.373462653698;6278.215223097113 04:01:05 INFO - PID 3564 | |5;yui.html;909.5906841921135;914.2411798207488;917.9311551633629;921.4241099312932;922.4050487435604;18446.35437759679;18540.721889171673;18651.90674046631;18738.531536711587;18943.71584426231;21423.14307427705;21826;21850.781492185113;22004.559908801813;22041;994.2294721590753;997.2670087485692;999.215615741643;1000.9899901001006;1005.2762011351815;992.4640694025218;1001.739547717595;1003.9447830369327;1004.467632154959;1007.9697609071703;1037.5331101004579;1040.1834559870504;1045.4354648489843;1045.9320144190642;1046.5970601318509;1018.332991890313;1028.2442404832443;1033.0083120204613;1038.3717850700332;1039.6465201831413;754.9207333229987;757.0952711509748;758.2303961479104;758.2909979169494;758.8368500772306;20034.59930801376;20046.1981520739;20076.196952121896;20194.49513762153;20299.695504567444;19684.901575492175;21676.566468670695;21770.238041668465;21784.455388615253;21799.237026704148;17390.3043878246;17398.826011739846;17783;17903.73144402835;17924.55188620295;3703.111253299189;3759.7368184227116;3760.4735337052834;3760.7743535387963;3769.491118698968;101957.49021254921;112020.4398978;133662.33168834192;142477.2876135623;143070;17501.824981750273;17645.558861028578;17691.646167076586;17752.55618609545;17787.19957601885;31579.52630710541;31602.683973159976;32003.359932801213;32094.197645058593;32156.67843321537;9027;9119.407238529475;9170.86243706345;9177.495237761987;9183;4092.979535102365;4159.833606655699;4164.729292595972;4166.541680415152;4199.391088292181;5300.701328174622;5428.321459817523;5456.127019676833;5492.670439773627;5523.558115350762;1081.7890511350367;1102.72431892027;1121.9439028048564;1127.22784892349;1132.377192544114;652.709544252803;689.6138162628944;700.2227527444533;703.683342495879;706.1138271469273;11615.361155136548;11898.702532436759;12117.75764484723;13117.868821311855;13239.867601323864;645.3449748505271;663.1346093348227;664.9767258145941;674.150570281449;682.5836239893661;5707.4577915098;5727.6849773262875;5784.537237021028;5821.18503409523;5858.355580886099;112289.87710122958;119679.40160299143;120913;121971.39014305049;122401.38799305947;101714;103943;106178.46910765396;106761;107759.46120269505;95471;96823;99529;99764;100005;10660.84008739885;10744.140468762324;10745.838812417664;10960.123190144928;11055.0603198729;43381.56618433775;44422;45243.32135017912;45472.09055818931;46102.30846537238;54141;55164.17253741117;55700.442995571146;55781.72109139428;56543.434565655465;14982.325795339453;15355.61610959735;15364.769528456858;15491;15494.612634684223;16785.580360491087;16925.576860578585;17110.315587376364;17125;17240.137993100547;15245;15267.236638167826;15315.61710957235;15389.846101538842;15850.68298634044;15694.9215253923;15718.371265149266;15924.840751592335;16022.839771602135;16189.75715364294;15347.846521535088;15626.45307414235;15715.44995925183;15739.606509837346;15833.208339582745;11604.245724027911;12081.275123492618;12178.817317740419;12185.817212741638;12381.504739810667;11934.761304774029;12207.69480762988;12239.571614993432;12268.877311226774;12337.198082124632 04:01:05 INFO - PID 3564 | __end_tp_report 04:01:05 INFO - PID 3564 | __start_cc_report 04:01:05 INFO - PID 3564 | _x_x_mozilla_cycle_collect,301 04:01:05 INFO - PID 3564 | __end_cc_report 04:01:05 INFO - PID 3564 | __startTimestamp1506510065362__endTimestamp 04:01:05 INFO - PID 3564 | 04:01:05 INFO - PID 3564 | ------- Summary: start ------- 04:01:05 INFO - PID 3564 | Number of tests: 6 04:01:05 INFO - PID 3564 | 04:01:05 INFO - PID 3564 | [#0] dojo.html Cycles:165 Average:6164.06 Median:6382.33 stddev:740.63 (11.6%) stddev-sans-first:705.40 04:01:05 INFO - PID 3564 | Values: 3197.9 3205.5 3219.7 3227.0 3228.0 6065.5 6245.5 6319.2 6322.9 6337.3 6179.4 6237.8 6276.9 6277.2 6329.1 5716.3 5761.9 5775.3 5793.4 5804.3 5726.5 5762.1 5792.4 5795.9 5867.9 5736.5 5775.9 5796.1 5829.6 5907.5 5515.9 5770.5 5799.9 5814.6 5853.8 5597.9 5607.0 5637.0 5691.0 5735.8 6162.4 6189.4 6232.1 6271.3 6329.2 6626.5 6687.1 6739.5 6770.4 6776.8 6792.6 6792.9 6821.5 6841.9 6862.2 6225.8 6264.8 6332.1 6355.3 6376.7 6919.1 6935.8 7010.3 7024.9 7025.2 6442.4 6521.5 6568.0 6593.5 6739.5 6681.3 6719.6 6726.0 6730.8 6782.1 6664.1 6664.9 6748.3 6757.8 6764.6 6488.3 6704.2 6732.7 6796.4 6825.0 5103.5 5178.7 5251.2 5253.6 5258.3 4585.3 4608.3 4610.6 4630.2 4644.7 5681.5 5743.4 5806.4 5808.5 5819.3 6655.2 6690.5 6724.9 6751.4 6818.4 5607.1 5724.7 5728.1 5740.9 5813.1 5636.5 5671.1 5696.8 5726.1 5785.1 6485.2 6506.5 6542.1 6587.8 6611.7 6742.5 6773.1 6835.7 6852.3 6870.3 6394.1 6483.5 6514.3 6608.8 6611.4 6515.9 6551.7 6552.8 6574.7 6585.3 6646.1 6763.9 6769.3 6831.0 6848.4 6439.4 6477.6 6509.7 6557.0 6570.3 6322.8 6401.8 6416.7 6423.8 6438.1 6328.1 6372.6 6376.9 6387.8 6388.7 6344.1 6442.9 6483.7 6503.6 6606.6 6346.6 6351.4 6382.3 6414.8 6419.5 04:01:05 INFO - PID 3564 | 04:01:05 INFO - PID 3564 | [#1] ext.html Cycles:180 Average:35622.09 Median:18378.03 stddev:49535.67 (269.5%) stddev-sans-first:49605.56 04:01:05 INFO - PID 3564 | Values: 785.1 796.7 804.2 809.1 811.6 37404.6 40670.0 40703.4 40852.0 41245.0 38020.4 38218.8 38248.2 38325.2 38329.0 6946.0 7031.0 7044.7 7051.0 7097.1 7025.3 7912.9 8112.9 8133.5 8137.8 8054.6 8074.5 8121.4 8129.1 8144.9 7874.0 7907.2 7962.6 8078.0 8078.4 7882.1 7972.4 8019.9 8028.9 8044.4 36743.3 36839.0 36910.0 37068.0 37178.0 3231.2 3257.1 3264.7 3267.3 3300.1 30562.5 30567.0 30643.8 30658.4 30719.2 5202.4 5245.4 5285.9 5297.1 5328.5 183312.1 184491.2 185146.0 185363.0 185443.0 46413.0 46532.0 46631.0 46787.3 46861.3 43373.3 44352.8 49639.5 49681.5 49809.0 15801.0 16013.7 16020.1 16112.4 16134.8 13097.6 13128.1 13172.3 13176.7 13250.3 13758.2 13830.7 13918.2 14031.3 14110.4 5619.8 5633.9 5640.5 5725.3 5841.5 982.2 987.9 1004.4 1006.5 1010.3 22768.9 22787.4 22852.5 22915.3 23014.1 1092.1 1101.5 1107.4 1110.4 1121.6 12026.2 12054.7 12060.5 12130.8 12160.6 200005.0 201214.0 202186.0 204468.0 208924.0 49507.0 49600.8 49609.0 49831.5 49990.5 1421.9 1437.2 1446.5 1448.2 1457.8 21639.1 22269.3 22469.6 22531.5 22716.4 35367.6 35525.6 35609.6 35692.0 35808.1 185514.0 185697.0 187400.1 187692.0 188163.0 29852.7 30258.7 32456.2 33456.0 33996.0 41949.0 42041.0 42343.6 42399.4 42784.8 30936.4 31084.4 31103.0 31308.5 31770.0 30264.8 30314.7 30821.5 31035.2 31474.7 33984.0 34131.5 34315.1 34674.5 35068.0 30009.7 30335.0 30400.2 30542.4 30793.4 22864.4 22903.3 22937.2 22985.2 23134.0 04:01:05 INFO - PID 3564 | 04:01:05 INFO - PID 3564 | [#2] jquery.html Cycles:180 Average:33189.69 Median:12414.13 stddev:76783.59 (618.5%) stddev-sans-first:76959.90 04:01:05 INFO - PID 3564 | Values: 558.2 577.5 592.4 593.4 610.2 22192.1 22565.7 22812.2 22862.4 23004.7 22950.9 24005.9 24523.8 24752.0 24793.5 6633.0 6717.8 6758.0 6787.2 6820.5 6597.4 6636.2 6646.9 6662.6 6717.6 6384.6 6684.9 6705.6 6736.7 6739.3 6552.9 6619.9 6630.3 6648.5 6660.9 6088.1 6160.6 6168.1 6180.7 6204.7 25733.4 28201.0 28257.3 28303.9 28606.1 1950.6 2007.6 2020.3 2033.0 2035.4 18300.5 18991.8 19227.4 19307.8 19309.2 2262.6 2316.3 2318.7 2321.0 2324.2 123635.4 130698.3 133566.0 138068.3 139007.3 14026.6 14224.5 14395.4 14533.3 14667.0 22527.0 22696.9 22721.5 22738.5 22766.3 9530.8 9945.5 10025.4 10147.7 10148.2 9138.2 9231.3 9260.8 9290.8 9388.7 8752.7 8811.9 8816.8 8969.8 9182.9 2552.4 2628.3 2713.7 2752.1 2831.7 932.4 955.2 965.9 982.7 983.3 18266.3 18673.3 18731.4 18975.2 19196.2 1018.4 1029.7 1031.0 1031.7 1048.1 10240.3 10390.6 10406.4 10507.3 10578.7 444650.0 445808.0 449255.0 462228.0 468919.0 110675.0 110892.4 111172.4 111273.4 111290.0 1117.2 1136.8 1137.4 1142.1 1143.1 16851.2 17318.1 17354.6 17537.9 17629.0 54808.5 55107.0 55871.0 56006.2 57557.0 68440.3 68582.3 68826.3 69202.3 69980.7 14320.4 14390.6 14451.7 14465.3 14510.0 21952.3 22136.3 22286.9 22394.0 22478.0 17642.4 17782.4 17825.4 17913.5 18424.4 16010.6 16075.8 16283.1 16667.2 16776.7 17962.3 18580.0 18762.8 18837.6 18875.0 14306.9 14405.4 14414.6 14415.8 14440.7 17925.0 18609.7 19019.8 19091.7 19095.9 04:01:05 INFO - PID 3564 | 04:01:05 INFO - PID 3564 | [#3] mootools.html Cycles:180 Average:9352.69 Median:2697.87 stddev:6756.23 (250.4%) stddev-sans-first:6748.43 04:01:05 INFO - PID 3564 | Values: 1351.4 1381.5 1397.9 1415.5 1418.3 14705.6 15425.4 15441.8 15472.1 15503.2 15191.4 15223.6 15323.5 15334.2 15375.7 2637.0 2663.3 2708.3 2708.9 2719.4 2661.7 2731.7 2746.7 2752.9 2753.6 2622.9 2673.8 2687.4 2752.8 2761.1 2760.6 2761.7 2788.2 2788.2 2792.0 2560.1 2594.4 2599.5 2615.3 2621.4 14662.6 15160.6 15168.3 15168.7 15176.9 7994.4 8178.8 8219.5 8222.2 8239.3 4946.5 5336.1 5366.7 5469.4 5504.9 1841.4 1871.9 1904.0 1942.4 1944.4 27092.2 27157.5 27233.2 27403.5 27406.7 6705.2 7325.1 7567.2 7572.8 7637.9 17149.6 17310.5 17396.1 17432.2 17463.8 7853.3 7957.6 7976.8 7989.9 8540.2 7359.4 7503.3 7551.4 7565.4 7640.5 5007.5 5117.1 5127.7 5196.9 5217.4 1466.9 1467.3 1473.7 1488.5 1499.1 868.6 869.6 894.8 895.3 902.2 7380.9 7385.2 7386.3 7415.3 7534.4 706.1 714.5 715.9 718.4 722.0 4845.2 4874.0 5074.1 5128.0 5137.4 20897.4 21214.4 21699.5 21715.9 22241.3 20557.7 20955.4 21925.5 21940.3 22280.7 11348.2 11493.4 11561.1 11582.2 11634.4 8036.2 8066.8 8069.4 8157.1 8184.3 18040.9 18113.6 18649.5 18889.4 18962.1 19116.1 19288.8 19307.3 19629.1 19646.2 11124.9 11186.5 11231.4 11282.1 11318.9 13578.6 13771.7 13784.1 13790.9 13792.7 11469.9 11555.9 11597.1 11625.0 11710.6 10700.1 11263.7 11482.9 11485.9 11551.8 9375.8 9563.7 9585.3 9653.1 9663.5 7208.3 7218.9 7231.8 7250.2 7307.1 7183.6 7203.6 7227.8 7247.3 7291.4 04:01:05 INFO - PID 3564 | 04:01:05 INFO - PID 3564 | [#4] prototype.html Cycles:180 Average:5494.93 Median:6118.85 stddev:1492.77 (24.4%) stddev-sans-first:1449.44 04:01:05 INFO - PID 3564 | Values: 516.7 524.1 548.7 551.9 552.4 6219.4 6227.2 6242.2 6265.4 6334.2 6116.9 6211.7 6222.2 6231.5 6269.3 5138.5 5159.9 5204.8 5212.1 5225.9 5083.0 5103.5 5135.8 5212.7 5228.4 5086.2 5099.9 5108.4 5110.3 5138.3 5071.6 5094.8 5099.4 5123.6 5165.0 4632.2 4656.8 4718.4 4719.7 4731.8 6068.8 6073.2 6077.3 6095.7 6120.8 5835.2 5864.9 5876.9 5909.3 5911.4 6355.6 6532.2 6549.3 6559.6 6584.3 4937.7 5045.9 5062.1 5064.9 5076.2 6548.0 6708.3 6754.6 6763.0 6772.9 5236.8 5340.0 5365.8 5371.2 5408.9 5403.7 5428.7 5482.0 5503.6 5514.4 5451.5 5563.3 5635.1 5657.5 5680.3 6419.6 6458.8 6473.8 6521.3 6577.8 1720.0 1720.7 1750.7 1757.8 1771.5 1193.2 1232.6 1241.0 1242.5 1247.9 5457.3 5567.8 5573.0 5577.9 5578.8 6383.8 6449.8 6641.2 6649.3 6653.4 5505.6 5541.3 5557.5 5617.6 5648.5 3484.2 3496.0 3507.8 3530.7 3533.9 6316.6 6332.2 6348.5 6384.2 6389.9 6761.3 6773.0 6774.4 6797.5 6848.7 6418.7 6437.6 6444.0 6448.7 6487.6 5988.6 6539.1 6587.2 6639.8 6658.5 6283.7 6494.2 6507.0 6529.1 6575.5 6148.0 6273.5 6321.8 6424.7 6458.4 4934.0 4947.5 4954.9 4989.0 5017.1 6475.7 6510.7 6521.5 6538.5 6680.1 6317.3 6378.2 6383.8 6415.5 6471.3 6308.5 6399.2 6399.9 6431.5 6474.1 6321.9 6355.6 6383.8 6383.8 6394.5 6427.7 6465.7 6466.5 6477.4 6505.7 6175.0 6220.2 6255.3 6265.4 6278.2 04:01:05 INFO - PID 3564 | 04:01:05 INFO - PID 3564 | [#5] yui.html Cycles:180 Average:23961.90 Median:17914.14 stddev:33891.99 (189.2%) stddev-sans-first:33942.87 04:01:05 INFO - PID 3564 | Values: 909.6 914.2 917.9 921.4 922.4 18446.4 18540.7 18651.9 18738.5 18943.7 21423.1 21826.0 21850.8 22004.6 22041.0 994.2 997.3 999.2 1001.0 1005.3 992.5 1001.7 1003.9 1004.5 1008.0 1037.5 1040.2 1045.4 1045.9 1046.6 1018.3 1028.2 1033.0 1038.4 1039.6 754.9 757.1 758.2 758.3 758.8 20034.6 20046.2 20076.2 20194.5 20299.7 19684.9 21676.6 21770.2 21784.5 21799.2 17390.3 17398.8 17783.0 17903.7 17924.6 3703.1 3759.7 3760.5 3760.8 3769.5 101957.5 112020.4 133662.3 142477.3 143070.0 17501.8 17645.6 17691.6 17752.6 17787.2 31579.5 31602.7 32003.4 32094.2 32156.7 9027.0 9119.4 9170.9 9177.5 9183.0 4093.0 4159.8 4164.7 4166.5 4199.4 5300.7 5428.3 5456.1 5492.7 5523.6 1081.8 1102.7 1121.9 1127.2 1132.4 652.7 689.6 700.2 703.7 706.1 11615.4 11898.7 12117.8 13117.9 13239.9 645.3 663.1 665.0 674.2 682.6 5707.5 5727.7 5784.5 5821.2 5858.4 112289.9 119679.4 120913.0 121971.4 122401.4 101714.0 103943.0 106178.5 106761.0 107759.5 95471.0 96823.0 99529.0 99764.0 100005.0 10660.8 10744.1 10745.8 10960.1 11055.1 43381.6 44422.0 45243.3 45472.1 46102.3 54141.0 55164.2 55700.4 55781.7 56543.4 14982.3 15355.6 15364.8 15491.0 15494.6 16785.6 16925.6 17110.3 17125.0 17240.1 15245.0 15267.2 15315.6 15389.8 15850.7 15694.9 15718.4 15924.8 16022.8 16189.8 15347.8 15626.5 15715.4 15739.6 15833.2 11604.2 12081.3 12178.8 12185.8 12381.5 11934.8 12207.7 12239.6 12268.9 12337.2 04:01:05 INFO - PID 3564 | -------- Summary: end -------- 04:01:05 INFO - PID 3564 | 04:01:06 INFO - TEST-INFO | 3564: exit 0 04:01:06 INFO - TEST-OK | dromaeo_css | took 1113160ms 04:01:06 INFO - TEST-START | kraken 04:01:06 INFO - Initialising browser for kraken test... 04:01:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47067/getInfo.html -profile /tmp/tmps65nr_/profile 04:01:06 INFO - TEST-INFO | started process 3950 (/builds/slave/test/build/application/firefox/firefox http://localhost:47067/getInfo.html) 04:01:12 INFO - TEST-INFO | 3950: exit 0 04:01:12 INFO - Browser initialized. 04:01:12 INFO - Running cycle 1/1 for kraken test... 04:01:12 INFO - Using env: {'DISPLAY': ':0', 04:01:12 INFO - 'HOME': '/home/cltbld', 04:01:12 INFO - 'JSGC_DISABLE_POISONING': '1', 04:01:12 INFO - 'LANG': 'en_US.UTF-8', 04:01:12 INFO - 'LANGUAGE': 'en_US:en', 04:01:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:01:12 INFO - 'LOGNAME': 'cltbld', 04:01:12 INFO - 'MAIL': '/var/mail/cltbld', 04:01:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:01:12 INFO - 'MOZ_ACCELERATED': '1', 04:01:12 INFO - 'MOZ_CRASHREPORTER': '1', 04:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:01:12 INFO - 'MOZ_NO_REMOTE': '1', 04:01:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:12 INFO - 'MOZ_WEBRENDER': '1', 04:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:12 INFO - 'NO_EM_RESTART': '1', 04:01:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:12 INFO - 'PWD': '/builds/slave/test', 04:01:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:12 INFO - 'RUST_BACKTRACE': 'full', 04:01:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:01:12 INFO - 'SHELL': '/bin/bash', 04:01:12 INFO - 'SHLVL': '1', 04:01:12 INFO - 'TERM': 'linux', 04:01:12 INFO - 'TMOUT': '86400', 04:01:12 INFO - 'USER': 'cltbld', 04:01:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687', 04:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:12 INFO - '_': '/tools/buildbot/bin/python'} 04:01:12 INFO - TEST-INFO | started process 4195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps65nr_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:13 INFO - PID 4195 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:01:13 INFO - PID 4195 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:01:13 INFO - PID 4195 | 04:01:13 INFO - PID 4195 | (/builds/slave/test/build/application/firefox/firefox:4255): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:01:13 INFO - PID 4195 | 04:01:23 INFO - PID 4195 | RSS: Main: 195227648 04:01:23 INFO - PID 4195 | 04:01:26 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47067/tests/kraken/driver.html?testName=audio-beat-detection) 04:01:27 INFO - PID 4195 | RSS: Main: 191553536 04:01:27 INFO - PID 4195 | 04:01:30 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47067/tests/kraken/driver.html?testName=audio-dft) 04:01:30 INFO - PID 4195 | RSS: Main: 191545344 04:01:30 INFO - PID 4195 | 04:01:33 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47067/tests/kraken/driver.html?testName=audio-fft) 04:01:34 INFO - PID 4195 | RSS: Main: 188268544 04:01:34 INFO - PID 4195 | 04:01:36 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47067/tests/kraken/driver.html?testName=audio-oscillator) 04:01:37 INFO - PID 4195 | RSS: Main: 188936192 04:01:37 INFO - PID 4195 | 04:01:39 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47067/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:01:40 INFO - PID 4195 | RSS: Main: 189288448 04:01:40 INFO - PID 4195 | 04:01:43 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47067/tests/kraken/driver.html?testName=imaging-darkroom) 04:01:43 INFO - PID 4195 | RSS: Main: 191721472 04:01:43 INFO - PID 4195 | 04:01:47 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47067/tests/kraken/driver.html?testName=imaging-desaturate) 04:01:48 INFO - PID 4195 | RSS: Main: 191102976 04:01:48 INFO - PID 4195 | 04:01:51 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47067/tests/kraken/driver.html?testName=json-parse-financial) 04:01:51 INFO - PID 4195 | RSS: Main: 192176128 04:01:51 INFO - PID 4195 | 04:01:53 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47067/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:01:54 INFO - PID 4195 | RSS: Main: 192339968 04:01:54 INFO - PID 4195 | 04:01:55 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47067/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:01:56 INFO - PID 4195 | RSS: Main: 192307200 04:01:56 INFO - PID 4195 | 04:01:58 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47067/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:01:59 INFO - PID 4195 | RSS: Main: 192299008 04:01:59 INFO - PID 4195 | 04:02:02 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:02:02 INFO - PID 4195 | RSS: Main: 192778240 04:02:02 INFO - PID 4195 | 04:02:05 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:02:06 INFO - PID 4195 | RSS: Main: 192892928 04:02:06 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:47067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47067/tests/kraken/driver.html?testName=ai-astar) 04:02:08 INFO - PID 4195 | RSS: Main: 194031616 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | __start_tp_report 04:02:08 INFO - PID 4195 | _x_x_mozilla_page_load 04:02:08 INFO - PID 4195 | _x_x_mozilla_page_load_details 04:02:08 INFO - PID 4195 | |i|pagename|runs| 04:02:08 INFO - PID 4195 | |0;ai-astar;122;108;113;111;113;115;107;108;107;114 04:02:08 INFO - PID 4195 | |1;audio-beat-detection;118;117;116;119;124;126;117;144;115;118 04:02:08 INFO - PID 4195 | |2;audio-dft;164;164;167;165;165;178;167;169;174;162 04:02:08 INFO - PID 4195 | |3;audio-fft;78;75;84;79;87;84;82;72;75;76 04:02:08 INFO - PID 4195 | |4;audio-oscillator;80;83;79;81;87;86;88;81;82;87 04:02:08 INFO - PID 4195 | |5;imaging-gaussian-blur;120;114;113;115;113;114;122;114;115;115 04:02:08 INFO - PID 4195 | |6;imaging-darkroom;153;157;157;155;149;158;155;150;150;149 04:02:08 INFO - PID 4195 | |7;imaging-desaturate;94;101;97;95;106;93;94;96;99;99 04:02:08 INFO - PID 4195 | |8;json-parse-financial;57;53;53;62;59;57;55;58;59;63 04:02:08 INFO - PID 4195 | |9;json-stringify-tinderbox;43;46;38;47;42;49;43;48;39;43 04:02:08 INFO - PID 4195 | |10;stanford-crypto-aes;78;78;79;74;71;77;79;76;77;76 04:02:08 INFO - PID 4195 | |11;stanford-crypto-ccm;124;120;117;116;117;111;118;126;114;111 04:02:08 INFO - PID 4195 | |12;stanford-crypto-pbkdf2;174;186;176;184;168;173;165;166;167;174 04:02:08 INFO - PID 4195 | |13;stanford-crypto-sha256-iterative;66;64;69;66;68;66;65;67;66;64 04:02:08 INFO - PID 4195 | __end_tp_report 04:02:08 INFO - PID 4195 | __start_cc_report 04:02:08 INFO - PID 4195 | _x_x_mozilla_cycle_collect,748 04:02:08 INFO - PID 4195 | __end_cc_report 04:02:08 INFO - PID 4195 | __startTimestamp1506510128308__endTimestamp 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | ------- Summary: start ------- 04:02:08 INFO - PID 4195 | Number of tests: 14 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:4.69 (4.1%) stddev-sans-first:3.20 04:02:08 INFO - PID 4195 | Values: 122.0 108.0 113.0 111.0 113.0 115.0 107.0 108.0 107.0 114.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#1] audio-beat-detection Cycles:10 Average:121.40 Median:118.50 stddev:8.67 (7.3%) stddev-sans-first:9.11 04:02:08 INFO - PID 4195 | Values: 118.0 117.0 116.0 119.0 124.0 126.0 117.0 144.0 115.0 118.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#2] audio-dft Cycles:10 Average:167.50 Median:167.00 stddev:4.97 (3.0%) stddev-sans-first:5.11 04:02:08 INFO - PID 4195 | Values: 164.0 164.0 167.0 165.0 165.0 178.0 167.0 169.0 174.0 162.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#3] audio-fft Cycles:10 Average:79.20 Median:80.50 stddev:4.87 (6.1%) stddev-sans-first:5.15 04:02:08 INFO - PID 4195 | Values: 78.0 75.0 84.0 79.0 87.0 84.0 82.0 72.0 75.0 76.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#4] audio-oscillator Cycles:10 Average:83.40 Median:84.50 stddev:3.31 (3.9%) stddev-sans-first:3.27 04:02:08 INFO - PID 4195 | Values: 80.0 83.0 79.0 81.0 87.0 86.0 88.0 81.0 82.0 87.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.00 stddev:3.03 (2.6%) stddev-sans-first:2.74 04:02:08 INFO - PID 4195 | Values: 120.0 114.0 113.0 115.0 113.0 114.0 122.0 114.0 115.0 115.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#6] imaging-darkroom Cycles:10 Average:153.30 Median:155.00 stddev:3.56 (2.3%) stddev-sans-first:3.77 04:02:08 INFO - PID 4195 | Values: 153.0 157.0 157.0 155.0 149.0 158.0 155.0 150.0 150.0 149.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#7] imaging-desaturate Cycles:10 Average:97.40 Median:95.50 stddev:3.98 (4.2%) stddev-sans-first:4.02 04:02:08 INFO - PID 4195 | Values: 94.0 101.0 97.0 95.0 106.0 93.0 94.0 96.0 99.0 99.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.50 stddev:3.37 (5.8%) stddev-sans-first:3.57 04:02:08 INFO - PID 4195 | Values: 57.0 53.0 53.0 62.0 59.0 57.0 55.0 58.0 59.0 63.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#9] json-stringify-tinderbox Cycles:10 Average:43.80 Median:44.50 stddev:3.68 (8.3%) stddev-sans-first:3.89 04:02:08 INFO - PID 4195 | Values: 43.0 46.0 38.0 47.0 42.0 49.0 43.0 48.0 39.0 43.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:77.50 stddev:2.46 (3.2%) stddev-sans-first:2.55 04:02:08 INFO - PID 4195 | Values: 78.0 78.0 79.0 74.0 71.0 77.0 79.0 76.0 77.0 76.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:117.50 stddev:4.95 (4.2%) stddev-sans-first:4.64 04:02:08 INFO - PID 4195 | Values: 124.0 120.0 117.0 116.0 117.0 111.0 118.0 126.0 114.0 111.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:174.00 stddev:7.26 (4.2%) stddev-sans-first:7.69 04:02:08 INFO - PID 4195 | Values: 174.0 186.0 176.0 184.0 168.0 173.0 165.0 166.0 167.0 174.0 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.60 (2.4%) stddev-sans-first:1.69 04:02:08 INFO - PID 4195 | Values: 66.0 64.0 69.0 66.0 68.0 66.0 65.0 67.0 66.0 64.0 04:02:08 INFO - PID 4195 | -------- Summary: end -------- 04:02:08 INFO - PID 4195 | 04:02:08 INFO - PID 4195 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:02:09 INFO - TEST-INFO | 4195: exit 0 04:02:09 INFO - TEST-OK | kraken | took 62938ms 04:02:09 INFO - SUITE-END | took 1176s 04:02:09 INFO - Completed test suite (00:19:36) 04:02:09 INFO - javascript benchmark 04:02:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8436.714378197203, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3197.8720851165954, 3205.535197396376, 3219.726323262523, 3227.03189043287, 3228.0477259208533, 6065.454109130177, 6245.469135123514, 6319.241690997081, 6322.873542529147, 6337.271213810419, 6179.351168127349, 6237.750489980395, 6276.874462510747, 6277.152584401105, 6329.113924050636, 5716.314042314928, 5761.855953601152, 5775.27809023872, 5793.449622285897, 5804.2744656917885, 5726.541876649879, 5762.1068734346245, 5792.391798861122, 5795.884082318351, 5867.911981320283, 5736.4550367715, 5775.884482310351, 5796.13058041293, 5829.5919285650025, 5907.497862681677, 5515.889682206373, 5770.451807078321, 5799.884002319972, 5814.592978491507, 5853.76584936602, 5597.888042239132, 5607.046802043662, 5637.041702910515, 5690.971545142289, 5735.770569177228, 6162.414570615784, 6189.414598220513, 6232.0963460298, 6271.341509141565, 6329.240491141092, 6626.536142470029, 6687.130673012477, 6739.5282330236905, 6770.356816102462, 6776.7628133015105, 6792.558483698544, 6792.864142717168, 6821.4542836572955, 6841.897371539381, 6862.210845752752, 6225.782097626607, 6264.812055638338, 6332.1135041094285, 6355.3009168991375, 6376.7130479128555, 6919.065926100013, 6935.791926242221, 7010.334018268256, 7024.929750702529, 7025.227225005246, 6442.35576442352, 6521.47828173745, 6568.047633093175, 6593.472522198213, 6739.494537909676, 6681.33186681328, 6719.630420326929, 6726.0, 6730.831729206809, 6782.050512928194, 6664.133662623828, 6664.933350666432, 6748.257691653914, 6757.797266082025, 6764.594124352555, 6488.28628850826, 6704.195496540349, 6732.697028633724, 6796.422304104207, 6824.965875170592, 5103.464136265638, 5178.71517066565, 5251.238570407269, 5253.605979551549, 5258.2638430619745, 4585.266357382803, 4608.28571571407, 4610.561996610317, 4630.21286381316, 4644.7213167210075, 5681.517071049007, 5743.368229494752, 5806.361300256968, 5808.5062769665055, 5819.272590926134, 6655.234648015444, 6690.498212634072, 6724.899126513106, 6751.4261287790105, 6818.352256535622, 5607.102863541813, 5724.713764311851, 5728.140778883201, 5740.942590574041, 5813.069908814569, 5636.464535869086, 5671.064274394761, 5696.772129114872, 5726.141078838207, 5785.132230165509, 6485.156929599122, 6506.512011599149, 6542.1168142300185, 6587.835304117435, 6611.669416529155, 6742.5280230383405, 6773.085633439521, 6835.658217089225, 6852.314768523208, 6870.27862074475, 6394.072859435449, 6483.481321494363, 6514.250861151028, 6608.801735947929, 6611.371919667624, 6515.869682606227, 6551.737930482727, 6552.83617909537, 6574.671266436755, 6585.275619681735, 6646.136002319668, 6763.93236067633, 6769.289224631343, 6831.0436538883605, 6848.417884479875, 6439.388258115471, 6477.578957367756, 6509.707063182263, 6557.0, 6570.342965703391, 6322.810315690536, 6401.807945761635, 6416.743330266737, 6423.839404014937, 6438.130852334875, 6328.082428047999, 6372.553921225655, 6376.947803612352, 6387.808365749035, 6388.744450221939, 6344.143540622142, 6442.872497313046, 6483.675816209076, 6503.577267477599, 6606.570572912745, 6346.587471814318, 6351.396617321347, 6382.329855365306, 6414.807555773335, 6419.518536109717], "value": 6108.54021499477, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.120664855362, 796.6773456750018, 804.1917872538095, 809.0655293136426, 811.6428771340611, 37404.625953740455, 40670.0, 40703.38944915828, 40852.0, 41245.0, 38020.42969355455, 38218.8089059555, 38248.23503529928, 38325.233495330074, 38329.0, 6945.965270173642, 7030.964845175767, 7044.718211271568, 7050.964745176293, 7097.148342198943, 7025.297470252985, 7912.881306780403, 8112.918870811305, 8133.511989280632, 8137.75586732399, 8054.556999365032, 8074.475159114668, 8121.350291976628, 8129.146439623843, 8144.918550814505, 7873.96063019687, 7907.209279072075, 7962.5620590867475, 8077.95961020194, 8078.353731701509, 7882.093559240703, 7972.402069844785, 8019.879701804478, 8028.879566806502, 8044.356451483867, 36743.265134697154, 36839.0, 36910.0, 37068.0, 37178.0, 3231.1922019495128, 3257.1368587324378, 3264.657210992835, 3267.281198136406, 3300.05948304732, 30562.54156187659, 30567.0, 30643.846780765954, 30658.38683226323, 30719.232019199477, 5202.375714914197, 5245.370555533361, 5285.894282114336, 5297.099493086184, 5328.547073498718, 183312.08343958328, 184491.15508844875, 185146.0, 185363.0, 185443.0, 46413.0, 46532.0, 46631.0, 46787.298190527166, 46861.297080543816, 43373.34939975903, 44352.778236108614, 49639.50360496349, 49681.50318496841, 49809.0, 15801.0, 16013.679726405406, 16020.118893460738, 16112.436064737678, 16134.75797863033, 13097.607071787861, 13128.146670466389, 13172.341382930816, 13176.670583235304, 13250.271235082164, 13758.243296618582, 13830.65423364424, 13918.234497102554, 14031.298435078204, 14110.435582576787, 5619.80330688424, 5633.873225354863, 5640.464155905182, 5725.2843394575675, 5841.474267315962, 982.1553464021079, 987.9209663226925, 1004.3923426327113, 1006.5369929832212, 1010.2927950434726, 22768.886155569115, 22787.430314242276, 22852.542949140923, 22915.312540623807, 23014.07943682234, 1092.1099304067159, 1101.5373543111912, 1107.4075369677184, 1110.3559935237543, 1121.5625905896707, 12026.15816892809, 12054.698632534082, 12060.46221111805, 12130.818037729441, 12160.574379896661, 200005.0, 201214.0, 202186.0, 204468.0, 208924.0, 49507.0, 49600.751996239786, 49609.0, 49831.501684982686, 49990.50009499931, 1421.9004669673232, 1437.1736251655132, 1446.5081872163514, 1448.246911605959, 1457.7813328000673, 21639.13443462244, 22269.331920042423, 22469.550608988055, 22531.549369012857, 22716.432089197242, 35367.64632353746, 35525.64474355327, 35609.64390356063, 35692.0, 35808.10479738027, 185514.0, 185697.0, 187400.06299968413, 187692.0, 188163.0, 29852.70147298499, 30258.697413025588, 32456.188595285308, 33455.99632011043, 33996.0, 41949.0, 42041.0, 42343.57656423396, 42399.36400953926, 42784.786076069424, 30936.381272374878, 31084.37831243317, 31103.0, 31308.530372044894, 31770.0, 30264.84867575648, 30314.696853031186, 30821.537676935313, 31035.224119397197, 31474.68525314809, 33984.0, 34131.48802767911, 34315.14212144716, 34674.47988280228, 35068.0, 30009.699903001565, 30335.0, 30400.239993999443, 30542.389152216387, 30793.384132317675, 22864.428389290402, 22903.312900613008, 22937.197198097987, 22985.195518156783, 23134.0], "value": 16667.828333586694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.2296430925322, 577.5495113811229, 592.386879579635, 593.3621357041179, 610.1640752169527, 22192.11231550738, 22565.66151507729, 22812.20157294495, 22862.428439289026, 23004.65493017604, 22950.885245573747, 24005.879970600166, 24523.75476245237, 24752.0, 24793.50412991739, 6633.0, 6717.798466046002, 6758.0, 6787.151606049244, 6820.454363650896, 6597.37324954131, 6636.2036555613395, 6646.900296495556, 6662.633555154464, 6717.56335838169, 6384.553081284312, 6684.899726504106, 6705.631190284533, 6736.730530778763, 6739.292374300677, 6552.868942621169, 6619.867602647968, 6630.270670226247, 6648.501362397839, 6660.9000864987065, 6088.1476593276975, 6160.599561028519, 6168.105624684441, 6180.690965451709, 6204.6587437690905, 25733.35666608331, 28201.0, 28257.293567660767, 28303.85848070767, 28606.14181574556, 1950.619629172312, 2007.5784085342095, 2020.3332900142918, 2032.9695054574192, 2035.4402539301661, 18300.542486437946, 18991.81008189928, 19227.423177304703, 19307.80692193074, 19309.227630894748, 2262.6040442922585, 2316.2819525946843, 2318.7449380568123, 2320.9883950580306, 2324.2097686786406, 123635.38182309121, 130698.3465082678, 133566.0, 138068.30965845208, 139007.30496347556, 14026.649333766738, 14224.502142425172, 14395.42418303277, 14533.273336333352, 14667.0, 22527.0, 22696.886515567647, 22721.545569088525, 22738.545229095656, 22766.31701048971, 9530.761730956781, 9945.45300008492, 10025.448600326907, 10147.695569132939, 10148.188144948386, 9138.17756401927, 9231.261499080058, 9260.814783704289, 9290.814183716422, 9388.67139650109, 8752.737417877473, 8811.911880881109, 8816.779580510538, 8969.820603587892, 9182.86225706615, 2552.3619095226195, 2628.2772237634804, 2713.74219449152, 2752.146834481317, 2831.716828317193, 932.379967321737, 955.2405837359316, 965.8502932045544, 982.7346616413529, 983.2674657380297, 18266.26934922588, 18673.253069877326, 18731.438056858315, 18975.24099036023, 19196.232150714095, 1018.3686114608989, 1029.6807989523272, 1031.0359813574332, 1031.654395777423, 1048.1405247696816, 10240.283180177315, 10390.636327728644, 10406.427646479366, 10507.264491485523, 10578.735531611617, 444650.0, 445808.0, 449255.0, 462228.0, 468919.0, 110675.0, 110892.4455377718, 111172.44413777879, 111273.44363278132, 111290.0, 1117.1900372230068, 1136.846525719034, 1137.374444055766, 1142.1091548592112, 1143.1312202725821, 16851.1574421276, 17318.134093295033, 17354.566135846704, 17537.912310438365, 17629.0, 54808.451915480335, 55107.0, 55871.0, 56006.15990760223, 57557.0, 68440.28899277358, 68582.31417685759, 68826.311736882, 69202.30797691959, 69980.65009674919, 14320.355583998537, 14390.568282951528, 14451.710965780836, 14465.27673616294, 14509.984301098822, 21952.341429757133, 22136.335909922727, 22286.88856555707, 22394.0, 22478.0, 17642.38251661186, 17782.37761678387, 17825.376111836023, 17913.462596122135, 18424.35514756977, 16010.599735006717, 16075.75886361729, 16283.104429256504, 16667.24997375145, 16776.748348774534, 17962.281508740027, 18580.0, 18762.812371876105, 18837.6232475347, 18875.0, 14306.928465357607, 14405.351759171072, 14414.639634009234, 14415.78376324335, 14440.711185776016, 17925.0, 18609.720854187468, 19019.809801901803, 19091.713624295924, 19095.90452047731], "value": 11744.759071017066, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.4459071780568, 1381.475039484996, 1397.89515786316, 1415.4550498058245, 1418.2625034981809, 14705.632359191011, 15425.382984680613, 15441.768373474379, 15472.149031803261, 15503.224838758046, 15191.392344306214, 15223.619409514768, 15323.463678771246, 15334.233288335594, 15375.692486150298, 2637.0, 2663.294227029834, 2708.2958430808035, 2708.9322766930786, 2719.3745438549145, 2661.6945540838337, 2731.726827317272, 2746.6978632350424, 2752.9174124776287, 2753.559430491122, 2622.8688565571742, 2673.7593616574504, 2687.4490729400522, 2752.7660148887367, 2761.1026416414643, 2760.5721113227482, 2761.6685997680306, 2788.1914244868963, 2788.219298596376, 2791.986040069807, 2560.142352311978, 2594.3514121469634, 2599.493098845726, 2615.333090062041, 2621.397078671897, 14662.633434164125, 15160.620984475367, 15168.31742571587, 15168.696626067416, 15176.924115379463, 7994.400419968526, 8178.836423271501, 8219.506829590244, 8222.218889205516, 8239.299659528888, 4946.455889852114, 5336.092864213093, 5366.651167674088, 5469.371022332403, 5504.944950550484, 1841.4199527148905, 1871.897045662488, 1904.0003997901074, 1942.4464027752165, 1944.445832937606, 27092.187234383, 27157.456850862873, 27233.183004509898, 27403.45193096147, 27406.725932740617, 6705.161854768154, 7325.120985481776, 7567.167611562723, 7572.7728168155045, 7637.923620763832, 17149.57126071858, 17310.480685579452, 17396.130193490273, 17432.21555030027, 17463.825361746472, 7853.293203611703, 7957.562334071682, 7976.840463190703, 7989.920100798918, 8540.231379175904, 7359.411247100219, 7503.287187717158, 7551.358134558514, 7565.394768418513, 7640.465167438226, 5007.524285192901, 5117.05769182714, 5127.717975511383, 5196.92204616931, 5217.3999990000875, 1466.8679818816358, 1467.2663668165917, 1473.7273604383224, 1488.4864721671006, 1499.137995652504, 868.5657171414293, 869.6390997735995, 894.7628878347243, 895.2793001633747, 902.1654969153507, 7380.889286660705, 7385.187629360766, 7386.298301661333, 7415.3326200642205, 7534.397248220129, 706.1244057368825, 714.4891402647132, 715.9427245820322, 718.3821913154683, 722.0288711682779, 4845.152098382769, 4874.0, 5074.08666440037, 5127.97436012825, 5137.357830271216, 20897.37307880766, 21214.36356909295, 21699.45751356197, 21715.891420542797, 22241.332760017227, 20557.69163462549, 20955.37133885986, 21925.451863703536, 21940.341789746333, 22280.66579001316, 11348.205625606293, 11493.367864767519, 11561.132915031407, 11582.247153935135, 11634.418279086012, 8036.196380361917, 8066.798330041796, 8069.435139540411, 8157.102718701057, 8184.345252379676, 18040.909795451465, 18113.637727245645, 18649.533761655526, 18889.433317000512, 18962.146703398656, 19116.139773710496, 19288.80711192926, 19307.324243651405, 19629.11668974928, 19646.21415143378, 11124.944375278072, 11186.496607652512, 11231.438428078727, 11282.097432205239, 11318.94340528292, 13578.592642220749, 13771.655708607364, 13784.104033237807, 13790.862091379358, 13792.655183620489, 11469.942650286695, 11555.942220288845, 11597.13021523406, 11625.0, 11710.648680539598, 10700.090492308242, 11263.66209013731, 11482.885171148182, 11485.942570287096, 11551.76896462083, 9375.765605859908, 9563.713088607354, 9585.281103917094, 9653.131218190396, 9663.468509231778, 7208.315210055036, 7218.89171662415, 7231.783046508614, 7250.20247772734, 7307.1231452226075, 7183.640817959185, 7203.567785932861, 7227.819304517429, 7247.347738703542, 7291.41668666516], "value": 6615.823138126024, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.6899860083947, 524.0959345129651, 548.6790227716785, 551.9144532597448, 552.3565046720571, 6219.378062193784, 6227.221597300338, 6242.157308763316, 6265.404786545277, 6334.239891213061, 6116.908246376297, 6211.720472578733, 6222.160008398865, 6231.50147988161, 6269.301112343716, 5138.537531622153, 5159.871003224912, 5204.843854684365, 5212.107280459343, 5225.921611175835, 5082.974585127069, 5103.515166059237, 5135.79308862417, 5212.687238765668, 5228.398734145565, 5086.21163719624, 5099.898002039976, 5108.361454818148, 5110.28456016158, 5138.2806407103035, 5071.594272458231, 5094.770735316901, 5099.4390617032095, 5123.615728820316, 5165.0, 4632.212523870916, 4656.767161641938, 4718.41019872516, 4719.693219940693, 4731.834385796481, 6068.757249710006, 6073.18012068374, 6077.270727512682, 6095.695215239265, 6120.785772497941, 5835.212246346731, 5864.912026319608, 5876.942150412924, 5909.349971503131, 5911.408859114097, 6355.618662880242, 6532.248791389004, 6549.312322206195, 6559.639219842907, 6584.27572966978, 4937.679050861719, 5045.899082018375, 5062.1141300272675, 5064.873378165538, 5076.23856421536, 6547.967260163717, 6708.262091169968, 6754.628495432749, 6762.966185169092, 6772.932270677329, 5236.790528378822, 5339.973300133553, 5365.812196573102, 5371.248025276464, 5408.91886621701, 5403.702796346239, 5428.701421421781, 5482.0406428874785, 5503.596582871342, 5514.448555144534, 5451.528087416455, 5563.304586926634, 5635.126555383922, 5657.4908258256955, 5680.289963754531, 6419.570496357592, 6458.773942911976, 6473.838154046187, 6521.347865213535, 6577.7635603894905, 1720.028184075993, 1720.673072116294, 1750.7111326630964, 1757.7539144519778, 1771.4862689820065, 1193.1945936492832, 1232.5562797392931, 1241.000994199678, 1242.4967888005372, 1247.875212478745, 5457.2905522282645, 5567.777288908398, 5573.0, 5577.9163312550345, 5578.8047418340975, 6383.840403989844, 6449.839028974736, 6641.203055633355, 6649.268580456146, 6653.434458071021, 5505.642133261325, 5541.312463455221, 5557.499825015687, 5617.578681598897, 5648.519875810603, 3484.2160513884173, 3495.9825200873834, 3507.8424120040327, 3530.699890509284, 3533.8939831805087, 6316.589421687576, 6332.176817013758, 6348.460380867678, 6384.201974753156, 6389.904151437732, 6761.309672581854, 6772.966135169293, 6774.390304872585, 6797.456203503708, 6848.6918088686125, 6418.711157997808, 6437.645929473924, 6444.0, 6448.677566121675, 6487.610743355413, 5988.622616798074, 6539.103659938564, 6587.176602924635, 6639.767608133692, 6658.533902626769, 6283.654399008098, 6494.188226471691, 6506.967465162644, 6529.08255046968, 6575.50683698715, 6147.969260153671, 6273.466755325849, 6321.778737744341, 6424.710888010144, 6458.354164583692, 4933.975330123327, 4947.505249475023, 4954.900901982012, 4989.0, 5017.122003649274, 6475.740970361321, 6510.674466276572, 6521.543491955517, 6538.509611779041, 6680.131582894387, 6317.30509643948, 6378.202724659418, 6383.776193022494, 6415.486761059197, 6471.320511346241, 6308.463780578702, 6399.168108146097, 6399.93600064012, 6431.517636177212, 6474.050828994404, 6321.862064828375, 6355.601767611118, 6383.808485745435, 6383.808485745435, 6394.4564712, 6427.742890284523, 6465.676716164267, 6466.547341686037, 6477.384648458389, 6505.674716264073, 6174.969125154345, 6220.160278362363, 6255.280642725963, 6265.373462653698, 6278.215223097113], "value": 5059.123294455179, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.5906841921135, 914.2411798207488, 917.9311551633629, 921.4241099312932, 922.4050487435604, 18446.35437759679, 18540.721889171673, 18651.90674046631, 18738.531536711587, 18943.71584426231, 21423.14307427705, 21826.0, 21850.781492185113, 22004.559908801813, 22041.0, 994.2294721590753, 997.2670087485692, 999.215615741643, 1000.9899901001006, 1005.2762011351815, 992.4640694025218, 1001.739547717595, 1003.9447830369327, 1004.467632154959, 1007.9697609071703, 1037.5331101004579, 1040.1834559870504, 1045.4354648489843, 1045.9320144190642, 1046.5970601318509, 1018.332991890313, 1028.2442404832443, 1033.0083120204613, 1038.3717850700332, 1039.6465201831413, 754.9207333229987, 757.0952711509748, 758.2303961479104, 758.2909979169494, 758.8368500772306, 20034.59930801376, 20046.1981520739, 20076.196952121896, 20194.49513762153, 20299.695504567444, 19684.901575492175, 21676.566468670695, 21770.238041668465, 21784.455388615253, 21799.237026704148, 17390.3043878246, 17398.826011739846, 17783.0, 17903.73144402835, 17924.55188620295, 3703.111253299189, 3759.7368184227116, 3760.4735337052834, 3760.7743535387963, 3769.491118698968, 101957.49021254921, 112020.4398978, 133662.33168834192, 142477.2876135623, 143070.0, 17501.824981750273, 17645.558861028578, 17691.646167076586, 17752.55618609545, 17787.19957601885, 31579.52630710541, 31602.683973159976, 32003.359932801213, 32094.197645058593, 32156.67843321537, 9027.0, 9119.407238529475, 9170.86243706345, 9177.495237761987, 9183.0, 4092.979535102365, 4159.833606655699, 4164.729292595972, 4166.541680415152, 4199.391088292181, 5300.701328174622, 5428.321459817523, 5456.127019676833, 5492.670439773627, 5523.558115350762, 1081.7890511350367, 1102.72431892027, 1121.9439028048564, 1127.22784892349, 1132.377192544114, 652.709544252803, 689.6138162628944, 700.2227527444533, 703.683342495879, 706.1138271469273, 11615.361155136548, 11898.702532436759, 12117.75764484723, 13117.868821311855, 13239.867601323864, 645.3449748505271, 663.1346093348227, 664.9767258145941, 674.150570281449, 682.5836239893661, 5707.4577915098, 5727.6849773262875, 5784.537237021028, 5821.18503409523, 5858.355580886099, 112289.87710122958, 119679.40160299143, 120913.0, 121971.39014305049, 122401.38799305947, 101714.0, 103943.0, 106178.46910765396, 106761.0, 107759.46120269505, 95471.0, 96823.0, 99529.0, 99764.0, 100005.0, 10660.84008739885, 10744.140468762324, 10745.838812417664, 10960.123190144928, 11055.0603198729, 43381.56618433775, 44422.0, 45243.32135017912, 45472.09055818931, 46102.30846537238, 54141.0, 55164.17253741117, 55700.442995571146, 55781.72109139428, 56543.434565655465, 14982.325795339453, 15355.61610959735, 15364.769528456858, 15491.0, 15494.612634684223, 16785.580360491087, 16925.576860578585, 17110.315587376364, 17125.0, 17240.137993100547, 15245.0, 15267.236638167826, 15315.61710957235, 15389.846101538842, 15850.68298634044, 15694.9215253923, 15718.371265149266, 15924.840751592335, 16022.839771602135, 16189.75715364294, 15347.846521535088, 15626.45307414235, 15715.44995925183, 15739.606509837346, 15833.208339582745, 11604.245724027911, 12081.275123492618, 12178.817317740419, 12185.817212741638, 12381.504739810667, 11934.761304774029, 12207.69480762988, 12239.571614993432, 12268.877311226774, 12337.198082124632], "value": 9009.39033779057, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1464.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 108.0, 113.0, 111.0, 113.0, 115.0, 107.0, 108.0, 107.0, 114.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 119.0, 124.0, 126.0, 117.0, 144.0, 115.0, 118.0], "value": 121.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 167.0, 165.0, 165.0, 178.0, 167.0, 169.0, 174.0, 162.0], "value": 167.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 84.0, 79.0, 87.0, 84.0, 82.0, 72.0, 75.0, 76.0], "value": 79.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 79.0, 81.0, 87.0, 86.0, 88.0, 81.0, 82.0, 87.0], "value": 83.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 114.0, 113.0, 115.0, 113.0, 114.0, 122.0, 114.0, 115.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 157.0, 157.0, 155.0, 149.0, 158.0, 155.0, 150.0, 150.0, 149.0], "value": 153.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 101.0, 97.0, 95.0, 106.0, 93.0, 94.0, 96.0, 99.0, 99.0], "value": 97.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 62.0, 59.0, 57.0, 55.0, 58.0, 59.0, 63.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 46.0, 38.0, 47.0, 42.0, 49.0, 43.0, 48.0, 39.0, 43.0], "value": 43.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 74.0, 71.0, 77.0, 79.0, 76.0, 77.0, 76.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 120.0, 117.0, 116.0, 117.0, 111.0, 118.0, 126.0, 114.0, 111.0], "value": 117.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 186.0, 176.0, 184.0, 168.0, 173.0, 165.0, 166.0, 167.0, 174.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 69.0, 66.0, 68.0, 66.0, 65.0, 67.0, 66.0, 64.0], "value": 66.1, "unit": "score"}]}]} 04:02:09 INFO - Return code: 0 04:02:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:02:09 INFO - # TBPL SUCCESS # 04:02:09 INFO - Running post-action listener: _package_coverage_data 04:02:09 INFO - Running post-action listener: _resource_record_post_action 04:02:09 INFO - [mozharness: 2017-09-27 11:02:09.586960Z] Finished run-tests step (success) 04:02:09 INFO - Running post-run listener: _resource_record_post_run 04:02:09 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 2899968; Write bytes: 342810624; Read time: 3212; Write time: 209244 04:02:09 INFO - TinderboxPrint: CPU usage
13.2% 04:02:09 INFO - TinderboxPrint: I/O read bytes / time
2,899,968 / 3,212 04:02:09 INFO - TinderboxPrint: I/O write bytes / time
342,810,624 / 209,244 04:02:09 INFO - TinderboxPrint: CPU idle
8,255.0 (86.7%) 04:02:09 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 04:02:09 INFO - TinderboxPrint: Swap in / out
0 / 0 04:02:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10207232; Read time: 0; Write time: 1360 04:02:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:02:09 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 2895872; Write bytes: 332603392; Read time: 3196; Write time: 207884 04:02:10 INFO - Running post-run listener: _upload_blobber_files 04:02:10 INFO - Blob upload gear active. 04:02:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:02:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:02:10 INFO - (blobuploader) - INFO - Open directory for files ... 04:02:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:02:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:02:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:11 INFO - (blobuploader) - INFO - Done attempting. 04:02:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:02:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:02:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:18 INFO - (blobuploader) - INFO - Done attempting. 04:02:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:02:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:02:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:20 INFO - (blobuploader) - INFO - Done attempting. 04:02:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:02:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:02:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:21 INFO - (blobuploader) - INFO - Done attempting. 04:02:21 INFO - (blobuploader) - INFO - Iteration through files over. 04:02:21 INFO - Return code: 0 04:02:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:02:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:02:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e43b0686126be938bc9fdde8b3dd1e98979eb5aabff2fe59cc059aead911ebd46db1fa0656dbab7c129e42543572af07746f7afe9d4ef0259a867c3c386e701a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f85bda5a1835745afa84bef61cedff46344faf91bc62a24f4805aede72d08c9e99ca66a720460d7052e71e49bc1fa993ce030a5279dcc12043baffaba4facb95", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea8c90719f2df6d7bb531f9731d734aa5fbca29c61dd9cd9f0c47fb7ff3b8673dfdc9702de4a5d40784263f707de45be71a26872f62d5b4119fb2d20c9dd61d7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/965a3eda0159b267152d6c9ee084c5d703929d7938ddb678d62315d642f12d0a4787458ace12be977dca3fbdca74b0e68cf729e34b5a1a88bc0491d55d66469f"} 04:02:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:02:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:02:21 INFO - Contents: 04:02:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e43b0686126be938bc9fdde8b3dd1e98979eb5aabff2fe59cc059aead911ebd46db1fa0656dbab7c129e42543572af07746f7afe9d4ef0259a867c3c386e701a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f85bda5a1835745afa84bef61cedff46344faf91bc62a24f4805aede72d08c9e99ca66a720460d7052e71e49bc1fa993ce030a5279dcc12043baffaba4facb95", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea8c90719f2df6d7bb531f9731d734aa5fbca29c61dd9cd9f0c47fb7ff3b8673dfdc9702de4a5d40784263f707de45be71a26872f62d5b4119fb2d20c9dd61d7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/965a3eda0159b267152d6c9ee084c5d703929d7938ddb678d62315d642f12d0a4787458ace12be977dca3fbdca74b0e68cf729e34b5a1a88bc0491d55d66469f"} 04:02:21 INFO - Running post-run listener: copy_logs_to_upload_dir 04:02:21 INFO - Copying logs to upload dir... 04:02:21 INFO - mkdir: /builds/slave/test/build/upload/logs 04:02:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.420791 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-27 04:02:21.342938) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 04:02:21.346330) ========= 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=db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687 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/e43b0686126be938bc9fdde8b3dd1e98979eb5aabff2fe59cc059aead911ebd46db1fa0656dbab7c129e42543572af07746f7afe9d4ef0259a867c3c386e701a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f85bda5a1835745afa84bef61cedff46344faf91bc62a24f4805aede72d08c9e99ca66a720460d7052e71e49bc1fa993ce030a5279dcc12043baffaba4facb95", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea8c90719f2df6d7bb531f9731d734aa5fbca29c61dd9cd9f0c47fb7ff3b8673dfdc9702de4a5d40784263f707de45be71a26872f62d5b4119fb2d20c9dd61d7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/965a3eda0159b267152d6c9ee084c5d703929d7938ddb678d62315d642f12d0a4787458ace12be977dca3fbdca74b0e68cf729e34b5a1a88bc0491d55d66469f"} build_url:https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/FadbKXGRQEiHgoCzlzPmQA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e43b0686126be938bc9fdde8b3dd1e98979eb5aabff2fe59cc059aead911ebd46db1fa0656dbab7c129e42543572af07746f7afe9d4ef0259a867c3c386e701a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f85bda5a1835745afa84bef61cedff46344faf91bc62a24f4805aede72d08c9e99ca66a720460d7052e71e49bc1fa993ce030a5279dcc12043baffaba4facb95", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea8c90719f2df6d7bb531f9731d734aa5fbca29c61dd9cd9f0c47fb7ff3b8673dfdc9702de4a5d40784263f707de45be71a26872f62d5b4119fb2d20c9dd61d7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/965a3eda0159b267152d6c9ee084c5d703929d7938ddb678d62315d642f12d0a4787458ace12be977dca3fbdca74b0e68cf729e34b5a1a88bc0491d55d66469f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 04:02:21.374926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:02:21.375275) ========= 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=db0483c52d987ecb441a263b000001ad-1506508446.2767-1881473687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:02:21.460312) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 04:02:21.460706) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 04:02:21.461089) ========= ========= Total master_lag: 0.21 =========