builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1505375670.42 results: success (0) revision: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.419363) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.419886) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.420226) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.537542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.537900) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 00:54:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2017-09-14 00:54:30 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.158883 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.734637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.735290) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022410 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:30.803152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-14 00:54:30.803550) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4702042aa919d5ae49dfe3ac5ee86507839b3c83 --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 4702042aa919d5ae49dfe3ac5ee86507839b3c83 --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=769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 00:54:30,747 truncating revision to first 12 chars 2017-09-14 00:54:30,747 Setting DEBUG logging. 2017-09-14 00:54:30,747 attempt 1/10 2017-09-14 00:54:30,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4702042aa919?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 00:54:31,992 unpacking tar archive at: mozilla-central-4702042aa919/testing/mozharness/ program finished with exit code 0 elapsedTime=1.508650 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-14 00:54:32.348387) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:32.348860) ========= script_repo_revision: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:32.349561) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:32.350172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:32.364665) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-14 00:54:32.365278) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:54:32 INFO - MultiFileLogger online at 20170914 00:54:32 in /builds/slave/test 00:54:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 00:54:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:54:32 INFO - {'append_to_log': False, 00:54:32 INFO - 'base_work_dir': '/builds/slave/test', 00:54:32 INFO - 'blob_upload_branch': 'Firefox', 00:54:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:54:32 INFO - 'branch': 'Firefox', 00:54:32 INFO - 'buildbot_json_path': 'buildprops.json', 00:54:32 INFO - 'code_coverage': False, 00:54:32 INFO - 'config_files': ('talos/linux_config.py',), 00:54:32 INFO - 'default_actions': ('clobber', 00:54:32 INFO - 'read-buildbot-config', 00:54:32 INFO - 'download-and-extract', 00:54:32 INFO - 'populate-webroot', 00:54:32 INFO - 'create-virtualenv', 00:54:32 INFO - 'install', 00:54:32 INFO - 'setup-mitmproxy', 00:54:32 INFO - 'run-tests'), 00:54:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:54:32 INFO - 'disable_ccov_upload': False, 00:54:32 INFO - 'disable_stylo': False, 00:54:32 INFO - 'download_minidump_stackwalk': True, 00:54:32 INFO - 'download_symbols': 'ondemand', 00:54:32 INFO - 'enable_stylo': False, 00:54:32 INFO - 'enable_webrender': False, 00:54:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 00:54:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:54:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:54:32 INFO - 'gecko_profile': False, 00:54:32 INFO - 'gecko_profile_interval': 0, 00:54:32 INFO - 'installer_path': 'installer.exe', 00:54:32 INFO - 'log_level': 'info', 00:54:32 INFO - 'log_name': 'talos', 00:54:32 INFO - 'log_to_console': True, 00:54:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:54:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:54:32 INFO - 'opt_config_files': (), 00:54:32 INFO - 'pip_index': False, 00:54:32 INFO - 'suite': 'dromaeojs-e10s', 00:54:32 INFO - 'system_bits': '32', 00:54:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:54:32 INFO - 'title': 'talos-linux64-ix-063', 00:54:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:54:32 INFO - 'use_talos_json': True, 00:54:32 INFO - 'verify': 'False', 00:54:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:54:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:54:32 INFO - 'work_dir': 'build'} 00:54:32 INFO - [mozharness: 2017-09-14 07:54:32.443524Z] Running clobber step. 00:54:32 INFO - Running pre-action listener: _resource_record_pre_action 00:54:32 INFO - Running main action method: clobber 00:54:32 INFO - rmtree: /builds/slave/test/build 00:54:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:54:33 INFO - Running post-action listener: _resource_record_post_action 00:54:33 INFO - [mozharness: 2017-09-14 07:54:33.431224Z] Finished clobber step (success) 00:54:33 INFO - [mozharness: 2017-09-14 07:54:33.431320Z] Running read-buildbot-config step. 00:54:33 INFO - Running pre-action listener: _resource_record_pre_action 00:54:33 INFO - Running main action method: read_buildbot_config 00:54:33 INFO - Using buildbot properties: 00:54:33 INFO - { 00:54:33 INFO - "project": "", 00:54:33 INFO - "product": "firefox", 00:54:33 INFO - "who": "kwierso@gmail.com", 00:54:33 INFO - "installer_path": "public/build/target.tar.bz2", 00:54:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 00:54:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 00:54:33 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 00:54:33 INFO - "stage_platform": "linux64-qr", 00:54:33 INFO - "basedir": "/builds/slave/test", 00:54:33 INFO - "buildnumber": 54, 00:54:33 INFO - "platform": "ubuntu64_hw_qr", 00:54:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:54:33 INFO - "slavebuilddir": "test", 00:54:33 INFO - "taskId": "d6eMmpguSiirg9dih5Hjbw", 00:54:33 INFO - "branch": "mozilla-central", 00:54:33 INFO - "script_repo_revision": "production", 00:54:33 INFO - "revision": "4702042aa919d5ae49dfe3ac5ee86507839b3c83", 00:54:33 INFO - "slavename": "talos-linux64-ix-063", 00:54:33 INFO - "repo_path": "mozilla-central" 00:54:33 INFO - } 00:54:33 INFO - Finding installer, test and symbols from parent task. 00:54:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d6eMmpguSiirg9dih5Hjbw'}, attempt #1 00:54:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d6eMmpguSiirg9dih5Hjbw'}, attempt #1 00:54:34 INFO - Task dependencies: L_3yr4h9Spyt82QzKDJcnw 00:54:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw'}, attempt #1 00:54:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 00:54:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.test_packages.json 00:54:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.crashreporter-symbols.zip 00:54:34 INFO - Running post-action listener: _resource_record_post_action 00:54:34 INFO - [mozharness: 2017-09-14 07:54:34.892303Z] Finished read-buildbot-config step (success) 00:54:34 INFO - [mozharness: 2017-09-14 07:54:34.892520Z] Running download-and-extract step. 00:54:34 INFO - Running pre-action listener: _resource_record_pre_action 00:54:34 INFO - Running main action method: download_and_extract 00:54:34 INFO - mkdir: /builds/slave/test/build/tests 00:54: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')]} 00:54:34 INFO - trying https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.test_packages.json 00:54:34 INFO - Downloading https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 00:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 00:54:35 INFO - Downloaded 989 bytes. 00:54:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:54:35 INFO - Using the following test package requirements: 00:54:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 00:54:35 INFO - u'common': [u'target.common.tests.zip'], 00:54:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:54:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:54:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:54:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:54:35 INFO - u'mozbase': [u'target.common.tests.zip'], 00:54:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:54:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:54:35 INFO - u'web-platform': [u'target.common.tests.zip', 00:54:35 INFO - u'target.web-platform.tests.tar.gz'], 00:54:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:54:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 00:54:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.common.tests.zip 00:54:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:54:35 INFO - Fetch https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.common.tests.zip into memory 00:54:38 INFO - Content-Length response header: 54588745 00:54:38 INFO - Bytes received: 54588745 00:54:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.talos.tests.zip 00:54:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 00:54:48 INFO - Fetch https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.talos.tests.zip into memory 00:54:49 INFO - Content-Length response header: 14500356 00:54:49 INFO - Bytes received: 14500356 00:54:49 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')]} 00:54:49 INFO - trying https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 00:54:49 INFO - Downloading https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 00:54:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 00:54:51 INFO - Downloaded 61305213 bytes. 00:54:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 00:54:51 INFO - mkdir: /builds/slave/test/properties 00:54:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:54:51 INFO - Writing to file /builds/slave/test/properties/build_url 00:54:51 INFO - Contents: 00:54:51 INFO - build_url:https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 00:54:51 INFO - Running post-action listener: _resource_record_post_action 00:54:51 INFO - Running post-action listener: find_tests_for_verification 00:54:51 INFO - Running post-action listener: set_extra_try_arguments 00:54:51 INFO - [mozharness: 2017-09-14 07:54:51.459098Z] Finished download-and-extract step (success) 00:54:51 INFO - [mozharness: 2017-09-14 07:54:51.459197Z] Running populate-webroot step. 00:54:51 INFO - Running pre-action listener: _resource_record_pre_action 00:54:51 INFO - Running main action method: populate_webroot 00:54:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:54:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['tresize', 00:54:51 INFO - 'tcanvasmark']}, 00:54:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:54:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['dromaeo_css', 00:54:51 INFO - 'kraken']}, 00:54:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:54:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:54:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'tests': ['damp', 'tps']}, 00:54:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['damp', 'tps']}, 00:54:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:54:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['dromaeo_dom']}, 00:54:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 00:54:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['basic_compositor_video', 00:54:51 INFO - 'glvideo']}, 00:54:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 00:54:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['ts_paint_webext', 00:54:51 INFO - 'tp5o_webext']}, 00:54:51 INFO - 'other-e10s': {'tests': ['a11yr', 00:54:51 INFO - 'ts_paint', 00:54:51 INFO - 'tpaint', 00:54:51 INFO - 'sessionrestore', 00:54:51 INFO - 'sessionrestore_many_windows', 00:54:51 INFO - 'sessionrestore_no_auto_restore', 00:54:51 INFO - 'tabpaint']}, 00:54:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['a11yr', 00:54:51 INFO - 'ts_paint', 00:54:51 INFO - 'tpaint', 00:54:51 INFO - 'sessionrestore', 00:54:51 INFO - 'sessionrestore_many_windows', 00:54:51 INFO - 'sessionrestore_no_auto_restore', 00:54:51 INFO - 'tabpaint']}, 00:54:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 00:54:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 00:54:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['bloom_basic_singleton']}, 00:54:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['bloom_basic']}, 00:54:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:54:51 INFO - 'tsvgr_opacity', 00:54:51 INFO - 'tart', 00:54:51 INFO - 'tscrollx', 00:54:51 INFO - 'tsvg_static']}, 00:54:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['tsvgx', 00:54:51 INFO - 'tsvgr_opacity', 00:54:51 INFO - 'tart', 00:54:51 INFO - 'tscrollx', 00:54:51 INFO - 'tsvg_static']}, 00:54:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:54:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'talos_options': ['--disable-stylo'], 00:54:51 INFO - 'tests': ['tp5o']}, 00:54:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:54:51 INFO - 'talos_options': ['--mitmproxy', 00:54:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:54:51 INFO - '--firstNonBlankPaint'], 00:54:51 INFO - 'tests': ['tp6_google', 00:54:51 INFO - 'tp6_youtube', 00:54:51 INFO - 'tp6_amazon', 00:54:51 INFO - 'tp6_facebook']}, 00:54:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:54:51 INFO - 'talos_options': ['--disable-stylo', 00:54:51 INFO - '--mitmproxy', 00:54:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:54:51 INFO - '--firstNonBlankPaint'], 00:54:51 INFO - 'tests': ['tp6_google', 00:54:51 INFO - 'tp6_youtube', 00:54:51 INFO - 'tp6_amazon', 00:54:51 INFO - 'tp6_facebook']}, 00:54:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:54:51 INFO - 'talos_options': ['--stylo-threads=1', 00:54:51 INFO - '--mitmproxy', 00:54:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:54:51 INFO - '--firstNonBlankPaint'], 00:54:51 INFO - 'tests': ['tp6_google', 00:54:51 INFO - 'tp6_youtube', 00:54:51 INFO - 'tp6_amazon', 00:54:51 INFO - 'tp6_facebook']}, 00:54:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'talos_options': ['--xperf_path', 00:54:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:54:51 INFO - 'tests': ['tp5n']}, 00:54:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:51 INFO - 'talos_options': ['--disable-stylo', 00:54:51 INFO - '--xperf_path', 00:54:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:54:51 INFO - 'tests': ['tp5n']}}} 00:54:51 INFO - Running post-action listener: _resource_record_post_action 00:54:51 INFO - [mozharness: 2017-09-14 07:54:51.474195Z] Finished populate-webroot step (success) 00:54:51 INFO - [mozharness: 2017-09-14 07:54:51.474283Z] Running create-virtualenv step. 00:54:51 INFO - Running pre-action listener: _resource_record_pre_action 00:54:51 INFO - Running main action method: create_virtualenv 00:54:51 INFO - Creating virtualenv /builds/slave/test/build/venv 00:54:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:54:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 00:54:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 00:54:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:54:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:54:52 INFO - Installing distribute.............................................................................................................................................................................................done. 00:54:52 INFO - Installing pip...............done. 00:54:52 INFO - Return code: 0 00:54:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:54:52 INFO - Reading from file tmpfile_stdout 00:54:52 INFO - Output received: 00:54:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 00:54:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402090>, '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 0x2402d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fcf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', '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 00:54:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:54:52 INFO - Using env: {'DISPLAY': ':0', 00:54:52 INFO - 'HOME': '/home/cltbld', 00:54:52 INFO - 'LANG': 'en_US.UTF-8', 00:54:52 INFO - 'LANGUAGE': 'en_US:en', 00:54:52 INFO - 'LOGNAME': 'cltbld', 00:54:52 INFO - 'MAIL': '/var/mail/cltbld', 00:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:52 INFO - 'MOZ_NO_REMOTE': '1', 00:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:52 INFO - 'NO_EM_RESTART': '1', 00:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:52 INFO - 'PWD': '/builds/slave/test', 00:54:52 INFO - 'SHELL': '/bin/bash', 00:54:52 INFO - 'SHLVL': '1', 00:54:52 INFO - 'TERM': 'linux', 00:54:52 INFO - 'TMOUT': '86400', 00:54:52 INFO - 'USER': 'cltbld', 00:54:52 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 00:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:52 INFO - '_': '/tools/buildbot/bin/python'} 00:54:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 00:54:53 INFO - Downloading/unpacking pip>=1.5 00:54:53 INFO - Running setup.py egg_info for package pip 00:54:53 INFO - warning: no files found matching 'pip/cacert.pem' 00:54:53 INFO - warning: no files found matching '*.html' under directory 'docs' 00:54:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:54:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:54:53 INFO - Installing collected packages: pip 00:54:53 INFO - Found existing installation: pip 1.1 00:54:53 INFO - Uninstalling pip: 00:54:53 INFO - Successfully uninstalled pip 00:54:53 INFO - Running setup.py install for pip 00:54:53 INFO - warning: no files found matching 'pip/cacert.pem' 00:54:53 INFO - warning: no files found matching '*.html' under directory 'docs' 00:54:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:54:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:54:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 00:54:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 00:54:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 00:54:53 INFO - Successfully installed pip 00:54:53 INFO - Cleaning up... 00:54:53 INFO - Return code: 0 00:54:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:54: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')]} 00:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54: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')]} 00:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54: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', '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 0x20921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402090>, '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 0x2402d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fcf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', '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 00:54: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', 'psutil>=3.1.1'] in /builds/slave/test/build 00:54: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 psutil>=3.1.1 00:54:53 INFO - Using env: {'DISPLAY': ':0', 00:54:53 INFO - 'HOME': '/home/cltbld', 00:54:53 INFO - 'LANG': 'en_US.UTF-8', 00:54:53 INFO - 'LANGUAGE': 'en_US:en', 00:54:53 INFO - 'LOGNAME': 'cltbld', 00:54:53 INFO - 'MAIL': '/var/mail/cltbld', 00:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:53 INFO - 'MOZ_NO_REMOTE': '1', 00:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:53 INFO - 'NO_EM_RESTART': '1', 00:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:53 INFO - 'PWD': '/builds/slave/test', 00:54:53 INFO - 'SHELL': '/bin/bash', 00:54:53 INFO - 'SHLVL': '1', 00:54:53 INFO - 'TERM': 'linux', 00:54:53 INFO - 'TMOUT': '86400', 00:54:53 INFO - 'USER': 'cltbld', 00:54:53 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 00:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:53 INFO - '_': '/tools/buildbot/bin/python'} 00:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:53 INFO - Downloading/unpacking psutil>=3.1.1 00:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:54:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:54:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:54:55 INFO - Installing collected packages: psutil 00:54:55 INFO - Running setup.py install for psutil 00:54:55 INFO - building 'psutil._psutil_linux' extension 00:54:55 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 00:54:55 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 00:54:55 INFO - building 'psutil._psutil_posix' extension 00:54:55 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 00:54:55 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 00:54:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:54:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:54:55 INFO - Successfully installed psutil 00:54:55 INFO - Cleaning up... 00:54:56 INFO - Return code: 0 00:54:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402090>, '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 0x2402d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fcf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', '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 00:54:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:54:56 INFO - Using env: {'DISPLAY': ':0', 00:54:56 INFO - 'HOME': '/home/cltbld', 00:54:56 INFO - 'LANG': 'en_US.UTF-8', 00:54:56 INFO - 'LANGUAGE': 'en_US:en', 00:54:56 INFO - 'LOGNAME': 'cltbld', 00:54:56 INFO - 'MAIL': '/var/mail/cltbld', 00:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:56 INFO - 'MOZ_NO_REMOTE': '1', 00:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:56 INFO - 'NO_EM_RESTART': '1', 00:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:56 INFO - 'PWD': '/builds/slave/test', 00:54:56 INFO - 'SHELL': '/bin/bash', 00:54:56 INFO - 'SHLVL': '1', 00:54:56 INFO - 'TERM': 'linux', 00:54:56 INFO - 'TMOUT': '86400', 00:54:56 INFO - 'USER': 'cltbld', 00:54:56 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 00:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:56 INFO - '_': '/tools/buildbot/bin/python'} 00:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:54:56 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 00:54:56 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 00:54:56 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 00:54:56 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 00:54:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:54:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:54:57 INFO - Installing collected packages: mozsystemmonitor 00:54:57 INFO - Running setup.py install for mozsystemmonitor 00:54:57 INFO - Successfully installed mozsystemmonitor 00:54:57 INFO - Cleaning up... 00:54:57 INFO - Return code: 0 00:54:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:54:57 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')]} 00:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:57 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')]} 00:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:57 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 0x20921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402090>, '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 0x2402d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fcf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', '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 00:54:57 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 00:54:57 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 00:54:57 INFO - Using env: {'DISPLAY': ':0', 00:54:57 INFO - 'HOME': '/home/cltbld', 00:54:57 INFO - 'LANG': 'en_US.UTF-8', 00:54:57 INFO - 'LANGUAGE': 'en_US:en', 00:54:57 INFO - 'LOGNAME': 'cltbld', 00:54:57 INFO - 'MAIL': '/var/mail/cltbld', 00:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:57 INFO - 'MOZ_NO_REMOTE': '1', 00:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:57 INFO - 'NO_EM_RESTART': '1', 00:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:57 INFO - 'PWD': '/builds/slave/test', 00:54:57 INFO - 'SHELL': '/bin/bash', 00:54:57 INFO - 'SHLVL': '1', 00:54:57 INFO - 'TERM': 'linux', 00:54:57 INFO - 'TMOUT': '86400', 00:54:57 INFO - 'USER': 'cltbld', 00:54:57 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 00:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:57 INFO - '_': '/tools/buildbot/bin/python'} 00:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:58 INFO - Downloading/unpacking jsonschema==2.5.1 00:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:54:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:59 INFO - Downloading functools32-3.2.3-2.tar.gz 00:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:54:59 INFO - warning: no files found matching '*.txt' 00:54:59 INFO - no previously-included directories found matching 'build' 00:54:59 INFO - no previously-included directories found matching 'dist' 00:54:59 INFO - no previously-included directories found matching '.git*' 00:54:59 INFO - Installing collected packages: jsonschema, functools32 00:54:59 INFO - Running setup.py install for functools32 00:54:59 INFO - warning: no files found matching '*.txt' 00:54:59 INFO - no previously-included directories found matching 'build' 00:54:59 INFO - no previously-included directories found matching 'dist' 00:54:59 INFO - no previously-included directories found matching '.git*' 00:54:59 INFO - Successfully installed jsonschema functools32 00:54:59 INFO - Cleaning up... 00:54:59 INFO - Return code: 0 00:54:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:59 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 0x20921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402090>, '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 0x2402d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fcf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', '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 00:54:59 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 00:54:59 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 00:54:59 INFO - Using env: {'DISPLAY': ':0', 00:54:59 INFO - 'HOME': '/home/cltbld', 00:54:59 INFO - 'LANG': 'en_US.UTF-8', 00:54:59 INFO - 'LANGUAGE': 'en_US:en', 00:54:59 INFO - 'LOGNAME': 'cltbld', 00:54:59 INFO - 'MAIL': '/var/mail/cltbld', 00:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:59 INFO - 'MOZ_NO_REMOTE': '1', 00:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:59 INFO - 'NO_EM_RESTART': '1', 00:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:59 INFO - 'PWD': '/builds/slave/test', 00:54:59 INFO - 'SHELL': '/bin/bash', 00:54:59 INFO - 'SHLVL': '1', 00:54:59 INFO - 'TERM': 'linux', 00:54:59 INFO - 'TMOUT': '86400', 00:54:59 INFO - 'USER': 'cltbld', 00:54:59 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 00:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:59 INFO - '_': '/tools/buildbot/bin/python'} 00:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:54:59 INFO - Cleaning up... 00:54:59 INFO - Return code: 0 00:54:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:59 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 0x20921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402090>, '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 0x2402d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fcf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', '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 00:54:59 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 00:54:59 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 00:54:59 INFO - Using env: {'DISPLAY': ':0', 00:54:59 INFO - 'HOME': '/home/cltbld', 00:54:59 INFO - 'LANG': 'en_US.UTF-8', 00:54:59 INFO - 'LANGUAGE': 'en_US:en', 00:54:59 INFO - 'LOGNAME': 'cltbld', 00:54:59 INFO - 'MAIL': '/var/mail/cltbld', 00:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:59 INFO - 'MOZ_NO_REMOTE': '1', 00:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:59 INFO - 'NO_EM_RESTART': '1', 00:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:59 INFO - 'PWD': '/builds/slave/test', 00:54:59 INFO - 'SHELL': '/bin/bash', 00:54:59 INFO - 'SHLVL': '1', 00:54:59 INFO - 'TERM': 'linux', 00:54:59 INFO - 'TMOUT': '86400', 00:54:59 INFO - 'USER': 'cltbld', 00:54:59 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 00:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:59 INFO - '_': '/tools/buildbot/bin/python'} 00:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:00 INFO - Downloading/unpacking blobuploader==1.2.4 00:55:00 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 00:55:00 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 00:55:00 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 00:55:00 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 00:55:01 INFO - Downloading blobuploader-1.2.4.tar.gz 00:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:55:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:55:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:01 INFO - Downloading docopt-0.6.1.tar.gz 00:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:55:01 INFO - Installing collected packages: blobuploader, requests, docopt 00:55:01 INFO - Running setup.py install for blobuploader 00:55:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:55:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:55:01 INFO - Running setup.py install for requests 00:55:02 INFO - Running setup.py install for docopt 00:55:02 INFO - Successfully installed blobuploader requests docopt 00:55:02 INFO - Cleaning up... 00:55:02 INFO - Return code: 0 00:55:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:02 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 0x20921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402090>, '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 0x2402d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fcf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', '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 00:55:02 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 00:55:02 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 00:55:02 INFO - Using env: {'DISPLAY': ':0', 00:55:02 INFO - 'HOME': '/home/cltbld', 00:55:02 INFO - 'LANG': 'en_US.UTF-8', 00:55:02 INFO - 'LANGUAGE': 'en_US:en', 00:55:02 INFO - 'LOGNAME': 'cltbld', 00:55:02 INFO - 'MAIL': '/var/mail/cltbld', 00:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:02 INFO - 'MOZ_NO_REMOTE': '1', 00:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:02 INFO - 'NO_EM_RESTART': '1', 00:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:02 INFO - 'PWD': '/builds/slave/test', 00:55:02 INFO - 'SHELL': '/bin/bash', 00:55:02 INFO - 'SHLVL': '1', 00:55:02 INFO - 'TERM': 'linux', 00:55:02 INFO - 'TMOUT': '86400', 00:55:02 INFO - 'USER': 'cltbld', 00:55:02 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 00:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:02 INFO - '_': '/tools/buildbot/bin/python'} 00:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:55:02 INFO - Running setup.py (path:/tmp/pip-69ajcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:55:02 INFO - Running setup.py (path:/tmp/pip-u2iWsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:55:02 INFO - Running setup.py (path:/tmp/pip-pVxLUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:55:02 INFO - Running setup.py (path:/tmp/pip-vf1WT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:55:02 INFO - Running setup.py (path:/tmp/pip-tbmPSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:55:02 INFO - Running setup.py (path:/tmp/pip-CVdZQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:55:03 INFO - Running setup.py (path:/tmp/pip-kyWvN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:55:03 INFO - Running setup.py (path:/tmp/pip-GaQdTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:55:03 INFO - Running setup.py (path:/tmp/pip-Q2R15z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:55:03 INFO - Running setup.py (path:/tmp/pip-Xyg148-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:55:03 INFO - Running setup.py (path:/tmp/pip-DCWgjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:55:03 INFO - Running setup.py (path:/tmp/pip-P_Dj0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:55:03 INFO - Running setup.py (path:/tmp/pip-rks3QW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:55:03 INFO - Running setup.py (path:/tmp/pip-HEP4xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:03 INFO - Running setup.py (path:/tmp/pip-syaWGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:55:03 INFO - Running setup.py (path:/tmp/pip-kYEo7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:55:03 INFO - Running setup.py (path:/tmp/pip-0HSH2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:55:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:55:03 INFO - Running setup.py install for manifestparser 00:55:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:55:03 INFO - Running setup.py install for mozcrash 00:55:03 INFO - Running setup.py install for mozdebug 00:55:04 INFO - Running setup.py install for mozdevice 00:55:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:55:04 INFO - Running setup.py install for mozfile 00:55:04 INFO - Running setup.py install for mozhttpd 00:55:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:55:04 INFO - Running setup.py install for mozinfo 00:55:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:55:04 INFO - Running setup.py install for mozInstall 00:55:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:55:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:55:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:55:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:55:04 INFO - Running setup.py install for mozleak 00:55:04 INFO - Running setup.py install for mozlog 00:55:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:55:04 INFO - Running setup.py install for moznetwork 00:55:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:55:04 INFO - Running setup.py install for mozprocess 00:55:04 INFO - Running setup.py install for mozprofile 00:55:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Running setup.py install for mozrunner 00:55:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Running setup.py install for mozscreenshot 00:55:05 INFO - Running setup.py install for moztest 00:55:05 INFO - Running setup.py install for mozversion 00:55:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:55:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:55:05 INFO - Cleaning up... 00:55:05 INFO - Return code: 0 00:55:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:05 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 0x20921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402090>, '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 0x2402d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fcf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', '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 00:55:05 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 00:55:05 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 00:55:05 INFO - Using env: {'DISPLAY': ':0', 00:55:05 INFO - 'HOME': '/home/cltbld', 00:55:05 INFO - 'LANG': 'en_US.UTF-8', 00:55:05 INFO - 'LANGUAGE': 'en_US:en', 00:55:05 INFO - 'LOGNAME': 'cltbld', 00:55:05 INFO - 'MAIL': '/var/mail/cltbld', 00:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:05 INFO - 'MOZ_NO_REMOTE': '1', 00:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:05 INFO - 'NO_EM_RESTART': '1', 00:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:05 INFO - 'PWD': '/builds/slave/test', 00:55:05 INFO - 'SHELL': '/bin/bash', 00:55:05 INFO - 'SHLVL': '1', 00:55:05 INFO - 'TERM': 'linux', 00:55:05 INFO - 'TMOUT': '86400', 00:55:05 INFO - 'USER': 'cltbld', 00:55:05 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 00:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:05 INFO - '_': '/tools/buildbot/bin/python'} 00:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:55:05 INFO - Running setup.py (path:/tmp/pip-84RCAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:55:05 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)) 00:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:55:05 INFO - Running setup.py (path:/tmp/pip-xBxioX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:55:05 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)) 00:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:55:05 INFO - Running setup.py (path:/tmp/pip-3Dum9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:55:05 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)) 00:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:55:05 INFO - Running setup.py (path:/tmp/pip-otMJbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:55:06 INFO - Running setup.py (path:/tmp/pip-oHMr6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:55:06 INFO - Running setup.py (path:/tmp/pip-dUyz4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:55:06 INFO - Running setup.py (path:/tmp/pip-Sabz1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:55:06 INFO - Running setup.py (path:/tmp/pip-FM2Yfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:55:06 INFO - Running setup.py (path:/tmp/pip-uHM9qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:55:06 INFO - Running setup.py (path:/tmp/pip-2EtlEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:55:06 INFO - Running setup.py (path:/tmp/pip-nYy51x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:55:06 INFO - Running setup.py (path:/tmp/pip-0TItkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:55:06 INFO - Running setup.py (path:/tmp/pip-RTUM_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:55:06 INFO - Running setup.py (path:/tmp/pip-OXeJ1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:06 INFO - Running setup.py (path:/tmp/pip-xMxspY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:55:06 INFO - Running setup.py (path:/tmp/pip-O3fheE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:55:06 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)) 00:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:55:06 INFO - Running setup.py (path:/tmp/pip-gBaVYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:55:06 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)) 00:55:06 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)) 00:55:06 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)) 00:55:06 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)) 00:55:06 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)) 00:55:06 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)) 00:55:06 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)) 00:55:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:55:06 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 00:55:06 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 00:55:06 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 00:55:06 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 00:55:08 INFO - Downloading blessings-1.6.tar.gz 00:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:55:08 INFO - Installing collected packages: blessings 00:55:08 INFO - Running setup.py install for blessings 00:55:08 INFO - Successfully installed blessings 00:55:08 INFO - Cleaning up... 00:55:08 INFO - Return code: 0 00:55:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:55:08 INFO - Reading from file tmpfile_stdout 00:55:08 INFO - Current package versions: 00:55:08 INFO - argparse == 1.2.1 00:55:08 INFO - blessings == 1.6 00:55:08 INFO - blobuploader == 1.2.4 00:55:08 INFO - docopt == 0.6.1 00:55:08 INFO - functools32 == 3.2.3-2 00:55:08 INFO - jsonschema == 2.5.1 00:55:08 INFO - manifestparser == 1.1 00:55:08 INFO - mozInstall == 1.13 00:55:08 INFO - mozcrash == 1.0 00:55:08 INFO - mozdebug == 0.1 00:55:08 INFO - mozdevice == 0.51 00:55:08 INFO - mozfile == 1.2 00:55:08 INFO - mozhttpd == 0.7 00:55:08 INFO - mozinfo == 0.10 00:55:08 INFO - mozleak == 0.1 00:55:08 INFO - mozlog == 3.5 00:55:08 INFO - moznetwork == 0.27 00:55:08 INFO - mozprocess == 0.25 00:55:08 INFO - mozprofile == 0.28 00:55:08 INFO - mozrunner == 6.13 00:55:08 INFO - mozscreenshot == 0.1 00:55:08 INFO - mozsystemmonitor == 0.3 00:55:08 INFO - moztest == 0.8 00:55:08 INFO - mozversion == 1.4 00:55:08 INFO - psutil == 3.1.1 00:55:08 INFO - requests == 1.2.3 00:55:08 INFO - wsgiref == 0.1.2 00:55:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:08 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 0x20921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402090>, '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 0x2402d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fcf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', '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 00:55:08 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 00:55:08 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 00:55:08 INFO - Using env: {'DISPLAY': ':0', 00:55:08 INFO - 'HOME': '/home/cltbld', 00:55:08 INFO - 'LANG': 'en_US.UTF-8', 00:55:08 INFO - 'LANGUAGE': 'en_US:en', 00:55:08 INFO - 'LOGNAME': 'cltbld', 00:55:08 INFO - 'MAIL': '/var/mail/cltbld', 00:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:08 INFO - 'MOZ_NO_REMOTE': '1', 00:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:08 INFO - 'NO_EM_RESTART': '1', 00:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:08 INFO - 'PWD': '/builds/slave/test', 00:55:08 INFO - 'SHELL': '/bin/bash', 00:55:08 INFO - 'SHLVL': '1', 00:55:08 INFO - 'TERM': 'linux', 00:55:08 INFO - 'TMOUT': '86400', 00:55:08 INFO - 'USER': 'cltbld', 00:55:08 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 00:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:08 INFO - '_': '/tools/buildbot/bin/python'} 00:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:08 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)) 00:55:08 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)) 00:55:08 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)) 00:55:08 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)) 00:55:08 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)) 00:55:08 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)) 00:55:08 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)) 00:55:08 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)) 00:55:08 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)) 00:55:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 00:55:08 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 00:55:08 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 00:55:08 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 00:55:08 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 00:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 00:55:09 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)) 00:55:09 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)) 00:55:09 INFO - Installing collected packages: simplejson 00:55:09 INFO - Running setup.py install for simplejson 00:55:10 INFO - building 'simplejson._speedups' extension 00:55:10 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 00:55:10 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 00:55:10 INFO - Successfully installed simplejson 00:55:10 INFO - Cleaning up... 00:55:11 INFO - Return code: 0 00:55:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:55: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')]} 00:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55: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')]} 00:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:11 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 0x20921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402090>, '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 0x2402d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fcf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', '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 00:55:11 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 00:55:11 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 00:55:11 INFO - Using env: {'DISPLAY': ':0', 00:55:11 INFO - 'HOME': '/home/cltbld', 00:55:11 INFO - 'LANG': 'en_US.UTF-8', 00:55:11 INFO - 'LANGUAGE': 'en_US:en', 00:55:11 INFO - 'LOGNAME': 'cltbld', 00:55:11 INFO - 'MAIL': '/var/mail/cltbld', 00:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:11 INFO - 'MOZ_NO_REMOTE': '1', 00:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:11 INFO - 'NO_EM_RESTART': '1', 00:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:11 INFO - 'PWD': '/builds/slave/test', 00:55:11 INFO - 'SHELL': '/bin/bash', 00:55:11 INFO - 'SHLVL': '1', 00:55:11 INFO - 'TERM': 'linux', 00:55:11 INFO - 'TMOUT': '86400', 00:55:11 INFO - 'USER': 'cltbld', 00:55:11 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 00:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:11 INFO - '_': '/tools/buildbot/bin/python'} 00:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:55:11 INFO - Cleaning up... 00:55:11 INFO - Return code: 0 00:55:11 INFO - Running post-action listener: _resource_record_post_action 00:55:11 INFO - Running post-action listener: _start_resource_monitoring 00:55:11 INFO - Starting resource monitoring. 00:55:11 INFO - [mozharness: 2017-09-14 07:55:11.286639Z] Finished create-virtualenv step (success) 00:55:11 INFO - [mozharness: 2017-09-14 07:55:11.287237Z] Running install step. 00:55:11 INFO - Running pre-action listener: _resource_record_pre_action 00:55:11 INFO - Running main action method: install 00:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:55:11 INFO - Reading from file tmpfile_stdout 00:55:11 INFO - Detecting whether we're running mozinstall >=1.0... 00:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:55:11 INFO - Reading from file tmpfile_stdout 00:55:11 INFO - Output received: 00:55:11 INFO - Usage: mozinstall [options] installer 00:55:11 INFO - Options: 00:55:11 INFO - -h, --help show this help message and exit 00:55:11 INFO - -d DEST, --destination=DEST 00:55:11 INFO - Directory to install application into. [default: 00:55:11 INFO - "/builds/slave/test"] 00:55:11 INFO - --app=APP Application being installed. [default: firefox] 00:55:11 INFO - mkdir: /builds/slave/test/build/application 00:55:11 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'] 00:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 00:55:29 INFO - Reading from file tmpfile_stdout 00:55:29 INFO - Output received: 00:55:29 INFO - /builds/slave/test/build/application/firefox/firefox 00:55:29 INFO - Running post-action listener: _resource_record_post_action 00:55:29 INFO - [mozharness: 2017-09-14 07:55:29.380400Z] Finished install step (success) 00:55:29 INFO - [mozharness: 2017-09-14 07:55:29.380653Z] Running setup-mitmproxy step. 00:55:29 INFO - Running pre-action listener: _resource_record_pre_action 00:55:29 INFO - Running main action method: setup_mitmproxy 00:55:29 INFO - Skipping: mitmproxy is not required 00:55:29 INFO - Running post-action listener: _resource_record_post_action 00:55:29 INFO - [mozharness: 2017-09-14 07:55:29.381780Z] Finished setup-mitmproxy step (success) 00:55:29 INFO - [mozharness: 2017-09-14 07:55:29.382000Z] Running run-tests step. 00:55:29 INFO - Running pre-action listener: _resource_record_pre_action 00:55:29 INFO - Running pre-action listener: _set_gcov_prefix 00:55:29 INFO - Running main action method: run_tests 00:55:29 WARNING - Try message not found. 00:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:55:29 INFO - Python 2.7.3 00:55:29 INFO - Return code: 0 00:55:29 INFO - grabbing minidump binary from tooltool 00:55:29 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')]} 00:55:29 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 0x2402090>, '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 0x2402d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fcf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:55:29 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 00:55:29 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 00:55:29 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 00:55:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:55:29 INFO - Return code: 0 00:55:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:55:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:55:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:55:29 INFO - ENV: RUST_BACKTRACE is now full 00:55:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:55:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 00:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 00:55:29 INFO - Using env: {'DISPLAY': ':0', 00:55:29 INFO - 'HOME': '/home/cltbld', 00:55:29 INFO - 'LANG': 'en_US.UTF-8', 00:55:29 INFO - 'LANGUAGE': 'en_US:en', 00:55:29 INFO - 'LOGNAME': 'cltbld', 00:55:29 INFO - 'MAIL': '/var/mail/cltbld', 00:55:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:55:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:55:29 INFO - 'MOZ_ACCELERATED': '1', 00:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:29 INFO - 'MOZ_NO_REMOTE': '1', 00:55:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:55:29 INFO - 'MOZ_WEBRENDER': '1', 00:55:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:29 INFO - 'NO_EM_RESTART': '1', 00:55:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:29 INFO - 'PWD': '/builds/slave/test', 00:55:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:55:29 INFO - 'RUST_BACKTRACE': 'full', 00:55:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:55:29 INFO - 'SHELL': '/bin/bash', 00:55:29 INFO - 'SHLVL': '1', 00:55:29 INFO - 'TERM': 'linux', 00:55:29 INFO - 'TMOUT': '86400', 00:55:29 INFO - 'USER': 'cltbld', 00:55:29 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 00:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:29 INFO - '_': '/tools/buildbot/bin/python'} 00:55:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 00:55:29 INFO - mozversion application_buildid: 20170914070342 00:55:29 INFO - mozversion application_changeset: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 00:55:29 INFO - mozversion application_display_name: Nightly 00:55:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:55:29 INFO - mozversion application_name: Firefox 00:55:29 INFO - mozversion application_remotingname: firefox 00:55:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:55:29 INFO - mozversion application_vendor: Mozilla 00:55:29 INFO - mozversion application_version: 57.0a1 00:55:29 INFO - mozversion platform_buildid: 20170914070342 00:55:29 INFO - mozversion platform_changeset: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 00:55:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:55:29 INFO - mozversion platform_version: 57.0a1 00:55:29 INFO - using testdate: 1505375729 00:55:29 INFO - actual date: 1505375729 00:55:29 INFO - starting webserver on 'localhost:46937' 00:55:29 INFO - SUITE-START | Running 2 tests 00:55:29 INFO - TEST-START | dromaeo_css 00:55:29 INFO - Initialising browser for dromaeo_css test... 00:55:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46937/getInfo.html -profile /tmp/tmpYpldeQ/profile 00:55:29 INFO - TEST-INFO | started process 13206 (/builds/slave/test/build/application/firefox/firefox http://localhost:46937/getInfo.html) 00:55:36 INFO - TEST-INFO | 13206: exit 0 00:55:36 INFO - Browser initialized. 00:55:36 INFO - Running cycle 1/1 for dromaeo_css test... 00:55:36 INFO - Using env: {'DISPLAY': ':0', 00:55:36 INFO - 'HOME': '/home/cltbld', 00:55:36 INFO - 'JSGC_DISABLE_POISONING': '1', 00:55:36 INFO - 'LANG': 'en_US.UTF-8', 00:55:36 INFO - 'LANGUAGE': 'en_US:en', 00:55:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 00:55:36 INFO - 'LOGNAME': 'cltbld', 00:55:36 INFO - 'MAIL': '/var/mail/cltbld', 00:55:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:55:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:55:36 INFO - 'MOZ_ACCELERATED': '1', 00:55:36 INFO - 'MOZ_CRASHREPORTER': '1', 00:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 00:55:36 INFO - 'MOZ_NO_REMOTE': '1', 00:55:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:55:36 INFO - 'MOZ_WEBRENDER': '1', 00:55:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:36 INFO - 'NO_EM_RESTART': '1', 00:55:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:36 INFO - 'PWD': '/builds/slave/test', 00:55:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:55:36 INFO - 'RUST_BACKTRACE': 'full', 00:55:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:55:36 INFO - 'SHELL': '/bin/bash', 00:55:36 INFO - 'SHLVL': '1', 00:55:36 INFO - 'TERM': 'linux', 00:55:36 INFO - 'TMOUT': '86400', 00:55:36 INFO - 'USER': 'cltbld', 00:55:36 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 00:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:36 INFO - '_': '/tools/buildbot/bin/python'} 00:55:36 INFO - TEST-INFO | started process 13450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYpldeQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:55:37 INFO - PID 13450 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 00:55:37 INFO - PID 13450 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 00:55:37 INFO - PID 13450 | 00:55:37 INFO - PID 13450 | (/builds/slave/test/build/application/firefox/firefox:13510): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:55:37 INFO - PID 13450 | 00:55:48 INFO - PID 13450 | RSS: Main: 196726784 00:55:48 INFO - PID 13450 | 00:58:46 INFO - PID 13450 | Cycle 1(1): loaded http://localhost:46937/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46937/tests/dromaeo/cssquery-ext.html) 00:58:47 INFO - PID 13450 | RSS: Main: 204271616 00:58:47 INFO - PID 13450 | 01:01:49 INFO - PID 13450 | Cycle 1(1): loaded http://localhost:46937/tests/dromaeo/cssquery-ext.html (next: http://localhost:46937/tests/dromaeo/cssquery-jquery.html) 01:01:50 INFO - PID 13450 | RSS: Main: 207245312 01:01:50 INFO - PID 13450 | 01:04:52 INFO - PID 13450 | Cycle 1(1): loaded http://localhost:46937/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46937/tests/dromaeo/cssquery-mootools.html) 01:04:53 INFO - PID 13450 | RSS: Main: 209084416 01:04:53 INFO - PID 13450 | 01:07:55 INFO - PID 13450 | Cycle 1(1): loaded http://localhost:46937/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46937/tests/dromaeo/cssquery-prototype.html) 01:07:55 INFO - PID 13450 | RSS: Main: 204881920 01:07:55 INFO - PID 13450 | 01:10:59 INFO - PID 13450 | Cycle 1(1): loaded http://localhost:46937/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46937/tests/dromaeo/cssquery-yui.html) 01:11:00 INFO - PID 13450 | RSS: Main: 206471168 01:11:00 INFO - PID 13450 | 01:14:02 INFO - PID 13450 | Cycle 1(1): loaded http://localhost:46937/tests/dromaeo/cssquery-yui.html (next: http://localhost:46937/tests/dromaeo/cssquery-dojo.html) 01:14:02 INFO - PID 13450 | RSS: Main: 211980288 01:14:02 INFO - PID 13450 | 01:14:02 INFO - PID 13450 | __start_tp_report 01:14:02 INFO - PID 13450 | _x_x_mozilla_page_load 01:14:02 INFO - PID 13450 | _x_x_mozilla_page_load_details 01:14:02 INFO - PID 13450 | |i|pagename|runs| 01:14:02 INFO - PID 13450 | |0;dojo.html;3121.204092956296;3152.416802891465;3159.6524382317957;3194.8562314695837;3201.663825298342;6079.908801367983;6260.7808726694575;6262.686865656716;6372.139761132252;6404;6169.506439484841;6173.413525715061;6196.101565273033;6248.15649887265;6255.030470277103;5702.4012478689765;5710.086386178213;5715.657060576368;5745.5116315113055;5767.653940763567;5696.800611978581;5779.422057794208;5807.1579620954935;5809.477147056764;5897.941020589804;5799.333076696171;5820.185174075633;5838.824835254949;5847.473727364536;5889.057750759879;5576.525995290405;5608.551315894719;5631.63394379364;5801.30384353876;5926.674032928187;5658.773649054033;5720.914186287209;5754.762726013885;5805.36141024487;5809.941900580982;6177.7837775677635;6190.969045154746;6194.5044396448175;6217.595856269328;6308.432241098323;6518.608883467007;6527.184101987252;6584.209894812605;6666.200055993312;6772;6698.095757072781;6718.798436046877;6721.6975236114495;6736.225334086594;6759.5606285591275;6179.3820617937845;6273.435390814803;6282.968585157045;6294.685265736741;6317.210348706411;6880.827979300458;6924;6939.618320992293;6975.651217439107;6980.616066116311;6378.075179099097;6515;6533.575317604341;6550.344965503412;6694;6545.967270163619;6596;6667.399934005963;6669.399754022064;6671.566348187353;6541.8691626168165;6578.407943285128;6580.8354791130605;6643.800685979331;6646.933530664632;6728.3271672832325;6782.864342713118;6823.590584564942;6825.761098361533;6828.829279267959;5125.974370128126;5167.58659307262;5186.351706036746;5223.973880130651;5271.868203294872;4484.843030493982;4553.793997407544;4556.863294101182;4587.954120458753;4639.930401043987;5682.204491371212;5722.4277572242445;5735.139729040678;5765.07758758605;5779.942200578024;6762.289959554274;6802.795916122524;6807.9319206807295;6814;6835.4189893859575;5736.799212027559;5805.7387417566315;5871.148683440877;5871.941280587225;5879.265091863517;5802;5825.0679891217205;5852.590318677737;5875.618084824473;5878.882422351529;6395.6482393468805;6512.869742605121;6522.608643481311;6624.900626490607;6651.800445986628;6425.614463132227;6472.611643301417;6517;6541.411272985454;6560.671966401565;6219.595726277777;6315.336889626523;6321.747130114744;6357.841053973688;6366.427021568081;6523.739050438119;6579.013148027834;6625.337466253336;6687;6713.060171575886;6745.865082698417;6775.728970841111;6785.626790526371;6797.422219111431;6865.141857267841;6376.585521941059;6467.514936379696;6543.5419520633095;6551.50863685216;6553.541252112306;6407.391297826699;6415.486761059197;6470.450011749054;6472.223333200046;6487.351264873475;6335.1130841683125;6356.3325850785;6399.8080057598345;6407.807765767035;6428.132202152837;6561.048647946117;6581.276059633532;6616.569922954993;6619.702113405005;6658.966705166443;6258.499320054294;6290.528210384331;6358.618482891041;6360.395762402564;6372.426481616677 01:14:02 INFO - PID 13450 | |1;ext.html;835.9373047021468;838.1785849867131;880.2781718990423;881.2333270055053;882.1443200095907;39553.20893582127;43655.34516982248;43785.343219851726;43861.78069109658;44328;39527.209455810866;39786;39851.60148398515;40082.19835603286;40088;6876.140482439695;6913.723451061952;6923.099997000383;6936.237013928464;7002.474814388916;6879.415249703781;7026.1217347831525;7034.6482675866255;7053.259407762188;7053.788386348418;6912.412444942186;6936.271691472399;6958.756443524478;6985.3363930426785;7001.719931202746;7391.556506609594;7622.390208783284;7627.923720762777;7684.615769211517;7686.269804368576;7495.700171993114;7577.393808495307;7587.544747315179;7612.657430415645;7648.043994500687;37914.43128353077;38275.425868611994;38310.616893830986;39696.20607587861;40291.395629065584;3494.5806503219524;3514.6309637487952;3517.8065206413635;3525.7708248963736;3543.2204914918934;32948.83525582357;33096.17259568506;33099;33268.50097248543;33377;4573.634109271284;4576.039031803325;4596.149712303235;4630.768461576941;4685.367475390847;189150;192832;192906.03546982317;193260;193285;43440.348394774104;43682.78158609186;44400.555994439645;47701.284480732815;48511.75744121257;50801;51359;51416.48583514117;51634.74182629063;51684.74157629263;15895.364185432685;15991.36034558628;16013.119278439797;16060.357585696675;16060.919695401448;12955;12993.220406775623;13000.804987925188;13128;13176.143550669176;13984.230867302396;14030.649233769238;14169.858301416854;14287.57137285883;14482.855171448151;5621.184928185472;5644.322681278273;5681.687507187062;5801;5819.068948968229;979.5200351827696;995.5619527407918;1014.0771897573173;1014.6803756816579;1039.8232300508932;22996.7700322998;23126.190583329502;23185.3044408668;23376;23455.648165277533;1102.6534467890076;1103.0403548912498;1106.8284415915546;1113.6881673131536;1125.1842414249604;12188.20776649515;12282.692932676577;12306.569270075504;12317.07621928359;12323.568675096329;221515;221515;223969;224112;224267;51940;52303.476965229864;52617.736911315966;52697;52767.208491872654;1382.1845111384332;1410.612081677547;1425.2517428349993;1442.8052212951536;1449.9782503262459;22877.31368058961;22908.198213062464;23159.65260521127;23169.304920852403;23337.533249334578;38230.61769382271;38251.2349753009;38294.2341153181;38361.23277534489;38410.61589384182;194632;194738;197280;198540;199264;31618.209544761565;31619.84190079035;31662;32101.357972839945;34842.82578587091;38318;44196.779016104716;44800.327995079446;44803;45348.77325613351;32070.67929320677;32095.197620059684;32282.515762264055;32462.513062303613;33059.669403305656;31636.683633163375;31863;31906.84046579845;31941.36117277688;32269;35259.29481410409;35619.46570801492;35863.28273434569;35953.280934380644;36034.45948310725;29410.705892940798;29899;29952.25119372033;30302;30329.24176895595;22198.556028879655;22389.32832015042;22505.887470562542;22837.657435138153;22929.31212063641 01:14:02 INFO - PID 13450 | |2;jquery.html;538.8194954690179;554.6671996801916;556.4102051825066;567.8466813960231;568.6360729133355;22251.666225006637;23106.422339441502;23127.537449251005;23140.30579082626;23154.073837046497;23099.538009239805;24360.05119590433;24448.89979950902;24457.143999960004;24553.508929821393;6458.063580780784;6477.74089036438;6494.480441564663;6496.317886621908;6512.772052978146;6369.490440764751;6465.935340646603;6472.029195620671;6473.643949582771;6479.578827376229;6266.905996410058;6442.516811239152;6444.226692796871;6463.095166676646;6545.9018114728315;6475.481961443097;6539.93460065398;6553.410193082622;6567;6567.737290508374;6059.787907423263;6098.32918378978;6098.603590766586;6113.174721412642;6119.082137679339;27447.588286175724;27907.302317442227;28476.145715628565;28552;28566;1995.8403327733747;2018.8586798924082;2032.674772036482;2033.4712974626555;2040.5918816236813;18426.63146737058;18651.906740466347;18679.62640747191;18716.719249211274;18800.965946872915;2307.3885420363617;2361.114582031738;2365.3258821236036;2369.9289021329387;2415.9396015099587;111323.44338278337;117028;127120;132053;132379.33810330983;13859.514916977858;14088.577342679737;14165.504207352693;14495.20276384788;14552.85447145536;22409.10363585471;22444.887775561343;22560.887195564246;22654.433639158822;22675.659865102036;9311.580978855833;9312.953435232781;9394.62421503146;9730.659426920023;9814.263930205263;8441.240288374076;8606.096359882247;8745.868811967826;8795.648174072965;8816.118388161261;8668.566571671518;8841.027486976427;8848.955755221183;9000.23498002664;9056.773580660405;2733.2073698627573;2745.258780129394;2753.6144939708456;2759.089500464882;2810.845403502786;936.1293996583107;959.2421986630484;962.3359881681617;972.6255391674115;975.5073687787622;18575.275935983893;18590.721139182922;18810;18913.621727565373;19073;987.5309228116587;989.9604015839286;994.1798016636304;1011.22135955314;1025.6922923123034;10465.215108866865;10562.20783441245;10589.417582032907;10638.574457021632;10682.1988350874;464951;467697;470153;472859;476216;111507;113462.43268783769;114259;114421;114528.42735786267;1139.863216414019;1163.5229555882217;1176.1472932124314;1176.7822952753768;1180.8996235320094;16235.512934611981;16595.66808663844;16643.91678041602;16719;17198.742018869478;53890.73054634702;54495;54796.72601636966;55225.72387138039;55293.723531382086;67076;67462;67571;67858.3214167852;68497.97253041109;12922.901553368069;13992.790108148183;14010.509632162826;14079.366428510946;14155.858441415454;21427;21707.240246591293;21742.56514869662;21954.89022554877;21970;17442.215100320263;17506.73739893877;17531.649367012844;17569.209385577426;17578.64842703113;14675.559733208021;14981.325840336993;15128.39486420531;15131.713804326755;15325.693486129992;17084.145792710562;17147;17195.22621482011;17300.44296013365;17392.913035434744;13435.798463023259;13446.260455675032;13507.797383039066;13608.591742247749;13743.312834358441;16936.237869295666;16945.406910758556;17345;17356.82643173552;17376.565585860455 01:14:02 INFO - PID 13450 | |3;mootools.html;1302.4139137388174;1361.176488224624;1368.0628769293035;1373.21726615829;1374.051904186112;14847.257637118142;15414.306356213969;15476.69046619067;15513.767293490606;15550;15102.697946041073;15130.6973860523;15148.697026059472;15165.090094594332;15167.544973650809;2677.6385187999663;2798.4263226038615;2801.495730768461;2802.971970280302;2806.789490788199;2676.7055623881356;2768.7784977201777;2791.6510436195476;2797.7202279771964;2798.034678036074;2698.878550465224;2726.61827344172;2727.6044973478834;2742.7120152383914;2760.6963234044238;2736.8905243790223;2738.2469820799242;2786.874590643426;2801.831890086601;2826.3923256499847;2703.540398132322;2707.417905150402;2726.4001919577663;2742.657167854018;2743.876525556355;14382.856171438361;14697.971142020064;14721.705565888622;14730.484433044792;14734.926325368411;7739.883901741478;7995.6801727930815;8052.557109358983;8055.63749631268;8058.717944871902;5140.511651393112;5270.894582108336;5287.524122828964;5343.492368225013;5397.919031214535;1777.2180240694054;1792.6952418088827;1817.273090763692;1830;1847.344192811546;25412.618810717853;26288.211353659422;26302.21093367202;26442.074527391447;26453.73546264532;6999.475039372068;7014.123234595676;7051.612161331073;7206.0271863297785;7219.458540609476;19871.60256794885;19965;19966.600667986848;19976.800231997786;19992.300269490497;8044.4368894178015;8127.471714338549;8267.545285009382;8307.044689860622;8307.584620769057;7229.493935424575;7344.889826652605;7345.632718364167;7429.182789893108;7517.473776835678;5323.547498462596;5583.664980101207;5583.972080139654;5598.188262701886;5601.215829783833;1676.7736355592083;1818.8999605021852;1847.8152184781684;1852.536865783554;1854.1285595769966;725.271102541942;882.2853488674194;885.3979294080087;909.0409617853096;915.8534634458455;8090.959545202354;8210.712625058213;8218.835623287501;8350.123237060021;8361.540115293717;959.8080383923243;976.3214565876648;988.125508924607;996.5764550066193;1003.3377970539409;5093.465186155475;5174.870628234325;5184.196449550326;5278.868028299246;5302.09864323066;20551.691724624143;21368.252111176032;21383.144674212857;21404.892975535022;21416.036278367512;20653.58692826135;20695.482612934495;20868.373948781562;20904.581908361746;21209;10757.246992710592;10824.78350432987;10899.564017439372;10929.071028962628;10940.507677154546;7759.418043646862;7809;7877.881831772643;7884.960575197088;7890.566018869017;17736.645267094846;18193.545161371072;18625.813741862406;18926.716099258796;18937.715934260723;18806.9656168912;18903.243870245034;18963.90518047401;19208.90395548069;19421.4173574793;11823.76352472963;11903.702407439883;11939.940300298444;11944.343061131722;12068.939655301667;13161.341932903508;13165.144265622705;13213.537526186537;13245.536406225736;13252.271125088213;10070.69787906364;10077.445740484343;10109.545070471993;10143.746406339606;10370.429626370622;9901.108900199017;10208.132308753839;10259.897401026194;10262.076413122855;10294.330868493524;8942.239909607497;9117.863232051657;9123.270138389045;9160.267178625827;9171;6881.690323935335;6903.896441553481;6908.654567271717;6920.100386949664;6953.322970656232;6728.966355168192;6808.455323574003;6827.941669041306;6931.930680693128;7009.9649501752165 01:14:02 INFO - PID 13450 | |4;prototype.html;474.5586604457855;514.899594579057;530.075019091685;530.9123994540901;531.3013387395577;6261.3738626137365;6287.59130656507;6304.621722696641;6316.05259211118;6320.598172694381;6202.5968312059795;6213.844653883655;6237.0665093820835;6268.185135932323;6346.682665866711;5109.386873575167;5117.46266642001;5204.479552044803;5223.2165175223645;5236.842894713146;5106.774374150195;5133.640645154841;5161.896762064756;5166.328377310944;5210.739463026853;4762.761861906908;4909.337239472679;5115.769790359443;5118.667286626376;5161.5870730341485;4936.555709986119;4940.7035577865445;4944.851654450372;4949.133901567211;4952.232403977408;4382.583654552813;4406.713563618355;4413.183561041185;4423.203823311803;4454.732716037048;5999.580029397944;6028.547858910555;6085.908711369333;6101.298350689639;6161.933124138048;5688.544916406678;5689.459501347365;5691.857703557403;5717.914231286534;5733.942660573382;6497;6514.185726784152;6584.341565843377;6585.850913924197;6598.406143447113;4859.757012149414;4861.614439884651;4867.172580661296;4884.755762211875;4885.267209918505;6667.499937504706;6797.422219111431;6854.383105520477;6869.210040845317;6889.689963951634;5397.865053373697;5445.833937038169;5454.372747134131;5461.9453805461435;5489.286392768914;5516.393196748354;5532.6680399175375;5533.142362933671;5592.608517403824;5631.267935168484;5919.668074683162;5962;5997.550183736237;6003.429674180946;6007.789727359522;6572;6633.502487313374;6668.666566671647;6687.398134167948;6688.933110668929;1919.42417274817;1933.2556965568358;1941.281725761449;1942;1951.5218771400814;1274.5024596099545;1416.5113036002563;1420.4744244629346;1433.605758416444;1442.170751817709;5720.342160651495;5756;5761.567882408836;5773.364929857712;5806.941930580725;6687.531872768859;6739.258681545124;6766.763163289262;6805.557638753465;6807.489438292049;5721.227634269404;5761.88476230473;5771.336296325892;5784.640609456775;5840.182374467578;3577.2308953575107;3596.2987217492337;3600.225951420457;3601.2353946565995;3611;6492.545521813522;6513.1532900722605;6531.967340163269;6549.410553050248;6556.606603603799;6839.760608378683;6896.7586134485055;6915.4121899638085;6939.514234003571;7007.824804379931;6506.089147519351;6529.379708927644;6537.215534136029;6567.638779867153;6588.8352791180605;6654.502736884356;6659.433948114464;6720.563163394364;6722.394984451423;6736;6559.27847936717;6590.769323073861;6603.702833372414;6620.503462240447;6688.866222675617;6326.070548482757;6359.3147815827915;6392.520560957853;6472.478967442553;6568.770093046721;5363.222332761649;5381.75782089799;5451.754671039892;5463.153211252262;5472.179173124063;6526.314736952551;6611.892410567026;6718.731250750111;6726.159230096238;6730.8653826924165;6428.614283143026;6479.254885688206;6549.672516374258;6590.275069742229;6622.549656627079;6390.562123522171;6424.550281480251;6461.256955449995;6495.642739649175;6516.152900123143;6300.243970723543;6308.842278943063;6318.526110541636;6405.743770249138;6476.31998640136;6428.55000149985;6437.227532696106;6496.350364963655;6499.350064993652;6574.211094668671;6351.681636202845;6354.936450635434;6371.23545174582;6405.135306733531;6412.166418365583 01:14:02 INFO - PID 13450 | |5;yui.html;890.9242714369278;904.5884122724161;908.7455512456512;916.6012784438766;918.6004088221622;17600.559986000357;18197.99999999998;18260.72608910864;18389.816101838976;18580.628387432243;18750.624987500243;18915.337963171292;19032.524186895334;19195;19215.519612009673;967.8161149381613;969.2149359019181;975.4391225045591;979.0307595480459;979.6522234606718;967.4775621164563;981.9607215711399;984.5913945712521;985.5072463768116;986.5807032011367;989.5250279865669;1011.4335971855747;1020.6529779874878;1025.4770067265674;1029.7991891581107;1019.7960407918409;1020.8009438159562;1022.4836457588907;1026.4508487958906;1027.3476342522476;719;732.1360794262768;744.7616762635959;748.7080038784878;750.2834792772943;19741.802581974283;19855.106520206624;19938.60122797536;19990.100445479842;20002.899985500124;20938.37184884456;21101.68347474789;21991.670124947977;22056.44858878525;22194.223202187844;16712.41506547265;16829.990200587883;16849.241784119622;16930;17200.82799172005;3643.3806252937065;3655.4334078217917;3662.359087159763;3671.541057367829;3681.226942342111;103141;134806;138984;144381.99999999895;144692.27653861768;17560.648787024187;17627.735583966252;17629.118544072746;17712.114394280234;17845;31013.534796978063;31421;31504;31565.36869262602;31656.683433165374;7997.800054998555;8056.476329038711;8119.147489513634;8121.147279535682;8135.75592732219;4133.173365326947;4182.811773470201;4183.414321994923;4187.183499217685;4205.201011807747;5494.917576236359;5536.197251398525;5614.971925140429;5620.634658747168;5630.5495560355075;891.3332069030824;905.6649039855296;917.8623206518942;926.592299388267;929.4655573045526;675.9662016899135;695.2144077192739;699.9965000175068;705.1608585782902;710.2506855267742;11379.772404551863;11435.485403156878;11637.952584267456;11923;12409.317487538272;692.0933577014127;694.8188080263471;699.6396855619361;701.3722718167314;711.1395211793684;5187.922181167285;5277.393099793496;5407.594430417735;5465.808696695596;5517.227588137664;118446.40776796233;123132.38433807774;124527.37736311441;125302.37348813197;126438.36780816037;104189;105236;109920;110063;111039;90216;90234.09765902389;91424.54287728519;91437;94281;9835.542550062608;9935.106298272143;10067.89932100699;10141.036601522843;10297.691069267934;43630.34554481749;44703.55296446994;44811.327830083224;45222.77388613036;45548.31677524774;55967.440325596224;58243.70878145582;58741.4125858753;58868;59160.70419647874;15361.078335299917;15474.922625386802;15535.300911459237;15620.140892251035;15668.138252396227;16809.159542023095;16883.493495195165;16952.915235423745;17118.914405427895;17225.56936076608;14555.345009474811;14624.634384140481;14730.63173420673;14803;14905.105693658415;14474.85525144735;14575.198364090076;14578.125312481285;14612;14698.926505367404;15095.622609434413;15316.770248446504;15324.540263792103;15406.075635461908;15433.84566154324;11908.52365905354;11920.76158476843;12167;12311.138220324492;12561.05792065617;11507.654770356903;11623.76752464963;11634.360110193682;11681.357525336189;11803.940980295043 01:14:02 INFO - PID 13450 | __end_tp_report 01:14:02 INFO - PID 13450 | __start_cc_report 01:14:02 INFO - PID 13450 | _x_x_mozilla_cycle_collect,364 01:14:02 INFO - PID 13450 | __end_cc_report 01:14:02 INFO - PID 13450 | __startTimestamp1505376842357__endTimestamp 01:14:02 INFO - PID 13450 | 01:14:02 INFO - PID 13450 | ------- Summary: start ------- 01:14:02 INFO - PID 13450 | Number of tests: 6 01:14:02 INFO - PID 13450 | 01:14:02 INFO - PID 13450 | [#0] dojo.html Cycles:165 Average:6146.52 Median:6360.40 stddev:733.58 (11.5%) stddev-sans-first:696.38 01:14:02 INFO - PID 13450 | Values: 3121.2 3152.4 3159.7 3194.9 3201.7 6079.9 6260.8 6262.7 6372.1 6404.0 6169.5 6173.4 6196.1 6248.2 6255.0 5702.4 5710.1 5715.7 5745.5 5767.7 5696.8 5779.4 5807.2 5809.5 5897.9 5799.3 5820.2 5838.8 5847.5 5889.1 5576.5 5608.6 5631.6 5801.3 5926.7 5658.8 5720.9 5754.8 5805.4 5809.9 6177.8 6191.0 6194.5 6217.6 6308.4 6518.6 6527.2 6584.2 6666.2 6772.0 6698.1 6718.8 6721.7 6736.2 6759.6 6179.4 6273.4 6283.0 6294.7 6317.2 6880.8 6924.0 6939.6 6975.7 6980.6 6378.1 6515.0 6533.6 6550.3 6694.0 6546.0 6596.0 6667.4 6669.4 6671.6 6541.9 6578.4 6580.8 6643.8 6646.9 6728.3 6782.9 6823.6 6825.8 6828.8 5126.0 5167.6 5186.4 5224.0 5271.9 4484.8 4553.8 4556.9 4588.0 4639.9 5682.2 5722.4 5735.1 5765.1 5779.9 6762.3 6802.8 6807.9 6814.0 6835.4 5736.8 5805.7 5871.1 5871.9 5879.3 5802.0 5825.1 5852.6 5875.6 5878.9 6395.6 6512.9 6522.6 6624.9 6651.8 6425.6 6472.6 6517.0 6541.4 6560.7 6219.6 6315.3 6321.7 6357.8 6366.4 6523.7 6579.0 6625.3 6687.0 6713.1 6745.9 6775.7 6785.6 6797.4 6865.1 6376.6 6467.5 6543.5 6551.5 6553.5 6407.4 6415.5 6470.5 6472.2 6487.4 6335.1 6356.3 6399.8 6407.8 6428.1 6561.0 6581.3 6616.6 6619.7 6659.0 6258.5 6290.5 6358.6 6360.4 6372.4 01:14:02 INFO - PID 13450 | 01:14:02 INFO - PID 13450 | [#1] ext.html Cycles:180 Average:37210.36 Median:3521.79 stddev:52996.38 (1504.8%) stddev-sans-first:53074.67 01:14:02 INFO - PID 13450 | Values: 835.9 838.2 880.3 881.2 882.1 39553.2 43655.3 43785.3 43861.8 44328.0 39527.2 39786.0 39851.6 40082.2 40088.0 6876.1 6913.7 6923.1 6936.2 7002.5 6879.4 7026.1 7034.6 7053.3 7053.8 6912.4 6936.3 6958.8 6985.3 7001.7 7391.6 7622.4 7627.9 7684.6 7686.3 7495.7 7577.4 7587.5 7612.7 7648.0 37914.4 38275.4 38310.6 39696.2 40291.4 3494.6 3514.6 3517.8 3525.8 3543.2 32948.8 33096.2 33099.0 33268.5 33377.0 4573.6 4576.0 4596.1 4630.8 4685.4 189150.0 192832.0 192906.0 193260.0 193285.0 43440.3 43682.8 44400.6 47701.3 48511.8 50801.0 51359.0 51416.5 51634.7 51684.7 15895.4 15991.4 16013.1 16060.4 16060.9 12955.0 12993.2 13000.8 13128.0 13176.1 13984.2 14030.6 14169.9 14287.6 14482.9 5621.2 5644.3 5681.7 5801.0 5819.1 979.5 995.6 1014.1 1014.7 1039.8 22996.8 23126.2 23185.3 23376.0 23455.6 1102.7 1103.0 1106.8 1113.7 1125.2 12188.2 12282.7 12306.6 12317.1 12323.6 221515.0 221515.0 223969.0 224112.0 224267.0 51940.0 52303.5 52617.7 52697.0 52767.2 1382.2 1410.6 1425.3 1442.8 1450.0 22877.3 22908.2 23159.7 23169.3 23337.5 38230.6 38251.2 38294.2 38361.2 38410.6 194632.0 194738.0 197280.0 198540.0 199264.0 31618.2 31619.8 31662.0 32101.4 34842.8 38318.0 44196.8 44800.3 44803.0 45348.8 32070.7 32095.2 32282.5 32462.5 33059.7 31636.7 31863.0 31906.8 31941.4 32269.0 35259.3 35619.5 35863.3 35953.3 36034.5 29410.7 29899.0 29952.3 30302.0 30329.2 22198.6 22389.3 22505.9 22837.7 22929.3 01:14:02 INFO - PID 13450 | 01:14:02 INFO - PID 13450 | [#2] jquery.html Cycles:180 Average:33147.36 Median:23116.98 stddev:79066.53 (342.0%) stddev-sans-first:79250.42 01:14:02 INFO - PID 13450 | Values: 538.8 554.7 556.4 567.8 568.6 22251.7 23106.4 23127.5 23140.3 23154.1 23099.5 24360.1 24448.9 24457.1 24553.5 6458.1 6477.7 6494.5 6496.3 6512.8 6369.5 6465.9 6472.0 6473.6 6479.6 6266.9 6442.5 6444.2 6463.1 6545.9 6475.5 6539.9 6553.4 6567.0 6567.7 6059.8 6098.3 6098.6 6113.2 6119.1 27447.6 27907.3 28476.1 28552.0 28566.0 1995.8 2018.9 2032.7 2033.5 2040.6 18426.6 18651.9 18679.6 18716.7 18801.0 2307.4 2361.1 2365.3 2369.9 2415.9 111323.4 117028.0 127120.0 132053.0 132379.3 13859.5 14088.6 14165.5 14495.2 14552.9 22409.1 22444.9 22560.9 22654.4 22675.7 9311.6 9313.0 9394.6 9730.7 9814.3 8441.2 8606.1 8745.9 8795.6 8816.1 8668.6 8841.0 8849.0 9000.2 9056.8 2733.2 2745.3 2753.6 2759.1 2810.8 936.1 959.2 962.3 972.6 975.5 18575.3 18590.7 18810.0 18913.6 19073.0 987.5 990.0 994.2 1011.2 1025.7 10465.2 10562.2 10589.4 10638.6 10682.2 464951.0 467697.0 470153.0 472859.0 476216.0 111507.0 113462.4 114259.0 114421.0 114528.4 1139.9 1163.5 1176.1 1176.8 1180.9 16235.5 16595.7 16643.9 16719.0 17198.7 53890.7 54495.0 54796.7 55225.7 55293.7 67076.0 67462.0 67571.0 67858.3 68498.0 12922.9 13992.8 14010.5 14079.4 14155.9 21427.0 21707.2 21742.6 21954.9 21970.0 17442.2 17506.7 17531.6 17569.2 17578.6 14675.6 14981.3 15128.4 15131.7 15325.7 17084.1 17147.0 17195.2 17300.4 17392.9 13435.8 13446.3 13507.8 13608.6 13743.3 16936.2 16945.4 17345.0 17356.8 17376.6 01:14:02 INFO - PID 13450 | 01:14:02 INFO - PID 13450 | [#3] mootools.html Cycles:180 Average:9265.28 Median:2726.51 stddev:6651.07 (243.9%) stddev-sans-first:6642.82 01:14:02 INFO - PID 13450 | Values: 1302.4 1361.2 1368.1 1373.2 1374.1 14847.3 15414.3 15476.7 15513.8 15550.0 15102.7 15130.7 15148.7 15165.1 15167.5 2677.6 2798.4 2801.5 2803.0 2806.8 2676.7 2768.8 2791.7 2797.7 2798.0 2698.9 2726.6 2727.6 2742.7 2760.7 2736.9 2738.2 2786.9 2801.8 2826.4 2703.5 2707.4 2726.4 2742.7 2743.9 14382.9 14698.0 14721.7 14730.5 14734.9 7739.9 7995.7 8052.6 8055.6 8058.7 5140.5 5270.9 5287.5 5343.5 5397.9 1777.2 1792.7 1817.3 1830.0 1847.3 25412.6 26288.2 26302.2 26442.1 26453.7 6999.5 7014.1 7051.6 7206.0 7219.5 19871.6 19965.0 19966.6 19976.8 19992.3 8044.4 8127.5 8267.5 8307.0 8307.6 7229.5 7344.9 7345.6 7429.2 7517.5 5323.5 5583.7 5584.0 5598.2 5601.2 1676.8 1818.9 1847.8 1852.5 1854.1 725.3 882.3 885.4 909.0 915.9 8091.0 8210.7 8218.8 8350.1 8361.5 959.8 976.3 988.1 996.6 1003.3 5093.5 5174.9 5184.2 5278.9 5302.1 20551.7 21368.3 21383.1 21404.9 21416.0 20653.6 20695.5 20868.4 20904.6 21209.0 10757.2 10824.8 10899.6 10929.1 10940.5 7759.4 7809.0 7877.9 7885.0 7890.6 17736.6 18193.5 18625.8 18926.7 18937.7 18807.0 18903.2 18963.9 19208.9 19421.4 11823.8 11903.7 11939.9 11944.3 12068.9 13161.3 13165.1 13213.5 13245.5 13252.3 10070.7 10077.4 10109.5 10143.7 10370.4 9901.1 10208.1 10259.9 10262.1 10294.3 8942.2 9117.9 9123.3 9160.3 9171.0 6881.7 6903.9 6908.7 6920.1 6953.3 6729.0 6808.5 6827.9 6931.9 7010.0 01:14:02 INFO - PID 13450 | 01:14:02 INFO - PID 13450 | [#4] prototype.html Cycles:180 Average:5575.29 Median:6208.22 stddev:1508.42 (24.3%) stddev-sans-first:1463.26 01:14:02 INFO - PID 13450 | Values: 474.6 514.9 530.1 530.9 531.3 6261.4 6287.6 6304.6 6316.1 6320.6 6202.6 6213.8 6237.1 6268.2 6346.7 5109.4 5117.5 5204.5 5223.2 5236.8 5106.8 5133.6 5161.9 5166.3 5210.7 4762.8 4909.3 5115.8 5118.7 5161.6 4936.6 4940.7 4944.9 4949.1 4952.2 4382.6 4406.7 4413.2 4423.2 4454.7 5999.6 6028.5 6085.9 6101.3 6161.9 5688.5 5689.5 5691.9 5717.9 5733.9 6497.0 6514.2 6584.3 6585.9 6598.4 4859.8 4861.6 4867.2 4884.8 4885.3 6667.5 6797.4 6854.4 6869.2 6889.7 5397.9 5445.8 5454.4 5461.9 5489.3 5516.4 5532.7 5533.1 5592.6 5631.3 5919.7 5962.0 5997.6 6003.4 6007.8 6572.0 6633.5 6668.7 6687.4 6688.9 1919.4 1933.3 1941.3 1942.0 1951.5 1274.5 1416.5 1420.5 1433.6 1442.2 5720.3 5756.0 5761.6 5773.4 5806.9 6687.5 6739.3 6766.8 6805.6 6807.5 5721.2 5761.9 5771.3 5784.6 5840.2 3577.2 3596.3 3600.2 3601.2 3611.0 6492.5 6513.2 6532.0 6549.4 6556.6 6839.8 6896.8 6915.4 6939.5 7007.8 6506.1 6529.4 6537.2 6567.6 6588.8 6654.5 6659.4 6720.6 6722.4 6736.0 6559.3 6590.8 6603.7 6620.5 6688.9 6326.1 6359.3 6392.5 6472.5 6568.8 5363.2 5381.8 5451.8 5463.2 5472.2 6526.3 6611.9 6718.7 6726.2 6730.9 6428.6 6479.3 6549.7 6590.3 6622.5 6390.6 6424.6 6461.3 6495.6 6516.2 6300.2 6308.8 6318.5 6405.7 6476.3 6428.6 6437.2 6496.4 6499.4 6574.2 6351.7 6354.9 6371.2 6405.1 6412.2 01:14:02 INFO - PID 13450 | 01:14:02 INFO - PID 13450 | [#5] yui.html Cycles:180 Average:23938.41 Median:19996.50 stddev:34705.02 (173.6%) stddev-sans-first:34759.22 01:14:02 INFO - PID 13450 | Values: 890.9 904.6 908.7 916.6 918.6 17600.6 18198.0 18260.7 18389.8 18580.6 18750.6 18915.3 19032.5 19195.0 19215.5 967.8 969.2 975.4 979.0 979.7 967.5 982.0 984.6 985.5 986.6 989.5 1011.4 1020.7 1025.5 1029.8 1019.8 1020.8 1022.5 1026.5 1027.3 719.0 732.1 744.8 748.7 750.3 19741.8 19855.1 19938.6 19990.1 20002.9 20938.4 21101.7 21991.7 22056.4 22194.2 16712.4 16830.0 16849.2 16930.0 17200.8 3643.4 3655.4 3662.4 3671.5 3681.2 103141.0 134806.0 138984.0 144382.0 144692.3 17560.6 17627.7 17629.1 17712.1 17845.0 31013.5 31421.0 31504.0 31565.4 31656.7 7997.8 8056.5 8119.1 8121.1 8135.8 4133.2 4182.8 4183.4 4187.2 4205.2 5494.9 5536.2 5615.0 5620.6 5630.5 891.3 905.7 917.9 926.6 929.5 676.0 695.2 700.0 705.2 710.3 11379.8 11435.5 11638.0 11923.0 12409.3 692.1 694.8 699.6 701.4 711.1 5187.9 5277.4 5407.6 5465.8 5517.2 118446.4 123132.4 124527.4 125302.4 126438.4 104189.0 105236.0 109920.0 110063.0 111039.0 90216.0 90234.1 91424.5 91437.0 94281.0 9835.5 9935.1 10067.9 10141.0 10297.7 43630.3 44703.6 44811.3 45222.8 45548.3 55967.4 58243.7 58741.4 58868.0 59160.7 15361.1 15474.9 15535.3 15620.1 15668.1 16809.2 16883.5 16952.9 17118.9 17225.6 14555.3 14624.6 14730.6 14803.0 14905.1 14474.9 14575.2 14578.1 14612.0 14698.9 15095.6 15316.8 15324.5 15406.1 15433.8 11908.5 11920.8 12167.0 12311.1 12561.1 11507.7 11623.8 11634.4 11681.4 11803.9 01:14:02 INFO - PID 13450 | -------- Summary: end -------- 01:14:02 INFO - PID 13450 | 01:14:03 INFO - TEST-INFO | 13450: exit 0 01:14:03 INFO - TEST-OK | dromaeo_css | took 1113621ms 01:14:03 INFO - TEST-START | kraken 01:14:03 INFO - Initialising browser for kraken test... 01:14:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46937/getInfo.html -profile /tmp/tmpxJZt0W/profile 01:14:03 INFO - TEST-INFO | started process 13834 (/builds/slave/test/build/application/firefox/firefox http://localhost:46937/getInfo.html) 01:14:09 INFO - TEST-INFO | 13834: exit 0 01:14:09 INFO - Browser initialized. 01:14:09 INFO - Running cycle 1/1 for kraken test... 01:14:09 INFO - Using env: {'DISPLAY': ':0', 01:14:09 INFO - 'HOME': '/home/cltbld', 01:14:09 INFO - 'JSGC_DISABLE_POISONING': '1', 01:14:09 INFO - 'LANG': 'en_US.UTF-8', 01:14:09 INFO - 'LANGUAGE': 'en_US:en', 01:14:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 01:14:09 INFO - 'LOGNAME': 'cltbld', 01:14:09 INFO - 'MAIL': '/var/mail/cltbld', 01:14:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:14:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:14:09 INFO - 'MOZ_ACCELERATED': '1', 01:14:09 INFO - 'MOZ_CRASHREPORTER': '1', 01:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 01:14:09 INFO - 'MOZ_NO_REMOTE': '1', 01:14:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:14:09 INFO - 'MOZ_WEBRENDER': '1', 01:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:09 INFO - 'NO_EM_RESTART': '1', 01:14:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:09 INFO - 'PWD': '/builds/slave/test', 01:14:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:14:09 INFO - 'RUST_BACKTRACE': 'full', 01:14:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:14:09 INFO - 'SHELL': '/bin/bash', 01:14:09 INFO - 'SHLVL': '1', 01:14:09 INFO - 'TERM': 'linux', 01:14:09 INFO - 'TMOUT': '86400', 01:14:09 INFO - 'USER': 'cltbld', 01:14:09 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877', 01:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:09 INFO - '_': '/tools/buildbot/bin/python'} 01:14:09 INFO - TEST-INFO | started process 14083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxJZt0W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:14:10 INFO - PID 14083 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 01:14:10 INFO - PID 14083 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 01:14:10 INFO - PID 14083 | 01:14:10 INFO - PID 14083 | (/builds/slave/test/build/application/firefox/firefox:14145): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 01:14:10 INFO - PID 14083 | 01:14:21 INFO - PID 14083 | RSS: Main: 194129920 01:14:21 INFO - PID 14083 | 01:14:23 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46937/tests/kraken/driver.html?testName=audio-beat-detection) 01:14:24 INFO - PID 14083 | RSS: Main: 199892992 01:14:24 INFO - PID 14083 | 01:14:27 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46937/tests/kraken/driver.html?testName=audio-dft) 01:14:28 INFO - PID 14083 | RSS: Main: 200556544 01:14:28 INFO - PID 14083 | 01:14:31 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46937/tests/kraken/driver.html?testName=audio-fft) 01:14:31 INFO - PID 14083 | RSS: Main: 196591616 01:14:31 INFO - PID 14083 | 01:14:34 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46937/tests/kraken/driver.html?testName=audio-oscillator) 01:14:34 INFO - PID 14083 | RSS: Main: 197627904 01:14:34 INFO - PID 14083 | 01:14:37 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46937/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:14:37 INFO - PID 14083 | RSS: Main: 197115904 01:14:37 INFO - PID 14083 | 01:14:41 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46937/tests/kraken/driver.html?testName=imaging-darkroom) 01:14:41 INFO - PID 14083 | RSS: Main: 200306688 01:14:41 INFO - PID 14083 | 01:14:45 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46937/tests/kraken/driver.html?testName=imaging-desaturate) 01:14:45 INFO - PID 14083 | RSS: Main: 198922240 01:14:45 INFO - PID 14083 | 01:14:49 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46937/tests/kraken/driver.html?testName=json-parse-financial) 01:14:49 INFO - PID 14083 | RSS: Main: 199053312 01:14:49 INFO - PID 14083 | 01:14:51 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46937/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:14:51 INFO - PID 14083 | RSS: Main: 200237056 01:14:51 INFO - PID 14083 | 01:14:53 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46937/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:14:54 INFO - PID 14083 | RSS: Main: 199925760 01:14:54 INFO - PID 14083 | 01:14:56 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46937/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:14:57 INFO - PID 14083 | RSS: Main: 199524352 01:14:57 INFO - PID 14083 | 01:14:59 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:15:00 INFO - PID 14083 | RSS: Main: 200597504 01:15:00 INFO - PID 14083 | 01:15:03 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:15:04 INFO - PID 14083 | RSS: Main: 200790016 01:15:04 INFO - PID 14083 | 01:15:05 INFO - PID 14083 | Cycle 1(1): loaded http://localhost:46937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46937/tests/kraken/driver.html?testName=ai-astar) 01:15:06 INFO - PID 14083 | RSS: Main: 202354688 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | __start_tp_report 01:15:06 INFO - PID 14083 | _x_x_mozilla_page_load 01:15:06 INFO - PID 14083 | _x_x_mozilla_page_load_details 01:15:06 INFO - PID 14083 | |i|pagename|runs| 01:15:06 INFO - PID 14083 | |0;ai-astar;116;115;113;109;111;108;114;115;109;113 01:15:06 INFO - PID 14083 | |1;audio-beat-detection;118;115;120;122;144;115;121;118;127;148 01:15:06 INFO - PID 14083 | |2;audio-dft;167;169;166;169;167;169;173;169;164;164 01:15:06 INFO - PID 14083 | |3;audio-fft;76;76;84;91;78;76;81;84;78;77 01:15:06 INFO - PID 14083 | |4;audio-oscillator;82;83;85;89;84;90;85;82;136;80 01:15:06 INFO - PID 14083 | |5;imaging-gaussian-blur;121;120;115;115;116;115;123;114;116;116 01:15:06 INFO - PID 14083 | |6;imaging-darkroom;148;148;151;148;154;148;149;153;155;150 01:15:06 INFO - PID 14083 | |7;imaging-desaturate;95;99;96;94;94;106;100;94;95;95 01:15:06 INFO - PID 14083 | |8;json-parse-financial;53;64;62;54;54;55;54;55;61;53 01:15:06 INFO - PID 14083 | |9;json-stringify-tinderbox;45;38;39;43;41;43;44;39;43;45 01:15:06 INFO - PID 14083 | |10;stanford-crypto-aes;76;75;76;78;75;82;73;81;72;80 01:15:06 INFO - PID 14083 | |11;stanford-crypto-ccm;113;114;121;127;120;117;125;120;121;123 01:15:06 INFO - PID 14083 | |12;stanford-crypto-pbkdf2;169;168;177;169;167;179;173;174;168;171 01:15:06 INFO - PID 14083 | |13;stanford-crypto-sha256-iterative;67;65;67;65;65;67;69;64;68;73 01:15:06 INFO - PID 14083 | __end_tp_report 01:15:06 INFO - PID 14083 | __start_cc_report 01:15:06 INFO - PID 14083 | _x_x_mozilla_cycle_collect,947 01:15:06 INFO - PID 14083 | __end_cc_report 01:15:06 INFO - PID 14083 | __startTimestamp1505376906191__endTimestamp 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | ------- Summary: start ------- 01:15:06 INFO - PID 14083 | Number of tests: 14 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:2.87 (2.5%) stddev-sans-first:2.71 01:15:06 INFO - PID 14083 | Values: 116.0 115.0 113.0 109.0 111.0 108.0 114.0 115.0 109.0 113.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:121.50 stddev:11.75 (9.7%) stddev-sans-first:12.20 01:15:06 INFO - PID 14083 | Values: 118.0 115.0 120.0 122.0 144.0 115.0 121.0 118.0 127.0 148.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#2] audio-dft Cycles:10 Average:167.70 Median:169.00 stddev:2.71 (1.6%) stddev-sans-first:2.86 01:15:06 INFO - PID 14083 | Values: 167.0 169.0 166.0 169.0 167.0 169.0 173.0 169.0 164.0 164.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#3] audio-fft Cycles:10 Average:80.10 Median:79.50 stddev:4.93 (6.2%) stddev-sans-first:5.00 01:15:06 INFO - PID 14083 | Values: 76.0 76.0 84.0 91.0 78.0 76.0 81.0 84.0 78.0 77.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:84.50 stddev:16.59 (19.6%) stddev-sans-first:17.37 01:15:06 INFO - PID 14083 | Values: 82.0 83.0 85.0 89.0 84.0 90.0 85.0 82.0 136.0 80.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:116.00 stddev:3.07 (2.6%) stddev-sans-first:2.92 01:15:06 INFO - PID 14083 | Values: 121.0 120.0 115.0 115.0 116.0 115.0 123.0 114.0 116.0 116.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:2.72 (1.8%) stddev-sans-first:2.74 01:15:06 INFO - PID 14083 | Values: 148.0 148.0 151.0 148.0 154.0 148.0 149.0 153.0 155.0 150.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:95.00 stddev:3.85 (4.1%) stddev-sans-first:4.03 01:15:06 INFO - PID 14083 | Values: 95.0 99.0 96.0 94.0 94.0 106.0 100.0 94.0 95.0 95.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:55.00 stddev:4.14 (7.5%) stddev-sans-first:4.20 01:15:06 INFO - PID 14083 | Values: 53.0 64.0 62.0 54.0 54.0 55.0 54.0 55.0 61.0 53.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#9] json-stringify-tinderbox Cycles:10 Average:42.00 Median:43.00 stddev:2.58 (6.0%) stddev-sans-first:2.50 01:15:06 INFO - PID 14083 | Values: 45.0 38.0 39.0 43.0 41.0 43.0 44.0 39.0 43.0 45.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:77.00 stddev:3.36 (4.4%) stddev-sans-first:3.55 01:15:06 INFO - PID 14083 | Values: 76.0 75.0 76.0 78.0 75.0 82.0 73.0 81.0 72.0 80.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:121.00 stddev:4.46 (3.7%) stddev-sans-first:3.92 01:15:06 INFO - PID 14083 | Values: 113.0 114.0 121.0 127.0 120.0 117.0 125.0 120.0 121.0 123.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:172.00 stddev:4.12 (2.4%) stddev-sans-first:4.27 01:15:06 INFO - PID 14083 | Values: 169.0 168.0 177.0 169.0 167.0 179.0 173.0 174.0 168.0 171.0 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:2.62 (3.9%) stddev-sans-first:2.78 01:15:06 INFO - PID 14083 | Values: 67.0 65.0 67.0 65.0 65.0 67.0 69.0 64.0 68.0 73.0 01:15:06 INFO - PID 14083 | -------- Summary: end -------- 01:15:06 INFO - PID 14083 | 01:15:06 INFO - PID 14083 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 01:15:07 INFO - TEST-INFO | 14083: exit 0 01:15:07 INFO - TEST-OK | kraken | took 63756ms 01:15:07 INFO - SUITE-END | took 1177s 01:15:07 INFO - Completed test suite (00:19:37) 01:15:07 INFO - javascript benchmark 01:15:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8418.874362650877, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.204092956296, 3152.416802891465, 3159.6524382317957, 3194.8562314695837, 3201.663825298342, 6079.908801367983, 6260.7808726694575, 6262.686865656716, 6372.139761132252, 6404.0, 6169.506439484841, 6173.413525715061, 6196.101565273033, 6248.15649887265, 6255.030470277103, 5702.4012478689765, 5710.086386178213, 5715.657060576368, 5745.5116315113055, 5767.653940763567, 5696.800611978581, 5779.422057794208, 5807.1579620954935, 5809.477147056764, 5897.941020589804, 5799.333076696171, 5820.185174075633, 5838.824835254949, 5847.473727364536, 5889.057750759879, 5576.525995290405, 5608.551315894719, 5631.63394379364, 5801.30384353876, 5926.674032928187, 5658.773649054033, 5720.914186287209, 5754.762726013885, 5805.36141024487, 5809.941900580982, 6177.7837775677635, 6190.969045154746, 6194.5044396448175, 6217.595856269328, 6308.432241098323, 6518.608883467007, 6527.184101987252, 6584.209894812605, 6666.200055993312, 6772.0, 6698.095757072781, 6718.798436046877, 6721.6975236114495, 6736.225334086594, 6759.5606285591275, 6179.3820617937845, 6273.435390814803, 6282.968585157045, 6294.685265736741, 6317.210348706411, 6880.827979300458, 6924.0, 6939.618320992293, 6975.651217439107, 6980.616066116311, 6378.075179099097, 6515.0, 6533.575317604341, 6550.344965503412, 6694.0, 6545.967270163619, 6596.0, 6667.399934005963, 6669.399754022064, 6671.566348187353, 6541.8691626168165, 6578.407943285128, 6580.8354791130605, 6643.800685979331, 6646.933530664632, 6728.3271672832325, 6782.864342713118, 6823.590584564942, 6825.761098361533, 6828.829279267959, 5125.974370128126, 5167.58659307262, 5186.351706036746, 5223.973880130651, 5271.868203294872, 4484.843030493982, 4553.793997407544, 4556.863294101182, 4587.954120458753, 4639.930401043987, 5682.204491371212, 5722.4277572242445, 5735.139729040678, 5765.07758758605, 5779.942200578024, 6762.289959554274, 6802.795916122524, 6807.9319206807295, 6814.0, 6835.4189893859575, 5736.799212027559, 5805.7387417566315, 5871.148683440877, 5871.941280587225, 5879.265091863517, 5802.0, 5825.0679891217205, 5852.590318677737, 5875.618084824473, 5878.882422351529, 6395.6482393468805, 6512.869742605121, 6522.608643481311, 6624.900626490607, 6651.800445986628, 6425.614463132227, 6472.611643301417, 6517.0, 6541.411272985454, 6560.671966401565, 6219.595726277777, 6315.336889626523, 6321.747130114744, 6357.841053973688, 6366.427021568081, 6523.739050438119, 6579.013148027834, 6625.337466253336, 6687.0, 6713.060171575886, 6745.865082698417, 6775.728970841111, 6785.626790526371, 6797.422219111431, 6865.141857267841, 6376.585521941059, 6467.514936379696, 6543.5419520633095, 6551.50863685216, 6553.541252112306, 6407.391297826699, 6415.486761059197, 6470.450011749054, 6472.223333200046, 6487.351264873475, 6335.1130841683125, 6356.3325850785, 6399.8080057598345, 6407.807765767035, 6428.132202152837, 6561.048647946117, 6581.276059633532, 6616.569922954993, 6619.702113405005, 6658.966705166443, 6258.499320054294, 6290.528210384331, 6358.618482891041, 6360.395762402564, 6372.426481616677], "value": 6091.085205868462, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.9373047021468, 838.1785849867131, 880.2781718990423, 881.2333270055053, 882.1443200095907, 39553.20893582127, 43655.34516982248, 43785.343219851726, 43861.78069109658, 44328.0, 39527.209455810866, 39786.0, 39851.60148398515, 40082.19835603286, 40088.0, 6876.140482439695, 6913.723451061952, 6923.099997000383, 6936.237013928464, 7002.474814388916, 6879.415249703781, 7026.1217347831525, 7034.6482675866255, 7053.259407762188, 7053.788386348418, 6912.412444942186, 6936.271691472399, 6958.756443524478, 6985.3363930426785, 7001.719931202746, 7391.556506609594, 7622.390208783284, 7627.923720762777, 7684.615769211517, 7686.269804368576, 7495.700171993114, 7577.393808495307, 7587.544747315179, 7612.657430415645, 7648.043994500687, 37914.43128353077, 38275.425868611994, 38310.616893830986, 39696.20607587861, 40291.395629065584, 3494.5806503219524, 3514.6309637487952, 3517.8065206413635, 3525.7708248963736, 3543.2204914918934, 32948.83525582357, 33096.17259568506, 33099.0, 33268.50097248543, 33377.0, 4573.634109271284, 4576.039031803325, 4596.149712303235, 4630.768461576941, 4685.367475390847, 189150.0, 192832.0, 192906.03546982317, 193260.0, 193285.0, 43440.348394774104, 43682.78158609186, 44400.555994439645, 47701.284480732815, 48511.75744121257, 50801.0, 51359.0, 51416.48583514117, 51634.74182629063, 51684.74157629263, 15895.364185432685, 15991.36034558628, 16013.119278439797, 16060.357585696675, 16060.919695401448, 12955.0, 12993.220406775623, 13000.804987925188, 13128.0, 13176.143550669176, 13984.230867302396, 14030.649233769238, 14169.858301416854, 14287.57137285883, 14482.855171448151, 5621.184928185472, 5644.322681278273, 5681.687507187062, 5801.0, 5819.068948968229, 979.5200351827696, 995.5619527407918, 1014.0771897573173, 1014.6803756816579, 1039.8232300508932, 22996.7700322998, 23126.190583329502, 23185.3044408668, 23376.0, 23455.648165277533, 1102.6534467890076, 1103.0403548912498, 1106.8284415915546, 1113.6881673131536, 1125.1842414249604, 12188.20776649515, 12282.692932676577, 12306.569270075504, 12317.07621928359, 12323.568675096329, 221515.0, 221515.0, 223969.0, 224112.0, 224267.0, 51940.0, 52303.476965229864, 52617.736911315966, 52697.0, 52767.208491872654, 1382.1845111384332, 1410.612081677547, 1425.2517428349993, 1442.8052212951536, 1449.9782503262459, 22877.31368058961, 22908.198213062464, 23159.65260521127, 23169.304920852403, 23337.533249334578, 38230.61769382271, 38251.2349753009, 38294.2341153181, 38361.23277534489, 38410.61589384182, 194632.0, 194738.0, 197280.0, 198540.0, 199264.0, 31618.209544761565, 31619.84190079035, 31662.0, 32101.357972839945, 34842.82578587091, 38318.0, 44196.779016104716, 44800.327995079446, 44803.0, 45348.77325613351, 32070.67929320677, 32095.197620059684, 32282.515762264055, 32462.513062303613, 33059.669403305656, 31636.683633163375, 31863.0, 31906.84046579845, 31941.36117277688, 32269.0, 35259.29481410409, 35619.46570801492, 35863.28273434569, 35953.280934380644, 36034.45948310725, 29410.705892940798, 29899.0, 29952.25119372033, 30302.0, 30329.24176895595, 22198.556028879655, 22389.32832015042, 22505.887470562542, 22837.657435138153, 22929.31212063641], "value": 16872.673084083806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.8194954690179, 554.6671996801916, 556.4102051825066, 567.8466813960231, 568.6360729133355, 22251.666225006637, 23106.422339441502, 23127.537449251005, 23140.30579082626, 23154.073837046497, 23099.538009239805, 24360.05119590433, 24448.89979950902, 24457.143999960004, 24553.508929821393, 6458.063580780784, 6477.74089036438, 6494.480441564663, 6496.317886621908, 6512.772052978146, 6369.490440764751, 6465.935340646603, 6472.029195620671, 6473.643949582771, 6479.578827376229, 6266.905996410058, 6442.516811239152, 6444.226692796871, 6463.095166676646, 6545.9018114728315, 6475.481961443097, 6539.93460065398, 6553.410193082622, 6567.0, 6567.737290508374, 6059.787907423263, 6098.32918378978, 6098.603590766586, 6113.174721412642, 6119.082137679339, 27447.588286175724, 27907.302317442227, 28476.145715628565, 28552.0, 28566.0, 1995.8403327733747, 2018.8586798924082, 2032.674772036482, 2033.4712974626555, 2040.5918816236813, 18426.63146737058, 18651.906740466347, 18679.62640747191, 18716.719249211274, 18800.965946872915, 2307.3885420363617, 2361.114582031738, 2365.3258821236036, 2369.9289021329387, 2415.9396015099587, 111323.44338278337, 117028.0, 127120.0, 132053.0, 132379.33810330983, 13859.514916977858, 14088.577342679737, 14165.504207352693, 14495.20276384788, 14552.85447145536, 22409.10363585471, 22444.887775561343, 22560.887195564246, 22654.433639158822, 22675.659865102036, 9311.580978855833, 9312.953435232781, 9394.62421503146, 9730.659426920023, 9814.263930205263, 8441.240288374076, 8606.096359882247, 8745.868811967826, 8795.648174072965, 8816.118388161261, 8668.566571671518, 8841.027486976427, 8848.955755221183, 9000.23498002664, 9056.773580660405, 2733.2073698627573, 2745.258780129394, 2753.6144939708456, 2759.089500464882, 2810.845403502786, 936.1293996583107, 959.2421986630484, 962.3359881681617, 972.6255391674115, 975.5073687787622, 18575.275935983893, 18590.721139182922, 18810.0, 18913.621727565373, 19073.0, 987.5309228116587, 989.9604015839286, 994.1798016636304, 1011.22135955314, 1025.6922923123034, 10465.215108866865, 10562.20783441245, 10589.417582032907, 10638.574457021632, 10682.1988350874, 464951.0, 467697.0, 470153.0, 472859.0, 476216.0, 111507.0, 113462.43268783769, 114259.0, 114421.0, 114528.42735786267, 1139.863216414019, 1163.5229555882217, 1176.1472932124314, 1176.7822952753768, 1180.8996235320094, 16235.512934611981, 16595.66808663844, 16643.91678041602, 16719.0, 17198.742018869478, 53890.73054634702, 54495.0, 54796.72601636966, 55225.72387138039, 55293.723531382086, 67076.0, 67462.0, 67571.0, 67858.3214167852, 68497.97253041109, 12922.901553368069, 13992.790108148183, 14010.509632162826, 14079.366428510946, 14155.858441415454, 21427.0, 21707.240246591293, 21742.56514869662, 21954.89022554877, 21970.0, 17442.215100320263, 17506.73739893877, 17531.649367012844, 17569.209385577426, 17578.64842703113, 14675.559733208021, 14981.325840336993, 15128.39486420531, 15131.713804326755, 15325.693486129992, 17084.145792710562, 17147.0, 17195.22621482011, 17300.44296013365, 17392.913035434744, 13435.798463023259, 13446.260455675032, 13507.797383039066, 13608.591742247749, 13743.312834358441, 16936.237869295666, 16945.406910758556, 17345.0, 17356.82643173552, 17376.565585860455], "value": 11512.566138552509, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.4139137388174, 1361.176488224624, 1368.0628769293035, 1373.21726615829, 1374.051904186112, 14847.257637118142, 15414.306356213969, 15476.69046619067, 15513.767293490606, 15550.0, 15102.697946041073, 15130.6973860523, 15148.697026059472, 15165.090094594332, 15167.544973650809, 2677.6385187999663, 2798.4263226038615, 2801.495730768461, 2802.971970280302, 2806.789490788199, 2676.7055623881356, 2768.7784977201777, 2791.6510436195476, 2797.7202279771964, 2798.034678036074, 2698.878550465224, 2726.61827344172, 2727.6044973478834, 2742.7120152383914, 2760.6963234044238, 2736.8905243790223, 2738.2469820799242, 2786.874590643426, 2801.831890086601, 2826.3923256499847, 2703.540398132322, 2707.417905150402, 2726.4001919577663, 2742.657167854018, 2743.876525556355, 14382.856171438361, 14697.971142020064, 14721.705565888622, 14730.484433044792, 14734.926325368411, 7739.883901741478, 7995.6801727930815, 8052.557109358983, 8055.63749631268, 8058.717944871902, 5140.511651393112, 5270.894582108336, 5287.524122828964, 5343.492368225013, 5397.919031214535, 1777.2180240694054, 1792.6952418088827, 1817.273090763692, 1830.0, 1847.344192811546, 25412.618810717853, 26288.211353659422, 26302.21093367202, 26442.074527391447, 26453.73546264532, 6999.475039372068, 7014.123234595676, 7051.612161331073, 7206.0271863297785, 7219.458540609476, 19871.60256794885, 19965.0, 19966.600667986848, 19976.800231997786, 19992.300269490497, 8044.4368894178015, 8127.471714338549, 8267.545285009382, 8307.044689860622, 8307.584620769057, 7229.493935424575, 7344.889826652605, 7345.632718364167, 7429.182789893108, 7517.473776835678, 5323.547498462596, 5583.664980101207, 5583.972080139654, 5598.188262701886, 5601.215829783833, 1676.7736355592083, 1818.8999605021852, 1847.8152184781684, 1852.536865783554, 1854.1285595769966, 725.271102541942, 882.2853488674194, 885.3979294080087, 909.0409617853096, 915.8534634458455, 8090.959545202354, 8210.712625058213, 8218.835623287501, 8350.123237060021, 8361.540115293717, 959.8080383923243, 976.3214565876648, 988.125508924607, 996.5764550066193, 1003.3377970539409, 5093.465186155475, 5174.870628234325, 5184.196449550326, 5278.868028299246, 5302.09864323066, 20551.691724624143, 21368.252111176032, 21383.144674212857, 21404.892975535022, 21416.036278367512, 20653.58692826135, 20695.482612934495, 20868.373948781562, 20904.581908361746, 21209.0, 10757.246992710592, 10824.78350432987, 10899.564017439372, 10929.071028962628, 10940.507677154546, 7759.418043646862, 7809.0, 7877.881831772643, 7884.960575197088, 7890.566018869017, 17736.645267094846, 18193.545161371072, 18625.813741862406, 18926.716099258796, 18937.715934260723, 18806.9656168912, 18903.243870245034, 18963.90518047401, 19208.90395548069, 19421.4173574793, 11823.76352472963, 11903.702407439883, 11939.940300298444, 11944.343061131722, 12068.939655301667, 13161.341932903508, 13165.144265622705, 13213.537526186537, 13245.536406225736, 13252.271125088213, 10070.69787906364, 10077.445740484343, 10109.545070471993, 10143.746406339606, 10370.429626370622, 9901.108900199017, 10208.132308753839, 10259.897401026194, 10262.076413122855, 10294.330868493524, 8942.239909607497, 9117.863232051657, 9123.270138389045, 9160.267178625827, 9171.0, 6881.690323935335, 6903.896441553481, 6908.654567271717, 6920.100386949664, 6953.322970656232, 6728.966355168192, 6808.455323574003, 6827.941669041306, 6931.930680693128, 7009.9649501752165], "value": 6656.643155553201, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.5586604457855, 514.899594579057, 530.075019091685, 530.9123994540901, 531.3013387395577, 6261.3738626137365, 6287.59130656507, 6304.621722696641, 6316.05259211118, 6320.598172694381, 6202.5968312059795, 6213.844653883655, 6237.0665093820835, 6268.185135932323, 6346.682665866711, 5109.386873575167, 5117.46266642001, 5204.479552044803, 5223.2165175223645, 5236.842894713146, 5106.774374150195, 5133.640645154841, 5161.896762064756, 5166.328377310944, 5210.739463026853, 4762.761861906908, 4909.337239472679, 5115.769790359443, 5118.667286626376, 5161.5870730341485, 4936.555709986119, 4940.7035577865445, 4944.851654450372, 4949.133901567211, 4952.232403977408, 4382.583654552813, 4406.713563618355, 4413.183561041185, 4423.203823311803, 4454.732716037048, 5999.580029397944, 6028.547858910555, 6085.908711369333, 6101.298350689639, 6161.933124138048, 5688.544916406678, 5689.459501347365, 5691.857703557403, 5717.914231286534, 5733.942660573382, 6497.0, 6514.185726784152, 6584.341565843377, 6585.850913924197, 6598.406143447113, 4859.757012149414, 4861.614439884651, 4867.172580661296, 4884.755762211875, 4885.267209918505, 6667.499937504706, 6797.422219111431, 6854.383105520477, 6869.210040845317, 6889.689963951634, 5397.865053373697, 5445.833937038169, 5454.372747134131, 5461.9453805461435, 5489.286392768914, 5516.393196748354, 5532.6680399175375, 5533.142362933671, 5592.608517403824, 5631.267935168484, 5919.668074683162, 5962.0, 5997.550183736237, 6003.429674180946, 6007.789727359522, 6572.0, 6633.502487313374, 6668.666566671647, 6687.398134167948, 6688.933110668929, 1919.42417274817, 1933.2556965568358, 1941.281725761449, 1942.0, 1951.5218771400814, 1274.5024596099545, 1416.5113036002563, 1420.4744244629346, 1433.605758416444, 1442.170751817709, 5720.342160651495, 5756.0, 5761.567882408836, 5773.364929857712, 5806.941930580725, 6687.531872768859, 6739.258681545124, 6766.763163289262, 6805.557638753465, 6807.489438292049, 5721.227634269404, 5761.88476230473, 5771.336296325892, 5784.640609456775, 5840.182374467578, 3577.2308953575107, 3596.2987217492337, 3600.225951420457, 3601.2353946565995, 3611.0, 6492.545521813522, 6513.1532900722605, 6531.967340163269, 6549.410553050248, 6556.606603603799, 6839.760608378683, 6896.7586134485055, 6915.4121899638085, 6939.514234003571, 7007.824804379931, 6506.089147519351, 6529.379708927644, 6537.215534136029, 6567.638779867153, 6588.8352791180605, 6654.502736884356, 6659.433948114464, 6720.563163394364, 6722.394984451423, 6736.0, 6559.27847936717, 6590.769323073861, 6603.702833372414, 6620.503462240447, 6688.866222675617, 6326.070548482757, 6359.3147815827915, 6392.520560957853, 6472.478967442553, 6568.770093046721, 5363.222332761649, 5381.75782089799, 5451.754671039892, 5463.153211252262, 5472.179173124063, 6526.314736952551, 6611.892410567026, 6718.731250750111, 6726.159230096238, 6730.8653826924165, 6428.614283143026, 6479.254885688206, 6549.672516374258, 6590.275069742229, 6622.549656627079, 6390.562123522171, 6424.550281480251, 6461.256955449995, 6495.642739649175, 6516.152900123143, 6300.243970723543, 6308.842278943063, 6318.526110541636, 6405.743770249138, 6476.31998640136, 6428.55000149985, 6437.227532696106, 6496.350364963655, 6499.350064993652, 6574.211094668671, 6351.681636202845, 6354.936450635434, 6371.23545174582, 6405.135306733531, 6412.166418365583], "value": 5142.803233861564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.9242714369278, 904.5884122724161, 908.7455512456512, 916.6012784438766, 918.6004088221622, 17600.559986000357, 18197.99999999998, 18260.72608910864, 18389.816101838976, 18580.628387432243, 18750.624987500243, 18915.337963171292, 19032.524186895334, 19195.0, 19215.519612009673, 967.8161149381613, 969.2149359019181, 975.4391225045591, 979.0307595480459, 979.6522234606718, 967.4775621164563, 981.9607215711399, 984.5913945712521, 985.5072463768116, 986.5807032011367, 989.5250279865669, 1011.4335971855747, 1020.6529779874878, 1025.4770067265674, 1029.7991891581107, 1019.7960407918409, 1020.8009438159562, 1022.4836457588907, 1026.4508487958906, 1027.3476342522476, 719.0, 732.1360794262768, 744.7616762635959, 748.7080038784878, 750.2834792772943, 19741.802581974283, 19855.106520206624, 19938.60122797536, 19990.100445479842, 20002.899985500124, 20938.37184884456, 21101.68347474789, 21991.670124947977, 22056.44858878525, 22194.223202187844, 16712.41506547265, 16829.990200587883, 16849.241784119622, 16930.0, 17200.82799172005, 3643.3806252937065, 3655.4334078217917, 3662.359087159763, 3671.541057367829, 3681.226942342111, 103141.0, 134806.0, 138984.0, 144381.99999999895, 144692.27653861768, 17560.648787024187, 17627.735583966252, 17629.118544072746, 17712.114394280234, 17845.0, 31013.534796978063, 31421.0, 31504.0, 31565.36869262602, 31656.683433165374, 7997.800054998555, 8056.476329038711, 8119.147489513634, 8121.147279535682, 8135.75592732219, 4133.173365326947, 4182.811773470201, 4183.414321994923, 4187.183499217685, 4205.201011807747, 5494.917576236359, 5536.197251398525, 5614.971925140429, 5620.634658747168, 5630.5495560355075, 891.3332069030824, 905.6649039855296, 917.8623206518942, 926.592299388267, 929.4655573045526, 675.9662016899135, 695.2144077192739, 699.9965000175068, 705.1608585782902, 710.2506855267742, 11379.772404551863, 11435.485403156878, 11637.952584267456, 11923.0, 12409.317487538272, 692.0933577014127, 694.8188080263471, 699.6396855619361, 701.3722718167314, 711.1395211793684, 5187.922181167285, 5277.393099793496, 5407.594430417735, 5465.808696695596, 5517.227588137664, 118446.40776796233, 123132.38433807774, 124527.37736311441, 125302.37348813197, 126438.36780816037, 104189.0, 105236.0, 109920.0, 110063.0, 111039.0, 90216.0, 90234.09765902389, 91424.54287728519, 91437.0, 94281.0, 9835.542550062608, 9935.106298272143, 10067.89932100699, 10141.036601522843, 10297.691069267934, 43630.34554481749, 44703.55296446994, 44811.327830083224, 45222.77388613036, 45548.31677524774, 55967.440325596224, 58243.70878145582, 58741.4125858753, 58868.0, 59160.70419647874, 15361.078335299917, 15474.922625386802, 15535.300911459237, 15620.140892251035, 15668.138252396227, 16809.159542023095, 16883.493495195165, 16952.915235423745, 17118.914405427895, 17225.56936076608, 14555.345009474811, 14624.634384140481, 14730.63173420673, 14803.0, 14905.105693658415, 14474.85525144735, 14575.198364090076, 14578.125312481285, 14612.0, 14698.926505367404, 15095.622609434413, 15316.770248446504, 15324.540263792103, 15406.075635461908, 15433.84566154324, 11908.52365905354, 11920.76158476843, 12167.0, 12311.138220324492, 12561.05792065617, 11507.654770356903, 11623.76752464963, 11634.360110193682, 11681.357525336189, 11803.940980295043], "value": 8790.102563353212, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1472.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 113.0, 109.0, 111.0, 108.0, 114.0, 115.0, 109.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 120.0, 122.0, 144.0, 115.0, 121.0, 118.0, 127.0, 148.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 166.0, 169.0, 167.0, 169.0, 173.0, 169.0, 164.0, 164.0], "value": 167.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 84.0, 91.0, 78.0, 76.0, 81.0, 84.0, 78.0, 77.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 85.0, 89.0, 84.0, 90.0, 85.0, 82.0, 136.0, 80.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 115.0, 115.0, 116.0, 115.0, 123.0, 114.0, 116.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 151.0, 148.0, 154.0, 148.0, 149.0, 153.0, 155.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 96.0, 94.0, 94.0, 106.0, 100.0, 94.0, 95.0, 95.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 64.0, 62.0, 54.0, 54.0, 55.0, 54.0, 55.0, 61.0, 53.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 38.0, 39.0, 43.0, 41.0, 43.0, 44.0, 39.0, 43.0, 45.0], "value": 42.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 78.0, 75.0, 82.0, 73.0, 81.0, 72.0, 80.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 121.0, 127.0, 120.0, 117.0, 125.0, 120.0, 121.0, 123.0], "value": 120.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 177.0, 169.0, 167.0, 179.0, 173.0, 174.0, 168.0, 171.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 65.0, 65.0, 67.0, 69.0, 64.0, 68.0, 73.0], "value": 67.0, "unit": "score"}]}]} 01:15:07 INFO - Return code: 0 01:15:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:15:07 INFO - # TBPL SUCCESS # 01:15:07 INFO - Running post-action listener: _package_coverage_data 01:15:07 INFO - Running post-action listener: _resource_record_post_action 01:15:07 INFO - [mozharness: 2017-09-14 08:15:07.473345Z] Finished run-tests step (success) 01:15:07 INFO - Running post-run listener: _resource_record_post_run 01:15:07 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 3887104; Write bytes: 400654336; Read time: 1528; Write time: 215144 01:15:07 INFO - TinderboxPrint: CPU usage
13.3% 01:15:07 INFO - TinderboxPrint: I/O read bytes / time
3,887,104 / 1,528 01:15:07 INFO - TinderboxPrint: I/O write bytes / time
400,654,336 / 215,144 01:15:07 INFO - TinderboxPrint: CPU idle
8,263.0 (86.7%) 01:15:07 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 01:15:07 INFO - TinderboxPrint: Swap in / out
0 / 0 01:15:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74244096; Read time: 0; Write time: 34224 01:15:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 01:15:07 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3883008; Write bytes: 326410240; Read time: 1512; Write time: 180920 01:15:08 INFO - Running post-run listener: _upload_blobber_files 01:15:08 INFO - Blob upload gear active. 01:15:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:15:08 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 01:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:15:08 INFO - (blobuploader) - INFO - Open directory for files ... 01:15:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:15:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:15:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:09 INFO - (blobuploader) - INFO - Done attempting. 01:15:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:10 INFO - (blobuploader) - INFO - Done attempting. 01:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:15:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:11 INFO - (blobuploader) - INFO - Done attempting. 01:15:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:15:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:15:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:18 INFO - (blobuploader) - INFO - Done attempting. 01:15:18 INFO - (blobuploader) - INFO - Iteration through files over. 01:15:18 INFO - Return code: 0 01:15:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:15:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:15:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97b4a9b4afad1d54e19ce2d3a8fbd5ad37107d3d9422899db083d504b83a02cf0013acbed6f0f3e7827d9d4e357444b6f937bcb20e53cb525cc4faf6d928d574", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15232a4e9eccf09bcb636fec1f01506877c65c212b2db08dd23f3ba82ee38c81d0bf2aa7017a53402376c440b1c8a3ced092201b2791b25244bc0c717e01f7fa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b14e79a1e9b6991858655b33517389afdc5178bb349970d2a39baa8c29c38920509e21e1bc4eb77f92cd0bef6a4a810d54bb70d40e292d992da787e410d79c43", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f78f658d6cb3b3a40d57f8aa7adcee770e696872bfc9065666da588dc4c3c57719bab218b76dd990faf1708b8e41c37734dd4e7d36a89dbc6145cb65e87a3415"} 01:15:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:15:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:15:18 INFO - Contents: 01:15:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97b4a9b4afad1d54e19ce2d3a8fbd5ad37107d3d9422899db083d504b83a02cf0013acbed6f0f3e7827d9d4e357444b6f937bcb20e53cb525cc4faf6d928d574", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15232a4e9eccf09bcb636fec1f01506877c65c212b2db08dd23f3ba82ee38c81d0bf2aa7017a53402376c440b1c8a3ced092201b2791b25244bc0c717e01f7fa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b14e79a1e9b6991858655b33517389afdc5178bb349970d2a39baa8c29c38920509e21e1bc4eb77f92cd0bef6a4a810d54bb70d40e292d992da787e410d79c43", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f78f658d6cb3b3a40d57f8aa7adcee770e696872bfc9065666da588dc4c3c57719bab218b76dd990faf1708b8e41c37734dd4e7d36a89dbc6145cb65e87a3415"} 01:15:18 INFO - Running post-run listener: copy_logs_to_upload_dir 01:15:18 INFO - Copying logs to upload dir... 01:15:18 INFO - mkdir: /builds/slave/test/build/upload/logs 01:15:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.296650 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-14 01:15:18.721460) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 01:15:18.724526) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97b4a9b4afad1d54e19ce2d3a8fbd5ad37107d3d9422899db083d504b83a02cf0013acbed6f0f3e7827d9d4e357444b6f937bcb20e53cb525cc4faf6d928d574", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15232a4e9eccf09bcb636fec1f01506877c65c212b2db08dd23f3ba82ee38c81d0bf2aa7017a53402376c440b1c8a3ced092201b2791b25244bc0c717e01f7fa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b14e79a1e9b6991858655b33517389afdc5178bb349970d2a39baa8c29c38920509e21e1bc4eb77f92cd0bef6a4a810d54bb70d40e292d992da787e410d79c43", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f78f658d6cb3b3a40d57f8aa7adcee770e696872bfc9065666da588dc4c3c57719bab218b76dd990faf1708b8e41c37734dd4e7d36a89dbc6145cb65e87a3415"} build_url:https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97b4a9b4afad1d54e19ce2d3a8fbd5ad37107d3d9422899db083d504b83a02cf0013acbed6f0f3e7827d9d4e357444b6f937bcb20e53cb525cc4faf6d928d574", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15232a4e9eccf09bcb636fec1f01506877c65c212b2db08dd23f3ba82ee38c81d0bf2aa7017a53402376c440b1c8a3ced092201b2791b25244bc0c717e01f7fa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b14e79a1e9b6991858655b33517389afdc5178bb349970d2a39baa8c29c38920509e21e1bc4eb77f92cd0bef6a4a810d54bb70d40e292d992da787e410d79c43", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f78f658d6cb3b3a40d57f8aa7adcee770e696872bfc9065666da588dc4c3c57719bab218b76dd990faf1708b8e41c37734dd4e7d36a89dbc6145cb65e87a3415"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 01:15:18.752762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:15:18.753069) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1505372753.222773-1530427877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:15:18.835043) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 01:15:18.835360) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 01:15:18.835659) ========= ========= Total master_lag: 0.27 =========