builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1504995733.76 results: success (0) revision: d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:13.757985) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:13.758452) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:13.758724) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:13.776031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:13.776423) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-09 15:22:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2017-09-09 15:22:13 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126715 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:13.920074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:13.920384) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014575 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:13.970064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:13.970401) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 --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 d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 --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=8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-09 15:22:13,975 truncating revision to first 12 chars 2017-09-09 15:22:13,975 Setting DEBUG logging. 2017-09-09 15:22:13,975 attempt 1/10 2017-09-09 15:22:13,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d53ba311ca2f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-09 15:22:14,387 unpacking tar archive at: mozilla-central-d53ba311ca2f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.767933 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:14.754783) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:14.755122) ========= script_repo_revision: d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:14.755497) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:14.755810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 15:22:14.768990) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-09 15:22:14.769289) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:22:14 INFO - MultiFileLogger online at 20170909 15:22:14 in /builds/slave/test 15:22:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:22:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:22:14 INFO - {'append_to_log': False, 15:22:14 INFO - 'base_work_dir': '/builds/slave/test', 15:22:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:22:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:22:14 INFO - 'branch': 'Firefox-Non-PGO', 15:22:14 INFO - 'buildbot_json_path': 'buildprops.json', 15:22:14 INFO - 'code_coverage': False, 15:22:14 INFO - 'config_files': ('talos/linux_config.py',), 15:22:14 INFO - 'default_actions': ('clobber', 15:22:14 INFO - 'read-buildbot-config', 15:22:14 INFO - 'download-and-extract', 15:22:14 INFO - 'populate-webroot', 15:22:14 INFO - 'create-virtualenv', 15:22:14 INFO - 'install', 15:22:14 INFO - 'setup-mitmproxy', 15:22:14 INFO - 'run-tests'), 15:22:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:22:14 INFO - 'disable_ccov_upload': False, 15:22:14 INFO - 'disable_stylo': False, 15:22:14 INFO - 'download_minidump_stackwalk': True, 15:22:14 INFO - 'download_symbols': 'ondemand', 15:22:14 INFO - 'enable_stylo': False, 15:22:14 INFO - 'enable_webrender': False, 15:22:14 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:22:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:22:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:22:14 INFO - 'gecko_profile': False, 15:22:14 INFO - 'gecko_profile_interval': 0, 15:22:14 INFO - 'installer_path': 'installer.exe', 15:22:14 INFO - 'log_level': 'info', 15:22:14 INFO - 'log_name': 'talos', 15:22:14 INFO - 'log_to_console': True, 15:22:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:22:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:22:14 INFO - 'opt_config_files': (), 15:22:14 INFO - 'pip_index': False, 15:22:14 INFO - 'suite': 'dromaeojs-e10s', 15:22:14 INFO - 'system_bits': '32', 15:22:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:22:14 INFO - 'title': 'talos-linux64-ix-089', 15:22:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:22:14 INFO - 'use_talos_json': True, 15:22:14 INFO - 'verify': 'False', 15:22:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:22:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:22:14 INFO - 'work_dir': 'build'} 15:22:14 INFO - [mozharness: 2017-09-09 22:22:14.917714Z] Running clobber step. 15:22:14 INFO - Running pre-action listener: _resource_record_pre_action 15:22:14 INFO - Running main action method: clobber 15:22:14 INFO - rmtree: /builds/slave/test/build 15:22:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:22:16 INFO - Running post-action listener: _resource_record_post_action 15:22:16 INFO - [mozharness: 2017-09-09 22:22:16.559192Z] Finished clobber step (success) 15:22:16 INFO - [mozharness: 2017-09-09 22:22:16.559290Z] Running read-buildbot-config step. 15:22:16 INFO - Running pre-action listener: _resource_record_pre_action 15:22:16 INFO - Running main action method: read_buildbot_config 15:22:16 INFO - Using buildbot properties: 15:22:16 INFO - { 15:22:16 INFO - "project": "", 15:22:16 INFO - "product": "firefox", 15:22:16 INFO - "who": "archaeopteryx@coole-files.de", 15:22:16 INFO - "installer_path": "public/build/target.tar.bz2", 15:22:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:22:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:22:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:22:16 INFO - "stage_platform": "linux64", 15:22:16 INFO - "basedir": "/builds/slave/test", 15:22:16 INFO - "buildnumber": 1130, 15:22:16 INFO - "platform": "ubuntu64_hw", 15:22:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:22:16 INFO - "slavebuilddir": "test", 15:22:16 INFO - "taskId": "e7bhvkuJQDq0ndyW1rrFzw", 15:22:16 INFO - "branch": "mozilla-central", 15:22:16 INFO - "script_repo_revision": "production", 15:22:16 INFO - "revision": "d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6", 15:22:16 INFO - "slavename": "talos-linux64-ix-089", 15:22:16 INFO - "repo_path": "mozilla-central" 15:22:16 INFO - } 15:22:16 INFO - Finding installer, test and symbols from parent task. 15:22:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e7bhvkuJQDq0ndyW1rrFzw'}, attempt #1 15:22:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e7bhvkuJQDq0ndyW1rrFzw'}, attempt #1 15:22:17 INFO - Task dependencies: MA-3vqX9SCK7dglRp0vY9Q 15:22:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q'}, attempt #1 15:22:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2 15:22:17 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.test_packages.json 15:22:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.crashreporter-symbols.zip 15:22:17 INFO - Running post-action listener: _resource_record_post_action 15:22:17 INFO - [mozharness: 2017-09-09 22:22:17.942798Z] Finished read-buildbot-config step (success) 15:22:17 INFO - [mozharness: 2017-09-09 22:22:17.943015Z] Running download-and-extract step. 15:22:17 INFO - Running pre-action listener: _resource_record_pre_action 15:22:17 INFO - Running main action method: download_and_extract 15:22:17 INFO - mkdir: /builds/slave/test/build/tests 15:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:17 INFO - trying https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.test_packages.json 15:22:17 INFO - Downloading https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:22:18 INFO - Downloaded 989 bytes. 15:22:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:22:18 INFO - Using the following test package requirements: 15:22:18 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:22:18 INFO - u'common': [u'target.common.tests.zip'], 15:22:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:22:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:22:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:22:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:22:18 INFO - u'mozbase': [u'target.common.tests.zip'], 15:22:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:22:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:22:18 INFO - u'web-platform': [u'target.common.tests.zip', 15:22:18 INFO - u'target.web-platform.tests.tar.gz'], 15:22:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:22:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:22:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.common.tests.zip 15:22:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:22:18 INFO - Fetch https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.common.tests.zip into memory 15:22:19 INFO - Content-Length response header: 55024690 15:22:19 INFO - Bytes received: 55024690 15:22:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.talos.tests.zip 15:22:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:22:30 INFO - Fetch https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.talos.tests.zip into memory 15:22:31 INFO - Content-Length response header: 14497963 15:22:31 INFO - Bytes received: 14497963 15:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:31 INFO - trying https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2 15:22:31 INFO - Downloading https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:22:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:22:32 INFO - Downloaded 62936068 bytes. 15:22:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2 15:22:32 INFO - mkdir: /builds/slave/test/properties 15:22:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:22:32 INFO - Writing to file /builds/slave/test/properties/build_url 15:22:32 INFO - Contents: 15:22:32 INFO - build_url:https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2 15:22:32 INFO - Running post-action listener: _resource_record_post_action 15:22:32 INFO - Running post-action listener: find_tests_for_verification 15:22:32 INFO - Running post-action listener: set_extra_try_arguments 15:22:32 INFO - [mozharness: 2017-09-09 22:22:32.764405Z] Finished download-and-extract step (success) 15:22:32 INFO - [mozharness: 2017-09-09 22:22:32.764543Z] Running populate-webroot step. 15:22:32 INFO - Running pre-action listener: _resource_record_pre_action 15:22:32 INFO - Running main action method: populate_webroot 15:22:32 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:22:32 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:32 INFO - 'tests': ['tresize', 15:22:32 INFO - 'tcanvasmark']}, 15:22:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:22:32 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:32 INFO - 'tests': ['dromaeo_css', 15:22:32 INFO - 'kraken']}, 15:22:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:22:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:32 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:22:32 INFO - 'talos_options': ['--disable-stylo'], 15:22:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:22:32 INFO - 'tests': ['damp', 'tps']}, 15:22:32 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:22:32 INFO - 'talos_options': ['--disable-stylo'], 15:22:32 INFO - 'tests': ['damp', 'tps']}, 15:22:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:22:32 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:32 INFO - 'tests': ['dromaeo_dom']}, 15:22:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:22:32 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:32 INFO - 'tests': ['basic_compositor_video', 15:22:32 INFO - 'glvideo']}, 15:22:32 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:22:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:22:32 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:22:32 INFO - 'talos_options': ['--disable-stylo'], 15:22:32 INFO - 'tests': ['ts_paint_webext', 15:22:32 INFO - 'tp5o_webext']}, 15:22:32 INFO - 'other-e10s': {'tests': ['a11yr', 15:22:32 INFO - 'ts_paint', 15:22:32 INFO - 'tpaint', 15:22:32 INFO - 'sessionrestore', 15:22:32 INFO - 'sessionrestore_many_windows', 15:22:32 INFO - 'sessionrestore_no_auto_restore', 15:22:32 INFO - 'tabpaint']}, 15:22:32 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:32 INFO - 'tests': ['a11yr', 15:22:32 INFO - 'ts_paint', 15:22:32 INFO - 'tpaint', 15:22:32 INFO - 'sessionrestore', 15:22:32 INFO - 'sessionrestore_many_windows', 15:22:32 INFO - 'sessionrestore_no_auto_restore', 15:22:32 INFO - 'tabpaint']}, 15:22:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:22:32 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:22:32 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:32 INFO - 'tests': ['bloom_basic_singleton']}, 15:22:32 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:32 INFO - 'tests': ['bloom_basic']}, 15:22:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:22:32 INFO - 'tsvgr_opacity', 15:22:32 INFO - 'tart', 15:22:32 INFO - 'tscrollx', 15:22:32 INFO - 'tsvg_static']}, 15:22:32 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:32 INFO - 'tests': ['tsvgx', 15:22:32 INFO - 'tsvgr_opacity', 15:22:32 INFO - 'tart', 15:22:32 INFO - 'tscrollx', 15:22:32 INFO - 'tsvg_static']}, 15:22:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:22:32 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:22:32 INFO - 'talos_options': ['--disable-stylo'], 15:22:32 INFO - 'tests': ['tp5o']}, 15:22:32 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:22:32 INFO - 'talos_options': ['--mitmproxy', 15:22:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:22:32 INFO - '--firstNonBlankPaint'], 15:22:32 INFO - 'tests': ['tp6_google', 15:22:32 INFO - 'tp6_youtube', 15:22:32 INFO - 'tp6_amazon', 15:22:32 INFO - 'tp6_facebook']}, 15:22:32 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:22:32 INFO - 'talos_options': ['--disable-stylo', 15:22:32 INFO - '--mitmproxy', 15:22:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:22:32 INFO - '--firstNonBlankPaint'], 15:22:32 INFO - 'tests': ['tp6_google', 15:22:32 INFO - 'tp6_youtube', 15:22:32 INFO - 'tp6_amazon', 15:22:32 INFO - 'tp6_facebook']}, 15:22:32 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:22:32 INFO - 'talos_options': ['--stylo-threads=1', 15:22:32 INFO - '--mitmproxy', 15:22:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:22:32 INFO - '--firstNonBlankPaint'], 15:22:32 INFO - 'tests': ['tp6_google', 15:22:32 INFO - 'tp6_youtube', 15:22:32 INFO - 'tp6_amazon', 15:22:32 INFO - 'tp6_facebook']}, 15:22:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:22:32 INFO - 'talos_options': ['--xperf_path', 15:22:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:32 INFO - 'tests': ['tp5n']}, 15:22:32 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:22:32 INFO - 'talos_options': ['--disable-stylo', 15:22:32 INFO - '--xperf_path', 15:22:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:32 INFO - 'tests': ['tp5n']}}} 15:22:32 INFO - Running post-action listener: _resource_record_post_action 15:22:32 INFO - [mozharness: 2017-09-09 22:22:32.780411Z] Finished populate-webroot step (success) 15:22:32 INFO - [mozharness: 2017-09-09 22:22:32.780506Z] Running create-virtualenv step. 15:22:32 INFO - Running pre-action listener: _resource_record_pre_action 15:22:32 INFO - Running main action method: create_virtualenv 15:22:32 INFO - Creating virtualenv /builds/slave/test/build/venv 15:22:32 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:22:32 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:22:32 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:22:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:22:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:22:34 INFO - Installing distribute.............................................................................................................................................................................................done. 15:22:34 INFO - Installing pip...............done. 15:22:34 INFO - Return code: 0 15:22:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:22:34 INFO - Reading from file tmpfile_stdout 15:22:34 INFO - Output received: 15:22:34 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:22:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:34 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 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d3090>, '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 0x28d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cdf90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:22:34 INFO - Using env: {'DISPLAY': ':0', 15:22:34 INFO - 'HOME': '/home/cltbld', 15:22:34 INFO - 'LANG': 'en_US.UTF-8', 15:22:34 INFO - 'LANGUAGE': 'en_US:en', 15:22:34 INFO - 'LOGNAME': 'cltbld', 15:22:34 INFO - 'MAIL': '/var/mail/cltbld', 15:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:34 INFO - 'MOZ_NO_REMOTE': '1', 15:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:34 INFO - 'NO_EM_RESTART': '1', 15:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:34 INFO - 'PWD': '/builds/slave/test', 15:22:34 INFO - 'SHELL': '/bin/bash', 15:22:34 INFO - 'SHLVL': '1', 15:22:34 INFO - 'TERM': 'linux', 15:22:34 INFO - 'TMOUT': '86400', 15:22:34 INFO - 'USER': 'cltbld', 15:22:34 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:34 INFO - '_': '/tools/buildbot/bin/python'} 15:22:35 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:22:35 INFO - Downloading/unpacking pip>=1.5 15:22:35 INFO - Running setup.py egg_info for package pip 15:22:35 INFO - warning: no files found matching 'pip/cacert.pem' 15:22:35 INFO - warning: no files found matching '*.html' under directory 'docs' 15:22:35 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:22:35 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:22:35 INFO - Installing collected packages: pip 15:22:35 INFO - Found existing installation: pip 1.1 15:22:35 INFO - Uninstalling pip: 15:22:35 INFO - Successfully uninstalled pip 15:22:35 INFO - Running setup.py install for pip 15:22:35 INFO - warning: no files found matching 'pip/cacert.pem' 15:22:35 INFO - warning: no files found matching '*.html' under directory 'docs' 15:22:35 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:22:35 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:22:35 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:22:35 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:22:35 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:22:35 INFO - Successfully installed pip 15:22:35 INFO - Cleaning up... 15:22:35 INFO - Return code: 0 15:22:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:35 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 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d3090>, '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 0x28d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cdf90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:22:35 INFO - Using env: {'DISPLAY': ':0', 15:22:35 INFO - 'HOME': '/home/cltbld', 15:22:35 INFO - 'LANG': 'en_US.UTF-8', 15:22:35 INFO - 'LANGUAGE': 'en_US:en', 15:22:35 INFO - 'LOGNAME': 'cltbld', 15:22:35 INFO - 'MAIL': '/var/mail/cltbld', 15:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:35 INFO - 'MOZ_NO_REMOTE': '1', 15:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:35 INFO - 'NO_EM_RESTART': '1', 15:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:35 INFO - 'PWD': '/builds/slave/test', 15:22:35 INFO - 'SHELL': '/bin/bash', 15:22:35 INFO - 'SHLVL': '1', 15:22:35 INFO - 'TERM': 'linux', 15:22:35 INFO - 'TMOUT': '86400', 15:22:35 INFO - 'USER': 'cltbld', 15:22:35 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:35 INFO - '_': '/tools/buildbot/bin/python'} 15:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:35 INFO - Downloading/unpacking psutil>=3.1.1 15:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:22:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:37 INFO - Installing collected packages: psutil 15:22:37 INFO - Running setup.py install for psutil 15:22:37 INFO - building 'psutil._psutil_linux' extension 15:22:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:22:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:22:37 INFO - building 'psutil._psutil_posix' extension 15:22:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:22:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:22:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:37 INFO - Successfully installed psutil 15:22:37 INFO - Cleaning up... 15:22:37 INFO - Return code: 0 15:22:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d3090>, '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 0x28d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cdf90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:22:37 INFO - Using env: {'DISPLAY': ':0', 15:22:37 INFO - 'HOME': '/home/cltbld', 15:22:37 INFO - 'LANG': 'en_US.UTF-8', 15:22:37 INFO - 'LANGUAGE': 'en_US:en', 15:22:37 INFO - 'LOGNAME': 'cltbld', 15:22:37 INFO - 'MAIL': '/var/mail/cltbld', 15:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:37 INFO - 'MOZ_NO_REMOTE': '1', 15:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:37 INFO - 'NO_EM_RESTART': '1', 15:22:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:37 INFO - 'PWD': '/builds/slave/test', 15:22:37 INFO - 'SHELL': '/bin/bash', 15:22:37 INFO - 'SHLVL': '1', 15:22:37 INFO - 'TERM': 'linux', 15:22:37 INFO - 'TMOUT': '86400', 15:22:37 INFO - 'USER': 'cltbld', 15:22:37 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:37 INFO - '_': '/tools/buildbot/bin/python'} 15:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:22:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:22:39 INFO - Installing collected packages: mozsystemmonitor 15:22:39 INFO - Running setup.py install for mozsystemmonitor 15:22:39 INFO - Successfully installed mozsystemmonitor 15:22:39 INFO - Cleaning up... 15:22:40 INFO - Return code: 0 15:22:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d3090>, '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 0x28d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cdf90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:22:40 INFO - Using env: {'DISPLAY': ':0', 15:22:40 INFO - 'HOME': '/home/cltbld', 15:22:40 INFO - 'LANG': 'en_US.UTF-8', 15:22:40 INFO - 'LANGUAGE': 'en_US:en', 15:22:40 INFO - 'LOGNAME': 'cltbld', 15:22:40 INFO - 'MAIL': '/var/mail/cltbld', 15:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:40 INFO - 'MOZ_NO_REMOTE': '1', 15:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:40 INFO - 'NO_EM_RESTART': '1', 15:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:40 INFO - 'PWD': '/builds/slave/test', 15:22:40 INFO - 'SHELL': '/bin/bash', 15:22:40 INFO - 'SHLVL': '1', 15:22:40 INFO - 'TERM': 'linux', 15:22:40 INFO - 'TMOUT': '86400', 15:22:40 INFO - 'USER': 'cltbld', 15:22:40 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:40 INFO - '_': '/tools/buildbot/bin/python'} 15:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:40 INFO - Downloading/unpacking jsonschema==2.5.1 15:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:22:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:42 INFO - Downloading functools32-3.2.3-2.tar.gz 15:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:22:42 INFO - warning: no files found matching '*.txt' 15:22:42 INFO - no previously-included directories found matching 'build' 15:22:42 INFO - no previously-included directories found matching 'dist' 15:22:42 INFO - no previously-included directories found matching '.git*' 15:22:42 INFO - Installing collected packages: jsonschema, functools32 15:22:42 INFO - Running setup.py install for functools32 15:22:42 INFO - warning: no files found matching '*.txt' 15:22:42 INFO - no previously-included directories found matching 'build' 15:22:42 INFO - no previously-included directories found matching 'dist' 15:22:42 INFO - no previously-included directories found matching '.git*' 15:22:42 INFO - Successfully installed jsonschema functools32 15:22:42 INFO - Cleaning up... 15:22:42 INFO - Return code: 0 15:22:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d3090>, '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 0x28d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cdf90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:22:42 INFO - Using env: {'DISPLAY': ':0', 15:22:42 INFO - 'HOME': '/home/cltbld', 15:22:42 INFO - 'LANG': 'en_US.UTF-8', 15:22:42 INFO - 'LANGUAGE': 'en_US:en', 15:22:42 INFO - 'LOGNAME': 'cltbld', 15:22:42 INFO - 'MAIL': '/var/mail/cltbld', 15:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:42 INFO - 'MOZ_NO_REMOTE': '1', 15:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:42 INFO - 'NO_EM_RESTART': '1', 15:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:42 INFO - 'PWD': '/builds/slave/test', 15:22:42 INFO - 'SHELL': '/bin/bash', 15:22:42 INFO - 'SHLVL': '1', 15:22:42 INFO - 'TERM': 'linux', 15:22:42 INFO - 'TMOUT': '86400', 15:22:42 INFO - 'USER': 'cltbld', 15:22:42 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:42 INFO - '_': '/tools/buildbot/bin/python'} 15:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:22:42 INFO - Cleaning up... 15:22:42 INFO - Return code: 0 15:22:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d3090>, '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 0x28d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cdf90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:22:42 INFO - Using env: {'DISPLAY': ':0', 15:22:42 INFO - 'HOME': '/home/cltbld', 15:22:42 INFO - 'LANG': 'en_US.UTF-8', 15:22:42 INFO - 'LANGUAGE': 'en_US:en', 15:22:42 INFO - 'LOGNAME': 'cltbld', 15:22:42 INFO - 'MAIL': '/var/mail/cltbld', 15:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:42 INFO - 'MOZ_NO_REMOTE': '1', 15:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:42 INFO - 'NO_EM_RESTART': '1', 15:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:42 INFO - 'PWD': '/builds/slave/test', 15:22:42 INFO - 'SHELL': '/bin/bash', 15:22:42 INFO - 'SHLVL': '1', 15:22:42 INFO - 'TERM': 'linux', 15:22:42 INFO - 'TMOUT': '86400', 15:22:42 INFO - 'USER': 'cltbld', 15:22:42 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:42 INFO - '_': '/tools/buildbot/bin/python'} 15:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:42 INFO - Downloading/unpacking blobuploader==1.2.4 15:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:43 INFO - Downloading blobuploader-1.2.4.tar.gz 15:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:22:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:22:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:44 INFO - Downloading docopt-0.6.1.tar.gz 15:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:22:44 INFO - Installing collected packages: blobuploader, requests, docopt 15:22:44 INFO - Running setup.py install for blobuploader 15:22:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:22:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:22:44 INFO - Running setup.py install for requests 15:22:44 INFO - Running setup.py install for docopt 15:22:44 INFO - Successfully installed blobuploader requests docopt 15:22:44 INFO - Cleaning up... 15:22:44 INFO - Return code: 0 15:22:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:45 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 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d3090>, '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 0x28d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cdf90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:22:45 INFO - Using env: {'DISPLAY': ':0', 15:22:45 INFO - 'HOME': '/home/cltbld', 15:22:45 INFO - 'LANG': 'en_US.UTF-8', 15:22:45 INFO - 'LANGUAGE': 'en_US:en', 15:22:45 INFO - 'LOGNAME': 'cltbld', 15:22:45 INFO - 'MAIL': '/var/mail/cltbld', 15:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:45 INFO - 'MOZ_NO_REMOTE': '1', 15:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:45 INFO - 'NO_EM_RESTART': '1', 15:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:45 INFO - 'PWD': '/builds/slave/test', 15:22:45 INFO - 'SHELL': '/bin/bash', 15:22:45 INFO - 'SHLVL': '1', 15:22:45 INFO - 'TERM': 'linux', 15:22:45 INFO - 'TMOUT': '86400', 15:22:45 INFO - 'USER': 'cltbld', 15:22:45 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:45 INFO - '_': '/tools/buildbot/bin/python'} 15:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:45 INFO - Running setup.py (path:/tmp/pip-dCv64T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:45 INFO - Running setup.py (path:/tmp/pip-SAeOFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:45 INFO - Running setup.py (path:/tmp/pip-4egm_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:45 INFO - Running setup.py (path:/tmp/pip-PoJ4Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:45 INFO - Running setup.py (path:/tmp/pip-A3aVPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:45 INFO - Running setup.py (path:/tmp/pip-KNazHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:45 INFO - Running setup.py (path:/tmp/pip-fgYjjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:45 INFO - Running setup.py (path:/tmp/pip-pbN6jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:45 INFO - Running setup.py (path:/tmp/pip-bfOQfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:45 INFO - Running setup.py (path:/tmp/pip-fi_Q87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:45 INFO - Running setup.py (path:/tmp/pip-GTc5T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:45 INFO - Running setup.py (path:/tmp/pip-2DbNhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:46 INFO - Running setup.py (path:/tmp/pip-adfqhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:46 INFO - Running setup.py (path:/tmp/pip-V_aNBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:46 INFO - Running setup.py (path:/tmp/pip-pNkrky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:46 INFO - Running setup.py (path:/tmp/pip-4K62MP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:46 INFO - Running setup.py (path:/tmp/pip-npthB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:22:46 INFO - Running setup.py install for manifestparser 15:22:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:22:46 INFO - Running setup.py install for mozcrash 15:22:46 INFO - Running setup.py install for mozdebug 15:22:46 INFO - Running setup.py install for mozdevice 15:22:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:22:46 INFO - Running setup.py install for mozfile 15:22:46 INFO - Running setup.py install for mozhttpd 15:22:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:22:47 INFO - Running setup.py install for mozinfo 15:22:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:22:47 INFO - Running setup.py install for mozInstall 15:22:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:22:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:22:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:22:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:22:47 INFO - Running setup.py install for mozleak 15:22:47 INFO - Running setup.py install for mozlog 15:22:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:22:47 INFO - Running setup.py install for moznetwork 15:22:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:22:47 INFO - Running setup.py install for mozprocess 15:22:47 INFO - Running setup.py install for mozprofile 15:22:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:22:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:22:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:22:47 INFO - Running setup.py install for mozrunner 15:22:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:22:47 INFO - Running setup.py install for mozscreenshot 15:22:47 INFO - Running setup.py install for moztest 15:22:48 INFO - Running setup.py install for mozversion 15:22:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:22:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:22:48 INFO - Cleaning up... 15:22:48 INFO - Return code: 0 15:22:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:48 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 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d3090>, '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 0x28d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cdf90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:22:48 INFO - Using env: {'DISPLAY': ':0', 15:22:48 INFO - 'HOME': '/home/cltbld', 15:22:48 INFO - 'LANG': 'en_US.UTF-8', 15:22:48 INFO - 'LANGUAGE': 'en_US:en', 15:22:48 INFO - 'LOGNAME': 'cltbld', 15:22:48 INFO - 'MAIL': '/var/mail/cltbld', 15:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:48 INFO - 'MOZ_NO_REMOTE': '1', 15:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:48 INFO - 'NO_EM_RESTART': '1', 15:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:48 INFO - 'PWD': '/builds/slave/test', 15:22:48 INFO - 'SHELL': '/bin/bash', 15:22:48 INFO - 'SHLVL': '1', 15:22:48 INFO - 'TERM': 'linux', 15:22:48 INFO - 'TMOUT': '86400', 15:22:48 INFO - 'USER': 'cltbld', 15:22:48 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:48 INFO - '_': '/tools/buildbot/bin/python'} 15:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:48 INFO - Running setup.py (path:/tmp/pip-KwiCDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:48 INFO - Running setup.py (path:/tmp/pip-PhcsUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:48 INFO - Running setup.py (path:/tmp/pip-meEqhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:48 INFO - Running setup.py (path:/tmp/pip-wfNiwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:48 INFO - Running setup.py (path:/tmp/pip-WFoPYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:48 INFO - Running setup.py (path:/tmp/pip-Tj_YuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:48 INFO - Running setup.py (path:/tmp/pip-hpLC5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:48 INFO - Running setup.py (path:/tmp/pip-HhA5Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:48 INFO - Running setup.py (path:/tmp/pip-_JVzWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:49 INFO - Running setup.py (path:/tmp/pip-2rNxDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:49 INFO - Running setup.py (path:/tmp/pip-bbD5OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:49 INFO - Running setup.py (path:/tmp/pip-iNMKS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:49 INFO - Running setup.py (path:/tmp/pip-LKvRtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:49 INFO - Running setup.py (path:/tmp/pip-lVlqcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:49 INFO - Running setup.py (path:/tmp/pip-zZLVXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:49 INFO - Running setup.py (path:/tmp/pip-abLCNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:49 INFO - Running setup.py (path:/tmp/pip-g6R97e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:22:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:50 INFO - Downloading blessings-1.6.tar.gz 15:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:22:50 INFO - Installing collected packages: blessings 15:22:50 INFO - Running setup.py install for blessings 15:22:50 INFO - Successfully installed blessings 15:22:50 INFO - Cleaning up... 15:22:51 INFO - Return code: 0 15:22:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:22:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:51 INFO - Reading from file tmpfile_stdout 15:22:51 INFO - Current package versions: 15:22:51 INFO - argparse == 1.2.1 15:22:51 INFO - blessings == 1.6 15:22:51 INFO - blobuploader == 1.2.4 15:22:51 INFO - docopt == 0.6.1 15:22:51 INFO - functools32 == 3.2.3-2 15:22:51 INFO - jsonschema == 2.5.1 15:22:51 INFO - manifestparser == 1.1 15:22:51 INFO - mozInstall == 1.13 15:22:51 INFO - mozcrash == 1.0 15:22:51 INFO - mozdebug == 0.1 15:22:51 INFO - mozdevice == 0.51 15:22:51 INFO - mozfile == 1.2 15:22:51 INFO - mozhttpd == 0.7 15:22:51 INFO - mozinfo == 0.10 15:22:51 INFO - mozleak == 0.1 15:22:51 INFO - mozlog == 3.5 15:22:51 INFO - moznetwork == 0.27 15:22:51 INFO - mozprocess == 0.25 15:22:51 INFO - mozprofile == 0.28 15:22:51 INFO - mozrunner == 6.13 15:22:51 INFO - mozscreenshot == 0.1 15:22:51 INFO - mozsystemmonitor == 0.3 15:22:51 INFO - moztest == 0.8 15:22:51 INFO - mozversion == 1.4 15:22:51 INFO - psutil == 3.1.1 15:22:51 INFO - requests == 1.2.3 15:22:51 INFO - wsgiref == 0.1.2 15:22:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:51 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 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d3090>, '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 0x28d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cdf90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:22:51 INFO - Using env: {'DISPLAY': ':0', 15:22:51 INFO - 'HOME': '/home/cltbld', 15:22:51 INFO - 'LANG': 'en_US.UTF-8', 15:22:51 INFO - 'LANGUAGE': 'en_US:en', 15:22:51 INFO - 'LOGNAME': 'cltbld', 15:22:51 INFO - 'MAIL': '/var/mail/cltbld', 15:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:51 INFO - 'MOZ_NO_REMOTE': '1', 15:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:51 INFO - 'NO_EM_RESTART': '1', 15:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:51 INFO - 'PWD': '/builds/slave/test', 15:22:51 INFO - 'SHELL': '/bin/bash', 15:22:51 INFO - 'SHLVL': '1', 15:22:51 INFO - 'TERM': 'linux', 15:22:51 INFO - 'TMOUT': '86400', 15:22:51 INFO - 'USER': 'cltbld', 15:22:51 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:51 INFO - '_': '/tools/buildbot/bin/python'} 15:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:22:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:22:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:22:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:22:52 INFO - Installing collected packages: simplejson 15:22:52 INFO - Running setup.py install for simplejson 15:22:52 INFO - building 'simplejson._speedups' extension 15:22:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:22:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:22:53 INFO - Successfully installed simplejson 15:22:53 INFO - Cleaning up... 15:22:53 INFO - Return code: 0 15:22:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d3090>, '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 0x28d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cdf90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:22:53 INFO - Using env: {'DISPLAY': ':0', 15:22:53 INFO - 'HOME': '/home/cltbld', 15:22:53 INFO - 'LANG': 'en_US.UTF-8', 15:22:53 INFO - 'LANGUAGE': 'en_US:en', 15:22:53 INFO - 'LOGNAME': 'cltbld', 15:22:53 INFO - 'MAIL': '/var/mail/cltbld', 15:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:53 INFO - 'MOZ_NO_REMOTE': '1', 15:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:53 INFO - 'NO_EM_RESTART': '1', 15:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:53 INFO - 'PWD': '/builds/slave/test', 15:22:53 INFO - 'SHELL': '/bin/bash', 15:22:53 INFO - 'SHLVL': '1', 15:22:53 INFO - 'TERM': 'linux', 15:22:53 INFO - 'TMOUT': '86400', 15:22:53 INFO - 'USER': 'cltbld', 15:22:53 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:53 INFO - '_': '/tools/buildbot/bin/python'} 15:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:22:53 INFO - Cleaning up... 15:22:53 INFO - Return code: 0 15:22:53 INFO - Running post-action listener: _resource_record_post_action 15:22:53 INFO - Running post-action listener: _start_resource_monitoring 15:22:53 INFO - Starting resource monitoring. 15:22:53 INFO - [mozharness: 2017-09-09 22:22:53.934229Z] Finished create-virtualenv step (success) 15:22:53 INFO - [mozharness: 2017-09-09 22:22:53.934691Z] Running install step. 15:22:53 INFO - Running pre-action listener: _resource_record_pre_action 15:22:53 INFO - Running main action method: install 15:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:54 INFO - Reading from file tmpfile_stdout 15:22:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:22:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:22:54 INFO - Reading from file tmpfile_stdout 15:22:54 INFO - Output received: 15:22:54 INFO - Usage: mozinstall [options] installer 15:22:54 INFO - Options: 15:22:54 INFO - -h, --help show this help message and exit 15:22:54 INFO - -d DEST, --destination=DEST 15:22:54 INFO - Directory to install application into. [default: 15:22:54 INFO - "/builds/slave/test"] 15:22:54 INFO - --app=APP Application being installed. [default: firefox] 15:22:54 INFO - mkdir: /builds/slave/test/build/application 15:22:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:23:11 INFO - Reading from file tmpfile_stdout 15:23:11 INFO - Output received: 15:23:11 INFO - /builds/slave/test/build/application/firefox/firefox 15:23:11 INFO - Running post-action listener: _resource_record_post_action 15:23:11 INFO - [mozharness: 2017-09-09 22:23:11.362137Z] Finished install step (success) 15:23:11 INFO - [mozharness: 2017-09-09 22:23:11.362479Z] Running setup-mitmproxy step. 15:23:11 INFO - Running pre-action listener: _resource_record_pre_action 15:23:11 INFO - Running main action method: setup_mitmproxy 15:23:11 INFO - Skipping: mitmproxy is not required 15:23:11 INFO - Running post-action listener: _resource_record_post_action 15:23:11 INFO - [mozharness: 2017-09-09 22:23:11.364088Z] Finished setup-mitmproxy step (success) 15:23:11 INFO - [mozharness: 2017-09-09 22:23:11.364397Z] Running run-tests step. 15:23:11 INFO - Running pre-action listener: _resource_record_pre_action 15:23:11 INFO - Running pre-action listener: _set_gcov_prefix 15:23:11 INFO - Running main action method: run_tests 15:23:11 WARNING - Try message not found. 15:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:23:11 INFO - Python 2.7.3 15:23:11 INFO - Return code: 0 15:23:11 INFO - grabbing minidump binary from tooltool 15:23: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')]} 15:23:11 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 0x28d3090>, '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 0x28d3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cdf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:23:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:23:11 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:23:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:23:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:23:11 INFO - Return code: 0 15:23:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:23:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:23:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:23:11 INFO - ENV: RUST_BACKTRACE is now full 15:23:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:23:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 15:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --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 15:23:11 INFO - Using env: {'DISPLAY': ':0', 15:23:11 INFO - 'HOME': '/home/cltbld', 15:23:11 INFO - 'LANG': 'en_US.UTF-8', 15:23:11 INFO - 'LANGUAGE': 'en_US:en', 15:23:11 INFO - 'LOGNAME': 'cltbld', 15:23:11 INFO - 'MAIL': '/var/mail/cltbld', 15:23:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:23:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:11 INFO - 'MOZ_NO_REMOTE': '1', 15:23:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:11 INFO - 'NO_EM_RESTART': '1', 15:23:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:11 INFO - 'PWD': '/builds/slave/test', 15:23:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:23:11 INFO - 'RUST_BACKTRACE': 'full', 15:23:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:23:11 INFO - 'SHELL': '/bin/bash', 15:23:11 INFO - 'SHLVL': '1', 15:23:11 INFO - 'TERM': 'linux', 15:23:11 INFO - 'TMOUT': '86400', 15:23:11 INFO - 'USER': 'cltbld', 15:23:11 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:11 INFO - '_': '/tools/buildbot/bin/python'} 15:23:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 15:23:11 INFO - mozversion application_buildid: 20170909213208 15:23:11 INFO - mozversion application_changeset: d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 15:23:11 INFO - mozversion application_display_name: Nightly 15:23:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:23:11 INFO - mozversion application_name: Firefox 15:23:11 INFO - mozversion application_remotingname: firefox 15:23:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:23:11 INFO - mozversion application_vendor: Mozilla 15:23:11 INFO - mozversion application_version: 57.0a1 15:23:11 INFO - mozversion platform_buildid: 20170909213208 15:23:11 INFO - mozversion platform_changeset: d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 15:23:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:23:11 INFO - mozversion platform_version: 57.0a1 15:23:11 INFO - using testdate: 1504995791 15:23:11 INFO - actual date: 1504995791 15:23:11 INFO - starting webserver on 'localhost:35264' 15:23:11 INFO - SUITE-START | Running 2 tests 15:23:11 INFO - TEST-START | dromaeo_css 15:23:11 INFO - Initialising browser for dromaeo_css test... 15:23:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35264/getInfo.html -profile /tmp/tmpgCC85D/profile 15:23:11 INFO - TEST-INFO | started process 11087 (/builds/slave/test/build/application/firefox/firefox http://localhost:35264/getInfo.html) 15:23:17 INFO - TEST-INFO | 11087: exit 0 15:23:17 INFO - Browser initialized. 15:23:17 INFO - Running cycle 1/1 for dromaeo_css test... 15:23:17 INFO - Using env: {'DISPLAY': ':0', 15:23:17 INFO - 'HOME': '/home/cltbld', 15:23:17 INFO - 'JSGC_DISABLE_POISONING': '1', 15:23:17 INFO - 'LANG': 'en_US.UTF-8', 15:23:17 INFO - 'LANGUAGE': 'en_US:en', 15:23:17 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:23:17 INFO - 'LOGNAME': 'cltbld', 15:23:17 INFO - 'MAIL': '/var/mail/cltbld', 15:23:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:23:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:23:17 INFO - 'MOZ_CRASHREPORTER': '1', 15:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:17 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:23:17 INFO - 'MOZ_NO_REMOTE': '1', 15:23:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:17 INFO - 'NO_EM_RESTART': '1', 15:23:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:17 INFO - 'PWD': '/builds/slave/test', 15:23:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:23:17 INFO - 'RUST_BACKTRACE': 'full', 15:23:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:23:17 INFO - 'SHELL': '/bin/bash', 15:23:17 INFO - 'SHLVL': '1', 15:23:17 INFO - 'TERM': 'linux', 15:23:17 INFO - 'TMOUT': '86400', 15:23:17 INFO - 'USER': 'cltbld', 15:23:17 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:17 INFO - '_': '/tools/buildbot/bin/python'} 15:23:17 INFO - TEST-INFO | started process 11288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgCC85D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:18 INFO - PID 11288 | 15:23:18 INFO - PID 11288 | (/builds/slave/test/build/application/firefox/firefox:11339): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:23:18 INFO - PID 11288 | 15:23:29 INFO - PID 11288 | RSS: Main: 170958848 15:23:29 INFO - PID 11288 | 15:26:26 INFO - PID 11288 | Cycle 1(1): loaded http://localhost:35264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35264/tests/dromaeo/cssquery-ext.html) 15:26:27 INFO - PID 11288 | RSS: Main: 174800896 15:26:27 INFO - PID 11288 | 15:29:29 INFO - PID 11288 | Cycle 1(1): loaded http://localhost:35264/tests/dromaeo/cssquery-ext.html (next: http://localhost:35264/tests/dromaeo/cssquery-jquery.html) 15:29:29 INFO - PID 11288 | RSS: Main: 170782720 15:29:29 INFO - PID 11288 | 15:32:31 INFO - PID 11288 | Cycle 1(1): loaded http://localhost:35264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35264/tests/dromaeo/cssquery-mootools.html) 15:32:32 INFO - PID 11288 | RSS: Main: 171274240 15:32:32 INFO - PID 11288 | 15:35:33 INFO - PID 11288 | Cycle 1(1): loaded http://localhost:35264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35264/tests/dromaeo/cssquery-prototype.html) 15:35:34 INFO - PID 11288 | RSS: Main: 170020864 15:35:34 INFO - PID 11288 | 15:38:37 INFO - PID 11288 | Cycle 1(1): loaded http://localhost:35264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35264/tests/dromaeo/cssquery-yui.html) 15:38:38 INFO - PID 11288 | RSS: Main: 173035520 15:38:38 INFO - PID 11288 | 15:41:39 INFO - PID 11288 | Cycle 1(1): loaded http://localhost:35264/tests/dromaeo/cssquery-yui.html (next: http://localhost:35264/tests/dromaeo/cssquery-dojo.html) 15:41:40 INFO - PID 11288 | RSS: Main: 174030848 15:41:40 INFO - PID 11288 | 15:41:40 INFO - PID 11288 | __start_tp_report 15:41:40 INFO - PID 11288 | _x_x_mozilla_page_load 15:41:40 INFO - PID 11288 | _x_x_mozilla_page_load_details 15:41:40 INFO - PID 11288 | |i|pagename|runs| 15:41:40 INFO - PID 11288 | |0;dojo.html;3081.3067059911514;3088.9691103088967;3115.8286294253808;3119.0954623159287;3133.4986402175655;6050.878982420349;6188.5358598105095;6189.504839612831;6291.968540157299;6308.653024083674;6171.50627949764;6189.628622282667;6206.131141640163;6244.750209991606;6249.3438188990185;5733.48398644122;5849.064149736054;5868.061110222366;5875.1187321901625;5900.291964964189;5812.550679350523;5825.679587622679;5900.911486327708;5912.320083190423;5929.822105336847;5696.943030569703;5865.912011319833;5881.147233651118;5884.529237660999;5932.406759324054;5707.62900411476;5748.16651585522;5750.424957504258;5787.102999035156;5817.040188368914;5682.488576028178;5725.685087320196;5759.568032397587;5771.769129234825;5775.27809023872;6184.752609895599;6230.875382492325;6237.095621134956;6246.531510136758;6310.337414571496;6469.611823290571;6547.476201903836;6623.3045530219115;6739;6776.966115169393;6783.118194634715;6833.658317084126;6856.348646878589;6862.828429289258;6872.037914691947;5990.97004514979;6070.119832624289;6078;6207.751689932397;6344.587601805868;6773.390394864486;6795.252522222551;6796.082528858639;6815.216250131299;6899.517033807686;6552.082708420825;6602.2737498875085;6628.7017084230365;6642;6708.6981085850275;6567.704453299613;6617.602943823386;6650.401463868275;6684.131062961881;6695.397414232742;6589.604623722592;6635.303293154246;6639.502037347218;6647.368499992493;6652.567583107082;6645.401913827779;6646.20245570525;6725.630090345078;6733.663316834139;6734.696938637773;5233.084210263189;5239.371275446971;5240.502152295526;5284.313039304866;5310.468953104659;4519.570640789119;4584.106099310669;4645.210314246586;4680.227762419163;4722.95277047232;5701.144828275792;5769.1923130761725;5778.94221057784;5827.213326200994;5830.53355731549;6618.536702430783;6627.3372662733345;6768;6791.320867913268;6799.32006799326;5566.55467562594;5708.514776243983;5755.3381361143165;5773.220615216976;5869.325027621878;5771.105478650816;5777.508911742465;5814.970925145347;5816.651000939957;5822.097574875901;6455.225372955181;6456.192975878015;6532.08550802888;6538.084668146464;6541.411272985359;6450.870982580228;6585.275619681927;6686.297938716365;6755.560888542229;6797.9320206799275;6406.679666016774;6476.773312934025;6505.51208659343;6509.641969691523;6519.185101862267;6549.901751473827;6567.080608714879;6651.035599838093;6654.101696270942;6669.899951500634;6609.272979972103;6665.233498147775;6699;6722.798316050526;6741.258461569126;6405.03924411342;6412.166418365583;6418.390252925965;6418.614883107029;6424.036394540856;6353.841153971188;6453.612783233021;6492.837679058061;6577.112089867998;6592.934070659424;6458.483321334376;6501.772437964838;6537.5096867736065;6539.247986481616;6541.280459149394;6545;6613.801585952429;6687.732490700318;6694;6705.161854768154;6186.412290832363;6270.905936410866;6374;6390.456811171102;6471.4822814175695 15:41:40 INFO - PID 11288 | |1;ext.html;861.3367706865713;886.255545341913;886.787171078941;889.4929889962716;891.5453118909359;37295;40283.39574906371;40670.389944150826;40677;40705.38941915874;37544.62455375445;37932.43101353482;37957.81021094898;37963.810180949054;38045;7728.26581474759;7884.132745398002;7884.724034658788;7894.3289820365335;7896.921030789705;7785.766427007199;7890.132085470594;7898.447108702393;7899.091604465474;7899.565523896184;7883.763487095368;7940.642671079786;7943.126256111823;7947.205279472064;7949.165337639552;7842.098158711764;7885.605719713992;7887.842243155104;7900.525968441912;7910.683572657087;7758.418118641068;7821.21787821219;7827.021622297213;7831.569263690495;7832.295093441618;37374;37390.06524836901;37510;37543;37558.43662345067;3346.9497957530657;3363.394588973984;3365.9831700841337;3368.208471009311;3368.983155084209;31418.21454463657;31468.055958321285;31528.527072093708;31564.842175789203;31585.8420707895;5103.081445339837;5264.105102132647;5278.261043453919;5302.09864323066;5310.362756469249;182170;182243;182821;182840;182992;42320;43122.35316470255;48044.27933580999;48051.5194848047;48758.26862597064;50813;50945.23582146271;50986.49013509892;50995;51070;14515.709685806436;14615;14629.414823406945;14639.04846185016;14664.486742963945;11710.180287379802;11756.823647645293;11763.058955283557;11766.941165294118;11820;14184.219867907364;14212.147271163763;14219.64450888736;14259.215743134228;14290.214038227998;5707.1153971134545;5719.397674058294;5764.971175144181;5883.17635531026;5951.315598706117;986.8717066781272;993.7714325705128;1002.7192386131894;1018.3024628129755;1024.9743756406149;22231;22478.887605561868;22486.775132248797;22492.88753556222;22579.43551411195;1099.3623698255153;1106.391484683421;1107.3466654673782;1108.1190453589415;1117.5306371324064;11684.357360345093;11883.821742673867;11895.643130706092;11965.40172991347;12021.098417618714;211205;212249;212253;212960;213202;51731;51767.482325176265;51851.74074129605;52117;52162;1303.7131830997166;1365.208179256029;1369.103237379518;1371.4240019191964;1428.957131286063;21620.783792161877;21686.67469987983;21809.23667671624;21976;22003.33989980303;36443.817780910926;36452.27095458023;36510.087247819014;36537.81731091328;36590.45114323234;186007;186124;186162;186439;186670;33190.5021424674;34226.48660270148;36186.27627447489;36296.81851590725;36380.81809590935;45160.77419612881;46127;46367.53632463767;46400.53599463962;46520;33044.83477582597;33289.16777080592;33509.664903350655;33533.32933341271;33683;32670.50994235136;32693.34613307768;32803.17992050218;33231;33734.32531349408;37746;37752;37961;37985.24029519339;37997.620023799405;32497.837510812296;32541.349173015933;32586.34827303488;32743.836280818443;32933.34133317368;24268.363331269273;24338;24378.390540236636;24682.012719491737;24932.875335623932 15:41:40 INFO - PID 11288 | |2;jquery.html;565.3583183087197;565.8302509247225;576.1962062922221;582.3274118393256;596.7941060334184;22057.33827985161;22703.978320975555;22708.999999999978;22767.886160569175;22788.088476460944;24327.905244264006;24530.75469245307;25107.246782596507;25685.87157064212;25809.48381032378;6440.484761219103;6644.933550664504;6657.633830139341;6660;6660.766873159416;6244.843878903041;6519.250286217099;6520.2175738911155;6601.50488713346;6611.272759996396;6476;6477.0284457331545;6486.643234622094;6496.317886621908;6497.837554061162;6483.448906842924;6497.252815926158;6502.187226596676;6504.707288172043;6931.965340173318;7049;7075.646217689095;7084.14990201174;7098.183708873494;7098.787036388917;30197.245068873235;31035.22411939697;31071.689283107105;31126.377472450426;31146.37707245865;2092.968605470919;2114.7990940860745;2118.2480219522154;2125.8618189817767;2135.9359219223293;20398.388048358574;20681;21642.458938526506;21669.241576544904;21701.565968680537;2489.7634724701124;2524.861132637704;2567;2578.3038579583595;2578.961315580249;120396;126436.36781816123;126746;135536.32231838876;135866;21095.578088438146;21211.257605983716;22144.33566992993;22441.214557490737;23102.42243943881;42203.15593688109;42222.366664500056;42247;42346.364804527955;42561;11083.72290692723;11279.661610151708;11459.885401146048;11602.825957610643;11663.183577149688;9492.145706886413;9600.615975360908;9639.855402168972;9644.469554174588;9663.420194788336;11151.665450036511;11180.329180249211;11338.886611133948;11528.250663706833;11641.88358116425;3891.5330160380367;4059.188162367538;4165.562615925345;4170.395292682544;4282.122164956177;907.4283201582961;916.9862452063225;918.7289749523907;918.8437965545739;962.485070487286;19210.423687289403;19621.705674414894;19859.106340214727;20066.197352106043;20115.899420503098;934.141059292004;956.1585804492003;959.4387283439266;963.7446076789656;1005.607812952949;10835.51240194193;10945.258719739439;11057.89421057904;11071.612493562849;11147.331160130418;438381;447506;455690;457091;457897;108016;110744.44627776809;111653.44173279082;112815.43592281986;117599.41200294114;1032.4321623107262;1073.7691396349821;1128.6614015795392;1137.243732917617;1178.0987544528443;20739;20875.478113047295;20900.163993440092;20956.895215524433;21036.47408814792;57593.42406576048;58573.414265856794;58933.41066589279;59773.70113149581;60643.39356606554;71571.28428715855;72317;72516;72646.63676681583;73173;19420.4173874784;20040.799592003892;20108.59782804365;20113.597728045064;20117.09473073686;22812.543749124594;22922.19772308028;22927.312180634606;22988.195413161127;23148.652770208122;18050.90974545119;18221.817781822014;18276.81723182751;18326.17532211027;18449.81550184481;15138.394464221308;15210.771838422654;15597.454089106826;15723.685526289182;16538.669226615642;18190;18746.906265468584;18938.621227575648;18984.43046708601;19042.7143592849;19701;19705.310314138937;19842;19882;19883.403497895088;17841;18019.639607208046;18094.5476363092;18099.09504524795;18118.72821907646 15:41:40 INFO - PID 11288 | |3;mootools.html;1322.7433937759129;1375.5598208573253;1377.7175678985816;1393.3103113958591;1395.1280449718927;14449.422023119076;15349.923250383747;15509.612259693513;15555.98886072406;15610.687786244269;15121;15374.385024599003;15428.151451670154;15437.150956697376;15442.845571544281;2677.4377380750016;2722.101706436881;2726.945461090777;2727.9590806137926;2730.563109902416;2554.9744502555013;2641.4849104424643;2643.431662192628;2655.5220060389124;2709.146618815067;2582.580786635572;2640.049582150424;2641.524525585394;2649.5628221343454;2655.137080448852;2551.8979240830345;2566.153169454085;2583.638290639312;2585.0176932765617;2586.2499875036215;2521.155412936668;2543.3133054075297;2545.032887502756;2554.8211625186245;2613.882375293116;14129.505467308698;14268.357923893449;14271.928640356835;14272.643183920485;14353.425862965469;7779.144294127642;8047.074586422578;8056.274935255797;8056.436049476481;8060.919390806075;4901.411830580318;4949.133901567247;5004.124278251292;5075.390953085654;5090.160123579642;1862.7019676851774;1875.3998720409475;1900.942971710851;1922.5770330527262;1931.6812725900209;25132.748672513222;25700.742992570023;25734.87132564344;25745.098921537843;25773;6976.534927665247;7064.7174113035935;7100.7869763907165;7285.380742636935;7324.523905946096;16541.503754887133;16717.582060448585;16750.497485075466;19286;19299.903500482407;7323;7511.774646760606;7518.624068796538;7525.360344370681;7529.435292353095;6957.199922008933;6970.721171153097;6972.093627828452;7110.040144580519;7302.671379787922;5251.36983561975;5401.810936617199;5408.2969214002715;5449.782008719686;5451.591130665216;1498.0337682194922;1525.0925699208954;1525.9542213733605;1536.64657128861;1559.9688006239812;863.6070587882498;889.4307643108416;899.5592159841631;900.4057322167338;908.2370808520874;7268.546290741767;7296.358319378203;7308.086489188851;7360.07999000125;7366.373858222111;686.7836631461174;704.9118860142482;716.451914285572;717;717.7631381644045;4716.858494245178;4758.286257061399;4799.28010798383;4877.731724755173;4918.286848406961;20119.09464074091;20301.49246268855;20808.79191208099;21101.366958991253;21120.683189752166;20134.19463221455;20406.591868162555;20819.791802082087;21039;21073.157073717186;10546.26176167661;10600.204984626338;10647.094996925192;10719.624813131659;10924.399158046224;7423.665935033045;7557.2820582044615;7589.279018493235;7707.34487568563;7748.573828439265;17554;17577.736333954745;17804.46586602404;17861;18158.182881770088;18168;18278.634427311114;18301.816981830543;18325.908370458597;18863.24547018104;10001.499925003865;10067.093961543496;10138.239632027775;10151.543180556744;10221.693349199535;13258.86741132615;13364;13410.731785364433;13545.525906593222;13621.455141794613;10488.475576221006;10502.474876256309;10575.947120264656;10638.52126654287;10673.35959842412;10529.10502607287;10540.789184216119;10641.201909856947;10648.201384896009;10844.620438284623;8661.220490155916;8747.518886461306;8827.382083254368;8828.911710882809;8849.247813935888;6794.490413219127;6802.0477133202385;6816.48876334267;6827.52207345481;6830.897536536857;6925.722971081101;6942.409895158968;7040.8943865843075;7068.71725130989;7171.211166771755 15:41:40 INFO - PID 11288 | |4;prototype.html;478.7654049515736;503.549323355597;518.7976689091255;518.8650950752804;519.8830263190782;6264.686765661716;6285.899967505679;6290.748370065197;6316.27362853272;6319.146915166451;6143.508519318455;6177.382261773821;6224.813255602327;6246.406591373812;6301.2753533343675;5141.126008578532;5145.151050076733;5168.741562921858;5181.507756763111;5188.533032027117;5058.570021548173;5114.232865070232;5147.0992576298995;5212.29633999409;5226.425093239741;4763.857084287477;4888.120138375091;4890.5109489051165;4915.238138088602;4966;4898.804047838083;4900.852974410774;4943.209086546153;4966.230234313687;4968.105740966625;4389.2977123660385;4400.581944715247;4450.532694067141;4453;4463.754493502856;6069.180660610805;6120.928837453428;6139.324674285825;6166.749136565166;6209.316975132731;5664.745086471077;5708.343540492813;5722.599418040739;5724.8855022899725;5742.368339482654;6429.935700642981;6480.222373315185;6494.805155845333;6571.605703657748;6577.276499585042;4846.515348465161;4849.393825771778;4859.319695242669;4859.368282123337;4868.78090485929;6680.995701289642;6741.696623651947;6864.519483636147;6906.274841141658;6913.75801846933;4953.405591329064;4957.82647607332;4968.577670897942;4972.925406118911;4996.1007018736245;4918.3360246367;5019.3976722793495;5032.496750325012;5050.671706339076;5100.821471248489;5619.988402087663;5625.831225063254;5648.632838865543;5673.15622422706;5680.6591604503865;6476.287608363076;6489.772857949949;6528.836779080466;6567;6602.1747281589805;1728.7666165067556;1736.7134422820345;1739.3042782886946;1748.2832038864005;1760.0671644028685;1137.4540220694114;1189.6133756529164;1202.500962100736;1204.1330242225583;1206.10748046445;5607.4112218217315;5678.290213723285;5680.829575112753;5694.487496125369;5698.971505142447;6659.167604049494;6676.298988606223;6677.332266773284;6700.329967003358;6723.361280678328;5625.774969001276;5642.125470552071;5677.261955945701;5702.914456283159;5709.28896217462;3452.706519945833;3497.387957107496;3504.859805607747;3512.2799826035603;3555.5733312002208;6351.872962540816;6374.362563743682;6395.328490508523;6437.294117058983;6478.935210647834;6785.930291261213;6827.507959594712;6872.553284036521;6900.861982760417;6912.27421120775;6485.513586481033;6508.745627186407;6531.281559028503;6540.9345906541275;6560;6220.346863579259;6586.077949087227;6595.967020164869;6674.933250667431;6741.898871516833;6427.357264273535;6489.221293444817;6539.607623542603;6622.668866556749;6632.369924857131;6393.6483493408305;6422.935770642233;6425.361532809104;6474.352564743488;6539.673016349068;4897.730624815669;4945.530174633404;4959;5002.17464118431;5003.4246061701915;6464.773732919325;6581.703823327866;6607.2071351438135;6654.201495820533;6734.326567343226;6375.776847810304;6384.425401713868;6396.616203027833;6497.588765897942;6509.153810004669;6343.207099112611;6367.808965731036;6448.226212854487;6490.675466226764;6496.707648155939;6285.962816135287;6309.1167236586;6354.968225158845;6418.03729440569;6433.613983161025;6429.22849258092;6495.707693153725;6548.3124271950755;6551.410373066256;6639.834004149935;6277.5605707600025;6335.683215839097;6343.746250149942;6353.205849268841;6413.551051426355 15:41:40 INFO - PID 11288 | |5;yui.html;856.8757530158131;887.7336798960313;899.8515244984574;904.2720609909021;927.0636656976452;17695.55761105973;18216.99806510643;18329.816701832977;18362.1737021834;18375.264989400443;16634.50096497104;16747.83252167481;16802.915985420088;17093.31626734932;17928.462146135636;941.2940294778899;950.6387572722356;950.7385468996013;951.029949451559;954.3605784124653;934.8177105464437;943.8820147481565;946.375392241121;946.8769060022188;948.9952550237274;973.8539219117154;974.0503009565653;974.7563109222694;975.2490582251662;1025.3489034463132;955.2739917662592;957.7653474898659;986.2504496582649;995.0546980368679;1016.9389836609827;716.9856602867914;718.1203026292802;718.138234119054;718.1489934427668;718.1489934427719;17800.287988480446;17833.732494012602;17901.7314740279;17919.820801791946;17926.820731792646;20460.38618841437;20744.06651700677;20905.477363065893;20955;20961.056752446024;13738.381772820247;13810.309484525733;14028.579142625635;14588.781168282485;14651;3698.4267438547067;3705.6109108543756;3715.479832823407;3717.75834570752;3720.274546463441;139644;141764;142468;144342;144391;16110.516684499484;16423.753643695352;16448.177591120395;16557.751633725264;16570.171491425623;30038.24904377408;30250.394992100035;30293.394132117235;30848.38303233923;30981;7971.123176450586;8090.150534193943;8102.189781021851;8103.635336409876;8108.554029528433;3801.258754542838;3809.771413715186;3875.8837234883;3879.515060617423;3937.586553411908;5307.177387504943;5369.812056578001;5397.136458166675;5401.243825864382;5415.214793854869;953.880764904387;975.590252094108;987.3335498538457;990.6879333010079;991.6330957545754;657.9703913323912;669.1735706402588;676.3371895542396;678.8133263352519;693.0574418790441;10857;11137.944310278397;11384.032357249727;11484;11489.770204595861;649.9805005849832;667.8630880669451;668.5954997226607;670.8188789027033;679.5650783498564;4738.8341408050555;4739.691920025188;4788.23388257884;4801.879953001133;4865.95134048662;124985;125198.37400812938;127105;127367;131276.3436182832;84965.18147534675;89384.5530772355;99296.50351748339;103254.48372758088;104255.47872260741;84412;89440;94138;96212;98538.01461985432;10650.307729997525;10726.624568140078;10853.294535855144;10897.67306980792;11138.27601205919;41135;41899.58100418957;42750.358744618236;43685;44798.3280250803;54765.03360231748;56937.43062569487;82164;86033;87137.56431218056;17214.13929303505;17472.563185920455;17499.737503937708;17508.387206447715;17601.82398176002;19427.51431214231;19926;19982.500437488598;20056;20218.393448196577;17382.826171738627;17634;17634.823651763832;17732.556686082436;17781.110944452466;18039.729404058686;18445.354412595494;18460.169292382143;18558.164882580048;18575.16411761501;16238.837611623732;16277.104759237882;16301.918490407472;16387.34450621962;16433.506994790176;12518.874811251771;13049.869501304865;13101.213927164401;13183.274919879499;13355.53255636048;11043;11083.168762342695;11120.332780033224;11240.494177761857;11298.830517542408 15:41:40 INFO - PID 11288 | __end_tp_report 15:41:40 INFO - PID 11288 | __start_cc_report 15:41:40 INFO - PID 11288 | _x_x_mozilla_cycle_collect,347 15:41:40 INFO - PID 11288 | __end_cc_report 15:41:40 INFO - PID 11288 | __startTimestamp1504996900139__endTimestamp 15:41:40 INFO - PID 11288 | 15:41:40 INFO - PID 11288 | ------- Summary: start ------- 15:41:40 INFO - PID 11288 | Number of tests: 6 15:41:40 INFO - PID 11288 | 15:41:40 INFO - PID 11288 | [#0] dojo.html Cycles:165 Average:6156.52 Median:6412.17 stddev:732.46 (11.4%) stddev-sans-first:693.84 15:41:40 INFO - PID 11288 | Values: 3081.3 3089.0 3115.8 3119.1 3133.5 6050.9 6188.5 6189.5 6292.0 6308.7 6171.5 6189.6 6206.1 6244.8 6249.3 5733.5 5849.1 5868.1 5875.1 5900.3 5812.6 5825.7 5900.9 5912.3 5929.8 5696.9 5865.9 5881.1 5884.5 5932.4 5707.6 5748.2 5750.4 5787.1 5817.0 5682.5 5725.7 5759.6 5771.8 5775.3 6184.8 6230.9 6237.1 6246.5 6310.3 6469.6 6547.5 6623.3 6739.0 6777.0 6783.1 6833.7 6856.3 6862.8 6872.0 5991.0 6070.1 6078.0 6207.8 6344.6 6773.4 6795.3 6796.1 6815.2 6899.5 6552.1 6602.3 6628.7 6642.0 6708.7 6567.7 6617.6 6650.4 6684.1 6695.4 6589.6 6635.3 6639.5 6647.4 6652.6 6645.4 6646.2 6725.6 6733.7 6734.7 5233.1 5239.4 5240.5 5284.3 5310.5 4519.6 4584.1 4645.2 4680.2 4723.0 5701.1 5769.2 5778.9 5827.2 5830.5 6618.5 6627.3 6768.0 6791.3 6799.3 5566.6 5708.5 5755.3 5773.2 5869.3 5771.1 5777.5 5815.0 5816.7 5822.1 6455.2 6456.2 6532.1 6538.1 6541.4 6450.9 6585.3 6686.3 6755.6 6797.9 6406.7 6476.8 6505.5 6509.6 6519.2 6549.9 6567.1 6651.0 6654.1 6669.9 6609.3 6665.2 6699.0 6722.8 6741.3 6405.0 6412.2 6418.4 6418.6 6424.0 6353.8 6453.6 6492.8 6577.1 6592.9 6458.5 6501.8 6537.5 6539.2 6541.3 6545.0 6613.8 6687.7 6694.0 6705.2 6186.4 6270.9 6374.0 6390.5 6471.5 15:41:40 INFO - PID 11288 | 15:41:40 INFO - PID 11288 | [#1] ext.html Cycles:180 Average:36425.65 Median:36241.55 stddev:50227.32 (138.6%) stddev-sans-first:50297.22 15:41:40 INFO - PID 11288 | Values: 861.3 886.3 886.8 889.5 891.5 37295.0 40283.4 40670.4 40677.0 40705.4 37544.6 37932.4 37957.8 37963.8 38045.0 7728.3 7884.1 7884.7 7894.3 7896.9 7785.8 7890.1 7898.4 7899.1 7899.6 7883.8 7940.6 7943.1 7947.2 7949.2 7842.1 7885.6 7887.8 7900.5 7910.7 7758.4 7821.2 7827.0 7831.6 7832.3 37374.0 37390.1 37510.0 37543.0 37558.4 3346.9 3363.4 3366.0 3368.2 3369.0 31418.2 31468.1 31528.5 31564.8 31585.8 5103.1 5264.1 5278.3 5302.1 5310.4 182170.0 182243.0 182821.0 182840.0 182992.0 42320.0 43122.4 48044.3 48051.5 48758.3 50813.0 50945.2 50986.5 50995.0 51070.0 14515.7 14615.0 14629.4 14639.0 14664.5 11710.2 11756.8 11763.1 11766.9 11820.0 14184.2 14212.1 14219.6 14259.2 14290.2 5707.1 5719.4 5765.0 5883.2 5951.3 986.9 993.8 1002.7 1018.3 1025.0 22231.0 22478.9 22486.8 22492.9 22579.4 1099.4 1106.4 1107.3 1108.1 1117.5 11684.4 11883.8 11895.6 11965.4 12021.1 211205.0 212249.0 212253.0 212960.0 213202.0 51731.0 51767.5 51851.7 52117.0 52162.0 1303.7 1365.2 1369.1 1371.4 1429.0 21620.8 21686.7 21809.2 21976.0 22003.3 36443.8 36452.3 36510.1 36537.8 36590.5 186007.0 186124.0 186162.0 186439.0 186670.0 33190.5 34226.5 36186.3 36296.8 36380.8 45160.8 46127.0 46367.5 46400.5 46520.0 33044.8 33289.2 33509.7 33533.3 33683.0 32670.5 32693.3 32803.2 33231.0 33734.3 37746.0 37752.0 37961.0 37985.2 37997.6 32497.8 32541.3 32586.3 32743.8 32933.3 24268.4 24338.0 24378.4 24682.0 24932.9 15:41:40 INFO - PID 11288 | 15:41:40 INFO - PID 11288 | [#2] jquery.html Cycles:180 Average:34758.76 Median:22867.37 stddev:76077.92 (332.7%) stddev-sans-first:76248.02 15:41:40 INFO - PID 11288 | Values: 565.4 565.8 576.2 582.3 596.8 22057.3 22704.0 22709.0 22767.9 22788.1 24327.9 24530.8 25107.2 25685.9 25809.5 6440.5 6644.9 6657.6 6660.0 6660.8 6244.8 6519.3 6520.2 6601.5 6611.3 6476.0 6477.0 6486.6 6496.3 6497.8 6483.4 6497.3 6502.2 6504.7 6932.0 7049.0 7075.6 7084.1 7098.2 7098.8 30197.2 31035.2 31071.7 31126.4 31146.4 2093.0 2114.8 2118.2 2125.9 2135.9 20398.4 20681.0 21642.5 21669.2 21701.6 2489.8 2524.9 2567.0 2578.3 2579.0 120396.0 126436.4 126746.0 135536.3 135866.0 21095.6 21211.3 22144.3 22441.2 23102.4 42203.2 42222.4 42247.0 42346.4 42561.0 11083.7 11279.7 11459.9 11602.8 11663.2 9492.1 9600.6 9639.9 9644.5 9663.4 11151.7 11180.3 11338.9 11528.3 11641.9 3891.5 4059.2 4165.6 4170.4 4282.1 907.4 917.0 918.7 918.8 962.5 19210.4 19621.7 19859.1 20066.2 20115.9 934.1 956.2 959.4 963.7 1005.6 10835.5 10945.3 11057.9 11071.6 11147.3 438381.0 447506.0 455690.0 457091.0 457897.0 108016.0 110744.4 111653.4 112815.4 117599.4 1032.4 1073.8 1128.7 1137.2 1178.1 20739.0 20875.5 20900.2 20956.9 21036.5 57593.4 58573.4 58933.4 59773.7 60643.4 71571.3 72317.0 72516.0 72646.6 73173.0 19420.4 20040.8 20108.6 20113.6 20117.1 22812.5 22922.2 22927.3 22988.2 23148.7 18050.9 18221.8 18276.8 18326.2 18449.8 15138.4 15210.8 15597.5 15723.7 16538.7 18190.0 18746.9 18938.6 18984.4 19042.7 19701.0 19705.3 19842.0 19882.0 19883.4 17841.0 18019.6 18094.5 18099.1 18118.7 15:41:40 INFO - PID 11288 | 15:41:40 INFO - PID 11288 | [#3] mootools.html Cycles:180 Average:8979.33 Median:25759.05 stddev:6479.05 (25.2%) stddev-sans-first:6471.69 15:41:40 INFO - PID 11288 | Values: 1322.7 1375.6 1377.7 1393.3 1395.1 14449.4 15349.9 15509.6 15556.0 15610.7 15121.0 15374.4 15428.2 15437.2 15442.8 2677.4 2722.1 2726.9 2728.0 2730.6 2555.0 2641.5 2643.4 2655.5 2709.1 2582.6 2640.0 2641.5 2649.6 2655.1 2551.9 2566.2 2583.6 2585.0 2586.2 2521.2 2543.3 2545.0 2554.8 2613.9 14129.5 14268.4 14271.9 14272.6 14353.4 7779.1 8047.1 8056.3 8056.4 8060.9 4901.4 4949.1 5004.1 5075.4 5090.2 1862.7 1875.4 1900.9 1922.6 1931.7 25132.7 25700.7 25734.9 25745.1 25773.0 6976.5 7064.7 7100.8 7285.4 7324.5 16541.5 16717.6 16750.5 19286.0 19299.9 7323.0 7511.8 7518.6 7525.4 7529.4 6957.2 6970.7 6972.1 7110.0 7302.7 5251.4 5401.8 5408.3 5449.8 5451.6 1498.0 1525.1 1526.0 1536.6 1560.0 863.6 889.4 899.6 900.4 908.2 7268.5 7296.4 7308.1 7360.1 7366.4 686.8 704.9 716.5 717.0 717.8 4716.9 4758.3 4799.3 4877.7 4918.3 20119.1 20301.5 20808.8 21101.4 21120.7 20134.2 20406.6 20819.8 21039.0 21073.2 10546.3 10600.2 10647.1 10719.6 10924.4 7423.7 7557.3 7589.3 7707.3 7748.6 17554.0 17577.7 17804.5 17861.0 18158.2 18168.0 18278.6 18301.8 18325.9 18863.2 10001.5 10067.1 10138.2 10151.5 10221.7 13258.9 13364.0 13410.7 13545.5 13621.5 10488.5 10502.5 10575.9 10638.5 10673.4 10529.1 10540.8 10641.2 10648.2 10844.6 8661.2 8747.5 8827.4 8828.9 8849.2 6794.5 6802.0 6816.5 6827.5 6830.9 6925.7 6942.4 7040.9 7068.7 7171.2 15:41:40 INFO - PID 11288 | 15:41:40 INFO - PID 11288 | [#4] prototype.html Cycles:180 Average:5480.43 Median:6193.35 stddev:1534.13 (24.8%) stddev-sans-first:1491.80 15:41:40 INFO - PID 11288 | Values: 478.8 503.5 518.8 518.9 519.9 6264.7 6285.9 6290.7 6316.3 6319.1 6143.5 6177.4 6224.8 6246.4 6301.3 5141.1 5145.2 5168.7 5181.5 5188.5 5058.6 5114.2 5147.1 5212.3 5226.4 4763.9 4888.1 4890.5 4915.2 4966.0 4898.8 4900.9 4943.2 4966.2 4968.1 4389.3 4400.6 4450.5 4453.0 4463.8 6069.2 6120.9 6139.3 6166.7 6209.3 5664.7 5708.3 5722.6 5724.9 5742.4 6429.9 6480.2 6494.8 6571.6 6577.3 4846.5 4849.4 4859.3 4859.4 4868.8 6681.0 6741.7 6864.5 6906.3 6913.8 4953.4 4957.8 4968.6 4972.9 4996.1 4918.3 5019.4 5032.5 5050.7 5100.8 5620.0 5625.8 5648.6 5673.2 5680.7 6476.3 6489.8 6528.8 6567.0 6602.2 1728.8 1736.7 1739.3 1748.3 1760.1 1137.5 1189.6 1202.5 1204.1 1206.1 5607.4 5678.3 5680.8 5694.5 5699.0 6659.2 6676.3 6677.3 6700.3 6723.4 5625.8 5642.1 5677.3 5702.9 5709.3 3452.7 3497.4 3504.9 3512.3 3555.6 6351.9 6374.4 6395.3 6437.3 6478.9 6785.9 6827.5 6872.6 6900.9 6912.3 6485.5 6508.7 6531.3 6540.9 6560.0 6220.3 6586.1 6596.0 6674.9 6741.9 6427.4 6489.2 6539.6 6622.7 6632.4 6393.6 6422.9 6425.4 6474.4 6539.7 4897.7 4945.5 4959.0 5002.2 5003.4 6464.8 6581.7 6607.2 6654.2 6734.3 6375.8 6384.4 6396.6 6497.6 6509.2 6343.2 6367.8 6448.2 6490.7 6496.7 6286.0 6309.1 6355.0 6418.0 6433.6 6429.2 6495.7 6548.3 6551.4 6639.8 6277.6 6335.7 6343.7 6353.2 6413.6 15:41:40 INFO - PID 11288 | 15:41:40 INFO - PID 11288 | [#5] yui.html Cycles:180 Average:24428.46 Median:30271.89 stddev:35628.74 (117.7%) stddev-sans-first:35684.73 15:41:40 INFO - PID 11288 | Values: 856.9 887.7 899.9 904.3 927.1 17695.6 18217.0 18329.8 18362.2 18375.3 16634.5 16747.8 16802.9 17093.3 17928.5 941.3 950.6 950.7 951.0 954.4 934.8 943.9 946.4 946.9 949.0 973.9 974.1 974.8 975.2 1025.3 955.3 957.8 986.3 995.1 1016.9 717.0 718.1 718.1 718.1 718.1 17800.3 17833.7 17901.7 17919.8 17926.8 20460.4 20744.1 20905.5 20955.0 20961.1 13738.4 13810.3 14028.6 14588.8 14651.0 3698.4 3705.6 3715.5 3717.8 3720.3 139644.0 141764.0 142468.0 144342.0 144391.0 16110.5 16423.8 16448.2 16557.8 16570.2 30038.2 30250.4 30293.4 30848.4 30981.0 7971.1 8090.2 8102.2 8103.6 8108.6 3801.3 3809.8 3875.9 3879.5 3937.6 5307.2 5369.8 5397.1 5401.2 5415.2 953.9 975.6 987.3 990.7 991.6 658.0 669.2 676.3 678.8 693.1 10857.0 11137.9 11384.0 11484.0 11489.8 650.0 667.9 668.6 670.8 679.6 4738.8 4739.7 4788.2 4801.9 4866.0 124985.0 125198.4 127105.0 127367.0 131276.3 84965.2 89384.6 99296.5 103254.5 104255.5 84412.0 89440.0 94138.0 96212.0 98538.0 10650.3 10726.6 10853.3 10897.7 11138.3 41135.0 41899.6 42750.4 43685.0 44798.3 54765.0 56937.4 82164.0 86033.0 87137.6 17214.1 17472.6 17499.7 17508.4 17601.8 19427.5 19926.0 19982.5 20056.0 20218.4 17382.8 17634.0 17634.8 17732.6 17781.1 18039.7 18445.4 18460.2 18558.2 18575.2 16238.8 16277.1 16301.9 16387.3 16433.5 12518.9 13049.9 13101.2 13183.3 13355.5 11043.0 11083.2 11120.3 11240.5 11298.8 15:41:40 INFO - PID 11288 | -------- Summary: end -------- 15:41:40 INFO - PID 11288 | 15:41:41 INFO - TEST-INFO | 11288: exit 0 15:41:41 INFO - TEST-OK | dromaeo_css | took 1109283ms 15:41:41 INFO - TEST-START | kraken 15:41:41 INFO - Initialising browser for kraken test... 15:41:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35264/getInfo.html -profile /tmp/tmpwNuf26/profile 15:41:41 INFO - TEST-INFO | started process 11671 (/builds/slave/test/build/application/firefox/firefox http://localhost:35264/getInfo.html) 15:41:47 INFO - TEST-INFO | 11671: exit 0 15:41:47 INFO - Browser initialized. 15:41:47 INFO - Running cycle 1/1 for kraken test... 15:41:47 INFO - Using env: {'DISPLAY': ':0', 15:41:47 INFO - 'HOME': '/home/cltbld', 15:41:47 INFO - 'JSGC_DISABLE_POISONING': '1', 15:41:47 INFO - 'LANG': 'en_US.UTF-8', 15:41:47 INFO - 'LANGUAGE': 'en_US:en', 15:41:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:41:47 INFO - 'LOGNAME': 'cltbld', 15:41:47 INFO - 'MAIL': '/var/mail/cltbld', 15:41:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:41:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:41:47 INFO - 'MOZ_CRASHREPORTER': '1', 15:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:41:47 INFO - 'MOZ_NO_REMOTE': '1', 15:41:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:47 INFO - 'NO_EM_RESTART': '1', 15:41:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:47 INFO - 'PWD': '/builds/slave/test', 15:41:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:41:47 INFO - 'RUST_BACKTRACE': 'full', 15:41:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:41:47 INFO - 'SHELL': '/bin/bash', 15:41:47 INFO - 'SHLVL': '1', 15:41:47 INFO - 'TERM': 'linux', 15:41:47 INFO - 'TMOUT': '86400', 15:41:47 INFO - 'USER': 'cltbld', 15:41:47 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968', 15:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:47 INFO - '_': '/tools/buildbot/bin/python'} 15:41:47 INFO - TEST-INFO | started process 11870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwNuf26/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:41:48 INFO - PID 11870 | 15:41:48 INFO - PID 11870 | (/builds/slave/test/build/application/firefox/firefox:11921): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:41:48 INFO - PID 11870 | 15:41:58 INFO - PID 11870 | RSS: Main: 167538688 15:41:58 INFO - PID 11870 | 15:42:01 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35264/tests/kraken/driver.html?testName=audio-beat-detection) 15:42:02 INFO - PID 11870 | RSS: Main: 172490752 15:42:02 INFO - PID 11870 | 15:42:04 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35264/tests/kraken/driver.html?testName=audio-dft) 15:42:05 INFO - PID 11870 | RSS: Main: 173469696 15:42:05 INFO - PID 11870 | 15:42:08 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35264/tests/kraken/driver.html?testName=audio-fft) 15:42:09 INFO - PID 11870 | RSS: Main: 168669184 15:42:09 INFO - PID 11870 | 15:42:11 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35264/tests/kraken/driver.html?testName=audio-oscillator) 15:42:11 INFO - PID 11870 | RSS: Main: 169254912 15:42:11 INFO - PID 11870 | 15:42:13 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:42:14 INFO - PID 11870 | RSS: Main: 169660416 15:42:14 INFO - PID 11870 | 15:42:17 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35264/tests/kraken/driver.html?testName=imaging-darkroom) 15:42:18 INFO - PID 11870 | RSS: Main: 172003328 15:42:18 INFO - PID 11870 | 15:42:21 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35264/tests/kraken/driver.html?testName=imaging-desaturate) 15:42:22 INFO - PID 11870 | RSS: Main: 171679744 15:42:22 INFO - PID 11870 | 15:42:25 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35264/tests/kraken/driver.html?testName=json-parse-financial) 15:42:26 INFO - PID 11870 | RSS: Main: 172097536 15:42:26 INFO - PID 11870 | 15:42:27 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:42:28 INFO - PID 11870 | RSS: Main: 172449792 15:42:28 INFO - PID 11870 | 15:42:29 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35264/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:42:30 INFO - PID 11870 | RSS: Main: 172232704 15:42:30 INFO - PID 11870 | 15:42:32 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:42:33 INFO - PID 11870 | RSS: Main: 172392448 15:42:33 INFO - PID 11870 | 15:42:36 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:42:36 INFO - PID 11870 | RSS: Main: 173043712 15:42:36 INFO - PID 11870 | 15:42:39 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:42:40 INFO - PID 11870 | RSS: Main: 173752320 15:42:40 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | Cycle 1(1): loaded http://localhost:35264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35264/tests/kraken/driver.html?testName=ai-astar) 15:42:42 INFO - PID 11870 | RSS: Main: 175034368 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | __start_tp_report 15:42:42 INFO - PID 11870 | _x_x_mozilla_page_load 15:42:42 INFO - PID 11870 | _x_x_mozilla_page_load_details 15:42:42 INFO - PID 11870 | |i|pagename|runs| 15:42:42 INFO - PID 11870 | |0;ai-astar;109;108;106;107;107;109;112;109;108;108 15:42:42 INFO - PID 11870 | |1;audio-beat-detection;118;115;117;118;150;119;116;118;163;120 15:42:42 INFO - PID 11870 | |2;audio-dft;162;162;163;162;162;162;171;168;161;163 15:42:42 INFO - PID 11870 | |3;audio-fft;85;73;73;74;74;73;80;74;74;74 15:42:42 INFO - PID 11870 | |4;audio-oscillator;80;80;80;78;78;79;80;80;79;80 15:42:42 INFO - PID 11870 | |5;imaging-gaussian-blur;114;113;114;113;113;114;113;113;114;114 15:42:42 INFO - PID 11870 | |6;imaging-darkroom;157;149;149;147;147;148;148;148;147;149 15:42:42 INFO - PID 11870 | |7;imaging-desaturate;93;93;94;94;94;96;94;94;97;94 15:42:42 INFO - PID 11870 | |8;json-parse-financial;56;55;54;55;56;55;54;56;56;55 15:42:42 INFO - PID 11870 | |9;json-stringify-tinderbox;37;37;38;37;37;37;38;38;37;37 15:42:42 INFO - PID 11870 | |10;stanford-crypto-aes;78;75;75;76;75;75;77;76;76;77 15:42:42 INFO - PID 11870 | |11;stanford-crypto-ccm;121;117;116;132;124;137;123;124;117;123 15:42:42 INFO - PID 11870 | |12;stanford-crypto-pbkdf2;180;171;166;168;167;167;166;166;169;176 15:42:42 INFO - PID 11870 | |13;stanford-crypto-sha256-iterative;69;65;64;64;65;65;67;65;66;68 15:42:42 INFO - PID 11870 | __end_tp_report 15:42:42 INFO - PID 11870 | __start_cc_report 15:42:42 INFO - PID 11870 | _x_x_mozilla_cycle_collect,937 15:42:42 INFO - PID 11870 | __end_cc_report 15:42:42 INFO - PID 11870 | __startTimestamp1504996962428__endTimestamp 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | ------- Summary: start ------- 15:42:42 INFO - PID 11870 | Number of tests: 14 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#0] ai-astar Cycles:10 Average:108.30 Median:108.50 stddev:1.64 (1.5%) stddev-sans-first:1.72 15:42:42 INFO - PID 11870 | Values: 109.0 108.0 106.0 107.0 107.0 109.0 112.0 109.0 108.0 108.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#1] audio-beat-detection Cycles:10 Average:125.40 Median:118.50 stddev:16.73 (14.1%) stddev-sans-first:17.53 15:42:42 INFO - PID 11870 | Values: 118.0 115.0 117.0 118.0 150.0 119.0 116.0 118.0 163.0 120.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#2] audio-dft Cycles:10 Average:163.60 Median:162.50 stddev:3.24 (2.0%) stddev-sans-first:3.38 15:42:42 INFO - PID 11870 | Values: 162.0 162.0 163.0 162.0 162.0 162.0 171.0 168.0 161.0 163.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#3] audio-fft Cycles:10 Average:75.40 Median:74.00 stddev:3.95 (5.3%) stddev-sans-first:2.18 15:42:42 INFO - PID 11870 | Values: 85.0 73.0 73.0 74.0 74.0 73.0 80.0 74.0 74.0 74.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:80.00 stddev:0.84 (1.1%) stddev-sans-first:0.87 15:42:42 INFO - PID 11870 | Values: 80.0 80.0 80.0 78.0 78.0 79.0 80.0 80.0 79.0 80.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:42:42 INFO - PID 11870 | Values: 114.0 113.0 114.0 113.0 113.0 114.0 113.0 113.0 114.0 114.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:148.50 stddev:2.96 (2.0%) stddev-sans-first:0.87 15:42:42 INFO - PID 11870 | Values: 157.0 149.0 149.0 147.0 147.0 148.0 148.0 148.0 147.0 149.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:1.25 (1.3%) stddev-sans-first:1.24 15:42:42 INFO - PID 11870 | Values: 93.0 93.0 94.0 94.0 94.0 96.0 94.0 94.0 97.0 94.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:0.79 (1.4%) stddev-sans-first:0.78 15:42:42 INFO - PID 11870 | Values: 56.0 55.0 54.0 55.0 56.0 55.0 54.0 56.0 56.0 55.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 15:42:42 INFO - PID 11870 | Values: 37.0 37.0 38.0 37.0 37.0 37.0 38.0 38.0 37.0 37.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:1.05 (1.4%) stddev-sans-first:0.83 15:42:42 INFO - PID 11870 | Values: 78.0 75.0 75.0 76.0 75.0 75.0 77.0 76.0 76.0 77.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:123.50 stddev:6.69 (5.4%) stddev-sans-first:7.04 15:42:42 INFO - PID 11870 | Values: 121.0 117.0 116.0 132.0 124.0 137.0 123.0 124.0 117.0 123.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:168.50 stddev:4.79 (2.8%) stddev-sans-first:3.28 15:42:42 INFO - PID 11870 | Values: 180.0 171.0 166.0 168.0 167.0 167.0 166.0 166.0 169.0 176.0 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.50 stddev:1.69 (2.6%) stddev-sans-first:1.33 15:42:42 INFO - PID 11870 | Values: 69.0 65.0 64.0 64.0 65.0 65.0 67.0 65.0 66.0 68.0 15:42:42 INFO - PID 11870 | -------- Summary: end -------- 15:42:42 INFO - PID 11870 | 15:42:42 INFO - PID 11870 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:42:43 INFO - TEST-INFO | 11870: exit 0 15:42:43 INFO - TEST-OK | kraken | took 62068ms 15:42:43 INFO - SUITE-END | took 1171s 15:42:43 INFO - Completed test suite (00:19:31) 15:42:43 INFO - javascript benchmark 15:42:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8494.843861128656, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.3067059911514, 3088.9691103088967, 3115.8286294253808, 3119.0954623159287, 3133.4986402175655, 6050.878982420349, 6188.5358598105095, 6189.504839612831, 6291.968540157299, 6308.653024083674, 6171.50627949764, 6189.628622282667, 6206.131141640163, 6244.750209991606, 6249.3438188990185, 5733.48398644122, 5849.064149736054, 5868.061110222366, 5875.1187321901625, 5900.291964964189, 5812.550679350523, 5825.679587622679, 5900.911486327708, 5912.320083190423, 5929.822105336847, 5696.943030569703, 5865.912011319833, 5881.147233651118, 5884.529237660999, 5932.406759324054, 5707.62900411476, 5748.16651585522, 5750.424957504258, 5787.102999035156, 5817.040188368914, 5682.488576028178, 5725.685087320196, 5759.568032397587, 5771.769129234825, 5775.27809023872, 6184.752609895599, 6230.875382492325, 6237.095621134956, 6246.531510136758, 6310.337414571496, 6469.611823290571, 6547.476201903836, 6623.3045530219115, 6739.0, 6776.966115169393, 6783.118194634715, 6833.658317084126, 6856.348646878589, 6862.828429289258, 6872.037914691947, 5990.97004514979, 6070.119832624289, 6078.0, 6207.751689932397, 6344.587601805868, 6773.390394864486, 6795.252522222551, 6796.082528858639, 6815.216250131299, 6899.517033807686, 6552.082708420825, 6602.2737498875085, 6628.7017084230365, 6642.0, 6708.6981085850275, 6567.704453299613, 6617.602943823386, 6650.401463868275, 6684.131062961881, 6695.397414232742, 6589.604623722592, 6635.303293154246, 6639.502037347218, 6647.368499992493, 6652.567583107082, 6645.401913827779, 6646.20245570525, 6725.630090345078, 6733.663316834139, 6734.696938637773, 5233.084210263189, 5239.371275446971, 5240.502152295526, 5284.313039304866, 5310.468953104659, 4519.570640789119, 4584.106099310669, 4645.210314246586, 4680.227762419163, 4722.95277047232, 5701.144828275792, 5769.1923130761725, 5778.94221057784, 5827.213326200994, 5830.53355731549, 6618.536702430783, 6627.3372662733345, 6768.0, 6791.320867913268, 6799.32006799326, 5566.55467562594, 5708.514776243983, 5755.3381361143165, 5773.220615216976, 5869.325027621878, 5771.105478650816, 5777.508911742465, 5814.970925145347, 5816.651000939957, 5822.097574875901, 6455.225372955181, 6456.192975878015, 6532.08550802888, 6538.084668146464, 6541.411272985359, 6450.870982580228, 6585.275619681927, 6686.297938716365, 6755.560888542229, 6797.9320206799275, 6406.679666016774, 6476.773312934025, 6505.51208659343, 6509.641969691523, 6519.185101862267, 6549.901751473827, 6567.080608714879, 6651.035599838093, 6654.101696270942, 6669.899951500634, 6609.272979972103, 6665.233498147775, 6699.0, 6722.798316050526, 6741.258461569126, 6405.03924411342, 6412.166418365583, 6418.390252925965, 6418.614883107029, 6424.036394540856, 6353.841153971188, 6453.612783233021, 6492.837679058061, 6577.112089867998, 6592.934070659424, 6458.483321334376, 6501.772437964838, 6537.5096867736065, 6539.247986481616, 6541.280459149394, 6545.0, 6613.801585952429, 6687.732490700318, 6694.0, 6705.161854768154, 6186.412290832363, 6270.905936410866, 6374.0, 6390.456811171102, 6471.4822814175695], "value": 6100.565262288416, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [861.3367706865713, 886.255545341913, 886.787171078941, 889.4929889962716, 891.5453118909359, 37295.0, 40283.39574906371, 40670.389944150826, 40677.0, 40705.38941915874, 37544.62455375445, 37932.43101353482, 37957.81021094898, 37963.810180949054, 38045.0, 7728.26581474759, 7884.132745398002, 7884.724034658788, 7894.3289820365335, 7896.921030789705, 7785.766427007199, 7890.132085470594, 7898.447108702393, 7899.091604465474, 7899.565523896184, 7883.763487095368, 7940.642671079786, 7943.126256111823, 7947.205279472064, 7949.165337639552, 7842.098158711764, 7885.605719713992, 7887.842243155104, 7900.525968441912, 7910.683572657087, 7758.418118641068, 7821.21787821219, 7827.021622297213, 7831.569263690495, 7832.295093441618, 37374.0, 37390.06524836901, 37510.0, 37543.0, 37558.43662345067, 3346.9497957530657, 3363.394588973984, 3365.9831700841337, 3368.208471009311, 3368.983155084209, 31418.21454463657, 31468.055958321285, 31528.527072093708, 31564.842175789203, 31585.8420707895, 5103.081445339837, 5264.105102132647, 5278.261043453919, 5302.09864323066, 5310.362756469249, 182170.0, 182243.0, 182821.0, 182840.0, 182992.0, 42320.0, 43122.35316470255, 48044.27933580999, 48051.5194848047, 48758.26862597064, 50813.0, 50945.23582146271, 50986.49013509892, 50995.0, 51070.0, 14515.709685806436, 14615.0, 14629.414823406945, 14639.04846185016, 14664.486742963945, 11710.180287379802, 11756.823647645293, 11763.058955283557, 11766.941165294118, 11820.0, 14184.219867907364, 14212.147271163763, 14219.64450888736, 14259.215743134228, 14290.214038227998, 5707.1153971134545, 5719.397674058294, 5764.971175144181, 5883.17635531026, 5951.315598706117, 986.8717066781272, 993.7714325705128, 1002.7192386131894, 1018.3024628129755, 1024.9743756406149, 22231.0, 22478.887605561868, 22486.775132248797, 22492.88753556222, 22579.43551411195, 1099.3623698255153, 1106.391484683421, 1107.3466654673782, 1108.1190453589415, 1117.5306371324064, 11684.357360345093, 11883.821742673867, 11895.643130706092, 11965.40172991347, 12021.098417618714, 211205.0, 212249.0, 212253.0, 212960.0, 213202.0, 51731.0, 51767.482325176265, 51851.74074129605, 52117.0, 52162.0, 1303.7131830997166, 1365.208179256029, 1369.103237379518, 1371.4240019191964, 1428.957131286063, 21620.783792161877, 21686.67469987983, 21809.23667671624, 21976.0, 22003.33989980303, 36443.817780910926, 36452.27095458023, 36510.087247819014, 36537.81731091328, 36590.45114323234, 186007.0, 186124.0, 186162.0, 186439.0, 186670.0, 33190.5021424674, 34226.48660270148, 36186.27627447489, 36296.81851590725, 36380.81809590935, 45160.77419612881, 46127.0, 46367.53632463767, 46400.53599463962, 46520.0, 33044.83477582597, 33289.16777080592, 33509.664903350655, 33533.32933341271, 33683.0, 32670.50994235136, 32693.34613307768, 32803.17992050218, 33231.0, 33734.32531349408, 37746.0, 37752.0, 37961.0, 37985.24029519339, 37997.620023799405, 32497.837510812296, 32541.349173015933, 32586.34827303488, 32743.836280818443, 32933.34133317368, 24268.363331269273, 24338.0, 24378.390540236636, 24682.012719491737, 24932.875335623932], "value": 16972.34068699725, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.3583183087197, 565.8302509247225, 576.1962062922221, 582.3274118393256, 596.7941060334184, 22057.33827985161, 22703.978320975555, 22708.999999999978, 22767.886160569175, 22788.088476460944, 24327.905244264006, 24530.75469245307, 25107.246782596507, 25685.87157064212, 25809.48381032378, 6440.484761219103, 6644.933550664504, 6657.633830139341, 6660.0, 6660.766873159416, 6244.843878903041, 6519.250286217099, 6520.2175738911155, 6601.50488713346, 6611.272759996396, 6476.0, 6477.0284457331545, 6486.643234622094, 6496.317886621908, 6497.837554061162, 6483.448906842924, 6497.252815926158, 6502.187226596676, 6504.707288172043, 6931.965340173318, 7049.0, 7075.646217689095, 7084.14990201174, 7098.183708873494, 7098.787036388917, 30197.245068873235, 31035.22411939697, 31071.689283107105, 31126.377472450426, 31146.37707245865, 2092.968605470919, 2114.7990940860745, 2118.2480219522154, 2125.8618189817767, 2135.9359219223293, 20398.388048358574, 20681.0, 21642.458938526506, 21669.241576544904, 21701.565968680537, 2489.7634724701124, 2524.861132637704, 2567.0, 2578.3038579583595, 2578.961315580249, 120396.0, 126436.36781816123, 126746.0, 135536.32231838876, 135866.0, 21095.578088438146, 21211.257605983716, 22144.33566992993, 22441.214557490737, 23102.42243943881, 42203.15593688109, 42222.366664500056, 42247.0, 42346.364804527955, 42561.0, 11083.72290692723, 11279.661610151708, 11459.885401146048, 11602.825957610643, 11663.183577149688, 9492.145706886413, 9600.615975360908, 9639.855402168972, 9644.469554174588, 9663.420194788336, 11151.665450036511, 11180.329180249211, 11338.886611133948, 11528.250663706833, 11641.88358116425, 3891.5330160380367, 4059.188162367538, 4165.562615925345, 4170.395292682544, 4282.122164956177, 907.4283201582961, 916.9862452063225, 918.7289749523907, 918.8437965545739, 962.485070487286, 19210.423687289403, 19621.705674414894, 19859.106340214727, 20066.197352106043, 20115.899420503098, 934.141059292004, 956.1585804492003, 959.4387283439266, 963.7446076789656, 1005.607812952949, 10835.51240194193, 10945.258719739439, 11057.89421057904, 11071.612493562849, 11147.331160130418, 438381.0, 447506.0, 455690.0, 457091.0, 457897.0, 108016.0, 110744.44627776809, 111653.44173279082, 112815.43592281986, 117599.41200294114, 1032.4321623107262, 1073.7691396349821, 1128.6614015795392, 1137.243732917617, 1178.0987544528443, 20739.0, 20875.478113047295, 20900.163993440092, 20956.895215524433, 21036.47408814792, 57593.42406576048, 58573.414265856794, 58933.41066589279, 59773.70113149581, 60643.39356606554, 71571.28428715855, 72317.0, 72516.0, 72646.63676681583, 73173.0, 19420.4173874784, 20040.799592003892, 20108.59782804365, 20113.597728045064, 20117.09473073686, 22812.543749124594, 22922.19772308028, 22927.312180634606, 22988.195413161127, 23148.652770208122, 18050.90974545119, 18221.817781822014, 18276.81723182751, 18326.17532211027, 18449.81550184481, 15138.394464221308, 15210.771838422654, 15597.454089106826, 15723.685526289182, 16538.669226615642, 18190.0, 18746.906265468584, 18938.621227575648, 18984.43046708601, 19042.7143592849, 19701.0, 19705.310314138937, 19842.0, 19882.0, 19883.403497895088, 17841.0, 18019.639607208046, 18094.5476363092, 18099.09504524795, 18118.72821907646], "value": 12835.441072659998, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.7433937759129, 1375.5598208573253, 1377.7175678985816, 1393.3103113958591, 1395.1280449718927, 14449.422023119076, 15349.923250383747, 15509.612259693513, 15555.98886072406, 15610.687786244269, 15121.0, 15374.385024599003, 15428.151451670154, 15437.150956697376, 15442.845571544281, 2677.4377380750016, 2722.101706436881, 2726.945461090777, 2727.9590806137926, 2730.563109902416, 2554.9744502555013, 2641.4849104424643, 2643.431662192628, 2655.5220060389124, 2709.146618815067, 2582.580786635572, 2640.049582150424, 2641.524525585394, 2649.5628221343454, 2655.137080448852, 2551.8979240830345, 2566.153169454085, 2583.638290639312, 2585.0176932765617, 2586.2499875036215, 2521.155412936668, 2543.3133054075297, 2545.032887502756, 2554.8211625186245, 2613.882375293116, 14129.505467308698, 14268.357923893449, 14271.928640356835, 14272.643183920485, 14353.425862965469, 7779.144294127642, 8047.074586422578, 8056.274935255797, 8056.436049476481, 8060.919390806075, 4901.411830580318, 4949.133901567247, 5004.124278251292, 5075.390953085654, 5090.160123579642, 1862.7019676851774, 1875.3998720409475, 1900.942971710851, 1922.5770330527262, 1931.6812725900209, 25132.748672513222, 25700.742992570023, 25734.87132564344, 25745.098921537843, 25773.0, 6976.534927665247, 7064.7174113035935, 7100.7869763907165, 7285.380742636935, 7324.523905946096, 16541.503754887133, 16717.582060448585, 16750.497485075466, 19286.0, 19299.903500482407, 7323.0, 7511.774646760606, 7518.624068796538, 7525.360344370681, 7529.435292353095, 6957.199922008933, 6970.721171153097, 6972.093627828452, 7110.040144580519, 7302.671379787922, 5251.36983561975, 5401.810936617199, 5408.2969214002715, 5449.782008719686, 5451.591130665216, 1498.0337682194922, 1525.0925699208954, 1525.9542213733605, 1536.64657128861, 1559.9688006239812, 863.6070587882498, 889.4307643108416, 899.5592159841631, 900.4057322167338, 908.2370808520874, 7268.546290741767, 7296.358319378203, 7308.086489188851, 7360.07999000125, 7366.373858222111, 686.7836631461174, 704.9118860142482, 716.451914285572, 717.0, 717.7631381644045, 4716.858494245178, 4758.286257061399, 4799.28010798383, 4877.731724755173, 4918.286848406961, 20119.09464074091, 20301.49246268855, 20808.79191208099, 21101.366958991253, 21120.683189752166, 20134.19463221455, 20406.591868162555, 20819.791802082087, 21039.0, 21073.157073717186, 10546.26176167661, 10600.204984626338, 10647.094996925192, 10719.624813131659, 10924.399158046224, 7423.665935033045, 7557.2820582044615, 7589.279018493235, 7707.34487568563, 7748.573828439265, 17554.0, 17577.736333954745, 17804.46586602404, 17861.0, 18158.182881770088, 18168.0, 18278.634427311114, 18301.816981830543, 18325.908370458597, 18863.24547018104, 10001.499925003865, 10067.093961543496, 10138.239632027775, 10151.543180556744, 10221.693349199535, 13258.86741132615, 13364.0, 13410.731785364433, 13545.525906593222, 13621.455141794613, 10488.475576221006, 10502.474876256309, 10575.947120264656, 10638.52126654287, 10673.35959842412, 10529.10502607287, 10540.789184216119, 10641.201909856947, 10648.201384896009, 10844.620438284623, 8661.220490155916, 8747.518886461306, 8827.382083254368, 8828.911710882809, 8849.247813935888, 6794.490413219127, 6802.0477133202385, 6816.48876334267, 6827.52207345481, 6830.897536536857, 6925.722971081101, 6942.409895158968, 7040.8943865843075, 7068.71725130989, 7171.211166771755], "value": 6392.081918672181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.7654049515736, 503.549323355597, 518.7976689091255, 518.8650950752804, 519.8830263190782, 6264.686765661716, 6285.899967505679, 6290.748370065197, 6316.27362853272, 6319.146915166451, 6143.508519318455, 6177.382261773821, 6224.813255602327, 6246.406591373812, 6301.2753533343675, 5141.126008578532, 5145.151050076733, 5168.741562921858, 5181.507756763111, 5188.533032027117, 5058.570021548173, 5114.232865070232, 5147.0992576298995, 5212.29633999409, 5226.425093239741, 4763.857084287477, 4888.120138375091, 4890.5109489051165, 4915.238138088602, 4966.0, 4898.804047838083, 4900.852974410774, 4943.209086546153, 4966.230234313687, 4968.105740966625, 4389.2977123660385, 4400.581944715247, 4450.532694067141, 4453.0, 4463.754493502856, 6069.180660610805, 6120.928837453428, 6139.324674285825, 6166.749136565166, 6209.316975132731, 5664.745086471077, 5708.343540492813, 5722.599418040739, 5724.8855022899725, 5742.368339482654, 6429.935700642981, 6480.222373315185, 6494.805155845333, 6571.605703657748, 6577.276499585042, 4846.515348465161, 4849.393825771778, 4859.319695242669, 4859.368282123337, 4868.78090485929, 6680.995701289642, 6741.696623651947, 6864.519483636147, 6906.274841141658, 6913.75801846933, 4953.405591329064, 4957.82647607332, 4968.577670897942, 4972.925406118911, 4996.1007018736245, 4918.3360246367, 5019.3976722793495, 5032.496750325012, 5050.671706339076, 5100.821471248489, 5619.988402087663, 5625.831225063254, 5648.632838865543, 5673.15622422706, 5680.6591604503865, 6476.287608363076, 6489.772857949949, 6528.836779080466, 6567.0, 6602.1747281589805, 1728.7666165067556, 1736.7134422820345, 1739.3042782886946, 1748.2832038864005, 1760.0671644028685, 1137.4540220694114, 1189.6133756529164, 1202.500962100736, 1204.1330242225583, 1206.10748046445, 5607.4112218217315, 5678.290213723285, 5680.829575112753, 5694.487496125369, 5698.971505142447, 6659.167604049494, 6676.298988606223, 6677.332266773284, 6700.329967003358, 6723.361280678328, 5625.774969001276, 5642.125470552071, 5677.261955945701, 5702.914456283159, 5709.28896217462, 3452.706519945833, 3497.387957107496, 3504.859805607747, 3512.2799826035603, 3555.5733312002208, 6351.872962540816, 6374.362563743682, 6395.328490508523, 6437.294117058983, 6478.935210647834, 6785.930291261213, 6827.507959594712, 6872.553284036521, 6900.861982760417, 6912.27421120775, 6485.513586481033, 6508.745627186407, 6531.281559028503, 6540.9345906541275, 6560.0, 6220.346863579259, 6586.077949087227, 6595.967020164869, 6674.933250667431, 6741.898871516833, 6427.357264273535, 6489.221293444817, 6539.607623542603, 6622.668866556749, 6632.369924857131, 6393.6483493408305, 6422.935770642233, 6425.361532809104, 6474.352564743488, 6539.673016349068, 4897.730624815669, 4945.530174633404, 4959.0, 5002.17464118431, 5003.4246061701915, 6464.773732919325, 6581.703823327866, 6607.2071351438135, 6654.201495820533, 6734.326567343226, 6375.776847810304, 6384.425401713868, 6396.616203027833, 6497.588765897942, 6509.153810004669, 6343.207099112611, 6367.808965731036, 6448.226212854487, 6490.675466226764, 6496.707648155939, 6285.962816135287, 6309.1167236586, 6354.968225158845, 6418.03729440569, 6433.613983161025, 6429.22849258092, 6495.707693153725, 6548.3124271950755, 6551.410373066256, 6639.834004149935, 6277.5605707600025, 6335.683215839097, 6343.746250149942, 6353.205849268841, 6413.551051426355], "value": 5025.786814013562, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.8757530158131, 887.7336798960313, 899.8515244984574, 904.2720609909021, 927.0636656976452, 17695.55761105973, 18216.99806510643, 18329.816701832977, 18362.1737021834, 18375.264989400443, 16634.50096497104, 16747.83252167481, 16802.915985420088, 17093.31626734932, 17928.462146135636, 941.2940294778899, 950.6387572722356, 950.7385468996013, 951.029949451559, 954.3605784124653, 934.8177105464437, 943.8820147481565, 946.375392241121, 946.8769060022188, 948.9952550237274, 973.8539219117154, 974.0503009565653, 974.7563109222694, 975.2490582251662, 1025.3489034463132, 955.2739917662592, 957.7653474898659, 986.2504496582649, 995.0546980368679, 1016.9389836609827, 716.9856602867914, 718.1203026292802, 718.138234119054, 718.1489934427668, 718.1489934427719, 17800.287988480446, 17833.732494012602, 17901.7314740279, 17919.820801791946, 17926.820731792646, 20460.38618841437, 20744.06651700677, 20905.477363065893, 20955.0, 20961.056752446024, 13738.381772820247, 13810.309484525733, 14028.579142625635, 14588.781168282485, 14651.0, 3698.4267438547067, 3705.6109108543756, 3715.479832823407, 3717.75834570752, 3720.274546463441, 139644.0, 141764.0, 142468.0, 144342.0, 144391.0, 16110.516684499484, 16423.753643695352, 16448.177591120395, 16557.751633725264, 16570.171491425623, 30038.24904377408, 30250.394992100035, 30293.394132117235, 30848.38303233923, 30981.0, 7971.123176450586, 8090.150534193943, 8102.189781021851, 8103.635336409876, 8108.554029528433, 3801.258754542838, 3809.771413715186, 3875.8837234883, 3879.515060617423, 3937.586553411908, 5307.177387504943, 5369.812056578001, 5397.136458166675, 5401.243825864382, 5415.214793854869, 953.880764904387, 975.590252094108, 987.3335498538457, 990.6879333010079, 991.6330957545754, 657.9703913323912, 669.1735706402588, 676.3371895542396, 678.8133263352519, 693.0574418790441, 10857.0, 11137.944310278397, 11384.032357249727, 11484.0, 11489.770204595861, 649.9805005849832, 667.8630880669451, 668.5954997226607, 670.8188789027033, 679.5650783498564, 4738.8341408050555, 4739.691920025188, 4788.23388257884, 4801.879953001133, 4865.95134048662, 124985.0, 125198.37400812938, 127105.0, 127367.0, 131276.3436182832, 84965.18147534675, 89384.5530772355, 99296.50351748339, 103254.48372758088, 104255.47872260741, 84412.0, 89440.0, 94138.0, 96212.0, 98538.01461985432, 10650.307729997525, 10726.624568140078, 10853.294535855144, 10897.67306980792, 11138.27601205919, 41135.0, 41899.58100418957, 42750.358744618236, 43685.0, 44798.3280250803, 54765.03360231748, 56937.43062569487, 82164.0, 86033.0, 87137.56431218056, 17214.13929303505, 17472.563185920455, 17499.737503937708, 17508.387206447715, 17601.82398176002, 19427.51431214231, 19926.0, 19982.500437488598, 20056.0, 20218.393448196577, 17382.826171738627, 17634.0, 17634.823651763832, 17732.556686082436, 17781.110944452466, 18039.729404058686, 18445.354412595494, 18460.169292382143, 18558.164882580048, 18575.16411761501, 16238.837611623732, 16277.104759237882, 16301.918490407472, 16387.34450621962, 16433.506994790176, 12518.874811251771, 13049.869501304865, 13101.213927164401, 13183.274919879499, 13355.53255636048, 11043.0, 11083.168762342695, 11120.332780033224, 11240.494177761857, 11298.830517542408], "value": 8801.077257078228, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1436.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 106.0, 107.0, 107.0, 109.0, 112.0, 109.0, 108.0, 108.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 117.0, 118.0, 150.0, 119.0, 116.0, 118.0, 163.0, 120.0], "value": 125.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 162.0, 162.0, 171.0, 168.0, 161.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 73.0, 73.0, 74.0, 74.0, 73.0, 80.0, 74.0, 74.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 78.0, 78.0, 79.0, 80.0, 80.0, 79.0, 80.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 149.0, 149.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0, 97.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 56.0, 55.0, 54.0, 56.0, 56.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 38.0, 37.0, 37.0, 37.0, 38.0, 38.0, 37.0, 37.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 76.0, 75.0, 75.0, 77.0, 76.0, 76.0, 77.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 117.0, 116.0, 132.0, 124.0, 137.0, 123.0, 124.0, 117.0, 123.0], "value": 123.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 171.0, 166.0, 168.0, 167.0, 167.0, 166.0, 166.0, 169.0, 176.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 64.0, 64.0, 65.0, 65.0, 67.0, 65.0, 66.0, 68.0], "value": 65.8, "unit": "score"}]}]} 15:42:43 INFO - Return code: 0 15:42:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:42:43 INFO - # TBPL SUCCESS # 15:42:43 INFO - Running post-action listener: _package_coverage_data 15:42:43 INFO - Running post-action listener: _resource_record_post_action 15:42:43 INFO - [mozharness: 2017-09-09 22:42:43.692299Z] Finished run-tests step (success) 15:42:43 INFO - Running post-run listener: _resource_record_post_run 15:42:43 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 302354432; Read time: 188; Write time: 176724 15:42:43 INFO - TinderboxPrint: CPU usage
13.1% 15:42:43 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 188 15:42:43 INFO - TinderboxPrint: I/O write bytes / time
302,354,432 / 176,724 15:42:43 INFO - TinderboxPrint: CPU idle
8,236.7 (86.9%) 15:42:43 INFO - TinderboxPrint: CPU user
1,190.3 (12.6%) 15:42:43 INFO - TinderboxPrint: Swap in / out
0 / 0 15:42:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13230080; Read time: 0; Write time: 2864 15:42:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:42:43 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289124352; Read time: 168; Write time: 173860 15:42:44 INFO - Running post-run listener: _upload_blobber_files 15:42:44 INFO - Blob upload gear active. 15:42:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:42:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:42:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:42:44 INFO - (blobuploader) - INFO - Open directory for files ... 15:42:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:42:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:42:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:45 INFO - (blobuploader) - INFO - Done attempting. 15:42:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:42:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:42:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:46 INFO - (blobuploader) - INFO - Done attempting. 15:42:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:42:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:42:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:47 INFO - (blobuploader) - INFO - Done attempting. 15:42:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:42:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:42:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:53 INFO - (blobuploader) - INFO - Done attempting. 15:42:53 INFO - (blobuploader) - INFO - Iteration through files over. 15:42:53 INFO - Return code: 0 15:42:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:42:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:42:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33673cd4b792efe14c1d5a78ccc0f181b38816dc23caa6988d710bff5a83f63385736bf1090c88bfeccf501c4ec36912134db948e869ce2a13b7d3ad1582d34b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db5e7504ff1f6241f351c82a8de8aa40a6123f1240db8d982e81d467405ead991c3715d7a11e48c3400588b0432815c2d4ba082593bdcbc509aa823d4e03f6f6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/788c09509193f55b33fbb356405658b604f9241e3efc8fec14f9a5ed17c30c3e5e84e2d1fbbf03d349ab43b2f92fa0267e6d78bf5f868bcad0f154ff37fdc660", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9228c6459c45eaa917819ad2085426168557b77124ea6910988bd6d882721de6cd63ed366bec776dc826dd4df19f30d1335ec4d5fa8cac2d61ff42d236d3d8bf"} 15:42:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:42:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:42:53 INFO - Contents: 15:42:53 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33673cd4b792efe14c1d5a78ccc0f181b38816dc23caa6988d710bff5a83f63385736bf1090c88bfeccf501c4ec36912134db948e869ce2a13b7d3ad1582d34b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db5e7504ff1f6241f351c82a8de8aa40a6123f1240db8d982e81d467405ead991c3715d7a11e48c3400588b0432815c2d4ba082593bdcbc509aa823d4e03f6f6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/788c09509193f55b33fbb356405658b604f9241e3efc8fec14f9a5ed17c30c3e5e84e2d1fbbf03d349ab43b2f92fa0267e6d78bf5f868bcad0f154ff37fdc660", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9228c6459c45eaa917819ad2085426168557b77124ea6910988bd6d882721de6cd63ed366bec776dc826dd4df19f30d1335ec4d5fa8cac2d61ff42d236d3d8bf"} 15:42:53 INFO - Running post-run listener: copy_logs_to_upload_dir 15:42:53 INFO - Copying logs to upload dir... 15:42:53 INFO - mkdir: /builds/slave/test/build/upload/logs 15:42:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.189715 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-09 15:42:54.028198) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 15:42:54.031752) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33673cd4b792efe14c1d5a78ccc0f181b38816dc23caa6988d710bff5a83f63385736bf1090c88bfeccf501c4ec36912134db948e869ce2a13b7d3ad1582d34b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db5e7504ff1f6241f351c82a8de8aa40a6123f1240db8d982e81d467405ead991c3715d7a11e48c3400588b0432815c2d4ba082593bdcbc509aa823d4e03f6f6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/788c09509193f55b33fbb356405658b604f9241e3efc8fec14f9a5ed17c30c3e5e84e2d1fbbf03d349ab43b2f92fa0267e6d78bf5f868bcad0f154ff37fdc660", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9228c6459c45eaa917819ad2085426168557b77124ea6910988bd6d882721de6cd63ed366bec776dc826dd4df19f30d1335ec4d5fa8cac2d61ff42d236d3d8bf"} build_url:https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33673cd4b792efe14c1d5a78ccc0f181b38816dc23caa6988d710bff5a83f63385736bf1090c88bfeccf501c4ec36912134db948e869ce2a13b7d3ad1582d34b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db5e7504ff1f6241f351c82a8de8aa40a6123f1240db8d982e81d467405ead991c3715d7a11e48c3400588b0432815c2d4ba082593bdcbc509aa823d4e03f6f6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/788c09509193f55b33fbb356405658b604f9241e3efc8fec14f9a5ed17c30c3e5e84e2d1fbbf03d349ab43b2f92fa0267e6d78bf5f868bcad0f154ff37fdc660", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9228c6459c45eaa917819ad2085426168557b77124ea6910988bd6d882721de6cd63ed366bec776dc826dd4df19f30d1335ec4d5fa8cac2d61ff42d236d3d8bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 15:42:54.063379) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:42:54.063939) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1504995732.912644-1725542968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:42:54.116127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 15:42:54.116438) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 15:42:54.116778) ========= ========= Total master_lag: 0.21 =========